Nur Text | Text mit Bildern

FHEM Forum

FHEM => Anfängerfragen => Thema gestartet von: Freibeuter am 18 Februar 2019, 16:07:47

Titel: wer blockiert hier ....
Beitrag von: Freibeuter am 18 Februar 2019, 16:07:47
Hallo zusammen,
ich habe Probleme das blockierende Device zu finden, wie soll ich vorgehen?

top meldet CP Laus von Perl 5-15% mem 15 %  alles andere weit darunter

Code Auswählen

active-timers: 171; max-active timers: 187; max-timer-load: 33  min-tmrHandlingTm: 0.0ms; max-tmrHandlingTm: 4705.6ms; totAvgDly: 513.5ms

name                                     function                               max    count      total  average   maxDly   avgDly TS Max call     param Max call
tmr-CUL_HM_procQs                        CUL_HM_procQs                            2     4694    2519.78     0.54 15638.92   189.56 18.02. 14:25:30 CUL_HM_procQs
tmr-BOSEST_checkWebSocketConnection      HASH(0x4f389a8)                         49     6523    9281.29     1.42 15314.25   155.20 18.02. 15:15:39 HASH(BOSE_Bad)
tmr-perfmon_ProcessTimer                 HASH_unnamed                           162     4728    1130.54     0.24 15280.22   210.33 18.02. 14:43:24 HASH(0x6be1a48)
tmr-at_Exec                              HASH(0x45258d8)                          4        9      29.74     3.30 11653.26  1318.50 18.02. 15:16:10 HASH(at_Girlande)
tmr-HTTPMOD_GetUpdate                    update                                  41     1108    3155.81     2.85 11582.79   366.24 18.02. 15:31:30 update:Fehmarnsund_Bruecke
tmr-Heating_Control_Update               HASH(0x74573e0)                         73        1      73.04    73.04 10288.68 10288.68 18.02. 15:16:10 HASH(t_Hzg_Kinderzimmer_8)
tmr-FW_closeInactiveClients              0                                       13       89     709.65     7.97  9362.15  3304.56 18.02. 14:53:57 0
tmr-at_Exec                              HASH(0x524c4c8)                         47        1      47.45    47.45  9337.94  9337.94 18.02. 15:16:10 HASH(a_w_Fenster)
tmr-RESIDENTStk_DurationTimer            HASH(0x76646a0)                          2        1       2.69     2.69  9298.62  9298.62 18.02. 15:16:11 HASH(Residents_DurationTimer)
tmr-RESIDENTStk_DurationTimer            HASH(0x7adb3b8)                         52        1      52.92    52.92  9293.44  9293.44 18.02. 15:16:11 HASH(rr_Jeannine_DurationTimer)
tmr-echodevice_GetSettings               HASH(0x6bafbe8)                         16       89     738.39     8.30  9291.26  3229.72 18.02. 14:59:12 HASH(ECHO_Plus)
tmr-echodevice_GetSettings               HASH(0x6be20f0)                         13       89     734.89     8.26  9290.39  3229.75 18.02. 15:37:12 HASH(ECHO)
tmr-SYSMON_Update                        HASH(0x28077f0)                        117       89    2207.45    24.80  9284.43  3237.32 18.02. 15:45:36 HASH(sysmon)
tmr-XiaomiDevice_GetUpdate               HASH(0x62ac030)                          2       89     112.69     1.27  9284.20  3237.21 18.02. 15:37:12 HASH(LuftFilter)
tmr-echodevice_LoginStart                HASH(0x62d0f78)                         44       89     189.39     2.13  9283.52  3236.38 18.02. 15:38:16 HASH(echodevice)
tmr-echodevice_GetSettings               HASH(0x6a9a010)                         16       89     797.62     8.96  9282.95  3229.57 18.02. 15:42:27 HASH(ECHO_7abc5c8643454d06ab3b4229100b7a6a)
tmr-echodevice_GetSettings               HASH(0x6b350a8)                         14       89     812.67     9.13  9281.68  3229.40 18.02. 15:37:12 HASH(ECHO_G070L81490270307)
tmr-echodevice_GetSettings               HASH(0x6d095f0)                         16       89     942.72    10.59  9279.46  3227.95 18.02. 15:37:12 HASH(ECHO_2ed1716e697b41cfa7306dd219ca0c4c)
tmr-echodevice_GetSettings               HASH(0x6bf2b20)                         28       89    1642.92    18.46  9268.31  3220.16 18.02. 15:37:12 HASH(ECHO_DOT)
tmr-RESIDENTStk_DurationTimer            HASH(0xe20b80)                          40        1      40.35    40.35  9264.80  9264.80 18.02. 15:16:10 HASH(rr_Gast_DurationTimer)
tmr-RESIDENTStk_DurationTimer            HASH(0x7714eb8)                         40        1      40.73    40.73  9261.42  9261.42 18.02. 15:16:10 HASH(rr_Housekeeping_DurationTimer)
tmr-RESIDENTStk_DurationTimer            HASH(0x7301690)                         40        1      40.23    40.23  9258.29  9258.29 18.02. 15:16:10 HASH(rr_Niki_DurationTimer)
tmr-RESIDENTStk_DurationTimer            HASH(0x75dbcd0)                         40        1      40.46    40.46  9254.95  9254.95 18.02. 15:16:10 HASH(rr_Renate_DurationTimer)
tmr-LaCrosseGateway_OnConnectTimer       HASH(0x51c4e90)                          4       89     235.87     2.65  9253.15  3233.51 18.02. 14:52:54 HASH(myLaCrosseGateway)
tmr-MQTT::Timer                          HASH(0x5dc4d18)                          6       89     404.56     4.55  9252.31  3233.90 18.02. 14:53:57 HASH(myBroker)
tmr-RESIDENTStk_DurationTimer            HASH(0x7a95260)                         40        1      40.61    40.61  9252.23  9252.23 18.02. 15:16:10 HASH(rr_PeterF_DurationTimer)
tmr-echodevice_GetSettings               HASH(0x62d0f78)                         60       89    3325.12    37.36  9242.21  3201.12 18.02. 15:42:27 HASH(echodevice)
tmr-at_Exec                              HASH(0x55d96a8)                         93        9     584.73    64.97  9224.05  1521.85 18.02. 15:26:01 HASH(a_XIAOMI_VACUUM_disconnected)
tmr-RESIDENTStk_DurationTimer            HASH(0x78be710)                         40        1      40.86    40.86  9220.63  9220.63 18.02. 15:16:10 HASH(rr_Annetta_DurationTimer)
tmr-RESIDENTStk_DurationTimer            HASH(0x7ab3840)                         40        1      40.55    40.55  9208.57  9208.57 18.02. 15:16:10 HASH(rr_Timo_DurationTimer)
tmr-RESIDENTStk_DurationTimer            HASH(0x6ba7120)                         40        1      40.49    40.49  9205.44  9205.44 18.02. 15:16:10 HASH(rr_Alexandra_DurationTimer)
tmr-RESIDENTStk_DurationTimer            HASH(0x7abd170)                         40        1      40.89    40.89  9201.87  9201.87 18.02. 15:16:10 HASH(rr_PeterFsen_DurationTimer)
tmr-Heating_Control_Update               HASH(0x7422eb0)                         34        1      34.96    34.96  8994.33  8994.33 18.02. 14:51:09 HASH(t_Hzg_Kinderzimmer_8)
tmr-at_Exec                              HASH(0x5d2abb8)                          2        1       2.68     2.68  7953.01  7953.01 18.02. 15:16:11 HASH(w_mysensors)
tmr-RESIDENTStk_DurationTimer            HASH(0x75a5888)                         54        1      54.77    54.77  6715.68  6715.68 18.02. 15:49:52 HASH(rr_Alexandra_DurationTimer)
tmr-RESIDENTStk_DurationTimer            HASH(0x58cdd80)                         55        1      55.44    55.44  6714.85  6714.85 18.02. 15:49:51 HASH(rr_PeterFsen_DurationTimer)
tmr-RESIDENTStk_DurationTimer            HASH(0x78f3bc8)                        111        1     111.72   111.72  6711.33  6711.33 18.02. 15:49:51 HASH(rr_PeterF_DurationTimer)
tmr-RESIDENTStk_DurationTimer            HASH(0x719c4a8)                         60        1      60.14    60.14  6708.87  6708.87 18.02. 15:49:51 HASH(rr_Annetta_DurationTimer)
tmr-RESIDENTStk_DurationTimer            HASH(0x6c0d098)                         39        1      39.32    39.32  6697.27  6697.27 18.02. 14:31:51 HASH(rr_PeterFsen_DurationTimer)
tmr-RESIDENTStk_DurationTimer            HASH(0x6bf4f68)                         39        1      39.06    39.06  6696.88  6696.88 18.02. 14:31:51 HASH(rr_Alexandra_DurationTimer)
tmr-RESIDENTStk_DurationTimer            HASH(0x75c3038)                         39        1      39.37    39.37  6696.06  6696.06 18.02. 14:31:51 HASH(rr_Timo_DurationTimer)



