Hue Entertainment Wizard is not saving.

discoluc commented 3 years ago

Bug report, debug log and your config file (FULL LOGS ARE MANDATORY)

Steps to reproduce

Using the Wizard for HUE Entertainment as described in your manual. The Entertainment Group is created in HUE App, and then in the wizard the position of the hue lamps is chosen. But the SAVE button is not working.

What is expected?

When the SAVE button of the Wizard is pressed the Wizard should close and show a successful message.

What is actually happening?

Nothing happens

System

HyperHDR Server:

Build: (HEAD detached at 4e4031c) (Awawa-eba222b/4e4031c-1630846534)
Build time: Sep 5 2021 13:29:15
Git Remote: https://github.com/awawa-dev/HyperHDR
Version: 17.0.0.0beta2
UI Lang: auto (BrowserLang: de-de)
UI Access: expert
Avail Capt: Linux (V4L2)
Database: read/write

HyperHDR Server OS:

Distribution: Raspbian GNU/Linux 10 (buster)
Architecture: arm
CPU Model: ARMv7 Processor rev 3 (v7l)
CPU Type: Raspberry Pi 4 Model B Rev 1.1
CPU Revision: c03111
CPU Hardware: BCM2711
Kernel: linux (5.10.17-v7l+ (WS: 32))
Qt Version: 5.11.3
Browser: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/14.1.2 Safari/605.1.15

awawa-dev commented 2 years ago

That crucial information was missing in your HyperHDR logs, but it's present after start.

HyperHdr's logs with that information please.

gogui63 commented 2 years ago

Sure, https://pastebin.com/8jZMZbsW

awawa-dev commented 2 years ago

Still the most interesting part is not there. Restart HyperHDR when you are on the log page to catch them just after start or/and disable grabbers&boot/background effects to stop spawning log messages at the startup.

gogui63 commented 2 years ago

pi@raspberrypi:~ $ sudo systemctl restart hyperhdr@pi.service

