Xiaomi soundbox pro can't play music by the dlan bridge

[laomao9000]

thanks for you good work! The dlna bridge can find my xiaomi soundbox pro，but can't play music on it. below is some log：

[12:00:52.896] Start:1507 Binding to 192.168.1.11:49152 (http:0) [12:00:53.764] AddMRDevice:1399 [004C428C]: adding renderer (灏忕埍闊崇-2209) [12:00:53.764] GetProtocolInfo:358 [004C428C]: uPNP GetProtocolInfo [12:00:53.771] GetProtocolInfo:369 [004C428C]: ProtocolInfo http-get:::* [12:00:53.771] stream_thread_init:464 [00510FAC] streambuf size: 1048576 [12:00:53.776] MasterHandler:1036 [004C428C]: subscribe success [12:00:53.903] output_thread_init:611 [00510FAC] init output media renderer [12:00:53.903] decode_thread_init:168 [00510FAC]: init decode [12:00:53.903] resample_init:345 [00510FAC]: resampling sync recipe: 0x00, flags: 0x00, scale: 0.89, precision: 0.0, passband_end: 0.00000, stopband_begin: 0.00000, phase_response: -1.0 [12:00:53.903] UpdateThread:1249 Updating configuration C:\ProgramData\Squeezebox\prefs\upnpbridge.xml [12:00:53.903] discover_server:809 [00510FAC] sending discovery [12:00:53.904] discover_server:841 [00510FAC] got response from: 192.168.1.11:3483 [12:00:53.904] slimproto:861 squeezelite [00510FAC] <=> player [004C428C] [12:00:53.904] slimproto:862 [00510FAC] connecting to 192.168.1.11:3483 [12:00:53.904] slimproto:892 [00510FAC] connected [12:00:53.904] sendHELO:134 [00510FAC] mac: bb:bb:18:69:a5:55 [12:00:53.904] sendHELO:135 [00510FAC] cap: CanHTTPS=1,Model=squeezelite,ModelName=UPnPBridge,AccuratePlayPoints=0,HasDigitalOut=1,MaxSampleRate=48000,aac,ogg,ops,ogf,flc,alc,wav,aif,pcm,mp3 [12:00:53.904] process:500 [00510FAC] strm [12:00:53.904] process_strm:241 [00510FAC] strm command q [12:00:53.904] decode_flush:208 [00510FAC]: decode flush [12:00:53.904] output_flush:606 [00510FAC]: flush output buffer [12:00:53.904] sq_callback:313 [004C428C]: device off or not controlled by LMS [12:00:53.904] process:500 [00510FAC] strm [12:00:53.904] process_strm:241 [00510FAC] strm command q [12:00:53.904] decode_flush:208 [00510FAC]: decode flush [12:00:53.904] output_flush:606 [00510FAC]: flush output buffer [12:00:53.904] process:500 [00510FAC] setd [12:00:53.904] sendSETDName:227 [1268]: set playername: 灏忕埍闊崇-2209 [12:00:53.905] process:500 [00510FAC] setd [12:00:53.905] process:500 [00510FAC] aude [12:00:53.905] process_aude:392 [00510FAC] on/off using aude 1 [12:00:53.905] sq_callback:309 [004C428C]: device set on/off 1 [12:00:53.905] process:500 [00510FAC] audg [12:00:53.905] process_audg:406 [00510FAC] (old) audg gainL: 46 gainR: 46 [12:00:54.000] process:500 [00510FAC] strm [12:00:54.000] process_strm:241 [00510FAC] strm command t [12:00:54.000] sendSTAT:169 [00510FAC]: STAT:[STMt] msplayed 0 [12:00:54.958] UpdateThread:1249 Updating configuration C:\ProgramData\Squeezebox\prefs\upnpbridge.xml [12:00:56.051] UpdateThread:1249 Updating configuration C:\ProgramData\Squeezebox\prefs\upnpbridge.xml [12:00:59.004] process:500 [00510FAC] strm [12:00:59.004] process_strm:241 [00510FAC] strm command t [12:00:59.004] sendSTAT:169 [00510FAC]: STAT:[STMt] msplayed 0 [12:01:04.010] process:500 [00510FAC] strm [12:01:04.010] process_strm:241 [00510FAC] strm command t [12:01:04.010] sendSTAT:169 [00510FAC]: STAT:[STMt] msplayed 0 [12:01:05.988] UpdateThread:1146 [004C428C] UPnP keep alive: 灏忕埍闊崇-2209 [12:01:08.422] process:500 [00510FAC] strm [12:01:08.422] process_strm:241 [00510FAC] strm command q [12:01:08.422] decode_flush:208 [00510FAC]: decode flush [12:01:08.422] output_flush:606 [00510FAC]: flush output buffer [12:01:08.422] AVTStop:216 [004C428C]: uPNP stop (cookie 00000000) [12:01:08.429] process:500 [00510FAC] audg [12:01:08.429] process_audg:406 [00510FAC] (old) audg gainL: 46 gainR: 46 [12:01:08.430] process:500 [00510FAC] strm [12:01:08.430] process_strm:238 [00510FAC] strm command s [12:01:08.430] process_strm:307 [00510FAC], strm s autostart: 1 transition period: 10 transition type: 0 codec: f [12:01:08.430] sendSTAT:169 [00510FAC]: STAT:[STMf] msplayed 0 [12:01:08.430] process_strm:322 [00510FAC]: set fade mode: 0 [12:01:08.430] cli_open_socket:180 [00510FAC]: opened CLI socket 1088 [12:01:08.432] sq_get_metadata:502 [00510FAC]: idx 1 artist:绋嬬挧 album:鏅存棩鍏卞壀绐� title:鎬濇晠涔� genre:Folk duration:212.213 size:0 cover:http://192.168.1.11:9000/music/0720cd9f/cover_.jpg [12:01:08.432] process_start:1214 [00510FAC]: something went wrong starting process 1 [12:01:08.433] connect_socket:155 [00510FAC] connecting to 192.168.1.11:9000 [12:01:08.433] stream_sock:592 [00510FAC] header: GET /stream.mp3?player=bb:bb:18:69:a5:55 HTTP/1.0

+++++++++++++++++++++++ The soundbox can play by foobar2000(use UPnP MediaRenderer Output.fb2k-component ).

[laomao9000]

This is my config:

[common parameters] These parameters set the defaults for all players (EMPTY value means use built-in default) Streaming options HTTP mode chunked Gapless Yes Seek on resume Yes Next 15 afore end
UPnP player audio capabilities Codecs aac,ogg,ops,ogf,flc,alc,wav,aif,pcm,mp3 Max sample rate 48000 Show advanced options
Audio format to UPnP player Transcode flac Flow 24 bits PCM packed type 1 Show advanced options
Player discovery options LMS Server ? Player is enabled Yes Remove timeout 120

Player volume management Maximum volume 100 LMS volume changes only when playing Feedback to LMS Yes

Send LMS metadata to player Yes Include cover art No at resolution Send ICY metadata Text only

[houoop]

my xiaomi wifi speaker has same problem. I tried every configration in plugin setting web ui, but it don't work always.

[22:03:39.369799] sendSTAT:169 [0xbbb140]: STAT:[STMc] msplayed 0 [22:03:39.369824] process_strm:342 [0xbbb140] no matching codec f [22:03:39.369846] sendSTAT:169 [0xbbb140]: STAT:[STMn] msplayed 0 [22:03:39.369878] process:500 [0xbbb140] audg [22:03:39.369900] process_audg:406 [0xbbb140] (old) audg gainL: 110 gainR: 110 [22:03:39.412075] process:500 [0xbbb140] strm [22:03:39.412165] process_strm:241 [0xbbb140] strm command q [22:03:39.412186] decode_flush:208 [0xbbb140]: decode flush [22:03:39.412264] output_flush:611 [0xbbb140]: flush output buffer [22:03:39.412336] sendSTAT:169 [0xbbb140]: STAT:[STMf] msplayed 0 [22:03:39.412384] AVTStop:217 [0xc44b00]: uPNP stop (cookie 0xe) [22:03:39.436270] process:500 [0xbbb140] audg [22:03:39.436359] process_audg:406 [0xbbb140] (old) audg gainL: 110 gainR: 110 [22:03:39.438288] process:500 [0xbbb140] strm [22:03:39.438371] process_strm:238 [0xbbb140] strm command s [22:03:39.438392] process_strm:307 [0xbbb140], strm s autostart: 1 transition period: 10 transition type: 0 codec: f [22:03:39.438415] sendSTAT:169 [0xbbb140]: STAT:[STMf] msplayed 0 [22:03:39.438507] process_strm:322 [0xbbb140]: set fade mode: 0 [22:03:39.438586] process_start:1226 [0xbbb140]: something went wrong starting process 14 [22:03:39.438631] connect_socket:155 [0xbbb140] connecting to 192.168.6.189:9000 [22:03:39.438800] stream_sock:592 [0xbbb140] header: GET /stream.mp3?player=bb:bb:a6:ba:fd:4f HTTP/1.0

[22:03:39.438837] sendSTAT:169 [0xbbb140]: STAT:[STMc] msplayed 0 [22:03:39.438865] process_strm:342 [0xbbb140] no matching codec f [22:03:39.438886] sendSTAT:169 [0xbbb140]: STAT:[STMn] msplayed 0 [22:03:39.438921] process:500 [0xbbb140] audg [22:03:39.438942] process_audg:406 [0xbbb140] (old) audg gainL: 110 gainR: 110 [22:03:39.455896] ActionHandler:837 [0xc44b00]: Waited action StopResponse [22:03:39.481631] process:500 [0xbbb140] strm [22:03:39.481719] process_strm:241 [0xbbb140] strm command q [22:03:39.481741] decode_flush:208 [0xbbb140]: decode flush [22:03:39.481808] output_flush:611 [0xbbb140]: flush output buffer [22:03:39.481892] sendSTAT:169 [0xbbb140]: STAT:[STMf] msplayed 0 [22:03:39.481944] AVTStop:217 [0xc44b00]: uPNP stop (cookie 0xf) [22:03:39.493993] ActionHandler:837 [0xc44b00]: Waited action StopResponse [22:03:39.507047] process:500 [0xbbb140] audg [22:03:39.507130] process_audg:406 [0xbbb140] (old) audg gainL: 110 gainR: 110 [22:03:39.507163] process:500 [0xbbb140] strm [22:03:39.507223] process_strm:238 [0xbbb140] strm command s [22:03:39.507257] process_strm:307 [0xbbb140], strm s autostart: 1 transition period: 10 transition type: 0 codec: f [22:03:39.507280] sendSTAT:169 [0xbbb140]: STAT:[STMf] msplayed 0 [22:03:39.507344] process_strm:322 [0xbbb140]: set fade mode: 0 [22:03:39.507425] process_start:1226 [0xbbb140]: something went wrong starting process 15 [22:03:39.507470] connect_socket:155 [0xbbb140] connecting to 192.168.6.189:9000 [22:03:39.507625] stream_sock:592 [0xbbb140] header: GET /stream.mp3?player=bb:bb:a6:ba:fd:4f HTTP/1.0

[22:03:39.507669] sendSTAT:169 [0xbbb140]: STAT:[STMc] msplayed 0 [22:03:39.507696] process_strm:342 [0xbbb140] no matching codec f [22:03:39.507718] sendSTAT:169 [0xbbb140]: STAT:[STMn] msplayed 0 [22:03:39.507751] process:500 [0xbbb140] audg [22:03:39.507772] process_audg:406 [0xbbb140] (old) audg gainL: 110 gainR: 110 [22:03:39.536558] stream_thread:337 [0xbbb140] headers: len: 488 HTTP/1.1 200 OK Server: Logitech Media Server (8.2.1 - TRUNK) Connection: close Content-Type: audio/x-flac Set-Cookie: Squeezebox-albumView=; path=/ Set-Cookie: Squeezebox-expandPlayerControl=true; path=/ Set-Cookie: Squeezebox-expanded-MY_MUSIC=1; path=/ Set-Cookie: Squeezebox-expanded-FAVORITES=0; path=/ Set-Cookie: Squeezebox-expanded-PLUGINS=1; path=/ Set-Cookie: Squeezebox-expanded-PLUGIN_MY_APPS_MODULE_NAME=1; path=/ Set-Cookie: Squeezebox-expanded-RADIO=1; path=/