Log File zeigt Perfmon freeze, darauf hin habe ich mal verbose auf 5 gesetzt:
Code Auswählen

2019.02.18 14:47:36 1: Perfmon: possible freeze starting at 14:47:33, delay is 3.016
2019.02.18 14:47:48 1: Perfmon: possible freeze starting at 14:47:45, delay is 3.863
2019.02.18 14:48:39 1: Perfmon: possible freeze starting at 14:48:36, delay is 3.016
2019.02.18 14:48:48 1: Perfmon: possible freeze starting at 14:48:45, delay is 3.654
2019.02.18 14:48:53 1: Perfmon: possible freeze starting at 14:48:52, delay is 1.862
2019.02.18 14:49:33 1: Perfmon: possible freeze starting at 14:49:30, delay is 3.134
2019.02.18 14:49:42 1: Perfmon: possible freeze starting at 14:49:39, delay is 3.016
2019.02.18 14:49:48 1: Perfmon: possible freeze starting at 14:49:45, delay is 3.768
2019.02.18 14:49:50 1: Perfmon: possible freeze starting at 14:49:49, delay is 1.642
2019.02.18 14:50:45 1: Perfmon: possible freeze starting at 14:50:42, delay is 3.016
2019.02.18 14:50:50 1: Perfmon: possible freeze starting at 14:50:46, delay is 4.464
2019.02.18 14:50:51 5: Starting notify loop for global, 1 event(s), first is ATTR global verbose 5
2019.02.18 14:50:51 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:51 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:51 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:51 5: End notify loop for global
2019.02.18 14:50:51 4: Connection accepted from telnetPort_127.0.0.1_60432
2019.02.18 14:50:51 4: ZWDongle_Read ZWDongle_1: rcvd 000400030e320221540000015f00070000015cb000 (request APPLICATION_COMMAND_HANDLER), sending ACK
2019.02.18 14:50:51 5: SW: 06
2019.02.18 14:50:51 5: ZWDongle_1: dispatch 000400030e320221540000015f00070000015cb000
2019.02.18 14:50:51 4: CMD:APPLICATION_COMMAND_HANDLER ID:03 ARG:0e320221540000015f00070000015cb000 CB:00
2019.02.18 14:50:51 5: Starting notify loop for ZWave_SWITCH_2, 3 event(s), first is power:  3.51 W previous: 3.48 delta_time: 7 s
2019.02.18 14:50:51 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:51 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:51 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:51 5: End notify loop for ZWave_SWITCH_2
2019.02.18 14:50:51 4: ZWDongle_Read ZWDongle_1: rcvd 000400030a3202a14a000300070004b000 (request APPLICATION_COMMAND_HANDLER), sending ACK
2019.02.18 14:50:51 5: SW: 06
2019.02.18 14:50:51 5: ZWDongle_1: dispatch 000400030a3202a14a000300070004b000
2019.02.18 14:50:51 4: CMD:APPLICATION_COMMAND_HANDLER ID:03 ARG:0a3202a14a000300070004b000 CB:00
2019.02.18 14:50:51 5: Starting notify loop for ZWave_SWITCH_2, 1 event(s), first is current:  0.03 A previous: 0.04 delta_time: 7 s
2019.02.18 14:50:51 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:51 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:51 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:51 5: End notify loop for ZWave_SWITCH_2
2019.02.18 14:50:51 4: BlockingCall (FRITZBOX_Readout_Run_Web): created child (7580), uses telnetPort to connect back
2019.02.18 14:50:51 5: BOSEST: run mojo loop
2019.02.18 14:50:51 5: BOSEST: finished mojo loop
2019.02.18 14:50:51 5: Cmd: >{BlockingRegisterTelnet($cl,1069)}<
2019.02.18 14:50:51 5: Cmd: >{BlockingStart('1068')}<
2019.02.18 14:50:51 4: ZWDongle_Read ZWDongle_1: rcvd 000400020e3202214400006054000700006054ca00 (request APPLICATION_COMMAND_HANDLER), sending ACK
2019.02.18 14:50:51 5: SW: 06
2019.02.18 14:50:51 5: ZWDongle_1: dispatch 000400020e3202214400006054000700006054ca00
2019.02.18 14:50:51 4: CMD:APPLICATION_COMMAND_HANDLER ID:02 ARG:0e3202214400006054000700006054ca00 CB:00
2019.02.18 14:50:51 5: Starting notify loop for ZWave_SWITCH_1, 1 event(s), first is energy:  246.6 kWh previous: 246.6 delta_time: 7 s
2019.02.18 14:50:51 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:51 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:51 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:51 5: End notify loop for ZWave_SWITCH_1
2019.02.18 14:50:51 5: Cmd: >{SYSMON_blockingFinish('name|sysmon|fhemuptime_text|0 days, 04 hours, 34 minutes|idletime_text|0 days, 04 hours, 18 minutes (93.78 %)|starttime|1550481301|uptime|16548|uptime_text|0 days, 04 hours, 35 minutes|idletime|15520 93.78 %|fhemuptime|16482|starttime_text|18.02.2019 10:15:01|fhemstarttime|1550481368|fhemstarttime_text|18.02.2019 10:16:08')}<
2019.02.18 14:50:51 5: SYSMON sysmon: blockingFinish.1034 name|sysmon|fhemuptime_text|0 days, 04 hours, 34 minutes|idletime_text|0 days, 04 hours, 18 minutes (93.78 %)|starttime|1550481301|uptime|16548|uptime_text|0 days, 04 hours, 35 minutes|idletime|15520 93.78 %|fhemuptime|16482|starttime_text|18.02.2019 10:15:01|fhemstarttime|1550481368|fhemstarttime_text|18.02.2019 10:16:08
2019.02.18 14:50:51 5: SYSMON sysmon: updateReadings.1053
2019.02.18 14:50:51 4: Connection accepted from telnetPort_127.0.0.1_60452
2019.02.18 14:50:51 4: WEB_192.168.110.32_63496 GET /fhem?room=7%5fEnergie&fw_id=4043; BUFLEN:0
2019.02.18 14:50:51 4: Ignoring Unknown
2019.02.18 14:50:51 4: Ignoring unknown1
2019.02.18 14:50:51 4: Ignoring Prologue_145
2019.02.18 14:50:51 4: Ignoring JeeTX
2019.02.18 14:50:52 4: WEB: /fhem?room=7%5fEnergie&fw_id=4043 / RL:4009 / text/html; charset=UTF-8 / Content-Encoding: gzip
/ Cache-Control: no-cache, no-store, must-revalidate

2019.02.18 14:50:52 5: BOSEST: run mojo loop
2019.02.18 14:50:52 5: BOSEST: finished mojo loop
2019.02.18 14:50:52 4: https://layla.amazon.de/api/np/player?deviceSerialNumber=G2A0WK048514020D&deviceType=A18O6U1UQFJ0XK&screenWidth=1392&_=1550497845: HTTP response code 400
2019.02.18 14:50:52 5: HttpUtils https://layla.amazon.de/api/np/player?deviceSerialNumber=G2A0WK048514020D&deviceType=A18O6U1UQFJ0XK&screenWidth=1392&_=1550497845: Got data, length: 16
2019.02.18 14:50:52 5: HttpUtils response header:
HTTP/1.1 400 Bad Request
Server: Server
Date: Mon, 18 Feb 2019 13:50:51 GMT
Content-Type: application/json
Content-Length: 36
Connection: keep-alive
x-amzn-RequestId: 33e86a42-3384-11e9-bf8b-518b521ebeeb
Content-Encoding: gzip
x-amzn-error: QUEUE_EXPIRED
x-amz-rid: M0610XT7HSX9CGTJNZNN
Vary: Accept-Encoding,X-Amzn-CDN-Cache,User-Agent
2019.02.18 14:50:52 4: [ECHO_Plus] [echodevice_Parse] [player]
2019.02.18 14:50:52 5: [ECHO_Plus] [echodevice_Parse] [player] DATA Dumper='{"message":null}'

