Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Problem starting airupnp after update 0.2.26.0 with low-privileged user - core dumped #256

Closed
eizedev opened this issue May 27, 2020 · 2 comments

Comments

@eizedev
Copy link

eizedev commented May 27, 2020

Hi @philippe44

i have just updated the synology package for AirConnect release 0.2.26.0 with your newest binaries.
I am using the airupnp and aircast binaries for arch x86-64 for testing.

If i start the package with a high-privileged user (such as root) i can start airupnp without any problems and it is running fine.
If i am trying to start airupnp with a low-privileged user, airupnp crashes directly after the start without an error but it generates a core dump and is throwing a seg faults in the messages log.
For the synology package i need to start the binaries as a low-privileged user.

2020-05-27T20:02:27+02:00 xx kernel: [76992.162360] airupnp[19007]: segfault at 0 ip 00007f5a8cb314bd sp 00007f5a87b69db0 error 4 in libc-2.20-2014.11.so[7f5a8cac7000+19b000]
2020-05-27T20:02:27+02:00 xx coredump: Process airupnp[18995] dumped core on signal [11].

I have used the same scripts, build steps, same low-privileged user etc. as of version 0.2.25.0. So it should be no problem with the synology package.
Version 0.2.25.0 is working fine for the moment.

Startup commands:

i am not using the config file in my tests (no file exists)

