Bug 435390

Summary:	INDI Driver: INDI Webcam crashed. Restart it?
Product:	[Applications] kstars	Reporter:	u.offermann
Component:	general	Assignee:	Jasem Mutlaq <mutlaqja>
Status:	RESOLVED UPSTREAM
Severity:	normal
Priority:	NOR
Version:	3.5.2
Target Milestone:	---
Platform:	macOS (DMG)
OS:	macOS
Latest Commit:		Version Fixed In:
Sentry Crash Report:

Description u.offermann 2021-04-05 17:50:24 UTC

SUMMARY


STEPS TO REPRODUCE
1. Use Internal INDI Server
1. Create new Ekos Profile with CCD: INDI WebCam (Auto Connect off) as only device
2. Start Ekso

OBSERVED RESULT

Error Popup "INDI Driver INDI Webcam crashed. Restart it?"

EXPECTED RESULT

Running Ekos


SOFTWARE/OS VERSIONS

macOS: 11.2.3

ADDITIONAL INFORMATION

I'm a KStars/Ekos newbie, so I may have overlooked a crucial detail. I also tried to report the bug on the INDI forum but I cannot register login to the forum (very weird: I successfully registered at the forum but the login doesn't work without any error messages).
I also tried to start the INDI server in the terminal where I also get the following error:

/Applications/KStars.app/Contents/MacOS/indi
==> ./indiserver indi_simulator_ccd
2021-04-05T17:26:05: startup: ./indiserver indi_simulator_ccd 
2021-04-05T17:26:05: Driver indi_simulator_ccd: 2021-04-05T17:26:05: Driver indi_simulator_ccd: execlp: No such file or directory
Child process 13289 died
2021-04-05T17:26:05: Driver indi_simulator_ccd: stderr EOF
2021-04-05T17:26:05: Driver indi_simulator_ccd: restart #1
2021-04-05T17:26:05: Driver indi_simulator_ccd: 2021-04-05T17:26:05: Driver indi_simulator_ccd: execlp: No such file or directory
Child process 13290 died
2021-04-05T17:26:05: Driver indi_simulator_ccd: stderr EOF
2021-04-05T17:26:05: Driver indi_simulator_ccd: restart #2
2021-04-05T17:26:05: Driver indi_simulator_ccd: 2021-04-05T17:26:05: Driver indi_simulator_ccd: execlp: No such file or directory
Child process 13291 died
...

Comment 1 u.offermann 2021-04-06 08:27:58 UTC

I made some more observations:

1) the simulators seem to work fine. I can start them and portscan shows that indi server is listening on port 7624.
2) I can reproduce the problem on macOS Catalina (10.15.7 - iMac 2017).
3) The same error ("Driver inidi_webcam_ccd: execlp: No such file or directory") is shown when I try to start the indi server in the shell

Comment 2 u.offermann 2021-04-06 08:50:14 UTC

When I try to start the indi server with the CCD webCam driver the Console App reveals that:

Process: indi_webcam_ccd:
This app has crashed because it attempted to access privacy-sensitive data without a usage description.  The app's Info.plist must contain an NSCameraUsageDescription key with a string value explaining to the user how the app uses this data.

Comment 3 u.offermann 2021-04-07 14:55:49 UTC

Log file:

[2021-04-07T16:53:26.536 CEST DEBG ][           org.kde.kstars.ekos] - Resetting Ekos Manager...
[2021-04-07T16:53:26.537 CEST WARN ][                       default] - QSqlDatabasePrivate::removeDatabase: connection 'filter_db' is still in use, all queries will cease to work.
[2021-04-07T16:53:26.538 CEST WARN ][                       default] - QSqlDatabasePrivate::addDatabase: duplicate connection name 'filter_db', old connection removed.
[2021-04-07T16:53:26.604 CEST INFO ][           org.kde.kstars.ekos] - "Starting INDI services..."
[2021-04-07T16:53:26.616 CEST DEBG ][           org.kde.kstars.indi] - INDI: Starting local drivers...
[2021-04-07T16:53:26.617 CEST DEBG ][           org.kde.kstars.indi] - Starting INDI Server:  ("-v", "-p", "7624", "-m", "300", "-r", "0", "-f", "/tmp/indififo31c28859") -f "/tmp/indififo31c28859"
[2021-04-07T16:53:26.628 CEST DEBG ][           org.kde.kstars.indi] - INDI Server Started?  true
[2021-04-07T16:53:26.629 CEST DEBG ][           org.kde.kstars.indi] - INDI: INDI Server started locally on port  7624
[2021-04-07T16:53:26.629 CEST DEBG ][           org.kde.kstars.indi] - Starting INDI Driver  "indi_webcam_ccd"
[2021-04-07T16:53:26.629 CEST DEBG ][           org.kde.kstars.indi] - Adding managed driver "INDI Webcam"
[2021-04-07T16:53:26.629 CEST DEBG ][           org.kde.kstars.indi] - INDIListener: Adding a new client manager to INDI listener..
[2021-04-07T16:53:26.629 CEST DEBG ][           org.kde.kstars.indi] - INDI: Connecting to local INDI server on port  7624  ...
[2021-04-07T16:53:26.631 CEST DEBG ][           org.kde.kstars.indi] - INDI Server:  "2021-04-07T14:53:26: startup: /Applications/KStars.app/Contents/MacOS/indi/indiserver -v -p 7624 -m 300 -r 0 -f /tmp/indififo31c28859 "
[2021-04-07T16:53:26.631 CEST DEBG ][           org.kde.kstars.indi] - INDI Server:  "2021-04-07T14:53:26: listening to port 7624 on fd 3"
[2021-04-07T16:53:26.631 CEST DEBG ][           org.kde.kstars.indi] - INDI Server:  "FIFO: start indi_webcam_ccd -n \"INDI Webcam\""
[2021-04-07T16:53:26.631 CEST DEBG ][           org.kde.kstars.indi] - INDI Server:  "With name: INDI Webcam"
[2021-04-07T16:53:26.631 CEST DEBG ][           org.kde.kstars.indi] - INDI Server:  "FIFO: Starting driver indi_webcam_ccd"
[2021-04-07T16:53:26.631 CEST DEBG ][           org.kde.kstars.indi] - INDI Server:  "2021-04-07T14:53:26: Driver indi_webcam_ccd: pid=24563 rfd=4 wfd=7 efd=8"
[2021-04-07T16:53:26.632 CEST DEBG ][           org.kde.kstars.indi] - INDI Server:  ""
[2021-04-07T16:53:26.736 CEST DEBG ][           org.kde.kstars.indi] - INDI: Connecting to local INDI server on port  7624  ...
[2021-04-07T16:53:26.737 CEST DEBG ][           org.kde.kstars.indi] - INDI server connected.
[2021-04-07T16:53:26.738 CEST DEBG ][           org.kde.kstars.indi] - Connection to INDI server is successful
[2021-04-07T16:53:26.738 CEST DEBG ][           org.kde.kstars.indi] - Received new device INDI Webcam
[2021-04-07T16:53:26.738 CEST INFO ][           org.kde.kstars.ekos] - "INDI services started on port 7624. Please connect devices."
[2021-04-07T16:53:26.800 CEST DEBG ][           org.kde.kstars.indi] - INDI Server:  "2021-04-07T14:53:26: Driver indi_webcam_ccd: Webcam Driver initialized"
[2021-04-07T16:53:26.800 CEST DEBG ][           org.kde.kstars.indi] - INDI Server:  "2021-04-07T14:53:26: Driver indi_webcam_ccd: snooping on Telescope Simulator.EQUATORIAL_EOD_COORD"
[2021-04-07T16:53:26.801 CEST DEBG ][           org.kde.kstars.indi] - INDI Server:  "2021-04-07T14:53:26: Driver indi_webcam_ccd: snooping on Telescope Simulator.TELESCOPE_INFO"
[2021-04-07T16:53:26.801 CEST DEBG ][           org.kde.kstars.indi] - INDI Server:  "2021-04-07T14:53:26: Driver indi_webcam_ccd: snooping on Telescope Simulator.GEOGRAPHIC_COORD"
[2021-04-07T16:53:26.801 CEST DEBG ][           org.kde.kstars.indi] - INDI Server:  "2021-04-07T14:53:26: Driver indi_webcam_ccd: snooping on Telescope Simulator.TELESCOPE_PIER_SIDE"
[2021-04-07T16:53:26.801 CEST DEBG ][           org.kde.kstars.indi] - INDI Server:  "2021-04-07T14:53:26: Driver indi_webcam_ccd: snooping on Rotator Simulator.ABS_ROTATOR_ANGLE"
[2021-04-07T16:53:26.801 CEST DEBG ][           org.kde.kstars.indi] - INDI Server:  "2021-04-07T14:53:26: Driver indi_webcam_ccd: snooping on Focuser Simulator.ABS_FOCUS_POSITION"
[2021-04-07T16:53:26.801 CEST DEBG ][           org.kde.kstars.indi] - INDI Server:  "2021-04-07T14:53:26: Driver indi_webcam_ccd: snooping on Focuser Simulator.FOCUS_TEMPERATURE"
[2021-04-07T16:53:26.801 CEST DEBG ][           org.kde.kstars.indi] - INDI Server:  "2021-04-07T14:53:26: Driver indi_webcam_ccd: snooping on CCD Simulator.FILTER_SLOT"
[2021-04-07T16:53:26.801 CEST DEBG ][           org.kde.kstars.indi] - INDI Server:  "2021-04-07T14:53:26: Driver indi_webcam_ccd: snooping on CCD Simulator.FILTER_NAME"
[2021-04-07T16:53:26.801 CEST DEBG ][           org.kde.kstars.indi] - INDI Server:  "2021-04-07T14:53:26: Driver indi_webcam_ccd: snooping on SQM.SKY_QUALITY"
[2021-04-07T16:53:26.802 CEST DEBG ][           org.kde.kstars.indi] - INDI Server:  "2021-04-07T14:53:26: Client 5: new arrival from 127.0.0.1:63850 - welcome!"
[2021-04-07T16:53:26.802 CEST DEBG ][           org.kde.kstars.indi] - INDI Server:  "Child process 24563 died"
[2021-04-07T16:53:26.802 CEST DEBG ][           org.kde.kstars.indi] - INDI Server:  "2021-04-07T14:53:26: Driver indi_webcam_ccd: stderr EOF"
[2021-04-07T16:53:26.802 CEST DEBG ][           org.kde.kstars.indi] - INDI Server:  "<delProperty device=\"INDI Webcam\"/>"
[2021-04-07T16:53:26.802 CEST DEBG ][           org.kde.kstars.indi] - INDI Server:  "2021-04-07T14:53:26: Driver indi_webcam_ccd: Terminated after #0 restarts."
[2021-04-07T16:53:26.802 CEST DEBG ][           org.kde.kstars.indi] - INDI Server:  ""
[2021-04-07T16:53:26.802 CEST CRIT ][           org.kde.kstars.indi] - INDI driver  "indi_webcam_ccd"  crashed!
[2021-04-07T16:53:26.822 CEST DEBG ][           org.kde.kstars.indi] - INDIListener: New device INDI Webcam
[2021-04-07T16:53:26.823 CEST INFO ][           org.kde.kstars.ekos] - Ekos received a new device:  "INDI Webcam"
[2021-04-07T16:53:26.829 CEST DEBG ][           org.kde.kstars.indi] - < INDI Webcam >: < CONNECTION >
[2021-04-07T16:53:26.841 CEST DEBG ][           org.kde.kstars.indi] - < INDI Webcam >: < DRIVER_INFO >
[2021-04-07T16:53:26.848 CEST DEBG ][           org.kde.kstars.indi] - < INDI Webcam >: < POLLING_PERIOD >
[2021-04-07T16:53:26.860 CEST DEBG ][           org.kde.kstars.indi] - < INDI Webcam >: < RAPID_STACKING_OPTION >
[2021-04-07T16:53:26.866 CEST DEBG ][           org.kde.kstars.indi] - < INDI Webcam >: < OUTPUT_FORMAT_OPTION >
[2021-04-07T16:53:26.878 CEST DEBG ][           org.kde.kstars.indi] - < INDI Webcam >: < DEBUG >
[2021-04-07T16:53:26.885 CEST DEBG ][           org.kde.kstars.indi] - < INDI Webcam >: < CONFIG_PROCESS >
[2021-04-07T16:53:26.887 CEST DEBG ][           org.kde.kstars.indi] - < INDI Webcam >: < ACTIVE_DEVICES >
[2021-04-07T16:53:26.890 CEST DEBG ][           org.kde.kstars.indi] - < INDI Webcam >: < TIMEOUT_OPTIONS >
[2021-04-07T16:53:26.892 CEST DEBG ][           org.kde.kstars.indi] - < INDI Webcam >: < INPUT_SCAN >
[2021-04-07T16:53:26.896 CEST DEBG ][           org.kde.kstars.indi] - < INDI Webcam >: < CAPTURE_DEVICE >
[2021-04-07T16:53:26.897 CEST DEBG ][           org.kde.kstars.indi] - < INDI Webcam >: < INPUT_OPTIONS >
[2021-04-07T16:53:26.900 CEST DEBG ][           org.kde.kstars.indi] - < INDI Webcam >: < CAPTURE_SOURCE >
[2021-04-07T16:53:26.901 CEST DEBG ][           org.kde.kstars.indi] - < INDI Webcam >: < CAPTURE_VIDEO_SIZE >
[2021-04-07T16:53:26.902 CEST DEBG ][           org.kde.kstars.indi] - < INDI Webcam >: < CAPTURE_FRAME_RATE >
[2021-04-07T16:53:26.902 CEST DEBG ][           org.kde.kstars.indi] - Removing device "INDI Webcam"
[2021-04-07T16:53:26.903 CEST INFO ][           org.kde.kstars.indi] - INDI Webcam :  "[INFO] Briefly connecting to avfoundation to update the source list "
[2021-04-07T16:53:26.904 CEST INFO ][           org.kde.kstars.indi] - INDI Webcam :  "[INFO] Attempting to connect "
[2021-04-07T16:53:26.910 CEST DEBG ][           org.kde.kstars.indi] - INDIListener: Removing device "INDI Webcam"
[2021-04-07T16:53:26.910 CEST INFO ][           org.kde.kstars.ekos] - "INDI Webcam is offline."
[2021-04-07T16:53:26.920 CEST DEBG ][           org.kde.kstars.indi] - INDI: Stopping local drivers...
[2021-04-07T16:53:26.920 CEST DEBG ][           org.kde.kstars.indi] - Removing managed driver "INDI Webcam"
[2021-04-07T16:53:26.921 CEST DEBG ][           org.kde.kstars.indi] - INDIListener: Removing client manager for server localhost @ 7624
[2021-04-07T16:53:26.921 CEST DEBG ][           org.kde.kstars.indi] - INDI server disconnected. Exit code: 0
[2021-04-07T16:53:26.921 CEST DEBG ][           org.kde.kstars.indi] - INDI server disconnected. Exit code: 0
[2021-04-07T16:53:26.921 CEST DEBG ][           org.kde.kstars.indi] - Stopping INDI Driver  "indi_webcam_ccd"
[2021-04-07T16:53:26.921 CEST DEBG ][           org.kde.kstars.indi] - Stopping INDI Server  "localhost" @ "7624"
[2021-04-07T16:53:26.922 CEST DEBG ][           org.kde.kstars.ekos] - Resetting Ekos Manager...
[2021-04-07T16:53:26.923 CEST WARN ][                       default] - QSqlDatabasePrivate::removeDatabase: connection 'filter_db' is still in use, all queries will cease to work.
[2021-04-07T16:53:26.923 CEST WARN ][                       default] - QSqlDatabasePrivate::addDatabase: duplicate connection name 'filter_db', old connection removed.
[2021-04-07T16:53:26.924 CEST INFO ][           org.kde.kstars.ekos] - "INDI services stopped."

Comment 4 u.offermann 2021-04-11 09:03:12 UTC

Relates to bug report at https://github.com/indilib/indi/issues/1416

Comment 5 Jasem Mutlaq 2021-09-12 11:02:59 UTC

Not a KStars issue, please follow up with INDI.