2019.02.18 14:50:52 5: Starting notify loop for ECHO_Plus, 1 event(s), first is connected
2019.02.18 14:50:52 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: End notify loop for ECHO_Plus
2019.02.18 14:50:52 4: [ECHO_Plus] [echodevice_HandleCmdQueue] [media] send command=https://layla.amazon.de/api/media/state?deviceSerialNumber=SERIAL&deviceType=A18O6U1UQFJ0XK&screenWidth=1392&_=1550497845 Data=
2019.02.18 14:50:52 5: HttpUtils url=https://layla.amazon.de/api/media/state?deviceSerialNumber=G2A0WK048514020D&deviceType=A18O6U1UQFJ0XK&screenWidth=1392&_=1550497845
2019.02.18 14:50:52 4: IP: layla.amazon.de -> 52.94.220.236
2019.02.18 14:50:52 4: https://layla.amazon.de/api/notifications: HTTP response code 200
2019.02.18 14:50:52 5: HttpUtils https://layla.amazon.de/api/notifications: Got data, length: 20
2019.02.18 14:50:52 5: HttpUtils response header:
HTTP/1.1 200 OK
Server: Server
Date: Mon, 18 Feb 2019 13:50:51 GMT
Content-Type: application/json
Content-Length: 40
Connection: keep-alive
x-amzn-RequestId: 33e66f15-3384-11e9-951a-cbb2706af75c
Content-Encoding: gzip
x-amz-rid: 6YFPK39YW7N376AM9H5Q
Vary: Accept-Encoding,X-Amzn-CDN-Cache,User-Agent
2019.02.18 14:50:52 4: [echodevice] [echodevice_Parse] [getnotifications]
2019.02.18 14:50:52 5: [echodevice] [echodevice_Parse] [getnotifications] DATA Dumper='{"notifications":[]}'

2019.02.18 14:50:52 5: Starting notify loop for echodevice, 1 event(s), first is connected
2019.02.18 14:50:52 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: End notify loop for echodevice
2019.02.18 14:50:52 5: Starting notify loop for ECHO_G070L81490270307, 6 event(s), first is timer_count: 0
2019.02.18 14:50:52 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: End notify loop for ECHO_G070L81490270307
2019.02.18 14:50:52 5: Starting notify loop for ECHO_DOT, 6 event(s), first is timer_count: 0
2019.02.18 14:50:52 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: End notify loop for ECHO_DOT
2019.02.18 14:50:52 5: Starting notify loop for ECHO, 6 event(s), first is timer_count: 0
2019.02.18 14:50:52 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: End notify loop for ECHO
2019.02.18 14:50:52 5: Starting notify loop for ECHO_Plus, 6 event(s), first is timer_count: 0
2019.02.18 14:50:52 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: End notify loop for ECHO_Plus
2019.02.18 14:50:52 5: Starting notify loop for echodevice, 6 event(s), first is timer_count: 0
2019.02.18 14:50:52 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: End notify loop for echodevice
2019.02.18 14:50:52 4: [echodevice] [echodevice_HandleCmdQueue] [getsettingstraffic] send command=https://layla.amazon.de/api/traffic/settings Data=
2019.02.18 14:50:52 5: HttpUtils url=https://layla.amazon.de/api/traffic/settings
2019.02.18 14:50:52 4: IP: layla.amazon.de -> 52.94.220.236
2019.02.18 14:50:52 4: https://layla.amazon.de/api/bootstrap: HTTP response code 200
2019.02.18 14:50:52 5: HttpUtils https://layla.amazon.de/api/bootstrap: Got data, length: 175
2019.02.18 14:50:52 5: HttpUtils response header:
HTTP/1.1 200 OK
Server: Server
Date: Mon, 18 Feb 2019 13:50:51 GMT
Content-Type: application/json
Content-Length: 154
Connection: close
x-amzn-RequestId: 33e97bd4-3384-11e9-a8f5-83bcb7b62c99
Content-Encoding: gzip
x-amz-rid: K22GSMBX510J4XYS825S
Vary: Accept-Encoding,X-Amzn-CDN-Cache,User-Agent
2019.02.18 14:50:52 4: [echodevice] [echodevice_ParseAuth] [cookielogin6]
2019.02.18 14:50:52 5: [echodevice] [echodevice_ParseAuth] [cookielogin6] DATA Dumper='{"authentication":{"authenticated":true,"canAccessPrimeMusicContent":true,"customerEmail":"USER","customerId":"CUSTOMER","customerName":"Jeannine Butenschön"}}'

2019.02.18 14:50:52 5: Starting notify loop for ECHO_2ed1716e697b41cfa7306dd219ca0c4c, 1 event(s), first is connected
2019.02.18 14:50:52 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: End notify loop for ECHO_2ed1716e697b41cfa7306dd219ca0c4c
2019.02.18 14:50:52 5: Starting notify loop for ECHO_4301f1c987eb407d9456cbe1f3771d16, 1 event(s), first is connected
2019.02.18 14:50:52 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: End notify loop for ECHO_4301f1c987eb407d9456cbe1f3771d16
2019.02.18 14:50:52 5: Starting notify loop for ECHO_7abc5c8643454d06ab3b4229100b7a6a, 1 event(s), first is connected
2019.02.18 14:50:52 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: End notify loop for ECHO_7abc5c8643454d06ab3b4229100b7a6a
2019.02.18 14:50:52 5: Starting notify loop for ECHO_G070L81490270307, 1 event(s), first is connected
2019.02.18 14:50:52 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: End notify loop for ECHO_G070L81490270307
2019.02.18 14:50:52 5: Starting notify loop for ECHO_DOT, 1 event(s), first is connected
2019.02.18 14:50:52 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: End notify loop for ECHO_DOT
2019.02.18 14:50:52 5: Starting notify loop for ECHO, 1 event(s), first is connected
2019.02.18 14:50:52 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:52 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: End notify loop for ECHO
2019.02.18 14:50:53 5: Starting notify loop for ECHO_Plus, 1 event(s), first is connected
2019.02.18 14:50:53 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: End notify loop for ECHO_Plus
2019.02.18 14:50:53 5: Starting notify loop for echodevice, 1 event(s), first is connected
2019.02.18 14:50:53 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: End notify loop for echodevice
2019.02.18 14:50:53 5: Starting notify loop for ECHO_e590c09a476d41f1af022a93a8d67f40, 1 event(s), first is connected
2019.02.18 14:50:53 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: End notify loop for ECHO_e590c09a476d41f1af022a93a8d67f40
2019.02.18 14:50:53 5: Starting notify loop for echodevice, 1 event(s), first is connected
2019.02.18 14:50:53 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: End notify loop for echodevice
2019.02.18 14:50:53 5: Starting notify loop for echodevice, 2 event(s), first is connected
2019.02.18 14:50:53 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: End notify loop for echodevice
2019.02.18 14:50:53 4: [echodevice] [echodevice_ParseAuth] JSON OK = {authentication}{authenticated}
2019.02.18 14:50:53 4: ZWDongle_Read ZWDongle_1: rcvd 000400020e32022154000006a3000700000629ca00 (request APPLICATION_COMMAND_HANDLER), sending ACK
2019.02.18 14:50:53 5: SW: 06
2019.02.18 14:50:53 5: ZWDongle_1: dispatch 000400020e32022154000006a3000700000629ca00
2019.02.18 14:50:53 4: CMD:APPLICATION_COMMAND_HANDLER ID:02 ARG:0e32022154000006a3000700000629ca00 CB:00
2019.02.18 14:50:53 5: Starting notify loop for ZWave_SWITCH_1, 3 event(s), first is power:  16.99 W previous: 15.77 delta_time: 7 s
2019.02.18 14:50:53 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: End notify loop for ZWave_SWITCH_1
2019.02.18 14:50:53 4: ZWDongle_Read ZWDongle_1: rcvd 000400020e32022154000006a3000700000629ca00 (request APPLICATION_COMMAND_HANDLER), sending ACK
2019.02.18 14:50:53 5: SW: 06
2019.02.18 14:50:53 5: ZWDongle_1: dispatch 000400020e32022154000006a3000700000629ca00
2019.02.18 14:50:53 4: CMD:APPLICATION_COMMAND_HANDLER ID:02 ARG:0e32022154000006a3000700000629ca00 CB:00
2019.02.18 14:50:53 4: https://layla.amazon.de/api/np/player?deviceSerialNumber=2ed1716e697b41cfa7306dd219ca0c4c&deviceType=A15ERDAKK5HQQG&screenWidth=1392&_=1550497845: HTTP response code 200
2019.02.18 14:50:53 5: HttpUtils https://layla.amazon.de/api/np/player?deviceSerialNumber=2ed1716e697b41cfa7306dd219ca0c4c&deviceType=A15ERDAKK5HQQG&screenWidth=1392&_=1550497845: Got data, length: 339
2019.02.18 14:50:53 5: HttpUtils response header:
HTTP/1.1 200 OK
Server: Server
Date: Mon, 18 Feb 2019 13:50:52 GMT
Content-Type: application/json
Content-Length: 182
Connection: keep-alive
x-amzn-RequestId: 33f7ad56-3384-11e9-85f1-09943a98a34a
Content-Encoding: gzip
x-amz-rid: P3T6NCXKEN1RMNCDCMBC
Vary: Accept-Encoding,X-Amzn-CDN-Cache,User-Agent
2019.02.18 14:50:53 4: [ECHO_2ed1716e697b41cfa7306dd219ca0c4c] [echodevice_Parse] [player]
2019.02.18 14:50:53 5: [ECHO_2ed1716e697b41cfa7306dd219ca0c4c] [echodevice_Parse] [player] DATA Dumper='{"playerInfo":{"hint":null,"infoText":null,"isPlayingInLemur":false,"lemurVolume":null,"lyrics":null,"mainArt":null,"mediaId":null,"miniArt":null,"miniInfoText":null,"playbackSource":null,"playingInLemurId":null,"progress":null,"provider":null,"queueId":null,"state":null,"template":null,"transport":null,"upNextItems":null,"volume":null}}'

