I looked at the log:
First, the pause request is sent by LMS. It is acknowledged and
confirmed to the LMS "side" of the bridge
Code:
--------------------
[09:14:42.732774] process_strm:238 [0xba14c0] strm command p
[09:14:42.732791] process_strm:268 [0xba14c0] pause (interval:0)
[09:14:42.732811] sq_callback:257 callback for Living room Shield (4)
[09:14:42.732845] SendCastMessage:235 [0x7f5b300091c0]: Cast sending:
{"type":"PAUSE","requestId":379,"mediaSessionId":1}
[09:14:42.732864] CastSimple:199 [0xc28d40]: Immediate PAUSE (id:379)
[09:14:42.732883] sendSTAT:169 [0xba14c0]: STAT:[STMp] msplayed 55781
[09:14:42.781611] CastSocketThread:728 [0xc28d40]: type:MEDIA_STATUS (id:379)
PAUSED
[09:14:42.800856] stream_thread:436 [0xba14c0] streambuf read 90112 bytes
[09:14:43.733051] sendSTAT:169 [0xba14c0]: STAT:[STMt] msplayed 55781
[09:14:43.777300] CastSocketThread:731 [0xc28d40]: type:RECEIVER_STATUS
(id:378)
[09:14:43.777526] SendCastMessage:235 [0x7f5b300091c0]: Cast sending:
{"type":"GET_STATUS","requestId":380,"mediaSessionId":1}
[09:14:43.825689] CastSocketThread:728 [0xc28d40]: type:MEDIA_STATUS (id:380)
PAUSED
[09:14:44.733668] sendSTAT:169 [0xba14c0]: STAT:[STMt] msplayed 55781
[09:14:44.826001] SendCastMessage:235 [0x7f5b300091c0]: Cast sending:
{"type":"GET_STATUS","requestId":381,"mediaSessionId":1}
[09:14:44.873767] CastSocketThread:728 [0xc28d40]: type:MEDIA_STATUS (id:381)
PAUSED
[09:14:44.873884] _SyncNotifyState:485 Living room Shield: Cast pause
[09:14:44.873938] sq_notify:633 [0xba14c0] track paused at 7650736
--------------------
Then we are paused for a few seconds and every second there is a status
poll
Code:
--------------------
[09:14:45.874089] SendCastMessage:235 [0x7f5b300091c0]: Cast sending:
{"type":"GET_STATUS","requestId":382,"mediaSessionId":1}
[09:14:45.921726] CastSocketThread:728 [0xc28d40]: type:MEDIA_STATUS (id:382)
PAUSED
[09:14:46.001162] process:500 [0xba5880] strm
[09:14:46.001233] process_strm:241 [0xba5880] strm command t
[09:14:46.001253] sendSTAT:169 [0xba5880]: STAT:[STMt] msplayed 0
[09:14:46.001385] process:500 [0xbc32c0] strm
[09:14:46.002119] process_strm:241 [0xbb6780] strm command t
[09:14:46.002177] sendSTAT:169 [0xbb6780]: STAT:[STMt] msplayed 0
[09:14:46.922072] SendCastMessage:235 [0x7f5b300091c0]: Cast sending:
{"type":"GET_STATUS","requestId":383,"mediaSessionId":1}
[09:14:46.974692] CastSocketThread:728 [0xc28d40]: type:MEDIA_STATUS (id:383)
PAUSED
[09:14:47.003116] sendSTAT:169 [0xba14c0]: STAT:[STMt] msplayed 55781
[09:14:47.975029] SendCastMessage:235 [0x7f5b300091c0]: Cast sending:
{"type":"GET_STATUS","requestId":384,"mediaSessionId":1}
[09:14:48.004048] sendSTAT:169 [0xba14c0]: STAT:[STMt] msplayed 55781
[09:14:48.021718] CastSocketThread:728 [0xc28d40]: type:MEDIA_STATUS (id:384)
PAUSED
--------------------
Suddenly, the Cast side of the bridge receives an status that says that
the chromecast device is playing, as if somebody pressed on "play" from
the device (or a controller) directly
Code:
--------------------
[09:14:49.004779] sendSTAT:169 [0xba14c0]: STAT:[STMt] msplayed 55781
[09:14:49.022034] SendCastMessage:235 [0x7f5b300091c0]: Cast sending:
{"type":"GET_STATUS","requestId":385,"mediaSessionId":1}
[09:14:49.069836] CastSocketThread:728 [0xc28d40]: type:MEDIA_STATUS (id:385)
PAUSED
[09:14:50.005508] sendSTAT:169 [0xba14c0]: STAT:[STMt] msplayed 55781
[09:14:50.071407] _SyncNotifyState:455 [0xc28d40]: Cast playing
[09:14:50.071509] sq_notify:601 [0xba14c0] resume notification (paused time
14985)
[09:14:50.071530] sq_notify:621 [0xba14c0] unsollicited play
[09:14:50.071705] cli_open_socket:186 [0xba14c0]: opened CLI socket 29
[09:14:50.073168] process:500 [0xba14c0] audg
[09:14:50.073266] process_audg:406 [0xba14c0] (old) audg gainL: 0 gainR: 0
[09:14:50.079542] SendCastMessage:235 [0x7f5b300091c0]: Cast sending:
{"type":"GET_STATUS","requestId":386,"mediaSessionId":1}
[09:14:50.079648] sq_callback:257 callback for Living room Shield (7)
--------------------
So I don't know what to say... the whole process is compliant to what is
expected, it just seems that the CC decides to restart and his own...
LMS 7.9 on Pi 3B+ & Odroid-C2 - *SqueezeAMP!*, 5xRadio, 3xBoom, 4xDuet,
1xTouch, 1 SB3. Sonos PLAY:3, PLAY:5, Marantz NR1603, Foobar2000,
ShairPortW, JRiver 21, 2xChromecast Audio, Chromecast v1 and v2,
Squeezelite on Pi, Yamaha WX-010, AppleTV 4, Airport Express, GGMM E5,
Riva 1 & 3
------------------------------------------------------------------------
philippe_44's Profile: http://forums.slimdevices.com/member.php?userid=17261
View this thread: http://forums.slimdevices.com/showthread.php?t=104614
_______________________________________________
plugins mailing list
plugins@lists.slimdevices.com
http://lists.slimdevices.com/mailman/listinfo/plugins