[22:03:39.536912] sendRESP:197 [9]: RESP [22:03:39.536949] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.537274] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.537520] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.537746] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.537968] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.538178] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.538418] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.538792] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.538900] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.539068] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.539310] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.539537] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.539746] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.539972] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.540182] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.540440] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.540662] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.540875] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.541084] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.541332] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.541591] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.543464] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.544155] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.544471] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.544706] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.548292] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.548672] stream_thread:436 [0xbbb140] streambuf read 32768 bytes [22:03:39.552284] process:500 [0xbbb140] strm [22:03:39.552376] process_strm:241 [0xbbb140] strm command q [22:03:39.552399] decode_flush:208 [0xbbb140]: decode flush [22:03:39.552464] output_flush:611 [0xbbb140]: flush output buffer [22:03:39.552493] sendSTAT:169 [0xbbb140]: STAT:[STMf] msplayed 0 [22:03:39.552587] AVTStop:217 [0xc44b00]: uPNP stop (cookie 0x10) [22:03:39.567585] ActionHandler:837 [0xc44b00]: Waited action StopResponse [22:03:39.575043] process:500 [0xbbb140] audg [22:03:39.575140] process_audg:406 [0xbbb140] (old) audg gainL: 110 gainR: 110 [22:03:39.579009] process:500 [0xbbb140] strm [22:03:39.579091] process_strm:238 [0xbbb140] strm command s [22:03:39.579112] process_strm:307 [0xbbb140], strm s autostart: 1 transition period: 10 transition type: 0 codec: f [22:03:39.579134] sendSTAT:169 [0xbbb140]: STAT:[STMf] msplayed 0 [22:03:39.579265] process_strm:322 [0xbbb140]: set fade mode: 0 [22:03:39.579472] process_start:1226 [0xbbb140]: something went wrong starting process 16 [22:03:39.579539] connect_socket:155 [0xbbb140] connecting to 192.168.6.189:9000 [22:03:39.579746] stream_sock:592 [0xbbb140] header: GET /stream.mp3?player=bb:bb:a6:ba:fd:4f HTTP/1.0

[22:03:39.579797] sendSTAT:169 [0xbbb140]: STAT:[STMc] msplayed 0 [22:03:39.579835] process_strm:342 [0xbbb140] no matching codec f [22:03:39.579857] sendSTAT:169 [0xbbb140]: STAT:[STMn] msplayed 0 [22:03:39.579893] process:500 [0xbbb140] audg [22:03:39.579920] process_audg:406 [0xbbb140] (old) audg gainL: 110 gainR: 110 [22:03:39.622535] process:500 [0xbbb140] strm [22:03:39.622626] process_strm:241 [0xbbb140] strm command q [22:03:39.622647] decode_flush:208 [0xbbb140]: decode flush [22:03:39.622708] output_flush:611 [0xbbb140]: flush output buffer [22:03:39.622779] sendSTAT:169 [0xbbb140]: STAT:[STMf] msplayed 0 [22:03:39.622826] AVTStop:217 [0xc44b00]: uPNP stop (cookie 0x11) [22:03:39.641810] ActionHandler:837 [0xc44b00]: Waited action StopResponse [22:03:39.645421] process:500 [0xbbb140] audg [22:03:39.645527] process_audg:406 [0xbbb140] (old) audg gainL: 110 gainR: 110 [22:03:39.647665] process:500 [0xbbb140] strm [22:03:39.647753] process_strm:238 [0xbbb140] strm command s [22:03:39.647774] process_strm:307 [0xbbb140], strm s autostart: 1 transition period: 10 transition type: 0 codec: f [22:03:39.647796] sendSTAT:169 [0xbbb140]: STAT:[STMf] msplayed 0 [22:03:39.647838] process_strm:322 [0xbbb140]: set fade mode: 0 [22:03:39.647934] process_start:1226 [0xbbb140]: something went wrong starting process 17 [22:03:39.647980] connect_socket:155 [0xbbb140] connecting to 192.168.6.189:9000 [22:03:39.648139] stream_sock:592 [0xbbb140] header: GET /stream.mp3?player=bb:bb:a6:ba:fd:4f HTTP/1.0

this is my setting

<?xml version="1.0"?> <squeeze2upnp> <output_log>debug</output_log> <decode_log>debug</decode_log> <slimproto_log>debug</slimproto_log> <upnp_log>debug</upnp_log> <main_log>debug</main_log> <binding>?</binding> <log_limit>-1</log_limit> <slimmain_log>debug</slimmain_log> <stream_log>debug</stream_log> <common> <accept_nexturi>1</accept_nexturi> <max_volume>100</max_volume> <flac_header>1</flac_header> <sample_rate>48000</sample_rate> <roon_mode>1</roon_mode> <send_coverart>1</send_coverart> <server>?</server> <output_size>4194304</output_size> <stream_length>-1</stream_length> <codecs>aac,ogg,ops,ogf,flc,alc,wav,aif,pcm,mp3</codecs> <streambuf_size>1048576</streambuf_size> <mode>pcm</mode> <send_icy>0</send_icy> <enabled>1</enabled> <auto_play>0</auto_play> <volume_on_play>1</volume_on_play> <volume_feedback>1</volume_feedback> <next_delay>15</next_delay> <raw_audio_format>raw,wav,aif</raw_audio_format> <remove_timeout>120</remove_timeout> <seek_after_pause>0</seek_after_pause> <send_metadata>1</send_metadata> <L24_format>1</L24_format> <forced_mimetypes></forced_mimetypes> <coverart></coverart> <resample_options></resample_options> </common> <util_log>debug</util_log> <device> <mac>bb:bb:a6:ba:fd:4f</mac> <udn>uuid:88f16c5c-7568-46a2-95eb-79920a0fb96e</udn> <enabled>1</enabled> <name>小爱音箱-5260</name> <friendly_name>小爱音箱-5260</friendly_name> </device> <device> <enabled>0</enabled> <name>小爱音箱-7643</name> <friendly_name>小爱音箱-7643</friendly_name> <mac>bb:bb:c9:56:25:c0</mac> <udn>uuid:b6f2be06-837d-4a4e-8a5d-cf252712d651</udn> </device> </squeeze2upnp>

[philippe44]

You have set "roon" mode and use pcm for forced output format but your player likely does not support the "raw" formats of pcm. First, why do you use "roon" mode and then why forcing pcm as an output transcode?

[houoop]

no , I just want to try every param to let it work. Because I use the default param , It don't work . I try the all param from Transcode selection, no answer. so I think this plugin can't use in my dlna player.

this is the log when I use the default param. Maybe you can help me how to select the param. ths！

------------------------------------log----------------------------------------- [10:21:31.066335] sendSETDName:227 [9]: set playername: 小爱音箱-5260 [10:21:31.066406] process:500 [0xbbb140] setd [10:21:31.066439] process:500 [0xbbb140] aude [10:21:31.066462] process_aude:392 [0xbbb140] on/off using aude 1 [10:21:31.066485] sq_callback:312 [0xc44b00]: device set on/off 1 [10:21:31.066515] process:500 [0xbbb140] audg [10:21:31.066537] process_audg:406 [0xbbb140] (old) audg gainL: 110 gainR: 110 [10:21:31.085539] MasterHandler:1054 [0xc44b00]: subscribe success [10:21:34.001521] process:500 [0xbbb140] strm [10:21:34.001618] process_strm:241 [0xbbb140] strm command t [10:21:34.001646] sendSTAT:169 [0xbbb140]: STAT:[STMt] msplayed 0 [10:21:37.557100] UpdateThread:1273 Updating configuration /config/prefs/upnpbridge.xml [10:21:39.001925] process:500 [0xbbb140] strm [10:21:39.002042] process_strm:241 [0xbbb140] strm command t [10:21:39.002073] sendSTAT:169 [0xbbb140]: STAT:[STMt] msplayed 0 [10:21:42.589435] UpdateThread:1273 Updating configuration /config/prefs/upnpbridge.xml [10:21:44.000763] process:500 [0xbbb140] strm [10:21:44.000846] process_strm:241 [0xbbb140] strm command t [10:21:44.000868] sendSTAT:169 [0xbbb140]: STAT:[STMt] msplayed 0 [10:21:47.123390] UpdateThread:1169 [0xc44b00] UPnP keep alive: 小爱音箱-5260 [10:21:48.001290] UpdateThread:1110 Presence checking [10:21:48.201778] UpdateThread:1110 Presence checking [10:21:49.001288] process:500 [0xbbb140] strm [10:21:49.001378] process_strm:241 [0xbbb140] strm command t [10:21:49.001402] sendSTAT:169 [0xbbb140]: STAT:[STMt] msplayed 0 [10:21:54.001334] process:500 [0xbbb140] strm [10:21:54.001420] process_strm:241 [0xbbb140] strm command t [10:21:54.001443] sendSTAT:169 [0xbbb140]: STAT:[STMt] msplayed 0 [10:21:55.346562] UpdateThread:1169 [0xc44b00] UPnP keep alive: 小爱音箱-5260 [10:21:57.807060] UpdateThread:1273 Updating configuration /config/prefs/upnpbridge.xml [10:21:59.006363] process:500 [0xbbb140] strm [10:21:59.006458] process_strm:241 [0xbbb140] strm command t [10:21:59.006481] sendSTAT:169 [0xbbb140]: STAT:[STMt] msplayed 0 [10:22:01.153754] process:500 [0xbbb140] strm [10:22:01.153849] process_strm:241 [0xbbb140] strm command q [10:22:01.153872] decode_flush:208 [0xbbb140]: decode flush [10:22:01.153898] output_flush:611 [0xbbb140]: flush output buffer [10:22:01.153921] AVTStop:217 [0xc44b00]: uPNP stop (cookie (nil)) [10:22:03.551503] process:500 [0xbbb140] strm [10:22:03.551599] process_strm:241 [0xbbb140] strm command q [10:22:03.551624] decode_flush:208 [0xbbb140]: decode flush [10:22:03.551646] output_flush:611 [0xbbb140]: flush output buffer [10:22:03.860566] UpdateThread:1273 Updating configuration /config/prefs/upnpbridge.xml [10:22:03.934593] UpdateThread:1169 [0xc44b00] UPnP keep alive: 小爱音箱-5260 [10:22:04.001822] process:500 [0xbbb140] strm [10:22:04.001919] process_strm:241 [0xbbb140] strm command t [10:22:04.001943] sendSTAT:169 [0xbbb140]: STAT:[STMt] msplayed 0 [10:22:04.719703] process:500 [0xbbb140] strm [10:22:04.719798] process_strm:241 [0xbbb140] strm command q [10:22:04.719820] decode_flush:208 [0xbbb140]: decode flush [10:22:04.719842] output_flush:611 [0xbbb140]: flush output buffer [10:22:04.719865] AVTStop:217 [0xc44b00]: uPNP stop (cookie 0x1) [10:22:04.733294] ActionHandler:837 [0xc44b00]: Waited action StopResponse [10:22:06.086814] _SyncNotifState:659 [0xc44b00]: uPNP stop [10:22:06.086892] sq_notify:651 [0xbbb140] notify STOP [10:22:08.003323] UpdateThread:1110 Presence checking [10:22:08.204125] UpdateThread:1110 Presence checking [10:22:09.005002] process:500 [0xbbb140] strm [10:22:09.005098] process_strm:241 [0xbbb140] strm command t [10:22:09.005121] sendSTAT:169 [0xbbb140]: STAT:[STMt] msplayed 0 [10:22:13.163290] UpdateThread:1273 Updating configuration /config/prefs/upnpbridge.xml [10:22:14.001223] process:500 [0xbbb140] strm [10:22:14.001345] process_strm:241 [0xbbb140] strm command t [10:22:14.001369] sendSTAT:169 [0xbbb140]: STAT:[STMt] msplayed 0 [10:22:14.751634] UpdateThread:1169 [0xc44b00] UPnP keep alive: 小爱音箱-5260 [10:22:16.838338] UpdateThread:1273 Updating configuration /config/prefs/upnpbridge.xml [10:22:17.321496] UpdateThread:1169 [0xc44b00] UPnP keep alive: 小爱音箱-5260 [10:22:19.001768] process:500 [0xbbb140] strm [10:22:19.001857] process_strm:241 [0xbbb140] strm command t [10:22:19.001881] sendSTAT:169 [0xbbb140]: STAT:[STMt] msplayed 0 [10:22:24.002032] process:500 [0xbbb140] strm [10:22:24.002121] process_strm:241 [0xbbb140] strm command t [10:22:24.002143] sendSTAT:169 [0xbbb140]: STAT:[STMt] msplayed 0 ------------------------------------log-----------------------------------------

this is the default settings

------------------------------------settings----------------------------------------- <?xml version="1.0"?> <squeeze2upnp> <common> <send_metadata>1</send_metadata> <auto_play>0</auto_play> <volume_on_play>1</volume_on_play> <volume_feedback>1</volume_feedback> <next_delay>15</next_delay> <remove_timeout>120</remove_timeout> <raw_audio_format>raw,wav,aif</raw_audio_format> <seek_after_pause>0</seek_after_pause> <roon_mode>0</roon_mode> <send_coverart>1</send_coverart> <output_size>4194304</output_size> <server>?</server> <stream_length>-3</stream_length> <streambuf_size>1048576</streambuf_size> <codecs>aac,ogg,ops,ogf,flc,alc,wav,aif,pcm,mp3</codecs> <send_icy>1</send_icy> <mode>thru</mode> <enabled>1</enabled> <accept_nexturi>1</accept_nexturi> <max_volume>100</max_volume> <L24_format>1</L24_format> <flac_header>1</flac_header> <sample_rate>48000</sample_rate> <forced_mimetypes></forced_mimetypes> <coverart></coverart> <resample_options></resample_options> </common> <stream_log>debug</stream_log> <slimmain_log>debug</slimmain_log> <util_log>debug</util_log> <log_limit>-1</log_limit> <main_log>debug</main_log> <binding>?</binding> <decode_log>debug</decode_log> <output_log>debug</output_log> <slimproto_log>debug</slimproto_log> <upnp_log>debug</upnp_log> <device> <udn>uuid:88f16c5c-7568-46a2-95eb-79920a0fb96e</udn> <mac>bb:bb:a6:ba:fd:4f</mac> <enabled>1</enabled> <friendly_name>小爱音箱-5260</friendly_name> <name>小爱音箱-5260</name> </device> <device> <mac>bb:bb:c9:56:25:c0</mac> <udn>uuid:b6f2be06-837d-4a4e-8a5d-cf252712d651</udn> <enabled>0</enabled> <name>小爱音箱-7643</name> <friendly_name>小爱音箱-7643</friendly_name> </device> </squeeze2upnp> ------------------------------------settings-----------------------------------------