2019.02.18 14:50:53 5: Starting notify loop for ECHO_2ed1716e697b41cfa7306dd219ca0c4c, 1 event(s), first is connected
2019.02.18 14:50:53 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: End notify loop for ECHO_2ed1716e697b41cfa7306dd219ca0c4c
2019.02.18 14:50:53 5: Starting notify loop for ECHO_2ed1716e697b41cfa7306dd219ca0c4c, 9 event(s), first is playStatus: stopped
2019.02.18 14:50:53 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: End notify loop for ECHO_2ed1716e697b41cfa7306dd219ca0c4c
2019.02.18 14:50:53 4: [ECHO_2ed1716e697b41cfa7306dd219ca0c4c] [echodevice_HandleCmdQueue] [media] send command=https://layla.amazon.de/api/media/state?deviceSerialNumber=SERIAL&deviceType=A15ERDAKK5HQQG&screenWidth=1392&_=1550497845 Data=
2019.02.18 14:50:53 5: HttpUtils url=https://layla.amazon.de/api/media/state?deviceSerialNumber=2ed1716e697b41cfa7306dd219ca0c4c&deviceType=A15ERDAKK5HQQG&screenWidth=1392&_=1550497845
2019.02.18 14:50:53 4: IP: layla.amazon.de -> 52.94.220.236
2019.02.18 14:50:53 4: https://layla.amazon.de/api/np/player?deviceSerialNumber=G070L81490270307&deviceType=A2LWARUGJLBYEW&screenWidth=1392&_=1550497845: HTTP response code 200
2019.02.18 14:50:53 5: HttpUtils https://layla.amazon.de/api/np/player?deviceSerialNumber=G070L81490270307&deviceType=A2LWARUGJLBYEW&screenWidth=1392&_=1550497845: Got data, length: 339
2019.02.18 14:50:53 5: HttpUtils response header:
HTTP/1.1 200 OK
Server: Server
Date: Mon, 18 Feb 2019 13:50:51 GMT
Content-Type: application/json
Content-Length: 182
Connection: keep-alive
x-amzn-RequestId: 33f89724-3384-11e9-9b2c-3324557af298
Content-Encoding: gzip
x-amz-rid: XFYVS8PCATSS9M01TQ81
Vary: Accept-Encoding,X-Amzn-CDN-Cache,User-Agent
2019.02.18 14:50:53 4: [ECHO_G070L81490270307] [echodevice_Parse] [player]
2019.02.18 14:50:53 5: [ECHO_G070L81490270307] [echodevice_Parse] [player] DATA Dumper='{"playerInfo":{"hint":null,"infoText":null,"isPlayingInLemur":false,"lemurVolume":null,"lyrics":null,"mainArt":null,"mediaId":null,"miniArt":null,"miniInfoText":null,"playbackSource":null,"playingInLemurId":null,"progress":null,"provider":null,"queueId":null,"state":null,"template":null,"transport":null,"upNextItems":null,"volume":null}}'

2019.02.18 14:50:53 5: Starting notify loop for ECHO_G070L81490270307, 1 event(s), first is connected
2019.02.18 14:50:53 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: End notify loop for ECHO_G070L81490270307
2019.02.18 14:50:53 5: Starting notify loop for ECHO_G070L81490270307, 9 event(s), first is playStatus: stopped
2019.02.18 14:50:53 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: End notify loop for ECHO_G070L81490270307
2019.02.18 14:50:53 4: [ECHO_G070L81490270307] [echodevice_HandleCmdQueue] [media] send command=https://layla.amazon.de/api/media/state?deviceSerialNumber=SERIAL&deviceType=A2LWARUGJLBYEW&screenWidth=1392&_=1550497845 Data=
2019.02.18 14:50:53 5: HttpUtils url=https://layla.amazon.de/api/media/state?deviceSerialNumber=G070L81490270307&deviceType=A2LWARUGJLBYEW&screenWidth=1392&_=1550497845
2019.02.18 14:50:53 4: IP: layla.amazon.de -> 52.94.220.236
2019.02.18 14:50:53 4: https://layla.amazon.de/api/np/player?deviceSerialNumber=G090L90971460TUX&deviceType=A3S5BH2HU6VAYF&screenWidth=1392&_=1550497845: HTTP response code 200
2019.02.18 14:50:53 5: HttpUtils https://layla.amazon.de/api/np/player?deviceSerialNumber=G090L90971460TUX&deviceType=A3S5BH2HU6VAYF&screenWidth=1392&_=1550497845: Got data, length: 339
2019.02.18 14:50:53 5: HttpUtils response header:
HTTP/1.1 200 OK
Server: Server
Date: Mon, 18 Feb 2019 13:50:51 GMT
Content-Type: application/json
Content-Length: 182
Connection: keep-alive
x-amzn-RequestId: 33fa4493-3384-11e9-ac70-856117b76cbc
Content-Encoding: gzip
x-amz-rid: NQ7QHPVC4KS57G00W5SF
Vary: Accept-Encoding,X-Amzn-CDN-Cache,User-Agent
2019.02.18 14:50:53 4: [ECHO_DOT] [echodevice_Parse] [player]
2019.02.18 14:50:53 5: [ECHO_DOT] [echodevice_Parse] [player] DATA Dumper='{"playerInfo":{"hint":null,"infoText":null,"isPlayingInLemur":false,"lemurVolume":null,"lyrics":null,"mainArt":null,"mediaId":null,"miniArt":null,"miniInfoText":null,"playbackSource":null,"playingInLemurId":null,"progress":null,"provider":null,"queueId":null,"state":null,"template":null,"transport":null,"upNextItems":null,"volume":null}}'