2022-06-06T12:13:20.654Z [V4L2:USB VIDEO: USB] Restarting video grabber is now blocked due to reloading of the configuration
2022-06-06T12:13:20.654Z [V4L2:USB Video: USB] (GrabberWrapper.cpp:463) Auto resume is: enabled
2022-06-06T12:13:20.654Z [V4L2:USB VIDEO: USB] Cropping image: width=0 height=0; crop: left=0 right=0 top=0 bottom=0 
2022-06-06T12:13:20.655Z [V4L2:USB Video: USB] (GrabberWrapper.cpp:73) CEC keycode. Start: 0, stop: 0
2022-06-06T12:13:20.655Z [V4L2:USB VIDEO: USB] (Grabber.cpp:145) Set new width: 720, height: 480 for capture
2022-06-06T12:13:20.655Z [V4L2:USB VIDEO: USB] (Grabber.cpp:322) setWidthHeight preparing to restarting video grabber 0
2022-06-06T12:13:20.655Z [V4L2:USB VIDEO: USB] Delayed restart of the grabber due to change of the capturing resolution
2022-06-06T12:13:20.655Z [V4L2:USB VIDEO: USB] Delayed restart of the grabber due to change of the framerate
2022-06-06T12:13:20.655Z [V4L2:USB VIDEO: USB] (Grabber.cpp:259) setBrightnessContrastSaturationHue nothing changed
2022-06-06T12:13:20.655Z [V4L2:USB VIDEO: USB] (V4L2Grabber.cpp:125) setHdrToneMappingMode to: Disabled
2022-06-06T12:13:20.655Z [V4L2:USB VIDEO: USB] (Grabber.cpp:168) setFpsSoftwareDecimation to: 1
2022-06-06T12:13:20.656Z [V4L2:USB VIDEO: USB] Signal detection is now enabled
2022-06-06T12:13:20.656Z [SIGNAL_OLD] (DetectionManual.cpp:85) Signal detection area set to: 0.250000,0.250000 x 0.750000,0.750000
2022-06-06T12:13:20.656Z [SIGNAL_OLD] (DetectionManual.cpp:75) Signal threshold set to: {12, 12, 12} and frames: 200
2022-06-06T12:13:20.656Z [SIGNAL_AUTO] (DetectionAutomatic.cpp:383) Automatic signal detection -> errorTolerance: 9, modelTolerance: 90, sleepTime: 1000, wakeTime: 0
2022-06-06T12:13:20.656Z [V4L2:USB VIDEO: USB] (Grabber.cpp:367) setDeviceVideoStandard preparing to restart video grabber. Old: '' new: 'USB Video: USB Video (video0)'
2022-06-06T12:13:20.656Z [V4L2:USB VIDEO: USB] Delayed restart of the grabber due to change of selected device
2022-06-06T12:13:20.656Z [V4L2:USB VIDEO: USB] (Grabber.cpp:186) Force encoding to: yuyv (old: NO_CHANGE)
2022-06-06T12:13:20.656Z [V4L2:USB VIDEO: USB] Delayed restart of the grabber due to change of the video encoding format
2022-06-06T12:13:20.657Z [V4L2:USB VIDEO: USB] setQFrameDecimation is now: disabled
2022-06-06T12:13:20.657Z [V4L2:USB Video: USB] (GrabberWrapper.cpp:543) Frame cache is: enabled
2022-06-06T12:13:20.676Z [PIPEWIRE_SYSTEM:AUTO] Cropping image: width=0 height=0; crop: left=0 right=0 top=0 bottom=0 
2022-06-06T12:13:20.681Z [PIPEWIRE_SYSTEM:AUTO] Loaded Pipewire proxy library for screen capturing
2022-06-06T12:13:20.683Z [DAEMON] The system doesn't support the Pipewire/Portal grabber
2022-06-06T12:13:20.683Z [X11_SYSTEM:AUTO] Cropping image: width=0 height=0; crop: left=0 right=0 top=0 bottom=0 
2022-06-06T12:13:20.690Z [X11_SYSTEM:AUTO] Loaded X11 proxy library for screen capturing
2022-06-06T12:13:20.690Z [DAEMON] The system doesn't support the X11 grabber
2022-06-06T12:13:20.690Z [FRAMEBUFFER_SYSTEM:AUTO] Cropping image: width=0 height=0; crop: left=0 right=0 top=0 bottom=0 
2022-06-06T12:13:20.691Z [DAEMON] The system doesn't support the FrameBuffer grabber
2022-06-06T12:13:20.910Z [SETTINGSMGR] Settings database initialized
2022-06-06T12:13:20.922Z [BLACKBORDER] Set mode to: letterbox
2022-06-06T12:13:20.922Z [COMPONENTREG0] Blackborder detector: enabled
2022-06-06T12:13:20.923Z [IMAGETOLED0] (ImageProcessor.cpp:163) Set LED mapping type to advanced
2022-06-06T12:13:20.923Z [IMAGETOLED0] (ImageProcessor.cpp:147) setSparseProcessing to 0
2022-06-06T12:13:20.925Z [RGB_TRANSFORM0] RGB transform classic_config: 0, saturationGain: 1.000000, luminanceGain: 1.000000, backlightThreshold: 1
2022-06-06T12:13:20.926Z [RGB_TRANSFORM0] setBacklightThreshold: 1
2022-06-06T12:13:20.926Z [ADJUST_RED0] Set correction to 255
2022-06-06T12:13:20.926Z [ADJUST_BLUE0] Set correction to 255
2022-06-06T12:13:20.926Z [ADJUST_GREEN0] Set correction to 255
2022-06-06T12:13:21.090Z [SETTINGSMGR] Settings database initialized
2022-06-06T12:13:21.092Z [BLACKBORDER] Set mode to: default
2022-06-06T12:13:21.093Z [IMAGETOLED2] (ImageProcessor.cpp:163) Set LED mapping type to advanced
2022-06-06T12:13:21.093Z [IMAGETOLED2] (ImageProcessor.cpp:147) setSparseProcessing to 0
2022-06-06T12:13:21.095Z [RGB_TRANSFORM2] RGB transform classic_config: 0, saturationGain: 1.000000, luminanceGain: 1.000000, backlightThreshold: 1
2022-06-06T12:13:21.095Z [RGB_TRANSFORM2] setBacklightThreshold: 1
2022-06-06T12:13:21.095Z [ADJUST_RED2] Set correction to 255
2022-06-06T12:13:21.095Z [ADJUST_BLUE2] Set correction to 255
2022-06-06T12:13:21.095Z [ADJUST_GREEN2] Set correction to 255
2022-06-06T12:13:21.124Z [JSONSERVER] (JsonServer.cpp:24) Created instance
2022-06-06T12:13:21.125Z [JSONSERVER] Started on port 19444
2022-06-06T12:13:21.153Z [PIPEWIRE_SYSTEM:auto] (SystemWrapper.cpp:75) Closing grabber: PIPEWIRE_SYSTEM:auto
2022-06-06T12:13:21.154Z [X11_SYSTEM:auto] (SystemWrapper.cpp:75) Closing grabber: X11_SYSTEM:auto
2022-06-06T12:13:21.154Z [FRAMEBUF_SYSTEM:auto] (SystemWrapper.cpp:75) Closing grabber: FRAMEBUF_SYSTEM:auto
2022-06-06T12:13:20.937Z [HYPERHDR0] Led strip RGB order is: rgb
2022-06-06T12:13:20.938Z [DB] Database opened: /home/pi/.hyperhdr/db/hyperhdr.db
2022-06-06T12:13:20.959Z [SMOOTHING0] Clearing queued colors before: enabling
2022-06-06T12:13:20.959Z [SMOOTHING0] Smoothing queue is cleared
2022-06-06T12:13:20.959Z [COMPONENTREG0] Smoothing: enabled
2022-06-06T12:13:20.959Z [SMOOTHING0] Creating config (0) => type: Linear, dirMode: false, pause: false, settlingTime: 50ms, interval: 33ms (30Hz), antiFlickTres: 0, antiFlickStep: 0, antiFlickTime: 0
2022-06-06T12:13:20.959Z [SMOOTHING0] Clearing queued colors before: enabling. Smoothing configuration changed: restarting timer.
2022-06-06T12:13:20.960Z [SMOOTHING0] Smoothing queue is cleared
2022-06-06T12:13:20.960Z [SMOOTHING0] Selecting config (0) => type: Linear, dirMode: false, pause: false, settlingTime: 50ms, interval: 33ms (30Hz), antiFlickTres: 0, antiFlickStep: 0, antiFlickTime: 0
2022-06-06T12:13:20.960Z [SMOOTHING0] Selecting config (0) => type: Linear, dirMode: false, pause: false, settlingTime: 50ms, interval: 33ms (30Hz), antiFlickTres: 0, antiFlickStep: 0, antiFlickTime: 0
2022-06-06T12:13:20.961Z [LEDDEVICE_WLED] Start LedDevice 'wled'.
2022-06-06T12:13:20.961Z [LEDDEVICE_WLED] (LedDeviceWled.cpp:51) 
2022-06-06T12:13:20.962Z [LEDDEVICE_WLED] (LedDevice.cpp:164) deviceConfig: [{"colorOrder":"rgb","currentLedCount":422,"hardwareLedCount":422,"host":"192.168.20.94","latchTime":0,"refreshTime":0,"type":"wled"}]
2022-06-06T12:13:20.962Z [LEDDEVICE_WLED] (LedDevice.cpp:228) RefreshTime updated to 0ms
2022-06-06T12:13:20.962Z [LEDDEVICE_WLED] (LedDeviceWled.cpp:59) DeviceType   : wled
2022-06-06T12:13:20.962Z [LEDDEVICE_WLED] (LedDeviceWled.cpp:60) LedCount     : 422
2022-06-06T12:13:20.962Z [LEDDEVICE_WLED] (LedDeviceWled.cpp:63) Max retry    : 60
2022-06-06T12:13:20.963Z [LEDDEVICE_WLED] (LedDeviceWled.cpp:105) 
2022-06-06T12:13:20.965Z [LEDDEVICE_WLED] (LedDeviceWled.cpp:116) [1]
2022-06-06T12:13:20.965Z [MUXER0] Register new input 'System/VIDEOGRABBER' with priority 240 as inactive
2022-06-06T12:13:20.965Z [LEDDEVICE_WLED] (LedDevice.cpp:164) deviceConfig: [{"colorOrder":"rgb","currentLedCount":422,"hardwareLedCount":422,"host":"192.168.20.94","latchTime":0,"port":19446,"refreshTime":0,"type":"wled"}]
2022-06-06T12:13:20.965Z [COMPONENTREG0] Video capture device: enabled
2022-06-06T12:13:21.155Z [V4L2:USB VIDEO: USB] Multithreading for V4L2 is enabled. Available thread's count 4
2022-06-06T12:13:21.155Z [V4L2:USB VIDEO: USB] Found capture device: /dev/video14
2022-06-06T12:13:21.156Z [V4L2:USB VIDEO: USB] Found capture device: /dev/video22
2022-06-06T12:13:21.157Z [V4L2:USB VIDEO: USB] Found capture device: /dev/video15
2022-06-06T12:13:21.158Z [V4L2:USB VIDEO: USB] Found capture device: /dev/video21
2022-06-06T12:13:21.159Z [V4L2:USB VIDEO: USB] Found capture device: /dev/video0
2022-06-06T12:13:21.159Z [V4L2:USB VIDEO: USB] (V4L2Grabber.cpp:402) Device has 'brightness' control => min: -128, max: 127, default: -11
2022-06-06T12:13:21.159Z [V4L2:USB VIDEO: USB] (V4L2Grabber.cpp:408) Device has 'contrast' control => min: 0, max: 255, default: 148
2022-06-06T12:13:21.159Z [V4L2:USB VIDEO: USB] (V4L2Grabber.cpp:414) Device has 'saturation' control => min: 0, max: 255, default: 180
2022-06-06T12:13:21.159Z [V4L2:USB VIDEO: USB] (V4L2Grabber.cpp:420) Device has 'hue' control => min: -128, max: 127, default: 0
2022-06-06T12:13:21.161Z [V4L2:USB VIDEO: USB] (V4L2Grabber.cpp:212) Searching for USB Video: USB Video (video0) 720 x 480 @ 30 fps, input: -1 (yuyv)
2022-06-06T12:13:21.161Z [V4L2:USB VIDEO: USB] *************************************************************************************************
2022-06-06T12:13:21.161Z [V4L2:USB VIDEO: USB] Starting V4L2 grabber. Selected: USB Video: USB Video (video0) [/dev/video0] 720 x 480 @ 30 fps yuyv
2022-06-06T12:13:21.161Z [V4L2:USB VIDEO: USB] *************************************************************************************************
2022-06-06T12:13:21.162Z [V4L2:USB VIDEO: USB] (V4L2Grabber.cpp:807) Hardware cropping is not supported: ignoring
2022-06-06T12:13:21.162Z [V4L2:USB VIDEO: USB] Set device input to: Camera 1
2022-06-06T12:13:21.163Z [V4L2:USB VIDEO: USB] Set resolution to: 720 x 480
2022-06-06T12:13:21.164Z [V4L2:USB VIDEO: USB] Set framerate to 30 FPS
2022-06-06T12:13:21.164Z [V4L2:USB VIDEO: USB] Brightness set to: -11 (default)
2022-06-06T12:13:21.165Z [V4L2:USB VIDEO: USB] Contrast set to: 148 (default)
2022-06-06T12:13:21.167Z [V4L2:USB VIDEO: USB] Saturation set to: 180 (default)
2022-06-06T12:13:21.167Z [V4L2:USB VIDEO: USB] Hue set to: 0 (default)
2022-06-06T12:13:21.168Z [V4L2:USB VIDEO: USB] (V4L2Grabber.cpp:105) LUT folder location: '/usr/share/hyperhdr/lut'
2022-06-06T12:13:21.168Z [V4L2:USB VIDEO: USB] LUT file is not found here: /home/pi/.hyperhdr/lut_lin_tables.3d
2022-06-06T12:13:21.168Z [V4L2:USB VIDEO: USB] (Grabber.cpp:445) LUT file found: /usr/share/hyperhdr/lut/lut_lin_tables.3d
2022-06-06T12:13:21.168Z [V4L2:USB VIDEO: USB] (Grabber.cpp:460) Index 2 for YUV
2022-06-06T12:13:21.300Z [V4L2:USB VIDEO: USB] Found and loaded LUT: '/usr/share/hyperhdr/lut/lut_lin_tables.3d'
2022-06-06T12:13:21.301Z [V4L2:USB VIDEO: USB] Video pixel format is set to: YUYV
2022-06-06T12:13:21.306Z [V4L2:USB VIDEO: USB] Started
2022-06-06T12:13:20.965Z [LEDDEVICE_WLED] (LedDevice.cpp:228) RefreshTime updated to 0ms
2022-06-06T12:13:20.965Z [LEDDEVICE_WLED] (ProviderUdp.cpp:69) Successfully parsed 192.168.20.94 as an IP-address.
2022-06-06T12:13:20.966Z [LEDDEVICE_WLED] (ProviderUdp.cpp:99) UDP socket will write to 192.168.20.94:19446
2022-06-06T12:13:20.966Z [LEDDEVICE_WLED] (LedDeviceWled.cpp:94) Hostname/IP  : 192.168.20.94
2022-06-06T12:13:20.966Z [LEDDEVICE_WLED] (LedDeviceWled.cpp:95) Port         : 19446
2022-06-06T12:13:20.966Z [LEDDEVICE_WLED] (LedDeviceWled.cpp:99) [1]
2022-06-06T12:13:20.966Z [LEDDEVICE_WLED] (LedDevice.cpp:102) Enable device
2022-06-06T12:13:20.967Z [BOBLIGHT] Instance created
2022-06-06T12:13:20.967Z [LEDDEVICE_WLED] (LedDevice.cpp:310) Switch on
2022-06-06T12:13:20.967Z [LEDDEVICE_WLED] (LedDeviceWled.cpp:128) 
2022-06-06T12:13:20.968Z [LEDDEVICE] (ProviderRestApi.cpp:165) PUT: [http://192.168.20.94/json/state] [{"on":true,"live":true}]
2022-06-06T12:13:21.308Z [HYPERMANAGER] HyperHDR instance 'Bandeau' has been started
2022-06-06T12:13:21.309Z [DAEMON] Unload CEC
2022-06-06T12:13:20.993Z [SMOOTHING0] Using linear smoothing procedure (0)
2022-06-06T12:13:21.097Z [HYPERHDR2] Led strip RGB order is: rgb
2022-06-06T12:13:21.098Z [DB] Database opened: /home/pi/.hyperhdr/db/hyperhdr.db
2022-06-06T12:13:21.126Z [FLATBUFSERVER] Started on port 19400
2022-06-06T12:13:21.127Z [PROTOSERVER] Started on port 19445
2022-06-06T12:13:21.127Z [FLATBUFSERVER] Started local domain socket server: 'hyperhdr-domain'
2022-06-06T12:13:21.128Z [WEBSERVER] Initialize Webserver
2022-06-06T12:13:21.129Z [WEBSERVER] Initialize Webserver
2022-06-06T12:13:21.134Z [SMOOTHING2] Clearing queued colors before: enabling
2022-06-06T12:13:21.134Z [SMOOTHING2] Smoothing queue is cleared
2022-06-06T12:13:21.134Z [COMPONENTREG2] Smoothing: enabled
2022-06-06T12:13:21.134Z [SMOOTHING2] Creating config (0) => type: Linear, dirMode: false, pause: false, settlingTime: 50ms, interval: 33ms (30Hz), antiFlickTres: 0, antiFlickStep: 0, antiFlickTime: 0
2022-06-06T12:13:21.134Z [SMOOTHING2] Clearing queued colors before: enabling. Smoothing configuration changed: restarting timer.
2022-06-06T12:13:21.135Z [SMOOTHING2] Smoothing queue is cleared
2022-06-06T12:13:21.135Z [SMOOTHING2] Selecting config (0) => type: Linear, dirMode: false, pause: false, settlingTime: 50ms, interval: 33ms (30Hz), antiFlickTres: 0, antiFlickStep: 0, antiFlickTime: 0
2022-06-06T12:13:21.135Z [SMOOTHING2] Selecting config (0) => type: Linear, dirMode: false, pause: false, settlingTime: 50ms, interval: 33ms (30Hz), antiFlickTres: 0, antiFlickStep: 0, antiFlickTime: 0
2022-06-06T12:13:21.137Z [LEDDEVICE_FILE] Start LedDevice 'file'.
2022-06-06T12:13:21.138Z [LEDDEVICE_FILE] (LedDevice.cpp:164) deviceConfig: [{"colorOrder":"rgb","currentLedCount":1,"hardwareLedCount":1,"refreshTime":0,"type":"file"}]
2022-06-06T12:13:21.138Z [MUXER2] Register new input 'System/VIDEOGRABBER' with priority 240 as inactive
2022-06-06T12:13:21.138Z [COMPONENTREG2] Video capture device: enabled
2022-06-06T12:13:21.309Z [V4L2:USB VIDEO: USB] Multithreading for V4L2 is enabled. Available thread's count 4
2022-06-06T12:13:21.138Z [LEDDEVICE_FILE] (LedDevice.cpp:228) RefreshTime updated to 0ms
2022-06-06T12:13:21.139Z [LEDDEVICE_FILE] (LedDevice.cpp:102) Enable device
2022-06-06T12:13:21.139Z [LEDDEVICE_FILE] (LedDeviceFile.cpp:57) QIODevice::WriteOnly, /dev/null
2022-06-06T12:13:21.139Z [LEDDEVICE_FILE] (LedDevice.cpp:310) Switch on
2022-06-06T12:13:21.139Z [LEDDEVICE_FILE] (LedDevice.cpp:386) Power On
2022-06-06T12:13:21.140Z [BOBLIGHT] Instance created
2022-06-06T12:13:21.310Z [HYPERMANAGER] HyperHDR instance 'HuePlays-HyperHDR' has been started
2022-06-06T12:13:21.311Z [DAEMON] Unload CEC
2022-06-06T12:13:21.141Z [COMPONENTREG2] LED device: enabled
2022-06-06T12:13:21.142Z [EFFECTENGINE2] Run effect "Rainbow swirl fast" on channel 0
2022-06-06T12:13:21.143Z [EFFECTENGINE2] (EffectEngine.cpp:174) Start the effect: name [Rainbow swirl fast], smoothCfg [2]
2022-06-06T12:13:21.143Z [MUXER2] Register new input 'System/EFFECT' with priority 0 as inactive
2022-06-06T12:13:21.143Z [HYPERHDR] Initial foreground effect 'Rainbow swirl fast' started
2022-06-06T12:13:21.143Z [SMOOTHING2] Using linear smoothing input (0)
2022-06-06T12:13:21.145Z [EFFECT2(Rainbo...)] Begin playing the effect with priority: 0
2022-06-06T12:13:21.147Z [MUXER2] Priority 0 is now active
2022-06-06T12:13:21.147Z [MUXER2] Set visible priority to 0
2022-06-06T12:13:21.147Z [IMAGETOLED2] Total index number is: 320 (memory: 320). User sparse processing is: disabled, image size: 80 x 45, area number: 1
2022-06-06T12:13:21.148Z [HYPERHDR2] New priority[0], previous [255]
2022-06-06T12:13:21.148Z [HYPERHDR2] New source available -> switch LED-Device on
2022-06-06T12:13:21.148Z [SMOOTHING2] Clearing queued colors before: enabling
2022-06-06T12:13:21.148Z [SMOOTHING2] Smoothing queue is cleared
2022-06-06T12:13:21.148Z [LEDDEVICE_FILE] (LedDevice.cpp:102) Enable device
2022-06-06T12:13:21.149Z [SMOOTHING2] Clearing queued colors before: enabling. Smoothing configuration changed: restarting timer.
2022-06-06T12:13:21.149Z [SMOOTHING2] Smoothing queue is cleared
2022-06-06T12:13:21.149Z [SMOOTHING2] Selecting config (2) => type: Linear, dirMode: false, pause: false, settlingTime: 200ms, interval: 40ms (25Hz), antiFlickTres: 0, antiFlickStep: 0, antiFlickTime: 0
2022-06-06T12:13:21.149Z [SMOOTHING2] Using linear smoothing input (2)
2022-06-06T12:13:21.162Z [WEBSERVER] Apply Webserver settings
2022-06-06T12:13:21.162Z [WEBSERVER] Set document root to: :/webconfig
2022-06-06T12:13:21.163Z [WEBSERVER] Started on port 8090 name 'HyperHDR Webserver'
2022-06-06T12:13:21.166Z [WEBSERVER] Apply Webserver settings
2022-06-06T12:13:21.166Z [WEBSERVER] Set document root to: :/webconfig
2022-06-06T12:13:21.175Z [WEBSERVER] Setup SSL certificate
2022-06-06T12:13:21.176Z [WEBSERVER] Setup private SSL key
2022-06-06T12:13:21.176Z [WEBSERVER] Started on port 8092 name 'HyperHDR Webserver'
2022-06-06T12:13:21.190Z [SMOOTHING2] Using linear smoothing procedure (2)
2022-06-06T12:13:21.225Z [MUXER0] Set visible priority to 255
2022-06-06T12:13:21.225Z [HYPERHDR0] New priority[255], previous [255]
2022-06-06T12:13:21.226Z [HYPERHDR0] No source left -> switch LED-Device off
2022-06-06T12:13:21.226Z [SMOOTHING0] Clearing queued colors before: disabling
2022-06-06T12:13:21.226Z [SMOOTHING0] Smoothing queue is cleared
2022-06-06T12:13:21.275Z [LEDDEVICE] (ProviderRestApi.cpp:194) PUT exit: [http://192.168.20.94/json/state] [{"on":true,"live":true}]
2022-06-06T12:13:21.276Z [LEDDEVICE] (ProviderRestApi.cpp:383) Reply.httpStatusCode [200]
2022-06-06T12:13:21.276Z [LEDDEVICE_WLED] (LedDevice.cpp:136) Disable device
2022-06-06T12:13:21.277Z [LEDDEVICE_WLED] (LedDevice.cpp:336) Switch off
2022-06-06T12:13:21.277Z [LEDDEVICE_WLED] (LedDeviceWled.cpp:175) 
2022-06-06T12:13:21.277Z [LEDDEVICE_WLED] (LedDevice.cpp:294) Set LED strip to black/power off
2022-06-06T12:13:21.278Z [LEDDEVICE] (ProviderRestApi.cpp:165) PUT: [http://192.168.20.94/json/state] [{"on":false,"live":false}]
2022-06-06T12:13:21.408Z [V4L2:USB VIDEO: USB] (V4L2Grabber.cpp:1145) Worker's thread count  = 4
2022-06-06T12:13:21.420Z [V4L2:USB Video: USB] Detected the video frame size changed (720x480). Cache buffer was cleared.
2022-06-06T12:13:21.421Z [MUXER2] Priority 240 is now active
2022-06-06T12:13:21.509Z [LEDDEVICE] (ProviderRestApi.cpp:194) PUT exit: [http://192.168.20.94/json/state] [{"on":false,"live":false}]
2022-06-06T12:13:21.510Z [LEDDEVICE] (ProviderRestApi.cpp:383) Reply.httpStatusCode [200]
2022-06-06T12:13:21.511Z [COMPONENTREG0] LED device: enabled
2022-06-06T12:13:21.512Z [EFFECTENGINE0] Run effect "Rainbow swirl fast" on channel 0
2022-06-06T12:13:21.513Z [EFFECTENGINE0] (EffectEngine.cpp:174) Start the effect: name [Rainbow swirl fast], smoothCfg [2]
2022-06-06T12:13:21.513Z [MUXER0] Register new input 'System/EFFECT' with priority 0 as inactive
2022-06-06T12:13:21.513Z [HYPERHDR] Initial foreground effect 'Rainbow swirl fast' started
2022-06-06T12:13:21.514Z [SMOOTHING0] Using linear smoothing input (0)
2022-06-06T12:13:21.514Z [MUXER0] Priority 240 is now active
2022-06-06T12:13:21.514Z [MUXER0] Set visible priority to 0
2022-06-06T12:13:21.515Z [SMOOTHING0] Clearing queued colors before: enabling. Smoothing configuration changed: restarting timer.
2022-06-06T12:13:21.515Z [SMOOTHING0] Smoothing queue is cleared
2022-06-06T12:13:21.515Z [SMOOTHING0] Selecting config (2) => type: Linear, dirMode: false, pause: false, settlingTime: 200ms, interval: 40ms (25Hz), antiFlickTres: 0, antiFlickStep: 0, antiFlickTime: 0
2022-06-06T12:13:21.515Z [SMOOTHING0] Using linear smoothing input (2)
2022-06-06T12:13:21.515Z [HYPERHDR0] New priority[0], previous [255]
2022-06-06T12:13:21.515Z [HYPERHDR0] New source available -> switch LED-Device on
2022-06-06T12:13:21.516Z [SMOOTHING0] Clearing queued colors before: enabling
2022-06-06T12:13:21.516Z [SMOOTHING0] Smoothing queue is cleared
2022-06-06T12:13:21.516Z [LEDDEVICE_WLED] (LedDevice.cpp:102) Enable device
2022-06-06T12:13:21.517Z [LEDDEVICE_WLED] (LedDevice.cpp:310) Switch on
2022-06-06T12:13:21.518Z [LEDDEVICE_WLED] (LedDeviceWled.cpp:128) 
2022-06-06T12:13:21.519Z [LEDDEVICE] (ProviderRestApi.cpp:165) PUT: [http://192.168.20.94/json/state] [{"on":true,"live":true}]
2022-06-06T12:13:22.024Z [LEDDEVICE] (ProviderRestApi.cpp:194) PUT exit: [http://192.168.20.94/json/state] [{"on":true,"live":true}]
2022-06-06T12:13:22.024Z [LEDDEVICE] Reply.httpStatusCode [408 Timeout] - Check if target IP is valid and your network status
2022-06-06T12:13:22.024Z [LEDDEVICE_WLED] Device disabled, device 'wled' signals error: '[408 Timeout] - Check if target IP is valid and your network status'
2022-06-06T12:13:22.025Z [LEDDEVICE_WLED] The WLED device is not ready... will try to reconnect (try 1/60).
2022-06-06T12:13:22.026Z [COMPONENTREG0] LED device: disabled
2022-06-06T12:13:22.026Z [SMOOTHING0] Using linear smoothing procedure (2)
2022-06-06T12:13:22.027Z [EFFECT0(Rainbo...)] Begin playing the effect with priority: 0
2022-06-06T12:13:22.031Z [MUXER0] Priority 0 is now active
2022-06-06T12:13:22.032Z [IMAGETOLED0] Total index number is: 1680 (memory: 1680). User sparse processing is: disabled, image size: 80 x 45, area number: 420
2022-06-06T12:13:22.520Z [LEDDEVICE_WLED] (LedDevice.cpp:310) Switch on
2022-06-06T12:13:22.520Z [LEDDEVICE_WLED] (LedDeviceWled.cpp:128) 
2022-06-06T12:13:22.520Z [LEDDEVICE] (ProviderRestApi.cpp:165) PUT: [http://192.168.20.94/json/state] [{"on":true,"live":true}]
2022-06-06T12:13:22.882Z [LEDDEVICE] (ProviderRestApi.cpp:194) PUT exit: [http://192.168.20.94/json/state] [{"on":true,"live":true}]
2022-06-06T12:13:22.883Z [LEDDEVICE] (ProviderRestApi.cpp:383) Reply.httpStatusCode [200]
2022-06-06T12:13:22.883Z [COMPONENTREG0] LED device: enabled
2022-06-06T12:13:22.885Z [SMOOTHING0] Using linear smoothing input (2)
2022-06-06T12:13:24.160Z [EFFECT2(Rainbo...)] The effect quits with priority: 0
2022-06-06T12:13:24.162Z [MUXER2] Removed source priority 0
2022-06-06T12:13:24.162Z [MUXER2] Set visible priority to 240
2022-06-06T12:13:24.163Z [IMAGETOLED2] This is large image area for lamp: 1. It contains 27360 indexes for captured video frame so reduce it by four. Enabling 'sparse processing' option for you. Consider to enable it permanently in the processing configuration to hide that warning.
2022-06-06T12:13:24.163Z [IMAGETOLED2] Total index number is: 6840 (memory: 6840). User sparse processing is: disabled, image size: 720 x 480, area number: 1
2022-06-06T12:13:24.163Z [HYPERHDR2] New priority[240], previous [0]
2022-06-06T12:13:24.164Z [EFFECTENGINE2] Effect 'Rainbow swirl fast' has finished.
2022-06-06T12:13:24.164Z [EFFECT2(Rainbo...)] Deleting effect named: 'Rainbow swirl fast'
2022-06-06T12:13:24.164Z [EFFECT2(Rainbo...)] Effect named: 'Rainbow swirl fast' is deleted
2022-06-06T12:13:24.165Z [SMOOTHING2] Clearing queued colors before: enabling. Smoothing configuration changed: restarting timer.
2022-06-06T12:13:24.165Z [SMOOTHING2] Smoothing queue is cleared
2022-06-06T12:13:24.166Z [SMOOTHING2] Selecting config (0) => type: Linear, dirMode: false, pause: false, settlingTime: 50ms, interval: 33ms (30Hz), antiFlickTres: 0, antiFlickStep: 0, antiFlickTime: 0
2022-06-06T12:13:24.166Z [SMOOTHING2] Using linear smoothing input (0)
2022-06-06T12:13:24.199Z [SMOOTHING2] Using linear smoothing procedure (0)
2022-06-06T12:13:25.043Z [EFFECT0(Rainbo...)] The effect quits with priority: 0
2022-06-06T12:13:25.044Z [MUXER0] Removed source priority 0
2022-06-06T12:13:25.044Z [MUXER0] Set visible priority to 240
2022-06-06T12:13:25.049Z [IMAGETOLED0] Total index number is: 89280 (memory: 89280). User sparse processing is: disabled, image size: 720 x 480, area number: 420
2022-06-06T12:13:25.050Z [HYPERHDR0] New priority[240], previous [0]
2022-06-06T12:13:25.051Z [EFFECTENGINE0] Effect 'Rainbow swirl fast' has finished.
2022-06-06T12:13:25.056Z [IMAGETOLED0] Total index number is: 89280 (memory: 89280). User sparse processing is: disabled, image size: 720 x 480, area number: 420
2022-06-06T12:13:25.057Z [EFFECT0(Rainbo...)] Deleting effect named: 'Rainbow swirl fast'
2022-06-06T12:13:25.058Z [EFFECT0(Rainbo...)] Effect named: 'Rainbow swirl fast' is deleted
2022-06-06T12:13:25.064Z [SMOOTHING0] Clearing queued colors before: enabling. Smoothing configuration changed: restarting timer.
2022-06-06T12:13:25.065Z [SMOOTHING0] Smoothing queue is cleared
2022-06-06T12:13:25.065Z [SMOOTHING0] Selecting config (0) => type: Linear, dirMode: false, pause: false, settlingTime: 50ms, interval: 33ms (30Hz), antiFlickTres: 0, antiFlickStep: 0, antiFlickTime: 0
2022-06-06T12:13:25.065Z [SMOOTHING0] Using linear smoothing input (0)
2022-06-06T12:13:25.099Z [SMOOTHING0] Using linear smoothing procedure (0)
2022-06-06T12:13:42.584Z [WEBSOCKET] (WebSocketClient.cpp:30) New connection from ::ffff:192.168.10.12
2022-06-06T12:13:42.584Z [WEBSOCKET] (JsonAPI.cpp:96) Client '::ffff:192.168.10.12' switch to HyperHDR instance 0
2022-06-06T12:13:51.995Z [JSONSERVER] (JsonServer.cpp:88) New connection from: ::ffff:192.168.20.20 
2022-06-06T12:13:51.996Z [JSONCLIENTCONNECTION] (JsonAPI.cpp:96) Client '::ffff:192.168.20.10' switch to HyperHDR instance 0
2022-06-06T12:13:51.996Z [JSONSERVER] (JsonServer.cpp:88) New connection from: ::ffff:192.168.20.20 
2022-06-06T12:13:51.997Z [JSONCLIENTCONNECTION] (JsonAPI.cpp:96) Client '::ffff:192.168.20.10' switch to HyperHDR instance 0
2022-06-06T12:13:56.207Z [DB] Database opened: /home/pi/.hyperhdr/db/hyperhdr.db
2022-06-06T12:15:00.031Z [V4L2:USB VIDEO: USB] Video cache: enabled, size: 7, hits: 1801, needed: 0, cleanup: 1, limit: 8
2022-06-06T12:15:00.035Z [PERFORMANCE] [USB capturing: FPS = 30.01, decoding = 11ms, frames = 1801, invalid = 0], [INSTANCE0: FPS = 30.01, processed = 1801], [LED0: FPS = 30.30, send = 1818, processed = 1818], [INSTANCE2: FPS = 30.01, processed = 1801], [LED2: FPS = 30.30, send = 1819, processed = 1819]
2022-06-06T12:15:50.996Z [IMAGETOLED0] Total index number is: 79200 (memory: 79200). User sparse processing is: disabled, image size: 720 x 480, area number: 420
2022-06-06T12:16:00.018Z [V4L2:USB VIDEO: USB] Video cache: enabled, size: 7, hits: 1800, needed: 0, cleanup: 0, limit: 8
2022-06-06T12:16:00.034Z [PERFORMANCE] [USB capturing: FPS = 30.01, decoding = 9ms, frames = 1800, invalid = 0], [INSTANCE0: FPS = 30.01, processed = 1801], [LED0: FPS = 30.30, send = 1818, processed = 1818], [INSTANCE2: FPS = 30.01, processed = 1801], [LED2: FPS = 30.30, send = 1818, processed = 1818]
2022-06-06T12:16:01.528Z [IMAGETOLED0] Total index number is: 89280 (memory: 89280). User sparse processing is: disabled, image size: 720 x 480, area number: 420

awawa-dev commented 2 years ago

Beginning of the logs is still missing

gogui63 commented 2 years ago

Jun 06 14:22:39 raspberrypi systemd[1]: hyperhdr@pi.service: Succeeded.
Jun 06 14:22:39 raspberrypi systemd[1]: Stopped HyperHdr ambient light systemd service  for user pi.
Jun 06 14:22:39 raspberrypi systemd[1]: hyperhdr@pi.service: Consumed 4min 38.058s CPU time.
Jun 06 14:22:39 raspberrypi systemd[1]: Started HyperHdr ambient light systemd service  for user pi.
Jun 06 14:22:39 raspberrypi sudo[31044]: pam_unix(sudo:session): session closed for user root
Jun 06 14:22:39 raspberrypi hyperhdr[31049]: GUI application2022-06-06T14:22:39.244 MAIN                   : <INFO> Database path: '/home/pi/.hyperhdr/db/h>
Jun 06 14:22:39 raspberrypi hyperhdr[31049]: 2022-06-06T14:22:39.244 MAIN                   : <INFO> Starting HyperHdr - 18.0.0.0beta3, (HEAD detached at 8>
Jun 06 14:22:39 raspberrypi hyperhdr[31049]: 2022-06-06T14:22:39.245 MAIN                   : <INFO> Set user data path to '/home/pi/.hyperhdr'
Jun 06 14:22:39 raspberrypi hyperhdr[31049]: 2022-06-06T14:22:39.254 DB                     : <INFO> Database opened: /home/pi/.hyperhdr/db/hyperhdr.db
Jun 06 14:22:39 raspberrypi hyperhdr[31049]: 2022-06-06T14:22:39.535 SETTINGSMGR            : <INFO> Settings database initialized
Jun 06 14:22:39 raspberrypi hyperhdr[31049]: 2022-06-06T14:22:39.536 HYPERHDR               : <INFO> Sound device is disabled
Jun 06 14:22:39 raspberrypi hyperhdr[31049]: 2022-06-06T14:22:39.636 V4L2:USB VIDEO: USB    : <INFO> Cropping image: width=0 height=0; crop: left=0 right=0>

Logs from journactl

pi@raspberrypi:~/.hyperhdr/db $ ls -al
total 92
drwxr-xr-x 2 pi pi  4096 Jun  6 14:23 .
drwxr-xr-x 3 pi pi  4096 Jun  1 22:12 ..
-rw-r--r-- 1 pi pi 81920 Jun  6 14:23 hyperhdr.db

awawa-dev commented 2 years ago

No, let's do it differently. Stop hyperhdr service then run from command line /usr/bin/hyperhdr and paste full it's output from the console.

gogui63 commented 2 years ago

https://pastebin.com/apfCvbEH

I missed something ?

awawa-dev commented 2 years ago

Seems fine. Could you restore your old configuration from GUI (HyperHDR throws exception and exits then, it's done on purpose)

My HyperHDR configuration : https://pastebin.com/seQ6dGj9

then run /usr/bin/hyperhdr and search in the output if HyperHDR can fix it like in my case: https://github.com/awawa-dev/HyperHDR/issues/119#issuecomment-1147280360

gogui63 commented 2 years ago

You right :

pi@raspberrypi:~/.hyperhdr/db $ cat logs_awawa.log | grep Config
2022-06-06T14:44:08.303 SETTINGSMGR            : <WARNING> Config Fix: [root].effects.disable: Create property: disable with value: 
2022-06-06T14:44:08.303 SETTINGSMGR            : <WARNING> Config Fix: [root].effects.paths: Create property: paths with value: $ROOT/custom-effects
2022-06-06T14:44:08.303 SETTINGSMGR            : <WARNING> Config Fix: [root].foregroundEffect.color: Create property: color with value: 255
2022-06-06T14:44:08.303 SETTINGSMGR            : <WARNING> Config Fix: [root].foregroundEffect.duration_ms: Create property: duration_ms with value: 3000
2022-06-06T14:44:08.303 SETTINGSMGR            : <WARNING> Config Fix: [root].foregroundEffect.effect: Create property: effect with value: Rainbow swirl fast
2022-06-06T14:44:08.303 SETTINGSMGR            : <WARNING> Config Fix: [root].foregroundEffect.enable: Create property: enable with value: True
2022-06-06T14:44:08.303 SETTINGSMGR            : <WARNING> Config Fix: [root].foregroundEffect.type: Create property: type with value: effect
2022-06-06T14:44:08.303 SETTINGSMGR            : <WARNING> Config Fix: [root].rawUdpServer.enable: Create property: enable with value: False
2022-06-06T14:44:08.304 SETTINGSMGR            : <WARNING> Config Fix: [root].rawUdpServer.port: Create property: port with value: 5568
2022-06-06T14:44:08.304 SETTINGSMGR            : <WARNING> Config Fix: [root].rawUdpServer.priority: Create property: priority with value: 109
2022-06-06T14:44:08.304 SETTINGSMGR            : <WARNING> Config Fix: [root].smoothing.continuousOutput: Create property: continuousOutput with value: False
2022-06-06T14:44:08.304 SETTINGSMGR            : <WARNING> Config Fix: [root].smoothing.enable: Create property: enable with value: True
2022-06-06T14:44:08.304 SETTINGSMGR            : <WARNING> Config Fix: [root].smoothing.lowLightAntiFlickeringTimeout: Create property: lowLightAntiFlickeringTimeout with value: 0
2022-06-06T14:44:08.304 SETTINGSMGR            : <WARNING> Config Fix: [root].smoothing.lowLightAntiFlickeringTreshold: Create property: lowLightAntiFlickeringTreshold with value: 0
2022-06-06T14:44:08.304 SETTINGSMGR            : <WARNING> Config Fix: [root].smoothing.lowLightAntiFlickeringValue: Create property: lowLightAntiFlickeringValue with value: 2
2022-06-06T14:44:08.304 SETTINGSMGR            : <WARNING> Config Fix: [root].smoothing.time_ms: Create property: time_ms with value: 150
2022-06-06T14:44:08.305 SETTINGSMGR            : <WARNING> Config Fix: [root].smoothing.type: Create property: type with value: alternative
2022-06-06T14:44:08.305 SETTINGSMGR            : <WARNING> Config Fix: [root].smoothing.updateFrequency: Create property: updateFrequency with value: 50

awawa-dev commented 2 years ago

Exit from HyperHDR now. Run it again from command line. If the database works OK, then HyperHDR should not repair it again because it's already fixed and saved..

gogui63 commented 2 years ago

Right again :

pi@raspberrypi:~/.hyperhdr/db $ sudo systemctl stop hyperhdr@pi.service
pi@raspberrypi:~/.hyperhdr/db $ mv logs_awawa.log logs_awawa.log_old
pi@raspberrypi:~/.hyperhdr/db $ /usr/bin/hyperhdr >> logs_awawa.log
pi@raspberrypi:~/.hyperhdr/db $ cat logs_awawa.log | grep Config
pi@raspberrypi:~/.hyperhdr/db $

Finaly I added succesfully my hues plays at HyperHDR thanks for debugging ;)

awawa-dev commented 2 years ago

I'm not sure why this has happened to you earlier, but the configuration was broken for sure and couldn't be repair by HyperHDR during normal initialization at startup. I suspect some "rogue"/doubled records of the same component ID that confused HyperHDR (they would not reveal in the backup or logs). But when you've restored the configuration, all the database was cleared before import and these "hidden" records were also deleted.

awawa-dev / HyperHDR