[philippe44]

Don't start with all debug set. Erase config file and start just with default settings. What is you LMS configuration?

[houoop]

Logitech Media Server ver： 8.2.1 , docker ,network host mode docker run -d
--name logitechmediaserver
--restart always
-v /volume2/docker/LMS/config:/config:rw
-v /volume2/docker/music:/music:ro
-v /volume2/docker/LMS/playlist:/playlist:rw
-v "/etc/localtime":"/etc/localtime":ro
-e PUID=1026
-e PGID=100
-e TZ=Asia/Shanghai
--network host
snoopy86/logitechmediaserver

this is the log which I use the default settings

Starting Squeeze2upnp: /config/cache/InstalledPlugins/Plugins/UPnPBridge/Bin/squeeze2upnp-x86-64-static -Z -I -f /config/logs/upnpbridge.log -x /config/prefs/upnpbridge.xml [11:06:33.864718] main:1774 Starting squeeze2upnp version: v1.81.3 (Jan 25 2022 @ 21:19:39) [11:06:33.920832] register_alac:541 using alac to decode alc [11:06:33.920919] register_mad:433 using mad to decode mp3 [11:06:33.920940] register_faad:647 using faad to decode aac [11:06:33.920960] register_vorbis:346 using vorbis to decode ogg [11:06:33.920979] register_pcm:339 using pcm [11:06:33.920998] register_flac:313 using flac to decode flc [11:06:33.921017] register_opus:286 using opus to decode ops [11:06:33.921036] register_m4a_thru:307 using mp4 to aac (ADTS) [11:06:33.921055] register_flac_thru:212 using flac [11:06:33.921074] register_thru:106 using thru [11:06:33.921093] register_soxr:394 using soxr for resampling [11:06:33.921115] Start:1536 Binding to 192.168.6.189:49153 (http:0) [11:06:43.396132] UpdateThread:1273 Updating configuration /config/prefs/upnpbridge.xml [11:06:44.521290] AddMRDevice:1423 [0xc44b00]: adding renderer (小爱音箱-5260) [11:06:44.521381] GetProtocolInfo:359 [0xc44b00]: uPNP GetProtocolInfo [11:06:44.528428] GetProtocolInfo:370 [0xc44b00]: ProtocolInfo http-get:::* [11:06:44.528768] stream_thread_init:464 [0xbbb140] streambuf size: 1048576 [11:06:44.530345] output_thread_init:616 [0xbbb140] init output media renderer [11:06:44.530446] decode_thread_init:168 [0xbbb140]: init decode [11:06:44.530525] resample_init:345 [0xbbb140]: resampling sync recipe: 0x00, flags: 0x00, scale: 0.89, precision: 0.0, passband_end: 0.00000, stopband_begin: 0.00000, phase_response: -1.0 [11:06:44.530566] UpdateThread:1273 Updating configuration /config/prefs/upnpbridge.xml [11:06:44.531553] discover_server:809 [0xbbb140] sending discovery [11:06:44.532339] discover_server:841 [0xbbb140] got response from: 192.168.6.189:3483 [11:06:44.532435] slimproto:861 squeezelite [0xbbb140] <=> player [0xc44b00] [11:06:44.532460] slimproto:862 [0xbbb140] connecting to 192.168.6.189:3483 [11:06:44.532674] slimproto:892 [0xbbb140] connected [11:06:44.532755] sendHELO:134 [0xbbb140] mac: bb:bb:a6:ba:fd:4f [11:06:44.532780] sendHELO:135 [0xbbb140] cap: CanHTTPS=1,Model=squeezelite,ModelName=UPnPBridge,AccuratePlayPoints=0,HasDigitalOut=1,MaxSampleRate=48000, [11:06:44.535256] process:500 [0xbbb140] strm [11:06:44.535337] process_strm:241 [0xbbb140] strm command q [11:06:44.535359] decode_flush:208 [0xbbb140]: decode flush [11:06:44.535380] output_flush:611 [0xbbb140]: flush output buffer [11:06:44.535398] MasterHandler:1054 [0xc44b00]: subscribe success [11:06:44.535457] sq_callback:316 [0xc44b00]: device off or not controlled by LMS [11:06:44.535493] process:500 [0xbbb140] strm [11:06:44.535514] process_strm:241 [0xbbb140] strm command q [11:06:44.535533] decode_flush:208 [0xbbb140]: decode flush [11:06:44.535553] output_flush:611 [0xbbb140]: flush output buffer [11:06:44.536266] process:500 [0xbbb140] setd [11:06:44.536320] sendSETDName:227 [9]: set playername: 小爱音箱-5260 [11:06:44.536385] process:500 [0xbbb140] setd [11:06:44.536418] process:500 [0xbbb140] aude [11:06:44.536440] process_aude:392 [0xbbb140] on/off using aude 1 [11:06:44.536461] sq_callback:312 [0xc44b00]: device set on/off 1 [11:06:44.536489] process:500 [0xbbb140] audg [11:06:44.536510] process_audg:406 [0xbbb140] (old) audg gainL: 110 gainR: 110 [11:06:45.818712] UpdateThread:1273 Updating configuration /config/prefs/upnpbridge.xml [11:06:46.002783] process:500 [0xbbb140] strm [11:06:46.002976] process_strm:241 [0xbbb140] strm command t [11:06:46.003008] sendSTAT:169 [0xbbb140]: STAT:[STMt] msplayed 0 [11:06:47.611289] UpdateThread:1169 [0xc44b00] UPnP keep alive: 小爱音箱-5260 [11:06:51.008860] process:500 [0xbbb140] strm [11:06:51.008936] process_strm:241 [0xbbb140] strm command t [11:06:51.008959] sendSTAT:169 [0xbbb140]: STAT:[STMt] msplayed 0 [11:06:53.007745] UpdateThread:1110 Presence checking [11:06:54.025608] UpdateThread:1110 Presence checking [11:06:55.001250] process:500 [0xbbb140] strm [11:06:55.001359] process_strm:241 [0xbbb140] strm command t [11:06:55.001384] sendSTAT:169 [0xbbb140]: STAT:[STMt] msplayed 0 [11:06:59.001554] process:500 [0xbbb140] strm [11:06:59.001656] process_strm:241 [0xbbb140] strm command t [11:06:59.001680] sendSTAT:169 [0xbbb140]: STAT:[STMt] msplayed 0 [11:06:59.590756] UpdateThread:1169 [0xc44b00] UPnP keep alive: 小爱音箱-5260 [11:06:59.800553] process:500 [0xbbb140] strm [11:06:59.800645] process_strm:241 [0xbbb140] strm command q [11:06:59.800668] decode_flush:208 [0xbbb140]: decode flush [11:06:59.800696] output_flush:611 [0xbbb140]: flush output buffer [11:06:59.800720] AVTStop:217 [0xc44b00]: uPNP stop (cookie (nil)) [11:07:00.673482] UpdateThread:1169 [0xc44b00] UPnP keep alive: 小爱音箱-5260 [11:07:03.001337] process:500 [0xbbb140] strm [11:07:03.001424] process_strm:241 [0xbbb140] strm command t [11:07:03.001448] sendSTAT:169 [0xbbb140]: STAT:[STMt] msplayed 0 [11:07:05.085374] UpdateThread:1273 Updating configuration /config/prefs/upnpbridge.xml [11:07:06.748961] process:500 [0xbbb140] strm [11:07:06.749055] process_strm:241 [0xbbb140] strm command q [11:07:06.749077] decode_flush:208 [0xbbb140]: decode flush [11:07:06.749099] output_flush:611 [0xbbb140]: flush output buffer [11:07:06.749122] AVTStop:217 [0xc44b00]: uPNP stop (cookie 0x1) [11:07:06.823387] ActionHandler:837 [0xc44b00]: Waited action StopResponse [11:07:07.000943] process:500 [0xbbb140] strm [11:07:07.001034] process_strm:241 [0xbbb140] strm command t [11:07:07.001058] sendSTAT:169 [0xbbb140]: STAT:[STMt] msplayed 0 [11:07:09.546553] _SyncNotifState:659 [0xc44b00]: uPNP stop [11:07:09.546637] sq_notify:651 [0xbbb140] notify STOP [11:07:11.002257] process:500 [0xbbb140] strm [11:07:11.002347] process_strm:241 [0xbbb140] strm command t [11:07:11.002370] sendSTAT:169 [0xbbb140]: STAT:[STMt] msplayed 0 [11:07:12.156431] UpdateThread:1273 Updating configuration /config/prefs/upnpbridge.xml [11:07:12.197751] process:500 [0xbbb140] strm [11:07:12.197839] process_strm:241 [0xbbb140] strm command q [11:07:12.197861] decode_flush:208 [0xbbb140]: decode flush [11:07:12.197883] output_flush:611 [0xbbb140]: flush output buffer [11:07:12.197905] AVTStop:217 [0xc44b00]: uPNP stop (cookie 0x3) [11:07:12.209296] ActionHandler:837 [0xc44b00]: Waited action StopResponse [11:07:13.002074] UpdateThread:1110 Presence checking [11:07:14.001340] UpdateThread:1110 Presence checking [11:07:14.541496] _SyncNotifState:659 [0xc44b00]: uPNP stop [11:07:14.541580] sq_notify:651 [0xbbb140] notify STOP [11:07:14.839275] process:500 [0xbbb140] strm [11:07:14.839365] process_strm:241 [0xbbb140] strm command q [11:07:14.839387] decode_flush:208 [0xbbb140]: decode flush [11:07:14.839409] output_flush:611 [0xbbb140]: flush output buffer

[philippe44]

Can you try to play something? There is no play attempt in that log

[houoop]

it can't play anything , i try to play mp3 or flac from my library. if I click the play button , the logger will output these logs

[13:18:32.002468] UpdateThread:1110 Presence checking [13:18:32.003439] process:500 [0xbbb140] strm [13:18:32.003531] process_strm:241 [0xbbb140] strm command t [13:18:32.003555] sendSTAT:169 [0xbbb140]: STAT:[STMt] msplayed 0 [13:18:32.203095] UpdateThread:1110 Presence checking [13:18:33.352621] process:500 [0xbbb140] strm [13:18:33.352713] process_strm:241 [0xbbb140] strm command q [13:18:33.352736] decode_flush:208 [0xbbb140]: decode flush [13:18:33.352758] output_flush:611 [0xbbb140]: flush output buffer [13:18:33.352780] AVTStop:217 [0xc44b00]: uPNP stop (cookie (nil)) [13:18:33.593203] UpdateThread:1273 Updating configuration /config/prefs/upnpbridge.xml [13:18:37.001544] process:500 [0xbbb140] strm [13:18:37.001735] process_strm:241 [0xbbb140] strm command t [13:18:37.001761] sendSTAT:169 [0xbbb140]: STAT:[STMt] msplayed 0 [13:18:38.933297] process:500 [0xbbb140] strm [13:18:38.933395] process_strm:241 [0xbbb140] strm command q [13:18:38.933419] decode_flush:208 [0xbbb140]: decode flush [13:18:38.933452] output_flush:611 [0xbbb140]: flush output buffer [13:18:38.933477] AVTStop:217 [0xc44b00]: uPNP stop (cookie 0x1) [13:18:38.948958] ActionHandler:837 [0xc44b00]: Waited action StopResponse [13:18:40.007731] UpdateThread:1273 Updating configuration /config/prefs/upnpbridge.xml

[philippe44]

If LMS does not try to play that means that your library is not well scanned. It typically does that when it cannot find the file you are trying to play

[houoop]

But I have another squeeze player can play music in LMS

[houoop]

whether would I change any param to get it work , I try the silent param in transcode setting, it can play , and my wifi speaker's android app show it is playing.

[houoop]

if I try any transcode param , It just get other error or crash to restart always.

[philippe44]

Transcode should be "none" to start with (again, a blank / erased /clean config is what you want first). Please if you want my help dont try random things and setting changes. Now, your protocolInfo returned by the player is corrupted

[11:06:44.528428] GetProtocolInfo:370 [0xc44b00]: ProtocolInfo http-get:::*

Can you try "DeviceSpy" https://www.meshcommander.com/upnptools or a similar tool and under "ConnectManager" of you device, invoke "GetProtocolInfo" so see what comes back.

Otherwise, you can add in "additional mimetypes" (advanced settings of audio capabilities) and add "audio/mp3,audio/flac" - of course no "") and see what happens

[houoop]

[philippe44]

Well, that's the first time a player says "I can support ANYTHING" which is obviously wrong, there is a reason why ProtocolInfo was created - crap, again a crappy implementation. Try the trick of the additional mimetype