2019.02.18 14:50:53 5: Starting notify loop for ECHO_DOT, 1 event(s), first is connected
2019.02.18 14:50:53 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: End notify loop for ECHO_DOT
2019.02.18 14:50:53 5: Starting notify loop for ECHO_DOT, 9 event(s), first is playStatus: stopped
2019.02.18 14:50:53 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: End notify loop for ECHO_DOT
2019.02.18 14:50:53 4: [ECHO_DOT] [echodevice_HandleCmdQueue] [media] send command=https://layla.amazon.de/api/media/state?deviceSerialNumber=SERIAL&deviceType=A3S5BH2HU6VAYF&screenWidth=1392&_=1550497845 Data=
2019.02.18 14:50:53 5: HttpUtils url=https://layla.amazon.de/api/media/state?deviceSerialNumber=G090L90971460TUX&deviceType=A3S5BH2HU6VAYF&screenWidth=1392&_=1550497845
2019.02.18 14:50:53 4: IP: layla.amazon.de -> 52.94.220.236
2019.02.18 14:50:53 5: Cmd: >{BlockingRegisterTelnet($cl,1070)}<
2019.02.18 14:50:53 4: https://layla.amazon.de/api/np/player?deviceSerialNumber=G090RF04836703VP&deviceType=A7WXQPH584YP&screenWidth=1392&_=1550497845: HTTP response code 400
2019.02.18 14:50:53 5: HttpUtils https://layla.amazon.de/api/np/player?deviceSerialNumber=G090RF04836703VP&deviceType=A7WXQPH584YP&screenWidth=1392&_=1550497845: Got data, length: 16
2019.02.18 14:50:53 5: HttpUtils response header:
HTTP/1.1 400 Bad Request
Server: Server
Date: Mon, 18 Feb 2019 13:50:51 GMT
Content-Type: application/json
Content-Length: 36
Connection: keep-alive
x-amzn-RequestId: 33df4305-3384-11e9-b28f-07fbf6831e94
Content-Encoding: gzip
x-amzn-error: QUEUE_EXPIRED
x-amz-rid: ZJMET5KGF7846BBWSVR6
Vary: Accept-Encoding,X-Amzn-CDN-Cache,User-Agent
2019.02.18 14:50:53 4: [ECHO] [echodevice_Parse] [player]
2019.02.18 14:50:53 5: [ECHO] [echodevice_Parse] [player] DATA Dumper='{"message":null}'

2019.02.18 14:50:53 5: Starting notify loop for ECHO, 1 event(s), first is connected
2019.02.18 14:50:53 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: End notify loop for ECHO
2019.02.18 14:50:53 4: [ECHO] [echodevice_HandleCmdQueue] [media] send command=https://layla.amazon.de/api/media/state?deviceSerialNumber=SERIAL&deviceType=A7WXQPH584YP&screenWidth=1392&_=1550497845 Data=
2019.02.18 14:50:53 5: HttpUtils url=https://layla.amazon.de/api/media/state?deviceSerialNumber=G090RF04836703VP&deviceType=A7WXQPH584YP&screenWidth=1392&_=1550497845
2019.02.18 14:50:53 4: IP: layla.amazon.de -> 52.94.220.236
2019.02.18 14:50:53 5: BOSEST: run mojo loop
2019.02.18 14:50:53 5: BOSEST: finished mojo loop
2019.02.18 14:50:53 5: ENIGMA2 Sat: called function ENIGMA2_ReceiveCommand()
2019.02.18 14:50:53 4: ENIGMA2 Sat: RCV TIMEOUT powerstate
2019.02.18 14:50:53 5: HttpUtils request header:
GET /api/media/state?deviceSerialNumber=G090L90971460TUX&deviceType=A3S5BH2HU6VAYF&screenWidth=1392&_=1550497845 HTTP/1.1
Host: layla.amazon.de
Accept-Encoding: gzip,deflate
Connection: Close
User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:62.0) Gecko/20100101 Firefox/62.0
Accept-Language: de,en-US;q=0.7,en;q=0.3
DNT: 1
Connection: keep-alive
Upgrade-Insecure-Requests: 1
Cookie:session-id=259-9760591-9793803; session-id-time=2181214687l; ubid-acbde=257-9736164-2027209; x-acbde=H9l5jnoOF3ViR?IeZ2pQvsR@68DoL676; at-acbde=Atza|IwEBINvuHdBLcoLMteuTrN0MLzSxg8mgYW7ihkuvW_Y6Ig-i4WTml5ex5NBRWJ9jAlFQdP8MV-aVFmxf3mLxcvg-TRkPp-jHMhMLCmfQy-FypGPl447V34gGsxV4_kCr5QFlAL-rJq0JwIolg04lxqOpSMFBOEQ0X7bb3J2SaGtkI7nKV-qd9KWu2loRKcmqGk9HA-p4dj4Ojkjcc7GbmavfISj6_goAqvwL0QRmjLI7mcwz7cT-Mvybtchc1gbvANHylCfqcUhdSr1rxtBsxuzJApzCqUbrdgExgrd-I7fZiiDHirG1sz7sFE4iiVPazwhJsYsItWatOlNvZ9czlchNI1agNZ1Ik0k_CNxAroXPSx_JkYTZSY2W3s7m5lp449oToCVIwyVGsqlHCKw8b6Ma52LEjaKyu6TnhPDqepDCSdGPerBjvXq8ARgRATSpC4PqS07bIGqMIMSErp6TkOodrCEF; sess-at-acbde=STXNTT7EZTaazfCaZ0naHh97k853WCraDkm5h3mBOpA=; csrf=1826648016
csrf: 1826648016
Content-Type: application/json; charset=UTF-8
Content-Length: 0

2019.02.18 14:50:53 5: HttpUtils request header:
GET /api/media/state?deviceSerialNumber=G070L81490270307&deviceType=A2LWARUGJLBYEW&screenWidth=1392&_=1550497845 HTTP/1.1
Host: layla.amazon.de
Accept-Encoding: gzip,deflate
Connection: Close
User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:62.0) Gecko/20100101 Firefox/62.0
Accept-Language: de,en-US;q=0.7,en;q=0.3
DNT: 1
Connection: keep-alive
Upgrade-Insecure-Requests: 1
Cookie:session-id=259-9760591-9793803; session-id-time=2181214687l; ubid-acbde=257-9736164-2027209; x-acbde=H9l5jnoOF3ViR?IeZ2pQvsR@68DoL676; at-acbde=Atza|IwEBINvuHdBLcoLMteuTrN0MLzSxg8mgYW7ihkuvW_Y6Ig-i4WTml5ex5NBRWJ9jAlFQdP8MV-aVFmxf3mLxcvg-TRkPp-jHMhMLCmfQy-FypGPl447V34gGsxV4_kCr5QFlAL-rJq0JwIolg04lxqOpSMFBOEQ0X7bb3J2SaGtkI7nKV-qd9KWu2loRKcmqGk9HA-p4dj4Ojkjcc7GbmavfISj6_goAqvwL0QRmjLI7mcwz7cT-Mvybtchc1gbvANHylCfqcUhdSr1rxtBsxuzJApzCqUbrdgExgrd-I7fZiiDHirG1sz7sFE4iiVPazwhJsYsItWatOlNvZ9czlchNI1agNZ1Ik0k_CNxAroXPSx_JkYTZSY2W3s7m5lp449oToCVIwyVGsqlHCKw8b6Ma52LEjaKyu6TnhPDqepDCSdGPerBjvXq8ARgRATSpC4PqS07bIGqMIMSErp6TkOodrCEF; sess-at-acbde=STXNTT7EZTaazfCaZ0naHh97k853WCraDkm5h3mBOpA=; csrf=1826648016
csrf: 1826648016
Content-Type: application/json; charset=UTF-8
Content-Length: 0

