Hi there,


Since yesterday (18th Dec 2023) Provisioning Profile config file is not populated into our SNOM devices.

It looks like specific added/changed settings directly through SRAPS portal "Settings" tab are populated but I also have xml file assigned to the profile and it is not populated.


To describe everything in depth:

  • I have one provisioning profile with xml config file for D-Series SNOM devices (D715) (let's call it "Main Profile")
  • There are currently two devices added in the "Phones" section which I'm currently testing
  • Both of these devices have the same "Main Profile" provisioning profile assigned to them
  • Both devices have some settings overridden in Phones ā†’ <phone_1> ā†’ Settings tab
  • Looks like on both devices, settings changed on the phone settings tab are populated into them
  • None of the devices have any config populated from "Main Profile" config file
  • Everything was working perfectly fine until yesterday
  • Factory reset doesn't help (I did it multiple times)


This is what I have in the device logs:


Dec 19 14:16:16.770 [NOTICE] PHN: Setting server prio 1, type redirection, url: >https://provisioning.snom.com/snom715/%7Bmac%7D.htm<
Dec 19 14:16:16.770 [NOTICE] PHN: SetProvisioningActive
Dec 19 14:16:16.774 [NOTICE] PHN: AddSettingUrl https://provisioning.snom.com:443/snom715/<<REDACTED>>.htm
Dec 19 14:16:16.774 [NOTICE] PHN: AddSettingUrl https://127.0.0.1:443/dummy.htm
Dec 19 14:16:16.775 [NOTICE] PHN: Fetching URL: https://provisioning.snom.com:443/snom715/<<REDACTED>>.htm
Dec 19 14:16:16.783 [NOTICE] PHN: Fetching URL: phone://mb_exit/#...
Dec 19 14:16:16.824 [NOTICE] TLS: new session
Dec 19 14:16:16.874 [ERROR ] TLS: Error 62 at depth 0: Hostname mismatch
Dec 19 14:16:16.888 [ERROR ] TLS: OSSL error (GetDecryptedInput ssl error): code 337047686, error:1416F086:SSL routines:tls_process_server_certificate:certificate verify failed
Dec 19 14:16:16.888 [ERROR ] PHN: TPL: Socket Error: 29/37/connected, Tls error, closing
Dec 19 14:16:16.889 [NOTICE] WEBCLIENT: on_tcp_close conn_id:2
Dec 19 14:16:16.889 [ALERT ] WEBCLIENT: request https://provisioning.snom.com:443/snom715/<<REDACTED>>.htm failed due to no response from server (Success) for con_id:2; waiting to timeout so we can resend with BOTV
Dec 19 14:16:19.807 [ALERT ] WEBCLIENT: request https://provisioning.snom.com:443/snom715/<<REDACTED>>.htm stopped due to no response from server for con_id:2; resending with timeout 6000 ms
Dec 19 14:16:19.838 [NOTICE] TLS: new session
Dec 19 14:16:19.885 [ERROR ] TLS: Error 62 at depth 0: Hostname mismatch
Dec 19 14:16:19.899 [ERROR ] TLS: OSSL error (GetDecryptedInput ssl error): code 337047686, error:1416F086:SSL routines:tls_process_server_certificate:certificate verify failed
Dec 19 14:16:19.900 [ERROR ] PHN: TPL: Socket Error: 30/37/connected, Tls error, closing
Dec 19 14:16:19.900 [NOTICE] WEBCLIENT: on_tcp_close conn_id:2
Dec 19 14:16:19.901 [ALERT ] WEBCLIENT: request https://provisioning.snom.com:443/snom715/<<REDACTED>>.htm failed due to no response from server (Success) for con_id:2; waiting to timeout so we can resend with BOTV
Dec 19 14:16:25.817 [ALERT ] WEBCLIENT: request https://provisioning.snom.com:443/snom715/<<REDACTED>>.htm stopped due to no response from server for con_id:2; resending with timeout 12000 ms
Dec 19 14:16:25.845 [NOTICE] TLS: new session
Dec 19 14:16:25.897 [ERROR ] TLS: Error 62 at depth 0: Hostname mismatch
Dec 19 14:16:25.910 [ERROR ] TLS: OSSL error (GetDecryptedInput ssl error): code 337047686, error:1416F086:SSL routines:tls_process_server_certificate:certificate verify failed
Dec 19 14:16:25.910 [ERROR ] PHN: TPL: Socket Error: 31/37/connected, Tls error, closing
Dec 19 14:16:25.911 [NOTICE] WEBCLIENT: on_tcp_close conn_id:2
Dec 19 14:16:25.911 [ALERT ] WEBCLIENT: request https://provisioning.snom.com:443/snom715/<<REDACTED>>.htm failed due to no response from server (Success) for con_id:2; waiting to timeout so we can resend with BOTV
Dec 19 14:16:37.827 [ALERT ] WEBCLIENT: request https://provisioning.snom.com:443/snom715/<<REDACTED>>.htm stopped due to no response from server for con_id:2; resending with timeout 24000 ms
Dec 19 14:16:37.858 [NOTICE] TLS: new session
Dec 19 14:16:37.902 [ERROR ] TLS: Error 62 at depth 0: Hostname mismatch
Dec 19 14:16:37.914 [ERROR ] TLS: OSSL error (GetDecryptedInput ssl error): code 337047686, error:1416F086:SSL routines:tls_process_server_certificate:certificate verify failed
Dec 19 14:16:37.915 [ERROR ] PHN: TPL: Socket Error: 32/37/connected, Tls error, closing
Dec 19 14:16:37.916 [NOTICE] WEBCLIENT: on_tcp_close conn_id:2
Dec 19 14:16:37.917 [ALERT ] WEBCLIENT: request https://provisioning.snom.com:443/snom715/<<REDACTED>>.htm failed due to no response from server (Success) for con_id:2; waiting to timeout so we can resend with BOTV


Any help will be greatly appreciated.

Thanks




profilePicture

Mariusz Soltys

$userLabel.Name

Joined: 19.12.2023

3 Comments

  1. Mariusz Soltys

    Dec 19, 2023

    UPDATE:


    Looks like now I'm getting something from SRAPS but it's not merging / downloading settings from my provisioning profile config file:


    Dec 19 16:28:13.403 [NOTICE] PHN: TPL: Socket 48 idle/connect timeout
    Dec 19 16:28:14.512 [NOTICE] PHN: Fetching URL: file://xml/gui/state_settings.xml#...
    Dec 19 16:28:16.633 [NOTICE] PHN: TPL: Socket 47 idle/connect timeout
    Dec 19 16:28:17.217 [NOTICE] PHN: Fetching URL: file://xml/gui/maintenance.xml
    Dec 19 16:28:18.463 [NOTICE] PHN: TPL: Socket 49 idle/connect timeout
    Dec 19 16:28:19.150 [NOTICE] PHN: Fetching URL: file:///xml/gui/maintenance.xml#...
    Dec 19 16:28:20.191 [NOTICE] PHN: Setting server prio 1, type redirection, url: >https://provisioning.snom.com/snom715/%7Bmac%7D.htm<
    Dec 19 16:28:20.191 [NOTICE] PHN: SetProvisioningActive
    Dec 19 16:28:20.196 [NOTICE] PHN: AddSettingUrl https://provisioning.snom.com:443/snom715/<<<REDACTED>>>.htm
    Dec 19 16:28:20.196 [NOTICE] PHN: AddSettingUrl https://127.0.0.1:443/dummy.htm
    Dec 19 16:28:20.197 [NOTICE] PHN: Fetching URL: https://provisioning.snom.com:443/snom715/<<<REDACTED>>>.htm
    Dec 19 16:28:20.205 [NOTICE] PHN: Fetching URL: phone://mb_exit/#...
    Dec 19 16:28:20.246 [NOTICE] TLS: new session
    Dec 19 16:28:20.660 [NOTICE] PHN: read_xml_settings: found settings (container) XML header
    Dec 19 16:28:20.660 [NOTICE] PHN: read_xml_settings: found phone-settings XML header
    Dec 19 16:28:20.660 [NOTICE] PHN: read_xml_settings: found one byte encoding: 1
    Dec 19 16:28:20.661 [NOTICE] PHN: read_xml_settings: found uploads XML header
    Dec 19 16:28:20.661 [NOTICE] PHN: read_xml_settings: found one byte encoding: 1
    Dec 19 16:28:20.662 [NOTICE] PHN: Found data upload type >defaults< !
    Dec 19 16:28:20.663 [NOTICE] PHN: AddToUploadList: >https://secure-provisioning.snom.com:443/snom715/<<<REDACTED>>>/download/8eafa<<<REDACTED>>>d8dc2f< type: defaults
    Dec 19 16:28:20.663 [NOTICE] PHN: Config setup: found xml style settings
    Dec 19 16:28:20.666 [NOTICE] PHN: last prov successful:1; uri: >https://provisioning.snom.com/snom715/{mac}.htm<; default uri: >http://provisioning.snom.com/snom715/snom715.php?mac={mac}<
    Dec 19 16:28:20.668 [NOTICE] PHN: Fetching URL: https://127.0.0.1:443/dummy.htm
    Dec 19 16:28:20.671 [ERROR ] PHN: TPL: Socket Error: 51/35/connecting, connect_cb -> Operation now in progress (115)
    Dec 19 16:28:20.672 [NOTICE] WEBCLIENT: on_tcp_close conn_id:14
    Dec 19 16:28:20.673 [WARN Ā ] PHN: Config setup: code: 500, uri: https://127.0.0.1:443/dummy.htm
    Dec 19 16:28:20.680 [NOTICE] PHN: Fetching FW URL: https://provisioning.snom.com:443/snom715/snom715-firmware.htm
    Dec 19 16:28:20.680 [NOTICE] PHN: Fetching URL: https://provisioning.snom.com:443/snom715/snom715-firmware.htm
    Dec 19 16:28:20.688 [NOTICE] PHN: Fetching URL: https://secure-provisioning.snom.com:443/snom715/<<<REDACTED>>>/download/8eafa<<<REDACTED>>>d8dc2f
    Dec 19 16:28:20.692 [NOTICE] PHN: Last provisioning was successful, thus stop here!
    Dec 19 16:28:20.693 [NOTICE] PHN: Go to wizzard if all settings have been read.
    Dec 19 16:28:20.693 [NOTICE] PHN: SetProvisioningDone
    Dec 19 16:28:20.713 [NOTICE] TLS: new session
    Dec 19 16:28:21.054 [NOTICE] TLS: new session
    Dec 19 16:28:21.426 [NOTICE] PHN: OnFileUpload: Can not upload >https://secure-provisioning.snom.com:443/snom715/<<<REDACTED>>>/download/8eafa<<<REDACTED>>>d8dc2f<. Error >404<!
    Dec 19 16:28:21.427 [NOTICE] PHN: OnFileUpload: Erased url >https://secure-provisioning.snom.com:443/snom715/<<<REDACTED>>>/download/8eafa<<<REDACTED>>>d8dc2f< from upload_list_

  2. Gianmaria Tononi

    Dec 20, 2023

    Hi,

    I can see in your company profile two phones and two Provisioning Profile but they are all empty, with no settings, maybe because you're testing this.

    We can help with the testing, and get some logs from SRAPS too, but we would need a private ticket to do so

    You can raise one if you are a Snom partner or ask your Snom reseller, likely a partner, to do so for you: to learn more about our partner program or how to reach a partner please contact our sales team Sales

    Thank you

    1. Mariusz Soltys

      Dec 20, 2023

      Hi Gianmaria,


      Both profiles don't have any WEB UI settings but have "DefaultĀ settings" XML file assigned to them. (Both XML files are identical)
      Prior to Monday this xml file was populated on the SNOM device. But since then, only settings that are set through WEB UI on SRAPS get populated.

      Even XML file attached in "Product Defaults" is not populated to SNOM. Firmware is recognised ok but not the actual settings.


      Thanks