/volume1/@appstore/AirConnect/airupnp -b 192.168.1.x:49154 -l 1000:2000 -x "/volume1/@appstore/AirConnect/config.xml" -z -f "/var/log/airconnect.log" -d all=info  
/volume1/@appstore/AirConnect/aircast -b 192.168.1.x -l 1000:2000 -x "/volume1/@appstore/AirConnect/config-cast.xml" -z -f "/var/log/airconnect.log" -d all=info
Log `0.2.26.0` with low-privileged user - Not OK
[2020-05-27 20:02:13] #### Start preinst... ####
[20:02:13] Creating "airconnect" user.
[2020-05-27 20:02:17] #### Done preinst ####
[2020-05-27 20:02:18] #### Start postinst... ####
[20:02:18] Securing existing "airconnect" user.
[2020-05-27 20:02:22] #### Done postinst ####
[20:02:27] Starting AirConnect ...
[20:02:27] Starting airupnp on 192.168.1.x:49154
[20:02:27.568748] main:1378 Starting airupnp version: v0.2.26.0 (May 26 2020 @ 08:05:45)
[20:02:27.568884] main:1386 no config file, using defaults
[20:02:27.570227] Start:1103 Binding to 192.168.1.x:49154
[20:02:27] Starting aircast on 192.168.1.x
[20:02:27.579455] main:951 Starting aircast version: v0.2.26.0 (May 26 2020 @ 08:04:46)
[20:02:27.579590] main:959 no config file, using defaults
[20:02:27.579967] Start:715 Binding to 192.168.1.x
[20:02:27] Searching if renderer were added (for 10 seconds)...
[20:02:27.615244] GetMaster:127 [0x6a9540]: Master not discovered yet, assigning to self
[20:02:27.620687] AddMRDevice:989 [0x6a9540] skipping Sonos slave Bad
[20:02:27.620754] AddMRDevice:1012 [0x6a9540]: cannot get mac Bad+, creating fake b2a68013
[20:02:27.861774] AddCastDevice:652 [0x68f3c0]: adding renderer (SHIELD)
[20:02:27.861839] AddCastDevice:658 [0x68f3c0]: creating MAC 68f3ca
[20:02:28] At least one renderer successfully discovered!
[20:02:28] AirConnect successfully started on ip "192.168.1.x"!
[20:02:29] Status: airupnp not running!
[20:02:29] Status: airupnp not running!
[20:02:30.083266] rtsp_thread:351 got RTSP connection 9
[20:02:30.083586] read_line:1191 disconnected on the other end 9
[20:02:30.083656] rtsp_thread:366 RTSP close 9
[20:02:33] Status: airupnp not running!
Log `0.2.25.0` - OK
[2020-05-27 19:12:17] #### Start preinst... ####
[19:12:17] Creating "airconnect" user.
[2020-05-27 19:12:21] #### Done preinst ####
[2020-05-27 19:12:22] #### Start postinst... ####
[19:12:22] Securing existing "airconnect" user.
[2020-05-27 19:12:26] #### Done postinst ####
[19:12:30] Status: AirUpnp not running!
[19:12:30] Starting AirConnect ...
[19:12:31] Starting airupnp on 192.168.1.x:49154
[19:12:31.024366] main:1374 Starting airupnp version: v0.2.25.0 (May  3 2020 @ 17:42:14)
[19:12:31.024525] main:1382 no config file, using defaults
[19:12:31] Starting aircast on 192.168.1.x
[19:12:31.027345] Start:1099 Binding to 192.168.1.x:49154
[19:12:31.034726] main:945 Starting aircast version: v0.2.25.0 (May  3 2020 @ 17:41:26)
[19:12:31.034x8] main:953 no config file, using defaults
[19:12:31.035224] Start:712 Binding to 192.168.1.x
[19:12:31] Searching if renderer were added (for 10 seconds)...
[19:12:31] At least one renderer successfully discovered!
[19:12:31] AirConnect successfully started on ip "192.168.1.x"!
[19:12:31.133891] GetMaster:127 [0x6a9540]: Master not discovered yet, assigning to self
[19:12:31.145096] AddMRDevice:985 [0x6a9540] skipping Sonos slave 192.168.1.x - Sonos One SL
[19:12:31.145177] AddMRDevice:1008 [0x6a9540]: cannot get mac 192.168.1.x - Sonos One SL+, creating fake a61685dd
[19:12:31.149044] MasterHandler:657 [0x6a9540]: subscribe fail, re-trying 1
[19:12:31.152577] MasterHandler:657 [0x6a9540]: subscribe fail, re-trying 2
[19:12:31.157534] MasterHandler:657 [0x6a9540]: subscribe fail, re-trying 3
[19:12:31.161073] MasterHandler:661 [0x6a9540]: subscribe fail, volume feedback will not work
[19:12:31.170984] AddMRDevice:987 [0x6ab9e8]: adding renderer (Fernsehzimmer)
[19:12:31.171049] AddMRDevice:1008 [0x6ab9e8]: cannot get mac Fernsehzimmer+, creating fake 57175afd
[19:12:31.176430] MasterHandler:655 [0x6ab9e8]: subscribe success
[19:12:31.238987] AddMRDevice:987 [0x6ade90]: adding renderer (Flur)
[19:12:31.239057] AddMRDevice:1008 [0x6ade90]: cannot get mac Flur+, creating fake 30a98145
[19:12:31.246315] MasterHandler:655 [0x6ade90]: subscribe success
[19:12:31.282069] AddMRDevice:985 [0x6b0338] skipping Sonos slave 192.168.1.x - Sonos One SL
[19:12:31.282165] AddMRDevice:1008 [0x6b0338]: cannot get mac 192.168.1.x - Sonos One SL+, creating fake f7bb13e0
[19:12:31.285509] MasterHandler:657 [0x6b0338]: subscribe fail, re-trying 1
[19:12:31.289285] MasterHandler:657 [0x6b0338]: subscribe fail, re-trying 2
[19:12:31.292891] MasterHandler:657 [0x6b0338]: subscribe fail, re-trying 3
[19:12:31.296670] MasterHandler:661 [0x6b0338]: subscribe fail, volume feedback will not work
[19:12:31.528188] AddMRDevice:987 [0x6b27e0]: adding renderer (Esszimmer)
[19:12:31.528266] AddMRDevice:1008 [0x6b27e0]: cannot get mac Esszimmer+, creating fake f739047a
[19:12:31.534500] MasterHandler:655 [0x6b27e0]: subscribe success
[19:12:32.651463] AddMRDevice:985 [0x6b4c88] skipping Sonos slave Küche
[19:12:32.651545] AddMRDevice:1008 [0x6b4c88]: cannot get mac Küche+, creating fake 18ece22d
[19:12:32.669365] MasterHandler:655 [0x6b4c88]: subscribe success
[19:12:32.702767] AddMRDevice:985 [0x6b7130] skipping Sonos slave 192.168.1.x - Sonos Sub
[19:12:32.702831] AddMRDevice:1008 [0x6b7130]: cannot get mac 192.168.1.x - Sonos Sub+, creating fake 5ea1dac
[19:12:32.707024] MasterHandler:657 [0x6b7130]: subscribe fail, re-trying 1
[19:12:32.716680] MasterHandler:657 [0x6b7130]: subscribe fail, re-trying 2
[19:12:32.722167] MasterHandler:657 [0x6b7130]: subscribe fail, re-trying 3
[19:12:32.730071] MasterHandler:661 [0x6b7130]: subscribe fail, volume feedback will not work
[19:12:32.754890] UpdateThread:792 [0x6a9540]: Sonos 192.168.1.x - Sonos One SL+ is now slave
[19:12:32.827067] AddMRDevice:987 [0x6b95d8]: adding renderer (Schlafzimmer)
[19:12:32.827132] AddMRDevice:1008 [0x6b95d8]: cannot get mac Schlafzimmer+, creating fake f19db70f
[19:12:32.832924] MasterHandler:655 [0x6b95d8]: subscribe success
[19:12:32.897721] AddMRDevice:987 [0x6bba80]: adding renderer (Büro)
[19:12:32.897800] AddMRDevice:1008 [0x6bba80]: cannot get mac Büro+, creating fake 1553729b
[19:12:32.910460] MasterHandler:655 [0x6bba80]: subscribe success
[19:12:32.964252] AddMRDevice:985 [0x6bdf28] skipping Sonos slave 192.168.1.x - Sonos One SL
[19:12:32.964338] AddMRDevice:1008 [0x6bdf28]: cannot get mac 192.168.1.x - Sonos One SL+, creating fake b2a68013
[19:12:32.971641] MasterHandler:655 [0x6bdf28]: subscribe success
[19:12:33.019368] AddMRDevice:987 [0x6c03d0]: adding renderer (Kello_D4567C)
[19:12:33.019448] AddMRDevice:1008 [0x6c03d0]: cannot get mac Kello_D4567C+, creating fake 1fe1e692
[19:12:33.031539] MasterHandler:655 [0x6c03d0]: subscribe success
[19:12:34.513187] AddMRDevice:987 [0x6c2878]: adding renderer (SHIELD)
[19:12:34.513259] AddMRDevice:1008 [0x6c2878]: cannot get mac SHIELD+, creating fake b108b09
[19:12:34.521053] MasterHandler:655 [0x6c2878]: subscribe success
[19:12:37.037491] rtsp_thread:351 got RTSP connection 36
[19:12:37.037763] read_line:1191 disconnected on the other end 36
[19:12:37.037828] rtsp_thread:366 RTSP close 36
[19:12:37.03x10] rtsp_thread:351 got RTSP connection 34
[19:12:37.038847] read_line:1191 disconnected on the other end 34
[19:12:37.038911] rtsp_thread:366 RTSP close 34
[19:12:37.039696] rtsp_thread:351 got RTSP connection 30
[19:12:37.039926] read_line:1191 disconnected on the other end 30
[19:12:37.039989] rtsp_thread:366 RTSP close 30
[19:12:37.040769] rtsp_thread:351 got RTSP connection 27
[19:12:37.041011] read_line:1191 disconnected on the other end 27
[19:12:37.041076] rtsp_thread:366 RTSP close 27
[19:12:37.041843] rtsp_thread:351 got RTSP connection 21
[19:12:37.042071] read_line:1191 disconnected on the other end 21
[19:12:37.042134] rtsp_thread:366 RTSP close 21
[19:12:37.042921] rtsp_thread:351 got RTSP connection 18
[19:12:37.043160] read_line:1191 disconnected on the other end 18
[19:12:37.043222] rtsp_thread:366 RTSP close 18
[19:12:37.044007] rtsp_thread:351 got RTSP connection 14
[19:12:37.044255] read_line:1191 disconnected on the other end 14
[19:12:37.044318] rtsp_thread:366 RTSP close 14
[19:12:40.323102] AddCastDevice:649 [0x68f380]: adding renderer (SHIELD)
[19:12:40.323188] AddCastDevice:655 [0x68f380]: creating MAC 68f38a
[19:12:43.053113] rtsp_thread:351 got RTSP connection 9
[19:12:43.053434] read_line:1191 disconnected on the other end 9
[19:12:43.053524] rtsp_thread:366 RTSP close 9
[19:12:43.054316] rtsp_thread:351 got RTSP connection 35
[19:12:43.054580] read_line:1191 disconnected on the other end 35
[19:12:43.054673] rtsp_thread:366 RTSP close 35
[19:12:43.055441] rtsp_thread:351 got RTSP connection 34
[19:12:43.055668] read_line:1191 disconnected on the other end 34
[19:12:43.055749] rtsp_thread:366 RTSP close 34
[19:12:43.056601] rtsp_thread:351 got RTSP connection 30
[19:12:43.056906] read_line:1191 disconnected on the other end 30
[19:12:43.057007] rtsp_thread:366 RTSP close 30
[19:12:43.057811] rtsp_thread:351 got RTSP connection 27
[19:12:43.058045] read_line:1191 disconnected on the other end 27
[19:12:43.058112] rtsp_thread:366 RTSP close 27
[19:12:43.058923] rtsp_thread:351 got RTSP connection 21
[19:12:43.059163] read_line:1191 disconnected on the other end 21
[19:12:43.059271] rtsp_thread:366 RTSP close 21
[19:12:43.060092] rtsp_thread:351 got RTSP connection 18
[19:12:43.060324] read_line:1191 disconnected on the other end 18
[19:12:43.060427] rtsp_thread:366 RTSP close 18
[19:12:43.061334] rtsp_thread:351 got RTSP connection 14
[19:12:43.061580] read_line:1191 disconnected on the other end 14
[19:12:43.061658] rtsp_thread:366 RTSP close 14
[19:12:51.552298] UpdateThread:773 [0x6b4c88]: Device name change 192.168.1.x - Sonos Play:1 Küche
Log `0.2.26.0` with root user - OK
[20:30:07] Status: airupnp not running!
[20:30:21.095648] main:1378 Starting airupnp version: v0.2.26.0 (May 26 2020 @ 08:05:45)
[20:30:21.095793] main:1386 no config file, using defaults
[20:30:21.097897] Start:1103 Binding to 192.168.1.x:49154
[20:30:21.163485] AddMRDevice:991 [0x6a9540]: adding renderer (Fernsehzimmer)
[20:30:21.163566] AddMRDevice:1012 [0x6a9540]: cannot get mac Fernsehzimmer+, creating fake 57175afd
[20:30:21.165886] MasterHandler:655 [0x6a9540]: subscribe success
[20:30:21.210244] AddMRDevice:989 [0x6ab9e8] skipping Sonos slave 192.168.1.x - Sonos One SL
[20:30:21.210317] AddMRDevice:1012 [0x6ab9e8]: cannot get mac 192.168.1.x - Sonos One SL+, creating fake b2a68013
[20:30:21.217821] MasterHandler:655 [0x6ab9e8]: subscribe success
[20:30:21.294186] AddMRDevice:991 [0x6ade90]: adding renderer (Büro)
[20:30:21.294252] AddMRDevice:1012 [0x6ade90]: cannot get mac Büro+, creating fake 1553729b
[20:30:21.302186] MasterHandler:655 [0x6ade90]: subscribe success
[20:30:21.346101] AddMRDevice:989 [0x6b0338] skipping Sonos slave 192.168.1.x - Sonos Play:1
[20:30:21.346169] AddMRDevice:1012 [0x6b0338]: cannot get mac 192.168.1.x - Sonos Play:1+, creating fake 18ece22d
[20:30:21.350493] MasterHandler:655 [0x6b0338]: subscribe success
[20:30:21.406890] AddMRDevice:991 [0x6b27e0]: adding renderer (Flur)
[20:30:21.406960] AddMRDevice:1012 [0x6b27e0]: cannot get mac Flur+, creating fake 30a98145
[20:30:21.429968] MasterHandler:655 [0x6b27e0]: subscribe success
[20:30:21.474425] AddMRDevice:991 [0x6b4c88]: adding renderer (Schlafzimmer)
[20:30:21.474488] AddMRDevice:1012 [0x6b4c88]: cannot get mac Schlafzimmer+, creating fake f19db70f
[20:30:21.481477] MasterHandler:655 [0x6b4c88]: subscribe success
[20:30:21.516005] AddMRDevice:989 [0x6b7130] skipping Sonos slave 192.168.1.x - Sonos One SL
[20:30:21.516069] AddMRDevice:1012 [0x6b7130]: cannot get mac 192.168.1.x - Sonos One SL+, creating fake a61685dd
[20:30:21.519791] MasterHandler:657 [0x6b7130]: subscribe fail, re-trying 1
[20:30:21.524486] MasterHandler:657 [0x6b7130]: subscribe fail, re-trying 2
[20:30:21.529647] MasterHandler:657 [0x6b7130]: subscribe fail, re-trying 3
[20:30:21.533638] MasterHandler:661 [0x6b7130]: subscribe fail, volume feedback will not work
[20:30:21.563826] AddMRDevice:989 [0x6b95d8] skipping Sonos slave 192.168.1.x - Sonos Sub
[20:30:21.563895] AddMRDevice:1012 [0x6b95d8]: cannot get mac 192.168.1.x - Sonos Sub+, creating fake 5ea1dac
[20:30:21.568016] MasterHandler:657 [0x6b95d8]: subscribe fail, re-trying 1
[20:30:21.572352] MasterHandler:657 [0x6b95d8]: subscribe fail, re-trying 2
[20:30:21.576756] MasterHandler:657 [0x6b95d8]: subscribe fail, re-trying 3
[20:30:21.580788] MasterHandler:661 [0x6b95d8]: subscribe fail, volume feedback will not work
[20:30:21.620560] AddMRDevice:989 [0x6bba80] skipping Sonos slave 192.168.1.x - Sonos One SL
[20:30:21.620633] AddMRDevice:1012 [0x6bba80]: cannot get mac 192.168.1.x - Sonos One SL+, creating fake f7bb13e0
[20:30:21.623940] MasterHandler:657 [0x6bba80]: subscribe fail, re-trying 1
[20:30:21.627623] MasterHandler:657 [0x6bba80]: subscribe fail, re-trying 2
[20:30:21.630997] MasterHandler:657 [0x6bba80]: subscribe fail, re-trying 3
[20:30:21.635732] MasterHandler:661 [0x6bba80]: subscribe fail, volume feedback will not work
[20:30:21.672999] AddMRDevice:991 [0x6bdf28]: adding renderer (Esszimmer)
[20:30:21.673063] AddMRDevice:1012 [0x6bdf28]: cannot get mac Esszimmer+, creating fake f739047a
[20:30:21.679796] MasterHandler:655 [0x6bdf28]: subscribe success
[20:30:23.523521] AddMRDevice:991 [0x6c03d0]: adding renderer (SHIELD)
[20:30:23.523596] AddMRDevice:1012 [0x6c03d0]: cannot get mac SHIELD+, creating fake b108b09
[20:30:23.530993] MasterHandler:655 [0x6c03d0]: subscribe success
[20:30:23.653319] AddMRDevice:991 [0x6c2878]: adding renderer (Kello_D4567C)
[20:30:23.653381] AddMRDevice:1012 [0x6c2878]: cannot get mac Kello_D4567C+, creating fake 1fe1e692
[20:30:23.664269] MasterHandler:655 [0x6c2878]: subscribe success
[20:30:26.077035] rtsp_thread:351 got RTSP connection 36
[20:30:26.077285] read_line:1191 disconnected on the other end 36
[20:30:26.077345] rtsp_thread:366 RTSP close 36
[20:30:26.078222] rtsp_thread:351 got RTSP connection 33
[20:30:26.079452] rtsp_thread:351 got RTSP connection 31
[20:30:26.079475] read_line:1191 disconnected on the other end 33
[20:30:26.079629] rtsp_thread:366 RTSP close 33
[20:30:26.079732] read_line:1191 disconnected on the other end 31
[20:30:26.079788] rtsp_thread:366 RTSP close 31
[20:30:26.080660] rtsp_thread:351 got RTSP connection 24
[20:30:26.080903] read_line:1191 disconnected on the other end 24
[20:30:26.080968] rtsp_thread:366 RTSP close 24
[20:30:26.081747] rtsp_thread:351 got RTSP connection 22
[20:30:26.081975] read_line:1191 disconnected on the other end 22
[20:30:26.082040] rtsp_thread:366 RTSP close 22
[20:30:26.082852] rtsp_thread:351 got RTSP connection 17
[20:30:26.083077] read_line:1191 disconnected on the other end 17
[20:30:26.083137] rtsp_thread:366 RTSP close 17
[20:30:26.083959] rtsp_thread:351 got RTSP connection 14
[20:30:26.084218] read_line:1191 disconnected on the other end 14
[20:30:26.084282] rtsp_thread:366 RTSP close 14
[20:30:26.085100] rtsp_thread:351 got RTSP connection 9
[20:30:26.085311] read_line:1191 disconnected on the other end 9
[20:30:26.085370] rtsp_thread:366 RTSP close 9

Thanks for your help,
René

@philippe44
Copy link
Owner

Corrected

@eizedev
Copy link
Author

eizedev commented May 28, 2020

@philippe44 Thanks, airupnp is now working :)
Fixed in AirConnect-Synology-0.2.26.1-20200528

@eizedev eizedev closed this as completed May 28, 2020
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

2 participants