2019.02.18 14:50:53 5: HttpUtils request header:
GET /api/media/state?deviceSerialNumber=2ed1716e697b41cfa7306dd219ca0c4c&deviceType=A15ERDAKK5HQQG&screenWidth=1392&_=1550497845 HTTP/1.1
Host: layla.amazon.de
Accept-Encoding: gzip,deflate
Connection: Close
User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:62.0) Gecko/20100101 Firefox/62.0
Accept-Language: de,en-US;q=0.7,en;q=0.3
DNT: 1
Connection: keep-alive
Upgrade-Insecure-Requests: 1
Cookie:session-id=259-9760591-9793803; session-id-time=2181214687l; ubid-acbde=257-9736164-2027209; x-acbde=H9l5jnoOF3ViR?IeZ2pQvsR@68DoL676; at-acbde=Atza|IwEBINvuHdBLcoLMteuTrN0MLzSxg8mgYW7ihkuvW_Y6Ig-i4WTml5ex5NBRWJ9jAlFQdP8MV-aVFmxf3mLxcvg-TRkPp-jHMhMLCmfQy-FypGPl447V34gGsxV4_kCr5QFlAL-rJq0JwIolg04lxqOpSMFBOEQ0X7bb3J2SaGtkI7nKV-qd9KWu2loRKcmqGk9HA-p4dj4Ojkjcc7GbmavfISj6_goAqvwL0QRmjLI7mcwz7cT-Mvybtchc1gbvANHylCfqcUhdSr1rxtBsxuzJApzCqUbrdgExgrd-I7fZiiDHirG1sz7sFE4iiVPazwhJsYsItWatOlNvZ9czlchNI1agNZ1Ik0k_CNxAroXPSx_JkYTZSY2W3s7m5lp449oToCVIwyVGsqlHCKw8b6Ma52LEjaKyu6TnhPDqepDCSdGPerBjvXq8ARgRATSpC4PqS07bIGqMIMSErp6TkOodrCEF; sess-at-acbde=STXNTT7EZTaazfCaZ0naHh97k853WCraDkm5h3mBOpA=; csrf=1826648016
csrf: 1826648016
Content-Type: application/json; charset=UTF-8
Content-Length: 0

2019.02.18 14:50:53 4: https://layla.amazon.de/api/np/player?deviceSerialNumber=7abc5c8643454d06ab3b4229100b7a6a&deviceType=A3C9PE6TNYLTCH&screenWidth=1392&_=1550497845: HTTP response code 400
2019.02.18 14:50:53 5: HttpUtils https://layla.amazon.de/api/np/player?deviceSerialNumber=7abc5c8643454d06ab3b4229100b7a6a&deviceType=A3C9PE6TNYLTCH&screenWidth=1392&_=1550497845: Got data, length: 16
2019.02.18 14:50:53 5: HttpUtils response header:
HTTP/1.1 400 Bad Request
Server: Server
Date: Mon, 18 Feb 2019 13:50:52 GMT
Content-Type: application/json
Content-Length: 36
Connection: keep-alive
x-amzn-RequestId: 33eb0315-3384-11e9-911b-8df43d4023d3
Content-Encoding: gzip
x-amzn-error: QUEUE_EXPIRED
x-amz-rid: F7C499209WDNMEXK4E37
Vary: Accept-Encoding,X-Amzn-CDN-Cache,User-Agent
2019.02.18 14:50:53 4: [ECHO_7abc5c8643454d06ab3b4229100b7a6a] [echodevice_Parse] [player]
2019.02.18 14:50:53 5: [ECHO_7abc5c8643454d06ab3b4229100b7a6a] [echodevice_Parse] [player] DATA Dumper='{"message":null}'

2019.02.18 14:50:53 5: Starting notify loop for ECHO_7abc5c8643454d06ab3b4229100b7a6a, 1 event(s), first is connected
2019.02.18 14:50:53 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: End notify loop for ECHO_7abc5c8643454d06ab3b4229100b7a6a
2019.02.18 14:50:53 4: [ECHO_7abc5c8643454d06ab3b4229100b7a6a] [echodevice_HandleCmdQueue] [media] send command=https://layla.amazon.de/api/media/state?deviceSerialNumber=SERIAL&deviceType=A3C9PE6TNYLTCH&screenWidth=1392&_=1550497845 Data=
2019.02.18 14:50:53 5: HttpUtils url=https://layla.amazon.de/api/media/state?deviceSerialNumber=7abc5c8643454d06ab3b4229100b7a6a&deviceType=A3C9PE6TNYLTCH&screenWidth=1392&_=1550497845
2019.02.18 14:50:53 4: IP: layla.amazon.de -> 52.94.220.236
2019.02.18 14:50:53 4: ZWDongle_Read ZWDongle_1: rcvd 000400020a3202a1425af100075ae1ca00 (request APPLICATION_COMMAND_HANDLER), sending ACK
2019.02.18 14:50:53 5: SW: 06
2019.02.18 14:50:53 5: ZWDongle_1: dispatch 000400020a3202a1425af100075ae1ca00
2019.02.18 14:50:53 4: CMD:APPLICATION_COMMAND_HANDLER ID:02 ARG:0a3202a1425af100075ae1ca00 CB:00
2019.02.18 14:50:53 5: Starting notify loop for ZWave_SWITCH_1, 1 event(s), first is voltage:  232.81 V previous: 232.65 delta_time: 7 s
2019.02.18 14:50:53 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:53 5: End notify loop for ZWave_SWITCH_1
2019.02.18 14:50:54 5: HttpUtils request header:
GET /api/traffic/settings HTTP/1.1
Host: layla.amazon.de
Accept-Encoding: gzip,deflate
Connection: Close
User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:62.0) Gecko/20100101 Firefox/62.0
Accept-Language: de,en-US;q=0.7,en;q=0.3
DNT: 1
Connection: keep-alive
Upgrade-Insecure-Requests: 1
Cookie:session-id=259-9760591-9793803; session-id-time=2181214687l; ubid-acbde=257-9736164-2027209; x-acbde=H9l5jnoOF3ViR?IeZ2pQvsR@68DoL676; at-acbde=Atza|IwEBINvuHdBLcoLMteuTrN0MLzSxg8mgYW7ihkuvW_Y6Ig-i4WTml5ex5NBRWJ9jAlFQdP8MV-aVFmxf3mLxcvg-TRkPp-jHMhMLCmfQy-FypGPl447V34gGsxV4_kCr5QFlAL-rJq0JwIolg04lxqOpSMFBOEQ0X7bb3J2SaGtkI7nKV-qd9KWu2loRKcmqGk9HA-p4dj4Ojkjcc7GbmavfISj6_goAqvwL0QRmjLI7mcwz7cT-Mvybtchc1gbvANHylCfqcUhdSr1rxtBsxuzJApzCqUbrdgExgrd-I7fZiiDHirG1sz7sFE4iiVPazwhJsYsItWatOlNvZ9czlchNI1agNZ1Ik0k_CNxAroXPSx_JkYTZSY2W3s7m5lp449oToCVIwyVGsqlHCKw8b6Ma52LEjaKyu6TnhPDqepDCSdGPerBjvXq8ARgRATSpC4PqS07bIGqMIMSErp6TkOodrCEF; sess-at-acbde=STXNTT7EZTaazfCaZ0naHh97k853WCraDkm5h3mBOpA=; csrf=1826648016
csrf: 1826648016
Content-Type: application/json; charset=UTF-8
Content-Length: 0

2019.02.18 14:50:54 5: HttpUtils request header:
GET /api/media/state?deviceSerialNumber=G2A0WK048514020D&deviceType=A18O6U1UQFJ0XK&screenWidth=1392&_=1550497845 HTTP/1.1
Host: layla.amazon.de
Accept-Encoding: gzip,deflate
Connection: Close
User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:62.0) Gecko/20100101 Firefox/62.0
Accept-Language: de,en-US;q=0.7,en;q=0.3
DNT: 1
Connection: keep-alive
Upgrade-Insecure-Requests: 1
Cookie:session-id=259-9760591-9793803; session-id-time=2181214687l; ubid-acbde=257-9736164-2027209; x-acbde=H9l5jnoOF3ViR?IeZ2pQvsR@68DoL676; at-acbde=Atza|IwEBINvuHdBLcoLMteuTrN0MLzSxg8mgYW7ihkuvW_Y6Ig-i4WTml5ex5NBRWJ9jAlFQdP8MV-aVFmxf3mLxcvg-TRkPp-jHMhMLCmfQy-FypGPl447V34gGsxV4_kCr5QFlAL-rJq0JwIolg04lxqOpSMFBOEQ0X7bb3J2SaGtkI7nKV-qd9KWu2loRKcmqGk9HA-p4dj4Ojkjcc7GbmavfISj6_goAqvwL0QRmjLI7mcwz7cT-Mvybtchc1gbvANHylCfqcUhdSr1rxtBsxuzJApzCqUbrdgExgrd-I7fZiiDHirG1sz7sFE4iiVPazwhJsYsItWatOlNvZ9czlchNI1agNZ1Ik0k_CNxAroXPSx_JkYTZSY2W3s7m5lp449oToCVIwyVGsqlHCKw8b6Ma52LEjaKyu6TnhPDqepDCSdGPerBjvXq8ARgRATSpC4PqS07bIGqMIMSErp6TkOodrCEF; sess-at-acbde=STXNTT7EZTaazfCaZ0naHh97k853WCraDkm5h3mBOpA=; csrf=1826648016
csrf: 1826648016
Content-Type: application/json; charset=UTF-8
Content-Length: 0