[houoop]

it work . thanks! xiaomi smart wifi speaker is a very famous product in China , so I think every xiaomi user will happen this problem. If you can ， you could fix this for us. Thanks you very much.

[philippe44]

Yes, I know it's a famous speaker, but still the ProtocolInfo is questionable at best

[houoop]

maybe this player's DLNA reciever is not standard implemented

[houoop]

I found another problem , It can't go to next track when a song end

[philippe44]

Send a log here, but it feels like another bad implementation if UPnP's gapless feature. In settings, try to set "Gapless" to "No" and see

[houoop]

it's not work when the Gapless is No, this is the log. upnpbridge (1).log

[philippe44]

Sorry but this log is too verbose to start with (do not add any additional debugging) and incomplete. Just clean the log, put a few tracks in the playlist and let it go till it fails.

[houoop]

'Additional debugging' is None , I have set it. upnpbridge (2).log

[houoop]

It can go to next track automatically when “Gapless” is Force. I would still be curious to have a good log with "No" set

[philippe44]

'Additional debugging' is None , I have set it. upnpbridge (2).log

This is the same log

[philippe44]

It can go to next track automatically when “Gapless” is Force.

OMG, this really means implementation is bad...

[houoop]

I don't know how to get the clean log, I have erased the old log file and restarted.

[philippe44]

I don't know how to get the clean log, I have erased the old log file and restarted.

Can you send me a copy of your config file? and a screenshot or the settings UI?

[houoop]

[houoop]

[philippe44]

Your config.xml contains all the log statements set to debug, for a reason I don't understand. Either erase the lines like <xxxxx_log>debug</xxxxx_log> or erase the whole file. But to erase if properly, stop the bridge, erase it, and restart the bridge. After a few seconds, it should re-created and then you can add the "additional mimetypes" and the post a log with "gapless" set to "No" and a failed track transition

[houoop]

Starting Squeeze2upnp: /config/cache/InstalledPlugins/Plugins/UPnPBridge/Bin/squeeze2upnp-x86-64-static -Z -I -f /config/logs/upnpbridge.log -x /config/prefs/upnpbridge.xml [15:59:41.930151] main:1774 Starting squeeze2upnp version: v1.81.3 (Jan 25 2022 @ 21:19:39) [15:59:41.932503] Start:1536 Binding to 192.168.6.189:49153 (http:0) [15:59:46.548656] AddMRDevice:1423 [0xc44b00]: adding renderer (小爱音箱-5260) [15:59:46.575277] slimproto:861 squeezelite [0xbbb140] <=> player [0xc44b00] [15:59:46.575357] slimproto:862 [0xbbb140] connecting to 192.168.6.189:3483 [15:59:46.575530] slimproto:892 [0xbbb140] connected [15:59:46.575604] sendHELO:135 [0xbbb140] cap: CanHTTPS=1,Model=squeezelite,ModelName=UPnPBridge,AccuratePlayPoints=0,HasDigitalOut=1,MaxSampleRate=48000,flc,mp3 [15:59:46.580104] MasterHandler:1054 [0xc44b00]: subscribe success [15:59:51.051442] AddMRDevice:1423 [0xc46e28]: adding renderer (小爱音箱-7643) [15:59:51.060351] slimproto:861 squeezelite [0xbbf608] <=> player [0xc46e28] [15:59:51.060434] slimproto:862 [0xbbf608] connecting to 192.168.6.189:3483 [15:59:51.061292] slimproto:892 [0xbbf608] connected [15:59:51.061433] sendHELO:135 [0xbbf608] cap: CanHTTPS=1,Model=squeezelite,ModelName=UPnPBridge,AccuratePlayPoints=0,HasDigitalOut=1,MaxSampleRate=48000,flc,mp3 [15:59:51.066756] MasterHandler:1054 [0xc46e28]: subscribe success [16:00:06.838971] AVTStop:217 [0xc44b00]: uPNP stop (cookie (nil)) [16:00:06.900070] process_strm:238 [0xbbb140] strm command s [16:00:06.900158] process_strm:307 [0xbbb140], strm s autostart: 1 transition period: 10 transition type: 0 codec: f [16:00:06.900184] sendSTAT:169 [0xbbb140]: STAT:[STMf] msplayed 0 [16:00:06.912582] output_start:81 [0xbbb140]: start thread 0 [16:00:06.912749] sq_callback:343 [0xc44b00]: artist:李健 album:似水流年 title:一辈子的十分钟 genre:无音乐曲风 duration:307.000 size:0 cover:http://192.168.6.189:9000/music/649e4470/cover_.jpg offset:0 [16:00:06.912786] sq_callback:382 [0xc44b00]: set current URI (s:0) http://192.168.6.189:37865/bridge-1.flac [16:00:06.912898] AVTSetURI:91 [0xc44b00]: uPNP setURI http://192.168.6.189:37865/bridge-1.flac (cookie 0x1) [16:00:06.913217] process_start:1220 [0xbbb140]: codec:c, ch:0, s:0, r:0 [16:00:06.913748] sendSTAT:169 [0xbbb140]: STAT:[STMc] msplayed 0 [16:00:06.924742] AVTSetPlayMode:167 [0xc44b00]: uPNP set play mode (cookie 0x2) [16:00:06.924932] AVTPlay:151 [0xc44b00]: uPNP play (cookie 0x2) [16:00:06.925012] CtrlSetVolume:245 [0xc44b00]: uPNP volume 19 (cookie 0x2) [16:00:07.019487] output_http_thread:157 [0xbbb140]: got HTTP connection 17 [16:00:07.019827] output_http_thread:186 [0xbbb140]: drain is 2621440 (waited 107) [16:00:07.023943] handle_http:483 [0xbbb140]: received GET /bridge-1.flac HTTP/1.1 [16:00:07.024036] handle_http:486 [0xbbb140]: HTTP headers Host: 192.168.6.189:37865 User-Agent: xiaoai Range: bytes=0- Connection: close Icy-MetaData: 1

[16:00:07.024168] handle_http:573 [0xbbb140]: responding: HTTP/1.1 200 OK Server: squeezebox-bridge Connection: close Content-Type: audio/flac Transfer-Encoding: chunked

[16:00:07.515820] SyncNotifState:687 小爱音箱-5260: uPNP playing [16:00:07.517158] sendSTAT:169 [0xbbb140]: STAT:[STMs] msplayed 0 [16:00:21.923581] output_http_thread:389 [0xbbb140]: end thread 0 (3506176 bytes) [16:00:21.925028] sendSTAT:169 [0xbbb140]: STAT:[STMf] msplayed 0 [16:00:21.925173] AVTStop:217 [0xc44b00]: uPNP stop (cookie 0x31) [16:00:21.942039] process_strm:238 [0xbbb140] strm command s [16:00:21.942132] process_strm:307 [0xbbb140], strm s autostart: 1 transition period: 10 transition type: 0 codec: f [16:00:21.942156] sendSTAT:169 [0xbbb140]: STAT:[STMf] msplayed 0 [16:00:21.953292] output_start:81 [0xbbb140]: start thread 0 [16:00:21.953630] sq_callback:343 [0xc44b00]: artist:李健 album:似水流年 title:一辈子的十分钟 genre:无音乐曲风 duration:24.675 size:0 cover:http://192.168.6.189:9000/music/649e4470/cover.jpg offset:0 [16:00:21.953676] sq_callback:382 [0xc44b00]: set current URI (s:0) http://192.168.6.189:60980/bridge-2.flac [16:00:21.953812] AVTSetURI:91 [0xc44b00]: uPNP setURI http://192.168.6.189:60980/bridge-2.flac (cookie 0x32) [16:00:21.953893] process_start:1220 [0xbbb140]: codec:c, ch:0, s:0, r:0 [16:00:21.954082] sendSTAT:169 [0xbbb140]: STAT:[STMc] msplayed 0 [16:00:22.048423] AVTSetPlayMode:167 [0xc44b00]: uPNP set play mode (cookie 0x33) [16:00:22.048568] AVTPlay:151 [0xc44b00]: uPNP play (cookie 0x33) [16:00:22.048636] CtrlSetVolume:245 [0xc44b00]: uPNP volume 19 (cookie 0x33) [16:00:22.173948] output_http_thread:157 [0xbbb140]: got HTTP connection 17 [16:00:22.174051] output_http_thread:186 [0xbbb140]: drain is 2621440 (waited 219) [16:00:22.177689] handle_http:483 [0xbbb140]: received GET /bridge-2.flac HTTP/1.1 [16:00:22.177729] handle_http:486 [0xbbb140]: HTTP headers Host: 192.168.6.189:60980 User-Agent: xiaoai Range: bytes=0- Connection: close Icy-MetaData: 1

[16:00:22.177837] handle_http:573 [0xbbb140]: responding: HTTP/1.1 200 OK Server: squeezebox-bridge Connection: close Content-Type: audio/flac Transfer-Encoding: chunked

[16:00:22.513889] process_strm:238 [0xbbb140] strm command u [16:00:22.513976] process_strm:287 [0xbbb140] unpause at: 0 now: 364046791 [16:00:22.514004] sendSTAT:169 [0xbbb140]: STAT:[STMr] msplayed 0 [16:00:22.661069] SyncNotifState:687 小爱音箱-5260: uPNP playing [16:00:22.663005] sendSTAT:169 [0xbbb140]: STAT:[STMs] msplayed 0 [16:00:22.718742] output_http_thread:389 [0xbbb140]: end thread 0 (1671168 bytes) [16:00:22.719609] AVTStop:217 [0xc44b00]: uPNP stop (cookie 0x38) [16:00:22.719838] process_strm:238 [0xbbb140] strm command s [16:00:22.719865] process_strm:307 [0xbbb140], strm s autostart: 1 transition period: 10 transition type: 0 codec: f [16:00:22.719888] sendSTAT:169 [0xbbb140]: STAT:[STMf] msplayed 0 [16:00:22.730036] output_start:81 [0xbbb140]: start thread 0 [16:00:22.730158] sq_callback:343 [0xc44b00]: artist:李健 album:似水流年 title:一辈子的十分钟 genre:无音乐曲风 duration:35.492 size:0 cover:http://192.168.6.189:9000/music/649e4470/cover.jpg offset:0 [16:00:22.730194] sq_callback:382 [0xc44b00]: set current URI (s:0) http://192.168.6.189:45907/bridge-3.flac [16:00:22.730318] AVTSetURI:91 [0xc44b00]: uPNP setURI http://192.168.6.189:45907/bridge-3.flac (cookie 0x39) [16:00:22.730388] process_start:1220 [0xbbb140]: codec:c, ch:0, s:0, r:0 [16:00:22.730611] sendSTAT:169 [0xbbb140]: STAT:[STMc] msplayed 0 [16:00:22.821869] AVTSetPlayMode:167 [0xc44b00]: uPNP set play mode (cookie 0x3a) [16:00:22.822019] AVTPlay:151 [0xc44b00]: uPNP play (cookie 0x3a) [16:00:22.822089] CtrlSetVolume:245 [0xc44b00]: uPNP volume 19 (cookie 0x3a) [16:00:23.021113] output_http_thread:157 [0xbbb140]: got HTTP connection 17 [16:00:23.022474] output_http_thread:186 [0xbbb140]: drain is 2621440 (waited 292) [16:00:23.032674] handle_http:483 [0xbbb140]: received GET /bridge-3.flac HTTP/1.1 [16:00:23.032774] handle_http:486 [0xbbb140]: HTTP headers Host: 192.168.6.189:45907 User-Agent: xiaoai Range: bytes=0- Connection: close Icy-MetaData: 1

[16:00:23.032919] handle_http:573 [0xbbb140]: responding: HTTP/1.1 200 OK Server: squeezebox-bridge Connection: close Content-Type: audio/flac Transfer-Encoding: chunked

[16:00:23.289754] process_strm:238 [0xbbb140] strm command u [16:00:23.289850] process_strm:287 [0xbbb140] unpause at: 0 now: 364047567 [16:00:23.289877] sendSTAT:169 [0xbbb140]: STAT:[STMr] msplayed 0 [16:00:23.867515] SyncNotifState:687 小爱音箱-5260: uPNP playing [16:00:23.868515] sendSTAT:169 [0xbbb140]: STAT:[STMs] msplayed 0 [16:00:31.768027] output_http_thread:306 [0xbbb140]: draining (3276800 bytes) [16:00:31.768175] sendSTAT:169 [0xbbb140]: STAT:[STMd] msplayed 7000 [16:00:31.800869] process_strm:238 [0xbbb140] strm command s [16:00:31.800957] process_strm:307 [0xbbb140], strm s autostart: 1 transition period: 10 transition type: 0 codec: f [16:00:31.800981] sendSTAT:169 [0xbbb140]: STAT:[STMf] msplayed 7000 [16:00:31.809127] output_start:81 [0xbbb140]: start thread 1 [16:00:31.809280] sq_callback:343 [0xc44b00]: artist:李健 album:无时无刻 title:我唯有的你 genre:Pop duration:252.091 size:0 cover:http://192.168.6.189:9000/music/631c1b46/cover.jpg offset:1 [16:00:31.809333] sq_callback:369 [0xc44b00]: next URI gapped (s:0) http://192.168.6.189:42932/bridge-4.flac [16:00:31.809356] process_start:1220 [0xbbb140]: codec:c, ch:0, s:0, r:0 [16:00:31.809541] sendSTAT:169 [0xbbb140]: STAT:[STMc] msplayed 7000 [16:00:35.752809] output_http_thread:258 [0xbbb140]: self-exit [16:00:35.753388] output_http_thread:389 [0xbbb140]: end thread 0 (3776321 bytes)

