2024-11-10 15:41:07.671 - debug: vofo-speedtest.0 (29633) Redis Objects: Use Redis connection: 127.0.0.1:9001
2024-11-10 15:41:07.767 - debug: vofo-speedtest.0 (29633) Objects client ready ... initialize now
2024-11-10 15:41:07.811 - debug: vofo-speedtest.0 (29633) Objects create System PubSub Client
2024-11-10 15:41:07.812 - debug: vofo-speedtest.0 (29633) Objects create User PubSub Client
2024-11-10 15:41:08.092 - debug: vofo-speedtest.0 (29633) Objects client initialize lua scripts
2024-11-10 15:41:08.139 - debug: vofo-speedtest.0 (29633) Objects connected to redis: 127.0.0.1:9001
2024-11-10 15:41:08.253 - debug: vofo-speedtest.0 (29633) Redis States: Use Redis connection: 127.0.0.1:9000
2024-11-10 15:41:08.357 - debug: vofo-speedtest.0 (29633) States create System PubSub Client
2024-11-10 15:41:08.359 - debug: vofo-speedtest.0 (29633) States create User PubSub Client
2024-11-10 15:41:08.524 - debug: vofo-speedtest.0 (29633) States connected to redis: 127.0.0.1:9000
2024-11-10 15:41:10.475 - info: vofo-speedtest.0 (29633) starting. Version 2.0.1 in /opt/iobroker/node_modules/iobroker.vofo-speedtest, node: v20.16.0, js-controller: 6.0.11
2024-11-10 15:41:10.508 - debug: vofo-speedtest.0 (29633) getApiKeyFile start...
2024-11-10 15:41:10.737 - debug: vofo-speedtest.0 (29633) getApiKeyFile finished with code 200
2024-11-10 15:41:10.738 - debug: vofo-speedtest.0 (29633) getApiKey start...
2024-11-10 15:41:10.942 - debug: vofo-speedtest.0 (29633) getApiKey finished with code 200
2024-11-10 15:41:10.951 - debug: vofo-speedtest.0 (29633) getConfig start...
2024-11-10 15:41:11.043 - debug: vofo-speedtest.0 (29633) getConfig finished with code 200
2024-11-10 15:41:11.044 - debug: vofo-speedtest.0 (29633) getRemotePort start...
2024-11-10 15:41:11.081 - debug: vofo-speedtest.0 (29633) getRemotePort finished with code 200
2024-11-10 15:41:11.082 - debug: vofo-speedtest.0 (29633) initSBC start...
2024-11-10 15:41:11.086 - debug: vofo-speedtest.0 (29633) initSBC: {"hostname":"api.speedtest.vodafone.anw.net","port":443,"path":"/v0/init/","method":"POST","rejectUnauthorized":false,"resolveWithFullResponse":true,"timeout":60000,"headers":{"Content-Type":"application/json; charset=utf-8","X-APIKEY":"eiquo8HuP0aeDoinono2nao4keip1the"}}
2024-11-10 15:41:11.576 - debug: vofo-speedtest.0 (29633) initSBC finished with code 200
2024-11-10 15:41:11.578 - debug: vofo-speedtest.0 (29633) _createState called for: modem with value : undefined
2024-11-10 15:41:11.578 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:11.642 - debug: vofo-speedtest.0 (29633) _createState called for: modem.vendor with value : null
2024-11-10 15:41:11.643 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:11.662 - debug: vofo-speedtest.0 (29633) _createState called for: modem.code with value : null
2024-11-10 15:41:11.663 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:11.679 - debug: vofo-speedtest.0 (29633) _createState called for: modem.name with value : null
2024-11-10 15:41:11.680 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:11.704 - debug: vofo-speedtest.0 (29633) _createState called for: modem.text with value : null
2024-11-10 15:41:11.704 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:11.723 - debug: vofo-speedtest.0 (29633) _createState called for: isCustomer with value : false
2024-11-10 15:41:11.724 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:11.798 - debug: vofo-speedtest.0 (29633) _createState called for: isp with value : Purtel dialin pool for COM-IN
2024-11-10 15:41:11.798 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:11.872 - debug: vofo-speedtest.0 (29633) _createState called for: ip with value : 141.78.152.168
2024-11-10 15:41:11.872 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:11.944 - debug: vofo-speedtest.0 (29633) _createState called for: ipCountry with value : DE
2024-11-10 15:41:11.945 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:12.008 - debug: vofo-speedtest.0 (29633) _createState called for: downstreamSpeed with value : null
2024-11-10 15:41:12.009 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:12.018 - debug: vofo-speedtest.0 (29633) _createState called for: upstreamSpeed with value : null
2024-11-10 15:41:12.019 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:12.030 - debug: vofo-speedtest.0 (29633) _createState called for: downstreamBooked with value : null
2024-11-10 15:41:12.031 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:12.042 - debug: vofo-speedtest.0 (29633) _createState called for: upstreamBooked with value : null
2024-11-10 15:41:12.043 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:12.055 - debug: vofo-speedtest.0 (29633) SBC-Init (Success): {"data":{"speedtest":{"id":"zvb9q7sgqn5r","standAloneMode":false,"parentSpeedtestId":null,"clientVersion":"1.2.1","startTime":"2024-11-10 15:41:11","servers":{"downloadServers":{"dualstack":["https://speedtest-22.vodafone.anw.net/data.zero.bin.512M","https://speedtest-21.vodafone.anw.net/data.zero.bin.512M"],"ipv6":["https://speedtest-22v6.vodafone.anw.net/data.zero.bin.512M","https://speedtest-21v6.vodafone.anw.net/data.zero.bin.512M"]},"uploadServer":{"dualstack":"https://speedtest-22.vodafone.anw.net/empty.txt","ipv6":"https://speedtest-22v6.vodafone.anw.net/empty.txt"},"pingServer":{"dualstack":"https://speedtest-22.vodafone.anw.net","ipv6":"https://speedtest-22v6.vodafone.anw.net"},"wsPingServer":{"dualstack":"wss://speedtest-22.vodafone.anw.net/ping/","ipv6":"wss://speedtest-22v6.vodafone.anw.net/ping/"}}},"connection":{"ip":"141.78.152.168","ipVersion":"v4","ipCountry":"DE","remotePort":57738,"isp":"Purtel dialin pool for COM-IN","isCustomer":false,"plannedImprovement":null,"ispFootprint":null,"isVpnActive":null,"vpnDetectedBy":null},"modem":{"vendor":null,"type":null,"name":null,"provisionedDownloadSpeed":null,"syncedDownloadSpeed":null,"provisionedUploadSpeed":null,"syncedUploadSpeed":null,"bookedDownloadSpeedMax":null,"bookedDownloadSpeedAvg":null,"bookedDownloadSpeedMin":null,"bookedUploadSpeedMax":null,"bookedUploadSpeedAvg":null,"bookedUploadSpeedMin":null,"swapScenario":null,"swapLink":null},"cmts":{"vendor":null,"isModemTestAvailable":false},"communication":{"modemSwapLink":null,"modemSwap":false,"plannedImprovement":null},"client":{"id":"d42155d0-9f71-11ef-9b6a-4b387c086628","userAgent":"","browser":{"name":null,"version":null,"isCurrent":null},"os":{"name":null,"version":null,"isCurrent":null},"device":{"id":null,"vendor":null,"model":null,"inches":null,"deviceType":"desktop"}},"location":{"countryCode":"DE"},"partialService":{"downloadIndex":0,"uploadIndex":0}},"status":{"code":0,"message":"ok"}}
2024-11-10 15:41:12.057 - debug: vofo-speedtest.0 (29633) startDownload start: null
2024-11-10 15:41:12.840 - debug: vofo-speedtest.0 (29633) gbun download
2024-11-10 15:41:13.589 - debug: vofo-speedtest.0 (29633) gbun download
2024-11-10 15:41:14.339 - debug: vofo-speedtest.0 (29633) gbun download
2024-11-10 15:41:15.089 - debug: vofo-speedtest.0 (29633) gbun download
2024-11-10 15:41:15.838 - debug: vofo-speedtest.0 (29633) gbun download
2024-11-10 15:41:16.588 - debug: vofo-speedtest.0 (29633) gbun download
2024-11-10 15:41:17.339 - debug: vofo-speedtest.0 (29633) gbun download
2024-11-10 15:41:18.088 - debug: vofo-speedtest.0 (29633) gbun download
2024-11-10 15:41:18.838 - debug: vofo-speedtest.0 (29633) gbun download
2024-11-10 15:41:19.590 - debug: vofo-speedtest.0 (29633) gbun download
2024-11-10 15:41:20.339 - debug: vofo-speedtest.0 (29633) gbun download
2024-11-10 15:41:21.090 - debug: vofo-speedtest.0 (29633) gbun download
2024-11-10 15:41:21.839 - debug: vofo-speedtest.0 (29633) gbun download
2024-11-10 15:41:22.086 - debug: vofo-speedtest.0 (29633) stopDownloadTest stopped: download
2024-11-10 15:41:22.101 - debug: vofo-speedtest.0 (29633) result start: "{\"speedtestId\":\"zvb9q7sgqn5r\",\"intermediateValues\":[485134,694612,501045,440290,592795,397591,531095,477626,518688,518013,456830,485840,540563],\"transferDuration\":9754,\"transferredBytes\":622720864}"
2024-11-10 15:41:22.102 - debug: vofo-speedtest.0 (29633) startDownload abort: undefined
2024-11-10 15:41:22.103 - debug: vofo-speedtest.0 (29633) startDownload abort: undefined
2024-11-10 15:41:22.103 - debug: vofo-speedtest.0 (29633) startDownload abort: undefined
2024-11-10 15:41:22.103 - debug: vofo-speedtest.0 (29633) startDownload abort: undefined
2024-11-10 15:41:22.103 - debug: vofo-speedtest.0 (29633) startDownload abort: undefined
2024-11-10 15:41:22.103 - debug: vofo-speedtest.0 (29633) startDownload abort: undefined
2024-11-10 15:41:22.104 - debug: vofo-speedtest.0 (29633) startDownload abort: undefined
2024-11-10 15:41:22.104 - debug: vofo-speedtest.0 (29633) startDownload abort: undefined
2024-11-10 15:41:22.104 - debug: vofo-speedtest.0 (29633) startDownload abort: undefined
2024-11-10 15:41:22.104 - debug: vofo-speedtest.0 (29633) startDownload abort: undefined
2024-11-10 15:41:22.104 - debug: vofo-speedtest.0 (29633) startDownload abort: undefined
2024-11-10 15:41:22.104 - debug: vofo-speedtest.0 (29633) startDownload abort: undefined
2024-11-10 15:41:22.188 - debug: vofo-speedtest.0 (29633) result: {"data":{"value":572228,"jitter":76011},"status":{"code":0,"message":"ok"}}
2024-11-10 15:41:22.590 - debug: vofo-speedtest.0 (29633) gbun null
2024-11-10 15:41:22.689 - debug: vofo-speedtest.0 (29633) run: upload
2024-11-10 15:41:22.691 - debug: vofo-speedtest.0 (29633) result start: "{\"speedtestId\":\"zvb9q7sgqn5r\",\"intermediateValues\":[],\"transferredBytes\":0}"
2024-11-10 15:41:22.747 - debug: vofo-speedtest.0 (29633) result: {"data":{"value":null,"jitter":null},"status":{"code":0,"message":"ok"}}
2024-11-10 15:41:23.248 - debug: vofo-speedtest.0 (29633) run: ping
2024-11-10 15:41:27.485 - debug: vofo-speedtest.0 (29633) _createState called for: Results.Last_Run with value : 1731249687485
2024-11-10 15:41:27.485 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:27.550 - debug: vofo-speedtest.0 (29633) _createState called for: Results.download_MB with value : 71.5285
2024-11-10 15:41:27.551 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:27.613 - debug: vofo-speedtest.0 (29633) _createState called for: Results.download_Mb with value : 572.228
2024-11-10 15:41:27.614 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:27.682 - debug: vofo-speedtest.0 (29633) _createState called for: Results.upload_MB with value : 0
2024-11-10 15:41:27.682 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:27.750 - debug: vofo-speedtest.0 (29633) _createState called for: Results.upload_Mb with value : 0
2024-11-10 15:41:27.750 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:27.821 - debug: vofo-speedtest.0 (29633) _createState called for: Results.download_MB_calc with value : 63.84732692307692
2024-11-10 15:41:27.821 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:27.882 - debug: vofo-speedtest.0 (29633) _createState called for: Results.download_Mb_calc with value : 510.77861538461536
2024-11-10 15:41:27.882 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:27.946 - debug: vofo-speedtest.0 (29633) _createState called for: Results.upload_MB_calc with value : NaN
2024-11-10 15:41:27.947 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:28.018 - debug: vofo-speedtest.0 (29633) _createState called for: Results.upload_Mb_calc with value : NaN
2024-11-10 15:41:28.018 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:28.092 - debug: vofo-speedtest.0 (29633) _createState called for: Results.ping.min with value : 5
2024-11-10 15:41:28.092 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:28.207 - debug: vofo-speedtest.0 (29633) _createState called for: Results.ping.max with value : 6
2024-11-10 15:41:28.208 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:28.282 - debug: vofo-speedtest.0 (29633) _createState called for: Results.ping.avg with value : 5
2024-11-10 15:41:28.282 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:28.353 - debug: vofo-speedtest.0 (29633) _createState called for: Results.ping.packetLoss with value : 0
2024-11-10 15:41:28.353 - debug: vofo-speedtest.0 (29633) Write value: false
2024-11-10 15:41:28.414 - info: vofo-speedtest.0 (29633) Vofo-Speedtest finished with 572.228mbit download speed and 0mbit upload speed.
2024-11-10 15:41:28.416 - info: vofo-speedtest.0 (29633) starting cleanup...
2024-11-10 15:41:28.416 - info: vofo-speedtest.0 (29633) cleaned everything up...
2024-11-10 15:41:28.464 - info: vofo-speedtest.0 (29633) Terminated (NO_ERROR): Without reason