2019.02.18 14:50:54 5: HttpUtils request header:
GET /api/media/state?deviceSerialNumber=G090RF04836703VP&deviceType=A7WXQPH584YP&screenWidth=1392&_=1550497845 HTTP/1.1
Host: layla.amazon.de
Accept-Encoding: gzip,deflate
Connection: Close
User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:62.0) Gecko/20100101 Firefox/62.0
Accept-Language: de,en-US;q=0.7,en;q=0.3
DNT: 1
Connection: keep-alive
Upgrade-Insecure-Requests: 1
Cookie:session-id=259-9760591-9793803; session-id-time=2181214687l; ubid-acbde=257-9736164-2027209; x-acbde=H9l5jnoOF3ViR?IeZ2pQvsR@68DoL676; at-acbde=Atza|IwEBINvuHdBLcoLMteuTrN0MLzSxg8mgYW7ihkuvW_Y6Ig-i4WTml5ex5NBRWJ9jAlFQdP8MV-aVFmxf3mLxcvg-TRkPp-jHMhMLCmfQy-FypGPl447V34gGsxV4_kCr5QFlAL-rJq0JwIolg04lxqOpSMFBOEQ0X7bb3J2SaGtkI7nKV-qd9KWu2loRKcmqGk9HA-p4dj4Ojkjcc7GbmavfISj6_goAqvwL0QRmjLI7mcwz7cT-Mvybtchc1gbvANHylCfqcUhdSr1rxtBsxuzJApzCqUbrdgExgrd-I7fZiiDHirG1sz7sFE4iiVPazwhJsYsItWatOlNvZ9czlchNI1agNZ1Ik0k_CNxAroXPSx_JkYTZSY2W3s7m5lp449oToCVIwyVGsqlHCKw8b6Ma52LEjaKyu6TnhPDqepDCSdGPerBjvXq8ARgRATSpC4PqS07bIGqMIMSErp6TkOodrCEF; sess-at-acbde=STXNTT7EZTaazfCaZ0naHh97k853WCraDkm5h3mBOpA=; csrf=1826648016
csrf: 1826648016
Content-Type: application/json; charset=UTF-8
Content-Length: 0

2019.02.18 14:50:54 5: HttpUtils request header:
GET /api/media/state?deviceSerialNumber=7abc5c8643454d06ab3b4229100b7a6a&deviceType=A3C9PE6TNYLTCH&screenWidth=1392&_=1550497845 HTTP/1.1
Host: layla.amazon.de
Accept-Encoding: gzip,deflate
Connection: Close
User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:62.0) Gecko/20100101 Firefox/62.0
Accept-Language: de,en-US;q=0.7,en;q=0.3
DNT: 1
Connection: keep-alive
Upgrade-Insecure-Requests: 1
Cookie:session-id=259-9760591-9793803; session-id-time=2181214687l; ubid-acbde=257-9736164-2027209; x-acbde=H9l5jnoOF3ViR?IeZ2pQvsR@68DoL676; at-acbde=Atza|IwEBINvuHdBLcoLMteuTrN0MLzSxg8mgYW7ihkuvW_Y6Ig-i4WTml5ex5NBRWJ9jAlFQdP8MV-aVFmxf3mLxcvg-TRkPp-jHMhMLCmfQy-FypGPl447V34gGsxV4_kCr5QFlAL-rJq0JwIolg04lxqOpSMFBOEQ0X7bb3J2SaGtkI7nKV-qd9KWu2loRKcmqGk9HA-p4dj4Ojkjcc7GbmavfISj6_goAqvwL0QRmjLI7mcwz7cT-Mvybtchc1gbvANHylCfqcUhdSr1rxtBsxuzJApzCqUbrdgExgrd-I7fZiiDHirG1sz7sFE4iiVPazwhJsYsItWatOlNvZ9czlchNI1agNZ1Ik0k_CNxAroXPSx_JkYTZSY2W3s7m5lp449oToCVIwyVGsqlHCKw8b6Ma52LEjaKyu6TnhPDqepDCSdGPerBjvXq8ARgRATSpC4PqS07bIGqMIMSErp6TkOodrCEF; sess-at-acbde=STXNTT7EZTaazfCaZ0naHh97k853WCraDkm5h3mBOpA=; csrf=1826648016
csrf: 1826648016
Content-Type: application/json; charset=UTF-8
Content-Length: 0

2019.02.18 14:50:54 4: ZWDongle_Read ZWDongle_1: rcvd 000400020a3202a14a000c0007000bcd00 (request APPLICATION_COMMAND_HANDLER), sending ACK
2019.02.18 14:50:54 5: SW: 06
2019.02.18 14:50:54 5: ZWDongle_1: dispatch 000400020a3202a14a000c0007000bcd00
2019.02.18 14:50:54 4: CMD:APPLICATION_COMMAND_HANDLER ID:02 ARG:0a3202a14a000c0007000bcd00 CB:00
2019.02.18 14:50:54 5: Starting notify loop for ZWave_SWITCH_1, 1 event(s), first is current:  0.12 A previous: 0.11 delta_time: 7 s
2019.02.18 14:50:54 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:54 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:54 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:54 5: End notify loop for ZWave_SWITCH_1
2019.02.18 14:50:54 5: BOSEST: run mojo loop
2019.02.18 14:50:54 5: BOSEST: finished mojo loop
2019.02.18 14:50:54 4: WEB_192.168.110.32_63494 GET /fhem/pgm2/jquery.min.js; BUFLEN:0
2019.02.18 14:50:54 4: WEB_192.168.110.32_63494 => 304 Not Modified
2019.02.18 14:50:54 4: WEB_192.168.110.32_64111 GET /fhem/codemirror/fhem_codemirror.js; BUFLEN:0
2019.02.18 14:50:54 4: WEB_192.168.110.32_64111 => 304 Not Modified
2019.02.18 14:50:54 5: Cmd: >{BlockingStart('1070')}<
2019.02.18 14:50:54 5: Cmd: >{BlockingStart('1069')}<
2019.02.18 14:50:54 5: Cmd: >{PRESENCE_ProcessLocalScan('P_FritzBox|0|present')}<
2019.02.18 14:50:54 5: PRESENCE (P_FritzBox) - blocking scan result: P_FritzBox|0|present
2019.02.18 14:50:54 4: PRESENCE (P_FritzBox) - rescheduling next check in 100 seconds
2019.02.18 14:50:54 4: WEB_192.168.110.32_63495 GET /fhem/pgm2/jquery-ui.min.js; BUFLEN:0
2019.02.18 14:50:54 4: WEB_192.168.110.32_63495 => 304 Not Modified
2019.02.18 14:50:54 4: WEB_192.168.110.32_63493 GET /fhem/pgm2/jquery-ui.min.css; BUFLEN:0
2019.02.18 14:50:54 4: WEB_192.168.110.32_63493 => 304 Not Modified
2019.02.18 14:50:54 4: WEB_192.168.110.32_63496 GET /fhem/pgm2/darkCommon.css; BUFLEN:0
2019.02.18 14:50:54 4: WEB_192.168.110.32_63496 => 304 Not Modified
2019.02.18 14:50:54 4: WEB_192.168.110.32_64058 GET /fhem/pgm2/fhemweb.js; BUFLEN:0
2019.02.18 14:50:54 4: WEB_192.168.110.32_64058 => 304 Not Modified
2019.02.18 14:50:54 4: https://layla.amazon.de/api/media/state?deviceSerialNumber=G090L90971460TUX&deviceType=A3S5BH2HU6VAYF&screenWidth=1392&_=1550497845: HTTP response code 400
2019.02.18 14:50:54 5: HttpUtils https://layla.amazon.de/api/media/state?deviceSerialNumber=G090L90971460TUX&deviceType=A3S5BH2HU6VAYF&screenWidth=1392&_=1550497845: Got data, length: 99
2019.02.18 14:50:54 5: HttpUtils response header:
HTTP/1.1 400 Bad Request
Server: Server
Date: Mon, 18 Feb 2019 13:50:54 GMT
Content-Type: application/json
Content-Length: 108
Connection: keep-alive
x-amzn-RequestId: 35d39886-3384-11e9-ba45-29fcaa2b67a2
Content-Encoding: gzip
x-amzn-error: QUEUE_DOES_NOT_EXIST
x-amz-rid: AGMR5BVS2AGBGEYYJ6F9
Vary: Accept-Encoding,X-Amzn-CDN-Cache,User-Agent
2019.02.18 14:50:54 4: [ECHO_DOT] [echodevice_Parse] [media]
2019.02.18 14:50:54 5: [ECHO_DOT] [echodevice_Parse] [media] DATA Dumper='{"message":"Music metadata was not found for reference id: 379d8be1-4001-494c-afb9-101d504d1d0a:1"}'