[philippe44]

Can you tell me what's happening in that log? Seems that 1st track plays but stops after ~20s and the player moves to the next one. Is this correct?

[houoop]

I just play a song , because The song need 5min to go to the end , I drag the progress bar to near the end， then several seconds later, it stop at the end, and the play buttion in web is also show "Playing", but it don't play any voice.

[philippe44]

I just play a song , because The song need 5min to go to the end , I drag the progress bar to near the end， then several seconds later, it stop at the end, and the play buttion in web is also show "Playing", but it don't play any voice.

Understood - that was pretty confusing. So, there is nothing in the log after, even waiting past the current track?

[16:00:31.809333] sq_callback:369 [0xc44b00]: next URI gapped (s:0) http://192.168.6.189:42932/bridge-4.flac
[16:00:31.809356] process_start:1220 [0xbbb140]: codec:c, ch:0, s:0, r:0
[16:00:31.809541] sendSTAT:169 [0xbbb140]: STAT:[STMc] msplayed 7000
[16:00:35.752809] output_http_thread:258 [0xbbb140]: self-exit
[16:00:35.753388] output_http_thread:389 [0xbbb140]: end thread 0 (3776321 bytes)

[houoop]

Yes , when it stopped , there was not logs any more. Then if I click the "NEXT BUTTON" in web ui , it can play next track normally

[houoop]

I just find these two line logs be added, maybe it can help you

[16:00:31.809541] sendSTAT:169 [0xbbb140]: STAT:[STMc] msplayed 7000 [16:00:35.752809] output_http_thread:258 [0xbbb140]: self-exit [16:00:35.753388] output_http_thread:389 [0xbbb140]: end thread 0 (3776321 bytes) [16:15:34.001027] slimproto_run:573 [0xbbb140] Closing CLI socket 10

[philippe44]

This is pretty amazing, the player does not even signal to its controller that it has stopped/finished!!! I know I'm repeating myself, but it seems an extremely broken UPnP implementation

[houoop]

the player is playing correctly when I use the "forked daapd" music server's DLNA.

[philippe44]

hmmm... I don't understand. AFAIK, forked daap is an AirPlay controller, not UPnP. Having said that, controllers which are just controller can more easily deal with broken players because they are the master of the system. My bridge is ... a bridge and has LMS as a master, so there are a bunch of aggressive actions I can no take "against" the player because LMS might counter them at any time. Out of curiosity, send me the exact reference (picture?) of the player so I can see if I can put my hands on one.

[houoop]

I use airconnect to switch upnp to airplay . what pictures do you want? I don't understand.

[philippe44]

Yes but if you use AirConnect, the way communication is handled with the UPnP device is different. There is no track change, so the problem where the player does not report an "end of track" is irrelevant because AirPlay is just one single big track. Re picture I mean there are so many Xiaomi products (even "smart speaker"), send me a picture of this exact one.

[philippe44]

Once thing you could do to help is take again a log when a track when a track ends and do not move to next one (Gapless set to "No") but also with in Additional Debugging, set "main application debugging". Clean the log, play 2 tracks and wait 30s after 1st track ends and nothing happens.

[houoop]

upnpbridge (3).log

I have two kind of product , they have same problem.

[philippe44]

Thanks - These log & pictures gave me the information I needed. I've already done a change to support the ProtocolInfo returned by that player but if possible I'd like to get one last detail. In the same conditions than above, can you use DeviceSpy and invoke the "GetTransportInfo", under the "AVTransport service one time when it is playing and, ~15s after it has stopped and has not moved to next track, invoke it again and tell me what is the "CurrentTransportState" in both cases?

[houoop]

when it's playing , CurrentTransportState is "PLAYING", and when it's play ended after 15s, CurrentTransportState is also "PLAYING"

[philippe44]

Thanks - that confirms the problem, crap. I have to decide if I do yet another workaround for a faulty player or not - this is how you destroy standards by making compromises ☹️

[houoop]

when I stop the song in the middle progress, then I play contine , it will replay this song from the start

[houoop]

yes, I know , can you write a special-purpose（for xiaomi player）settings file for these palyer to fix these problem. we can choose this setting by ourself.

[philippe44]

I've pushed a version 1.82.0. Can you, in the following order

1- Does it solve the problem of not moving to next track with the configration above 2- If you set HTTP mode to "no length" does it work 3- Different topic: if you remove the "extra mimetype" in the settings does it now plays mp3/flac normally

In all 3 cases, if it fails, can you add the log

[houoop]

when I start the new version plguin, it restart always

Starting Squeeze2upnp: /config/cache/InstalledPlugins/Plugins/UPnPBridge/Bin/squeeze2upnp-x86-64-static -Z -I -f /config/logs/upnpbridge.log -d main=debug -x /config/prefs/upnpbridge.xml [15:49:49.930975] main:1774 Starting squeeze2upnp version: v1.82.0 (Jan 28 2022 @ 23:31:15) [15:49:49.937093] Start:1536 Binding to 192.168.6.189:49155 (http:0) [15:49:56.866927] AddMRDevice:1423 [0xc44b00]: adding renderer (小爱音箱-5260)

Retarting Squeeze2upnp after crash: /config/cache/InstalledPlugins/Plugins/UPnPBridge/Bin/squeeze2upnp-x86-64-static -Z -I -f /config/logs/upnpbridge.log -d main=debug -x /config/prefs/upnpbridge.xml [15:50:02.172597] main:1774 Starting squeeze2upnp version: v1.82.0 (Jan 28 2022 @ 23:31:15) [15:50:02.227686] Start:1536 Binding to 192.168.6.189:49154 (http:0) [15:50:04.365732] AddMRDevice:1423 [0xc44b00]: adding renderer (小爱音箱-7643)

Retarting Squeeze2upnp after crash: /config/cache/InstalledPlugins/Plugins/UPnPBridge/Bin/squeeze2upnp-x86-64-static -Z -I -f /config/logs/upnpbridge.log -d main=debug -x /config/prefs/upnpbridge.xml -i /config/prefs/upnpbridge.xml [15:50:16.070382] main:1774 Starting squeeze2upnp version: v1.82.0 (Jan 28 2022 @ 23:31:15) [15:50:16.072802] Start:1536 Binding to 192.168.6.189:49154 (http:0) [15:50:17.706996] AddMRDevice:1423 [0xc44b00]: adding renderer (小爱音箱-7643) [15:50:17.715641] UpdateThread:1273 Updating configuration /config/prefs/upnpbridge.xml [15:50:17.726330] MasterHandler:1054 [0xc44b00]: subscribe success [15:50:21.058752] AddMRDevice:1423 [0xc46e28]: adding renderer (小爱音箱-5260) [15:50:21.070138] UpdateThread:1273 Updating configuration /config/prefs/upnpbridge.xml [15:50:21.086470] MasterHandler:1054 [0xc46e28]: subscribe success [15:50:25.921444] UpdateThread:1169 [0xc44b00] UPnP keep alive: 小爱音箱-7643 [15:50:31.879454] UpdateThread:1169 [0xc46e28] UPnP keep alive: 小爱音箱-5260 [15:50:36.000362] UpdateThread:1110 Presence checking [15:50:36.201203] UpdateThread:1110 Presence checking [15:50:37.482607] Stop:1558 stopping squeezelite devices ... [15:50:37.482741] Stop:1562 terminate update thread ... [15:50:37.488438] Stop:1567 terminate main thread ... [15:50:37.488535] Stop:1571 stopping UPnP devices ... [15:50:37.495304] Stop:1574 un-register libupnp callbacks ... [15:50:37.509303] Stop:1576 end libupnp ...

Retarting Squeeze2upnp after crash: /config/cache/InstalledPlugins/Plugins/UPnPBridge/Bin/squeeze2upnp-x86-64-static -Z -I -f /config/logs/upnpbridge.log -d main=debug -x /config/prefs/upnpbridge.xml -i /config/prefs/upnpbridge.xml [15:50:46.077538] main:1774 Starting squeeze2upnp version: v1.82.0 (Jan 28 2022 @ 23:31:15) [15:50:46.078720] Start:1536 Binding to 192.168.6.189:49153 (http:0) [15:50:50.577322] AddMRDevice:1423 [0xc44b00]: adding renderer (小爱音箱-7643) [15:50:50.586019] UpdateThread:1273 Updating configuration /config/prefs/upnpbridge.xml [15:50:50.593469] MasterHandler:1054 [0xc44b00]: subscribe success [15:50:51.325681] AddMRDevice:1423 [0xc46e28]: adding renderer (小爱音箱-5260) [15:50:51.334114] UpdateThread:1273 Updating configuration /config/prefs/upnpbridge.xml [15:50:51.341735] MasterHandler:1054 [0xc46e28]: subscribe success [15:50:56.738116] UpdateThread:1169 [0xc44b00] UPnP keep alive: 小爱音箱-7643 [15:50:59.693877] UpdateThread:1169 [0xc46e28] UPnP keep alive: 小爱音箱-5260 [15:51:06.000332] UpdateThread:1110 Presence checking [15:51:06.201518] UpdateThread:1110 Presence checking [15:51:07.485246] Stop:1558 stopping squeezelite devices ... [15:51:07.485385] Stop:1562 terminate update thread ... [15:51:07.485714] Stop:1567 terminate main thread ... [15:51:07.485820] Stop:1571 stopping UPnP devices ... [15:51:12.507409] Stop:1574 un-register libupnp callbacks ... [15:51:12.507510] Stop:1576 end libupnp ...

[houoop]

this is the "Additional debugging"=All log

Retarting Squeeze2upnp after crash: /config/cache/InstalledPlugins/Plugins/UPnPBridge/Bin/squeeze2upnp-x86-64-static -Z -I -f /config/logs/upnpbridge.log -d main=debug -x /config/prefs/upnpbridge.xml [15:57:09.776280] main:1774 Starting squeeze2upnp version: v1.82.0 (Jan 28 2022 @ 23:31:15) [15:57:09.778289] register_alac:541 using alac to decode alc [15:57:09.778372] register_mad:433 using mad to decode mp3 [15:57:09.778395] register_faad:647 using faad to decode aac [15:57:09.778415] register_vorbis:346 using vorbis to decode ogg [15:57:09.778435] register_pcm:339 using pcm [15:57:09.778456] register_flac:313 using flac to decode flc [15:57:09.778476] register_opus:286 using opus to decode ops [15:57:09.778495] register_m4a_thru:307 using mp4 to aac (ADTS) [15:57:09.778516] register_flac_thru:212 using flac [15:57:09.778536] register_thru:106 using thru [15:57:09.778555] register_soxr:394 using soxr for resampling [15:57:09.778577] Start:1536 Binding to 192.168.6.189:49154 (http:0) [15:57:12.690520] AddMRDevice:1423 [0xc44b00]: adding renderer (小爱音箱-7643) [15:57:12.690604] GetProtocolInfo:359 [0xc44b00]: uPNP GetProtocolInfo [15:57:12.700196] GetProtocolInfo:370 [0xc44b00]: ProtocolInfo http-get:::* [15:57:12.700465] stream_thread_init:464 [0xbbb140] streambuf size: 1048576 [15:57:12.701604] output_thread_init:616 [0xbbb140] init output media renderer [15:57:12.701891] decode_thread_init:168 [0xbbb140]: init decode [15:57:12.702005] resample_init:345 [0xbbb140]: resampling sync recipe: 0x00, flags: 0x00, scale: 0.89, precision: 0.0, passband_end: 0.00000, stopband_begin: 0.00000, phase_response: -1.0