2019.02.18 14:50:54 5: Starting notify loop for ECHO_DOT, 1 event(s), first is connected
2019.02.18 14:50:54 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:54 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:54 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:54 5: End notify loop for ECHO_DOT
2019.02.18 14:50:54 4: https://layla.amazon.de/api/traffic/settings: HTTP response code 200
2019.02.18 14:50:54 5: HttpUtils https://layla.amazon.de/api/traffic/settings: Got data, length: 859
2019.02.18 14:50:54 5: HttpUtils response header:
HTTP/1.1 200 OK
Server: Server
Date: Mon, 18 Feb 2019 13:50:54 GMT
Content-Type: application/json
Content-Length: 397
Connection: keep-alive
x-amzn-RequestId: 35d5469b-3384-11e9-8a6f-651277cc74ff
Content-Encoding: gzip
x-amz-rid: EKW5Q19MA52QJCXN84F4
Vary: Accept-Encoding,X-Amzn-CDN-Cache,User-Agent
2019.02.18 14:50:54 4: [echodevice] [echodevice_Parse] [getsettingstraffic]
2019.02.18 14:50:54 5: [echodevice] [echodevice_Parse] [getsettingstraffic] DATA Dumper='{"destination":{"addressId":"N7SK2EU3QEY3BRMQNUIIG13R184OX80B7QCUSTOMERPXTQ2EIA2OXUK2LJJ","addressLine1":"64 Westmarkstraße","addressLine2":"","addressLine3":"","city":"Oberhausen","countryCode":"DE","county":"Buschhausen","label":"64 Westmarkstraße, 46149 Oberhausen","placeId":null,"settingsAddressType":null,"state":"Nordrhein-Westfalen","stationName":null,"street":"64 Westmarkstraße","zipcode":"46149"},"origin":{"addressId":"UYF26PAFWVJRI7UPDYJUG13R184OX80B7QCUSTOMERPXTQ2EYA2OXWEBTDQ","addressLine1":null,"addressLine2":"Bismarckstr. 60","addressLine3":"","city":"Ratingen","countryCode":"DE","county":"","label":"Bismarckstr. 60, 40883 Ratingen","placeId":null,"settingsAddressType":null,"state":"Nordrhein-Westfalen","stationName":null,"street":null,"zipcode":"40883"},"preferredTransportMode":"CAR","transportNames":null,"waypoints":[]}'

2019.02.18 14:50:54 5: Starting notify loop for echodevice, 1 event(s), first is connected
2019.02.18 14:50:54 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:54 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:54 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:54 5: End notify loop for echodevice
2019.02.18 14:50:54 5: Starting notify loop for echodevice, 3 event(s), first is config_address_from: Bismarckstr. 60, 40883 Ratingen
2019.02.18 14:50:54 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:54 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:54 5: battStatus: not on any display, ignoring notify
2019.02.18 14:50:54 5: End notify loop for echodevice
2019.02.18 14:50:54 4: [echodevice] [echodevice_HandleCmdQueue] [getbehavior] send command=https://layla.amazon.de/api/behaviors/automations?limit=100 Data=
2019.02.18 14:50:54 5: HttpUtils url=https://layla.amazon.de/api/behaviors/automations?limit=100
2019.02.18 14:50:54 4: IP: layla.amazon.de -> 52.94.220.236
2019.02.18 14:50:54 4: WEB_192.168.110.32_64111 GET /fhem/pgm2/fhemweb_readingsGroup.js; BUFLEN:0
2019.02.18 14:50:54 4: WEB_192.168.110.32_64111 => 304 Not Modified
2019.02.18 14:50:54 4: WEB_192.168.110.32_63494 GET /fhem/pgm2/doif.js; BUFLEN:0
2019.02.18 14:50:54 4: WEB_192.168.110.32_63494 => 304 Not Modified
2019.02.18 14:50:54 4: https://layla.amazon.de/api/media/state?deviceSerialNumber=G070L81490270307&deviceType=A2LWARUGJLBYEW&screenWidth=1392&_=1550497845: HTTP response code 200
2019.02.18 14:50:54 5: HttpUtils https://layla.amazon.de/api/media/state?deviceSerialNumber=G070L81490270307&deviceType=A2LWARUGJLBYEW&screenWidth=1392&_=1550497845: Got data, length: 405
2019.02.18 14:50:54 5: HttpUtils response header:
HTTP/1.1 200 OK
Server: Server
Date: Mon, 18 Feb 2019 13:50:54 GMT
Content-Type: application/json
Content-Length: 225
Connection: keep-alive
x-amzn-RequestId: 35d1eb42-3384-11e9-8de0-15e5904a36ab
Content-Encoding: gzip
x-amz-rid: P5XGQQS5GK0KHY0ART89
Vary: Accept-Encoding,X-Amzn-CDN-Cache,User-Agent
2019.02.18 14:50:54 4: [ECHO_G070L81490270307] [echodevice_Parse] [media]
2019.02.18 14:50:54 5: [ECHO_G070L81490270307] [echodevice_Parse] [media] DATA Dumper='{"clientId":null,"contentId":null,"contentType":null,"currentState":"IDLE","imageURL":null,"isDisliked":false,"isLiked":false,"looping":false,"mediaOwnerCustomerId":null,"muted":false,"programId":null,"progressSeconds":0,"providerId":null,"queue":null,"queueId":null,"queueSize":0,"radioStationId":null,"radioVariety":0,"referenceId":null,"service":null,"shuffling":false,"timeLastShuffled":0,"volume":15}'

2019.02.18 14:50:54 5: Starting notify loop for ECHO_G070L81490270307, 1 event(s), first is connected
2019.02.18 14:50:54 5: BurstStatus: not on any display, ignoring notify
2019.02.18 14:50:54 5: VentilMotorStatus: not on any display, ignoring notify
2019.02.18 14:50:54 5: battStatus: not on any display, ignoring notify


Ich kann den Verursacher nicht finden, bin für jeden Tip dankbar.
Titel: Antw:wer blockiert hier ....
Beitrag von: Wzut am 18 Februar 2019, 16:10:36
Tipp : setzt das Ausgabemonster in Code Tags sonst liest das der eine oder andere erst gar nicht
Titel: Antw:wer blockiert hier ....
Beitrag von: Freibeuter am 18 Februar 2019, 16:28:54
Vielen Dank für den Hinweis,
Beitrag war wohl zu lang  und wurde abgeschnitten.
Titel: Antw:wer blockiert hier ....
Beitrag von: KernSani am 18 Februar 2019, 16:31:41
Probier mal das Freezemon Modul statt Perfmon und apptime, das ist i.d.R. effektiver
Nur Text | Text mit Bildern