Retarting Squeeze2upnp after crash: /config/cache/InstalledPlugins/Plugins/UPnPBridge/Bin/squeeze2upnp-x86-64-static -Z -I -f /config/logs/upnpbridge.log -d main=debug -x /config/prefs/upnpbridge.xml -i /config/prefs/upnpbridge.xml [15:57:16.175960] main:1774 Starting squeeze2upnp version: v1.82.0 (Jan 28 2022 @ 23:31:15) [15:57:16.177374] register_alac:541 using alac to decode alc [15:57:16.177454] register_mad:433 using mad to decode mp3 [15:57:16.177475] register_faad:647 using faad to decode aac [15:57:16.177495] register_vorbis:346 using vorbis to decode ogg [15:57:16.177514] register_pcm:339 using pcm [15:57:16.177534] register_flac:313 using flac to decode flc [15:57:16.177553] register_opus:286 using opus to decode ops [15:57:16.177572] register_m4a_thru:307 using mp4 to aac (ADTS) [15:57:16.177591] register_flac_thru:212 using flac [15:57:16.177611] register_thru:106 using thru [15:57:16.177630] register_soxr:394 using soxr for resampling [15:57:16.177651] Start:1536 Binding to 192.168.6.189:49154 (http:0) [15:57:21.416545] AddMRDevice:1423 [0xc44b00]: adding renderer (小爱音箱-5260) [15:57:21.416654] GetProtocolInfo:359 [0xc44b00]: uPNP GetProtocolInfo [15:57:21.438341] GetProtocolInfo:370 [0xc44b00]: ProtocolInfo http-get:::* [15:57:21.438728] UpdateThread:1273 Updating configuration /config/prefs/upnpbridge.xml [15:57:21.450007] MasterHandler:1054 [0xc44b00]: subscribe success [15:57:21.460427] AddMRDevice:1423 [0xc46e28]: adding renderer (小爱音箱-7643) [15:57:21.460503] GetProtocolInfo:359 [0xc46e28]: uPNP GetProtocolInfo [15:57:21.468399] GetProtocolInfo:370 [0xc46e28]: ProtocolInfo http-get:::* [15:57:21.468732] UpdateThread:1273 Updating configuration /config/prefs/upnpbridge.xml [15:57:21.476002] MasterHandler:1054 [0xc46e28]: subscribe success [15:57:25.577468] UpdateThread:1169 [0xc46e28] UPnP keep alive: 小爱音箱-7643 [15:57:36.001314] UpdateThread:1110 Presence checking [15:57:36.202261] UpdateThread:1110 Presence checking [15:57:36.277394] UpdateThread:1169 [0xc44b00] UPnP keep alive: 小爱音箱-5260 [15:57:37.262440] UpdateThread:1169 [0xc44b00] UPnP keep alive: 小爱音箱-5260 [15:57:37.579845] Stop:1558 stopping squeezelite devices ... [15:57:37.579971] Stop:1562 terminate update thread ... [15:57:37.580286] Stop:1567 terminate main thread ... [15:57:37.580713] Stop:1571 stopping UPnP devices ... [15:57:42.581316] Stop:1574 un-register libupnp callbacks ... [15:57:42.581410] Stop:1576 end libupnp ...

[philippe44]

Sorry, somethign wrong with the build, I'll fix it quickly

[philippe44]

Version 1.82.1 should be visible soon. If it still does not fix the issue, I'll rethink about it tomorrow!

[houoop]

1- Does it solve the problem of not moving to next track with the configration above it have same problem. no change. 2- If you set HTTP mode to "no length" does it work not work 3- Different topic: if you remove the "extra mimetype" in the settings does it now plays mp3/flac normally can't play

[philippe44]

argh... can you try for 3- to add in "Extra command line options" the following "-d all=info" and just restart the plugin (clean the log before is always good) so that I can see where the problem remains? It will likely require a few more logs but I'd like to start with that.

[Skylakc]

Hello Philippie! Happy Chinese New Year! My XiaoMi Soundbox Pro has same problem, it can't play anything by upnp bridge (both DMR and DMS). But It could be controlled by foobar2000 Upnp plugin. When I press the "play button", it doesn't work, and never entered in play mode. The logs look similar to @houoop and @laomao9000 .

----------------LOG--------------- [22:08:32.190793] ActionHandler:837 [0xc46e28]: Waited action StopResponse [22:08:32.196325] process:500 [0xbbf608] audg [22:08:32.196396] process_audg:406 [0xbbf608] (old) audg gainL: 46 gainR: 46 [22:08:32.197232] process:500 [0xbbf608] strm [22:08:32.197272] process_strm:238 [0xbbf608] strm command s [22:08:32.197291] process_strm:307 [0xbbf608], strm s autostart: 1 transition period: 10 transition type: 0 codec: m [22:08:32.197311] sendSTAT:169 [0xbbf608]: STAT:[STMf] msplayed 0 [22:08:32.197369] process_strm:322 [0xbbf608]: set fade mode: 0 [22:08:32.206471] sq_get_metadata:518 [0xbbf608]: idx 0 artist:Green Day album:21st Century Breakdown title:21 Guns genre:鏃犻煶涔愭洸椋� duration:321.123 size:0 cover:http://10.10.1.8:9001/music/a2ead641/cover_.jpg [22:08:32.206559] process_start:1226 [0xbbf608]: something went wrong starting process 14 [22:08:32.206613] connect_socket:155 [0xbbf608] connecting to 10.10.1.8:9001 [22:08:32.206814] stream_sock:592 [0xbbf608] header: GET /stream.mp3?player=bb:bb:6b:17:5a:08 HTTP/1.0

[22:08:32.206848] sendSTAT:169 [0xbbf608]: STAT:[STMc] msplayed 0 [22:08:32.206899] process_strm:342 [0xbbf608] no matching codec m [22:08:32.206918] sendSTAT:169 [0xbbf608]: STAT:[STMn] msplayed 0 [22:08:32.206978] process:500 [0xbbf608] audg [22:08:32.207000] process_audg:406 [0xbbf608] (old) audg gainL: 46 gainR: 46 [22:08:32.210025] process:500 [0xbbf608] strm [22:08:32.210075] process_strm:241 [0xbbf608] strm command q [22:08:32.210093] decode_flush:208 [0xbbf608]: decode flush [22:08:32.210140] output_flush:611 [0xbbf608]: flush output buffer [22:08:32.210309] sendSTAT:169 [0xbbf608]: STAT:[STMf] msplayed 0 [22:08:32.210379] AVTStop:217 [0xc46e28]: uPNP stop (cookie 0x1d) [22:08:32.221958] ActionHandler:837 [0xc46e28]: Waited action StopResponse

[Skylakc]

Well, It works! Here are my config screenshot. The most importent config is Additional MimeTypes Thanks a lot everyone!

[Skylakc]

I found a new issue, When I call up my AI Sound Box, It will be interrupted. And the playing can't resume. I think the issue is similar to ""the player could't moving to next song". This looks like the LMS and the speaker are not getting the end signal from each other at the end of playback. Because the phenomenon is that the LMS web ui side shows thar it has been playing, but the speaker through the light indicates that it is entering the buffing. I capture the packets through wireshark and it looks like everything is fine.

[philippe44]

That would be really great if one of you could give me the log here https://github.com/philippe44/LMS-to-uPnP/issues/57#issuecomment-1025058695 so that I can see why the first change I've made does not remove the need of setting "additional MimeTypes"

新年快樂 虎年行大運

[Skylakc]

Here are my logs. and the config screenshot

First, I play "Not Afraid-Eminem", and i change volume (turn it down and up),it works. （If I restart the plug-in at this time or manually click pause at the beginning or the next song, everything is fine） Then I dragged the music progress bar to the end. What you can see in the log is that the new audio stream is ready to be pushed, but the speaker is not responding.

I've been online this afternoon and may be able to help debug ---------------LOG----------- Starting Squeeze2upnp: /var/lib/squeezeboxserver/cache/InstalledPlugins/Plugins/UPnPBridge/Bin/squeeze2upnp-x86-64 -Z -I -f /var/log/squeezeboxserver/upnpbridge.log -d all=debug -x /var/lib/squeezeboxserver/prefs/upnpbridge.xml -d all=info [15:06:20.940420] main:1774 Starting squeeze2upnp version: v1.82.1 (Jan 29 2022 @ 00:03:57) [15:06:20.949505] output_init:652 success loading FLAC encoder [15:06:20.949779] register_alac:541 using alac to decode alc [15:06:20.950051] load_mad:392 dlerror: libmad.so.0: cannot open shared object file: No such file or directory [15:06:20.950322] load_faad:608 dlerror: libfaad.so.2: cannot open shared object file: No such file or directory [15:06:20.951191] load_vorbis:325 loaded libvorbisfile.so.3 [15:06:20.951228] register_vorbis:346 using vorbis to decode ogg [15:06:20.951243] register_pcm:339 using pcm [15:06:20.951266] load_flac:292 loaded libFLAC.so.8 [15:06:20.951280] register_flac:313 using flac to decode flc [15:06:20.951454] load_opus:251 dlerror: libopusfile.so.0: cannot open shared object file: No such file or directory [15:06:20.951481] register_m4a_thru:307 using mp4 to aac (ADTS) [15:06:20.951495] register_flac_thru:212 using flac [15:06:20.951505] register_thru:106 using thru [15:06:20.951515] register_soxr:394 using soxr for resampling [15:06:20.951541] Start:1536 Binding to 10.10.1.8:49154 (http:0) [15:06:21.000956] AddMRDevice:1423 [0x75d200]: adding renderer (瀹㈠巺鐢佃 DMR) [15:06:21.014357] resample_init:345 [0x6d3680]: resampling sync recipe: 0x00, flags: 0x00, scale: 0.89, precision: 0.0, passband_end: 0.00000, stopband_begin: 0.00000, phase_response: -1.0 [15:06:21.015190] MasterHandler:1054 [0x75d200]: subscribe success [15:06:21.166175] slimproto:861 squeezelite [0x6d3680] <=> player [0x75d200] [15:06:21.166329] slimproto:862 [0x6d3680] connecting to 10.10.1.8:3483 [15:06:21.166533] slimproto:892 [0x6d3680] connected [15:06:21.166581] sendHELO:135 [0x6d3680] cap: CanHTTPS=1,Model=squeezelite,ModelName=UPnPBridge,AccuratePlayPoints=0,HasDigitalOut=1,MaxSampleRate=48000,aac,ogg,flc,wav,aif,pcm,mp3 [15:06:35.384992] AddMRDevice:1423 [0x75f528]: adding renderer (灏忕埍闊崇-9033) [15:06:35.398775] resample_init:345 [0x6d7b48]: resampling sync recipe: 0x00, flags: 0x00, scale: 0.89, precision: 0.0, passband_end: 0.00000, stopband_begin: 0.00000, phase_response: -1.0 [15:06:35.399499] slimproto:861 squeezelite [0x6d7b48] <=> player [0x75f528] [15:06:35.399542] slimproto:862 [0x6d7b48] connecting to 10.10.1.8:3483 [15:06:35.399715] slimproto:892 [0x6d7b48] connected [15:06:35.399769] sendHELO:135 [0x6d7b48] cap: CanHTTPS=1,Model=squeezelite,ModelName=UPnPBridge,AccuratePlayPoints=0,HasDigitalOut=1,MaxSampleRate=48000,aac,ogg,ops,ogf,flc,alc,wav,aif,pcm,mp3 [15:06:35.406977] MasterHandler:1054 [0x75f528]: subscribe success [15:06:44.008551] AVTStop:217 [0x75f528]: uPNP stop (cookie (nil)) [15:06:44.066826] process_strm:238 [0x6d7b48] strm command s [15:06:44.066877] process_strm:307 [0x6d7b48], strm s autostart: 1 transition period: 10 transition type: 1 codec: m [15:06:44.066887] sendSTAT:169 [0x6d7b48]: STAT:[STMf] msplayed 0 [15:06:44.067116] cli_open_socket:186 [0x6d7b48]: opened CLI socket 9 [15:06:44.085018] thru_open:85 [0x6d7b48]: thru codec [15:06:44.085094] output_start:81 [0x6d7b48]: start thread 0 [15:06:44.085213] sq_callback:343 [0x75f528]: artist:Eminem album:Not Afraid title:Not Afraid (main) genre:鏃犻煶涔愭洸椋� duration:250.653 size:0 cover: offset:0 [15:06:44.085242] sq_callback:382 [0x75f528]: set current URI (s:0) http://10.10.1.8:49899/bridge-1.mp3 [15:06:44.085346] AVTSetURI:91 [0x75f528]: uPNP setURI http://10.10.1.8:49899/bridge-1.mp3 (cookie 0x1) [15:06:44.085817] process_start:1220 [0x6d7b48]: codec:*, ch:0, s:0, r:0 [15:06:44.085858] connect_socket:155 [0x6d7b48] connecting to 10.10.1.8:9001 [15:06:44.086011] stream_sock:592 [0x6d7b48] header: GET /stream.mp3?player=bb:bb:6b:17:5a:08 HTTP/1.0

[15:06:44.086244] sendSTAT:169 [0x6d7b48]: STAT:[STMc] msplayed 0 [15:06:44.117660] stream_thread:337 [0x6d7b48] headers: len: 490 HTTP/1.1 200 OK Server: Logitech Media Server (8.3.0 - 1641484361) Connection: close Content-Type: audio/mpeg Set-Cookie: Squeezebox-albumView=; path=/ Set-Cookie: Squeezebox-expandPlayerControl=true; path=/ Set-Cookie: Squeezebox-expanded-MY_MUSIC=1; path=/ Set-Cookie: Squeezebox-expanded-FAVORITES=1; path=/ Set-Cookie: Squeezebox-expanded-PLUGINS=0; path=/ Set-Cookie: Squeezebox-expanded-PLUGIN_MY_APPS_MODULE_NAME=; path=/ Set-Cookie: Squeezebox-expanded-RADIO=0; path=/

[15:06:44.187622] output_http_thread:159 [0x6d7b48]: got HTTP connection 16 [15:06:45.302334] AVTSetPlayMode:167 [0x75f528]: uPNP set play mode (cookie 0x2) [15:06:45.302532] AVTPlay:151 [0x75f528]: uPNP play (cookie 0x3) [15:06:45.302588] CtrlSetVolume:245 [0x75f528]: uPNP volume 49 (cookie 0x3) [15:06:45.314435] thru_decode:56 [0x6d7b48]: setting track_start [15:06:45.345116] output_http_thread:188 [0x6d7b48]: drain is 2621440 (waited 1259) [15:06:45.345366] handle_http:485 [0x6d7b48]: received GET /bridge-1.mp3 HTTP/1.1 [15:06:45.345390] handle_http:488 [0x6d7b48]: HTTP headers Host: 10.10.1.8:49899 User-Agent: xiaoai Range: bytes=0- Connection: close Icy-MetaData: 1

[15:06:45.345487] handle_http:575 [0x6d7b48]: responding: HTTP/1.1 200 OK Server: squeezebox-bridge Connection: close Content-Type: audio/mp3 Transfer-Encoding: chunked

[15:06:45.880933] _SyncNotifState:687 灏忕埍闊崇-9033: uPNP playing [15:06:45.880978] sq_notify:598 [0x6d7b48] play notification [15:06:45.881195] sq_notify:715 [0x6d7b48] track 1 started by info at 572286718 [15:06:45.881275] sendSTAT:169 [0x6d7b48]: STAT:[STMs] msplayed 0 [15:06:56.831055] CtrlSetVolume:245 [0x75f528]: uPNP volume 19 (cookie 0x28) [15:07:02.136342] CtrlSetVolume:245 [0x75f528]: uPNP volume 49 (cookie 0x38) [15:07:10.247350] stream_thread:411 [0x6d7b48] end of stream (t:8730061) [15:07:14.209240] output_http_thread:391 [0x6d7b48]: end thread 0 (2949120 bytes) [15:07:14.209870] AVTStop:217 [0x75f528]: uPNP stop (cookie 0x5d) [15:07:14.210051] process_strm:238 [0x6d7b48] strm command s [15:07:14.210076] process_strm:307 [0x6d7b48], strm s autostart: 1 transition period: 10 transition type: 1 codec: m [15:07:14.210086] sendSTAT:169 [0x6d7b48]: STAT:[STMf] msplayed 0 [15:07:14.231245] thru_open:85 [0x6d7b48]: thru codec [15:07:14.231346] output_start:81 [0x6d7b48]: start thread 0 [15:07:14.231477] sq_callback:343 [0x75f528]: artist:Eminem album:Not Afraid title:Not Afraid (main) genre:鏃犻煶涔愭洸椋� duration:8.354 size:0 cover: offset:0 [15:07:14.231515] sq_callback:382 [0x75f528]: set current URI (s:1) http://10.10.1.8:54215/bridge-2.mp3 [15:07:14.231614] AVTSetURI:91 [0x75f528]: uPNP setURI http://10.10.1.8:54215/bridge-2.mp3 (cookie 0x5e) [15:07:14.231927] process_start:1220 [0x6d7b48]: codec:*, ch:0, s:0, r:0 [15:07:14.231981] connect_socket:155 [0x6d7b48] connecting to 10.10.1.8:9001 [15:07:14.232128] stream_sock:592 [0x6d7b48] header: GET /stream.mp3?player=bb:bb:6b:17:5a:08 HTTP/1.0

[15:07:14.232153] sendSTAT:169 [0x6d7b48]: STAT:[STMc] msplayed 0 [15:07:14.261838] stream_thread:337 [0x6d7b48] headers: len: 490 HTTP/1.1 200 OK Server: Logitech Media Server (8.3.0 - 1641484361) Connection: close Content-Type: audio/mpeg Set-Cookie: Squeezebox-albumView=; path=/ Set-Cookie: Squeezebox-expandPlayerControl=true; path=/ Set-Cookie: Squeezebox-expanded-MY_MUSIC=1; path=/ Set-Cookie: Squeezebox-expanded-FAVORITES=1; path=/ Set-Cookie: Squeezebox-expanded-PLUGINS=0; path=/ Set-Cookie: Squeezebox-expanded-PLUGIN_MY_APPS_MODULE_NAME=; path=/ Set-Cookie: Squeezebox-expanded-RADIO=0; path=/

[15:07:14.402559] output_http_thread:159 [0x6d7b48]: got HTTP connection 16 [15:07:14.577344] _SyncNotifState:637 [0x75f528]: uPNP transition [15:07:15.538375] AVTSetPlayMode:167 [0x75f528]: uPNP set play mode (cookie 0x61) [15:07:15.538518] AVTPlay:151 [0x75f528]: uPNP play (cookie 0x62) [15:07:15.538568] CtrlSetVolume:245 [0x75f528]: uPNP volume 49 (cookie 0x62) [15:07:15.555866] thru_decode:56 [0x6d7b48]: setting track_start [15:07:15.556695] output_http_thread:188 [0x6d7b48]: drain is 2621440 (waited 1325) [15:07:15.557000] handle_http:485 [0x6d7b48]: received GET /bridge-2.mp3 HTTP/1.1 [15:07:15.557149] handle_http:488 [0x6d7b48]: HTTP headers Host: 10.10.1.8:54215 User-Agent: xiaoai Range: bytes=0- Connection: close Icy-MetaData: 1

[15:07:15.557369] handle_http:575 [0x6d7b48]: responding: HTTP/1.1 200 OK Server: squeezebox-bridge Connection: close Content-Type: audio/mp3 Transfer-Encoding: chunked

[15:07:15.816610] _SyncNotifState:687 灏忕埍闊崇-9033: uPNP playing [15:07:15.816658] sq_notify:598 [0x6d7b48] play notification [15:07:16.046598] stream_thread:411 [0x6d7b48] end of stream (t:285095) [15:07:16.047675] process_strm:238 [0x6d7b48] strm command u [15:07:16.047740] process_strm:287 [0x6d7b48] unpause at: 0 now: 572316885 [15:07:16.047783] sendSTAT:169 [0x6d7b48]: STAT:[STMr] msplayed 0 [15:07:16.057203] decode_thread:96 decode complete [15:07:16.057481] _checkfade:914 [0x6d7b48]: fade mode: 1 duration: 10 track-end [15:07:16.059408] output_http_thread:308 [0x6d7b48]: draining (285095 bytes) [15:07:16.109645] output_http_thread:260 [0x6d7b48]: self-exit [15:07:16.109885] output_http_thread:391 [0x6d7b48]: end thread 0 (285095 bytes) [15:07:16.256028] sq_notify:715 [0x6d7b48] track 2 started by info at 572317093 [15:07:16.256167] sendSTAT:169 [0x6d7b48]: STAT:[STMs] msplayed 0 [15:07:17.257392] sendSTAT:169 [0x6d7b48]: STAT:[STMd] msplayed 0 [15:07:17.275272] process_strm:238 [0x6d7b48] strm command s [15:07:17.275358] process_strm:307 [0x6d7b48], strm s autostart: 1 transition period: 10 transition type: 1 codec: m [15:07:17.275384] sendSTAT:169 [0x6d7b48]: STAT:[STMf] msplayed 0 [15:07:17.294673] thru_open:85 [0x6d7b48]: thru codec [15:07:17.294965] output_start:81 [0x6d7b48]: start thread 0 [15:07:17.295275] sq_callback:343 [0x75f528]: artist:Green Day album:Warning: title:Misery genre:鏃犻煶涔愭洸椋� duration:305.867 size:0 cover: offset:1 [15:07:17.295342] sq_callback:369 [0x75f528]: next URI gapped (s:1) http://10.10.1.8:41041/bridge-3.mp3 [15:07:17.295367] process_start:1220 [0x6d7b48]: codec:*, ch:0, s:0, r:0 [15:07:17.295415] connect_socket:155 [0x6d7b48] connecting to 10.10.1.8:9001 [15:07:17.295624] stream_sock:592 [0x6d7b48] header: GET /stream.mp3?player=bb:bb:6b:17:5a:08 HTTP/1.0

[15:07:17.295661] sendSTAT:169 [0x6d7b48]: STAT:[STMc] msplayed 0 [15:07:17.359886] stream_thread:337 [0x6d7b48] headers: len: 490 HTTP/1.1 200 OK Server: Logitech Media Server (8.3.0 - 1641484361) Connection: close Content-Type: audio/mpeg Set-Cookie: Squeezebox-albumView=; path=/ Set-Cookie: Squeezebox-expandPlayerControl=true; path=/ Set-Cookie: Squeezebox-expanded-MY_MUSIC=1; path=/ Set-Cookie: Squeezebox-expanded-FAVORITES=1; path=/ Set-Cookie: Squeezebox-expanded-PLUGINS=0; path=/ Set-Cookie: Squeezebox-expanded-PLUGIN_MY_APPS_MODULE_NAME=; path=/ Set-Cookie: Squeezebox-expanded-RADIO=0; path=/

[15:07:17.459950] thru_decode:56 [0x6d7b48]: setting track_start [15:07:17.882477] stream_thread:411 [0x6d7b48] end of stream (t:4894301) [15:07:17.883959] process_strm:238 [0x6d7b48] strm command u [15:07:17.884023] process_strm:287 [0x6d7b48] unpause at: 0 now: 572318721 [15:07:17.884046] sendSTAT:169 [0x6d7b48]: STAT:[STMr] msplayed 0

[philippe44]

The problem of not moving to "next" track can be solved by setting "Gapless" to "force", but this is not great as you should see that the last track will not end.

For the rest, would you know how to copy the attached binary file and replace the existing one in /var/lib/squeezeboxserver/cache/InstalledPlugins/plugins/UPnPBridge/Bin and take a log on just trying to play one track without the additional mimetypes? squeeze2upnp-x86-64.zip

[Skylakc]

Hello, I'm back! I replaced my binary file by WinSCP and erase my config file. Now I generate a new config file. But it crash all the time when I try to play.

-------------LOG-------------- Retarting Squeeze2upnp after crash: /var/lib/squeezeboxserver/cache/InstalledPlugins/Plugins/UPnPBridge/Bin/squeeze2upnp-x86-64-static -Z -I -f /var/log/squeezeboxserver/upnpbridge.log -d all=debug -x /var/lib/squeezeboxserver/prefs/upnpbridge.xml [16:10:11.801741] main:1774 Starting squeeze2upnp version: v1.82.1 (Jan 29 2022 @ 00:03:57) [16:10:11.855127] register_alac:541 using alac to decode alc [16:10:11.855253] register_mad:433 using mad to decode mp3 [16:10:11.855284] register_faad:647 using faad to decode aac [16:10:11.855306] register_vorbis:346 using vorbis to decode ogg [16:10:11.855326] register_pcm:339 using pcm [16:10:11.855344] register_flac:313 using flac to decode flc [16:10:11.855363] register_opus:286 using opus to decode ops [16:10:11.855383] register_m4a_thru:307 using mp4 to aac (ADTS) [16:10:11.855400] register_flac_thru:212 using flac [16:10:11.855417] register_thru:106 using thru [16:10:11.855435] register_soxr:394 using soxr for resampling [16:10:11.855455] Start:1536 Binding to 10.10.1.8:49156 (http:0) [16:10:11.914492] AddMRDevice:1423 [0xc44b00]: adding renderer (瀹㈠巺鐢佃 DMR) [16:10:11.914598] GetProtocolInfo:359 [0xc44b00]: uPNP GetProtocolInfo [16:10:11.921946] GetProtocolInfo:370 [0xc44b00]: ProtocolInfo http-get::video/webm:,http-get::audio/x-ms-wma:,http-get::image/jpeg:,http-get::###############################################################################:,http-get::video/x-matroska:,http-get::image/gif:,http-get::image/x-ms-bmp:,http-get::audio/midi:,http-get::video/x-ms-wm:,http-get::application/x-shockwave-flash:,http-get::image/webp:,http-get::video/mp2ts:,http-get::video/x-msvideo:,http-get::video/m2ts:,http-get::video/x-flv:,http-get::image/pns:,http-get::audio/x-flac:,http-get::audio/x-wav:,http-get::audio/x-pn-realaudio:,http-get::video/dvd:,http-get::audio/x-aiff:,http-get::video/mp2p:,http-get::video/dat:,http-get::image/png:,http-get::video/avi:,http-get::application/octet-stream:,http-get::video/x-ms-asf:,http-get::video/3gpp:,http-get::video/x-pn-realvideo:,http-get::video/x-ms-wvx:,http-get::audio/aac:,http-get::application/vnd.android.package-archive:,http-get::audio/flac:,http-get::audio/mpeg:,http-get::image/mpo:,http-get::audio/ogg:,http-get::video/x-ms-wmv:,http-get::video/mpeg:,http-get::video/x-ms-wmx:,http-get::image/x-jps:,http-get::video/m4v:,http-get::video/mts:,http-get::video/quicktime:,http-get::video/mp4:, [16:10:11.922602] stream_thread_init:464 [0xbbb140] streambuf size: 1048576 [16:10:11.924577] output_thread_init:616 [0xbbb140] init output media renderer [16:10:11.924666] decode_thread_init:168 [0xbbb140]: init decode [16:10:11.925888] resample_init:345 [0xbbb140]: resampling sync recipe: 0x00, flags: 0x00, scale: 0.89, precision: 0.0, passband_end: 0.00000, stopband_begin: 0.00000, phase_response: -1.0 [16:10:11.925966] UpdateThread:1273 Updating configuration /var/lib/squeezeboxserver/prefs/upnpbridge.xml [16:10:11.925977] discover_server:809 [0xbbb140] sending discovery [16:10:11.926973] UpdateThread:1169 [0xc44b00] UPnP keep alive: 瀹㈠巺鐢佃 DMR [16:10:11.927208] discover_server:841 [0xbbb140] got response from: 10.10.1.8:3483 [16:10:11.927262] slimproto:861 squeezelite [0xbbb140] <=> player [0xc44b00] [16:10:11.927288] slimproto:862 [0xbbb140] connecting to 10.10.1.8:3483 [16:10:11.927388] MasterHandler:1054 [0xc44b00]: subscribe success [16:10:11.927472] slimproto:892 [0xbbb140] connected [16:10:11.927501] sendHELO:134 [0xbbb140] mac: bb:bb:bd:23:37:72 [16:10:11.927516] sendHELO:135 [0xbbb140] cap: CanHTTPS=1,Model=squeezelite,ModelName=UPnPBridge,AccuratePlayPoints=0,HasDigitalOut=1,MaxSampleRate=48000,aac,ogg,flc,wav,aif,pcm,mp3 [16:10:11.931519] process:500 [0xbbb140] strm [16:10:11.931585] process_strm:241 [0xbbb140] strm command q [16:10:11.931611] decode_flush:208 [0xbbb140]: decode flush [16:10:11.931635] output_flush:611 [0xbbb140]: flush output buffer [16:10:11.931655] sq_callback:316 [0xc44b00]: device off or not controlled by LMS [16:10:11.931704] UpdateThread:1273 Updating configuration /var/lib/squeezeboxserver/prefs/upnpbridge.xml [16:10:11.932160] process:500 [0xbbb140] setd [16:10:11.932197] sendSETDName:227 [7]: set playername: 瀹㈠巺鐢佃 DMR [16:10:11.932307] process:500 [0xbbb140] setd [16:10:11.932940] process:500 [0xbbb140] aude [16:10:11.932990] process_aude:392 [0xbbb140] on/off using aude 1 [16:10:11.933011] sq_callback:312 [0xc44b00]: device set on/off 1 [16:10:11.933314] process:500 [0xbbb140] audg [16:10:11.933383] process_audg:406 [0xbbb140] (old) audg gainL: 46 gainR: 46 [16:10:11.937610] CheckAndLock:273 device is NULL [16:10:11.937818] CheckAndLock:273 device is NULL [16:10:11.937873] CheckAndLock:273 device is NULL

[16:10:11.942140] UpdateThread:1169 [0xc44b00] UPnP keep alive: 瀹㈠巺鐢佃 DMR [16:10:11.950159] CheckAndLock:273 device is NULL [16:10:11.950679] CheckAndLock:273 device is NULL

[16:10:11.950865] UpdateThread:1169 [0xc44b00] UPnP keep alive: 瀹㈠巺鐢佃 DMR [16:10:12.549167] UpdateThread:1169 [0xc44b00] UPnP keep alive: 瀹㈠巺鐢佃 DMR [16:10:12.557936] UpdateThread:1169 [0xc44b00] UPnP keep alive: 瀹㈠巺鐢佃 DMR [16:10:12.569002] UpdateThread:1169 [0xc44b00] UPnP keep alive: 瀹㈠巺鐢佃 DMR [16:10:12.574362] UpdateThread:1169 [0xc44b00] UPnP keep alive: 瀹㈠巺鐢佃 DMR [16:10:15.001167] process:500 [0xbbb140] strm [16:10:15.001267] process_strm:241 [0xbbb140] strm command t [16:10:15.001301] sendSTAT:169 [0xbbb140]: STAT:[STMt] msplayed 0 [16:10:19.002449] process:500 [0xbbb140] strm [16:10:19.002537] process_strm:241 [0xbbb140] strm command t [16:10:19.002568] sendSTAT:169 [0xbbb140]: STAT:[STMt] msplayed 0 [16:10:20.597334] AddMRDevice:1423 [0xc46e28]: adding renderer (灏忕埍闊崇-9033) [16:10:20.597443] GetProtocolInfo:359 [0xc46e28]: uPNP GetProtocolInfo [16:10:20.611215] GetProtocolInfo:370 [0xc46e28]: ProtocolInfo http-get:::* [16:10:20.611570] stream_thread_init:464 [0xbbf608] streambuf size: 1048576 [16:10:20.613385] output_thread_init:616 [0xbbf608] init output media renderer [16:10:20.613498] decode_thread_init:168 [0xbbf608]: init decode [16:10:20.613785] resample_init:345 [0xbbf608]: resampling sync recipe: 0x00, flags: 0x00, scale: 0.89, precision: 0.0, passband_end: 0.00000, stopband_begin: 0.00000, phase_response: -1.0 [16:10:20.613849] UpdateThread:1273 Updating configuration /var/lib/squeezeboxserver/prefs/upnpbridge.xml [16:10:20.613854] discover_server:809 [0xbbf608] sending discovery [16:10:20.614697] discover_server:841 [0xbbf608] got response from: 10.10.1.8:3483 [16:10:20.614785] slimproto:861 squeezelite [0xbbf608] <=> player [0xc46e28] [16:10:20.614830] slimproto:862 [0xbbf608] connecting to 10.10.1.8:3483 [16:10:20.615228] slimproto:892 [0xbbf608] connected [16:10:20.615274] sendHELO:134 [0xbbf608] mac: bb:bb:6b:17:5a:08 [16:10:20.615297] sendHELO:135 [0xbbf608] cap: CanHTTPS=1,Model=squeezelite,ModelName=UPnPBridge,AccuratePlayPoints=0,HasDigitalOut=1,MaxSampleRate=48000,aac,ogg,ops,ogf,flc,alc,wav,aif,pcm,mp3 [16:10:20.617130] process:500 [0xbbf608] strm [16:10:20.617183] process_strm:241 [0xbbf608] strm command q [16:10:20.617207] decode_flush:208 [0xbbf608]: decode flush [16:10:20.617230] output_flush:611 [0xbbf608]: flush output buffer [16:10:20.617251] sq_callback:316 [0xc46e28]: device off or not controlled by LMS [16:10:20.617670] process:500 [0xbbf608] strm [16:10:20.617707] process_strm:241 [0xbbf608] strm command q [16:10:20.617728] decode_flush:208 [0xbbf608]: decode flush [16:10:20.617750] output_flush:611 [0xbbf608]: flush output buffer [16:10:20.618085] process:500 [0xbbf608] setd [16:10:20.618132] sendSETDName:227 [11]: set playername: 灏忕埍闊崇Pro [16:10:20.618312] process:500 [0xbbf608] setd [16:10:20.618511] process:500 [0xbbf608] aude [16:10:20.618542] process_aude:392 [0xbbf608] on/off using aude 1 [16:10:20.618556] sq_callback:312 [0xc46e28]: device set on/off 1 [16:10:20.618827] process:500 [0xbbf608] audg [16:10:20.618858] process_audg:406 [0xbbf608] (old) audg gainL: 75 gainR: 75 [16:10:20.620614] CheckAndLock:273 device is NULL [16:10:20.620992] MasterHandler:1054 [0xc46e28]: subscribe success [16:10:20.621836] CheckAndLock:273 device is NULL [16:10:20.621894] CheckAndLock:273 device is NULL [16:10:20.621920] CheckAndLock:273 device is NULL

[16:10:23.000470] process:500 [0xbbb140] strm [16:10:23.000575] process_strm:241 [0xbbb140] strm command t [16:10:23.000591] sendSTAT:169 [0xbbb140]: STAT:[STMt] msplayed 0 [16:10:23.000660] process:500 [0xbbf608] strm [16:10:23.000674] process_strm:241 [0xbbf608] strm command t [16:10:23.000706] sendSTAT:169 [0xbbf608]: STAT:[STMt] msplayed 0 [16:10:23.006529] UpdateThread:1169 [0xc46e28] UPnP keep alive: 灏忕埍闊崇-9033 [16:10:25.335104] process:500 [0xbbf608] strm [16:10:25.335200] process_strm:241 [0xbbf608] strm command q [16:10:25.335228] decode_flush:208 [0xbbf608]: decode flush [16:10:25.335253] output_flush:611 [0xbbf608]: flush output buffer [16:10:25.335275] AVTStop:217 [0xc46e28]: uPNP stop (cookie (nil)) [16:10:25.355551] process:500 [0xbbf608] audg [16:10:25.355643] process_audg:406 [0xbbf608] (old) audg gainL: 75 gainR: 75 [16:10:25.356855] process:500 [0xbbf608] strm [16:10:25.356920] process_strm:238 [0xbbf608] strm command s [16:10:25.356945] process_strm:307 [0xbbf608], strm s autostart: 1 transition period: 10 transition type: 0 codec: m [16:10:25.356968] sendSTAT:169 [0xbbf608]: STAT:[STMf] msplayed 0 [16:10:25.357054] process_strm:322 [0xbbf608]: set fade mode: 0 [16:10:25.357428] cli_open_socket:186 [0xbbf608]: opened CLI socket 9 [16:10:25.373601] sq_get_metadata:518 [0xbbf608]: idx 0 artist:Green Day album:21st Century Breakdown title:21 Guns genre:鏃犻煶涔愭洸椋� duration:321.123 size:0 cover:http://10.10.1.8:9001/music/a2ead641/cover_.jpg [16:10:25.373673] process_start:1226 [0xbbf608]: something went wrong starting process 1 [16:10:25.373718] connect_socket:155 [0xbbf608] connecting to 10.10.1.8:9001 [16:10:25.373874] stream_sock:592 [0xbbf608] header: GET /stream.mp3?player=bb:bb:6b:17:5a:08 HTTP/1.0

[16:10:25.373901] sendSTAT:169 [0xbbf608]: STAT:[STMc] msplayed 0 [16:10:25.373944] process_strm:342 [0xbbf608] no matching codec * [16:10:25.373961] sendSTAT:169 [0xbbf608]: STAT:[STMn] msplayed 0 [16:10:25.374012] process:500 [0xbbf608] audg [16:10:25.374027] process_audg:406 [0xbbf608] (old) audg gainL: 75 gainR: 75 [16:10:25.376782] process:500 [0xbbf608] strm [16:10:25.376834] process_strm:241 [0xbbf608] strm command q [16:10:25.376855] decode_flush:208 [0xbbf608]: decode flush [16:10:25.377206] output_flush:611 [0xbbf608]: flush output buffer [16:10:25.377321] sendSTAT:169 [0xbbf608]: STAT:[STMf] msplayed 0 [16:10:25.377483] AVTStop:217 [0xc46e28]: uPNP stop (cookie 0x1) [16:10:25.390628] ActionHandler:837 [0xc46e28]: Waited action StopResponse [16:10:25.631467] _SyncNotifState:659 [0xc46e28]: uPNP stop [16:10:25.631590] sq_notify:651 [0xbbf608] notify STOP

[philippe44]

No No, you are launching the "static" version because the version you have installed is not executable. Do a "sudo chmod +x squeeze2upnp-x86-64". You should see "x" appear with the other "r" and "w" attributes

[Skylakc]

Embarrassed.......,it was my mistake. I changed it.

----------LOG-------

[Skylakc]

A Good News! After replace the Bin file, With "Force" Gapless, Additional MimeTypes, "chunked" HTTP mode. It works, both play and moving track automaticly. Of course, it is not a wisely solution.

but sometimes playing progress will offset, the issue coun't be reproduced. I found that when the additional parameter is turned off, the error ”no matching codec“ occurs.

[philippe44]

Can you try the same with that binary helper (same thing, need to make it executable). It will give me extra logs to try to understand why it fails. squeeze2upnp-x86-64.zip

[Skylakc]

Hello! I replace the new binary file. The main error still looks like "no matching codec"

--------Config-------- --------LOG--------

After I installed all codec logs.

[philippe44]

Thanks! I think I finally got it for that specific issue. Can you try this version squeeze2upnp-x86-64.zip

[Skylakc]

Hello! I used the newest binary file. It works! And now I can play songs without the Additional MimeTypes. But the track couldn't be switched automatically by parameter "Gapless YES or NO" ("Force"is OK) Log says "Error in action callback" for no reason doesn't look like a good thing. ------LOG-----

[philippe44]

The "Error in action callback" is a problem, but not the issue in that case. Now that I know that 1st issue is solved, I need to think of a solution to handle that speaker that does not signal when it has stopped playing a track, which is needed to move to next track (unless gapless works, which is kind of the case here, but that's not enough because last track will never end...)

[philippe44]

Are you familiar enough with Wireshark to take a trace when playing only one track, let it play till the end, wait 10s and send me the captured packets?

[Skylakc]

Are you familiar enough with Wireshark to take a trace when playing only one track, let it play till the end, wait 10s and send me the captured packets?

OK! I wiil track it tomorrow.

[Skylakc]

Hello! I have been inexplicably unable to log in github for the past month. But I can upload my code by "git pull". It's strange. I captured the packet, they looks like normal. In *_Force.pcap, I play the music, first then drag it to the last few seconds and wait for the switch, In *_YES.pcap, I repeated the same job and finally paused. By rpcapd_linux and Wireshark in Windows 10. I think everything should be fine for the next github login. :scream: PacketTraced.zip