[gelöst]FHEM Docker Container lässt sich nicht mehr starten / Teil 2

Begonnen von fhemjan, 01 Juni 2023, 18:16:14

Vorheriges Thema - Nächstes Thema

fhemjan

Hallo zusammen,
ich hatte schon mal ein ähnliches Problem hier beschrieben, damals war scheinbar der Fehler dass mein damaliger cul868 gestört hat (s. https://forum.fhem.de/index.php?topic=131288.msg1255098#msg1255098).

Nun ist es, einige fehlerfreie Monate später, wieder passiert: Der FHEM Container ist einfach ausgestiegen und lässt sich nun nicht mehr starten. Beim Versuch gibt er ein
Request failed with status code 500Er lief bis zum 29.05.23 15:05, hier der Auszug aus dem Log-file:
Starting FHEM ...
2023.05.27 21:13:27.081 1: Including fhem.cfg
2023.05.27 21:13:27.472 2: eventTypes: loaded 1762 lines from ./log/eventTypes.txt
2023.05.27 21:13:54.210 1: Including ./log/fhem.save
2023.05.27 21:14:02.467 0: Featurelevel: 6.1
2023.05.27 21:14:02.468 0: Server started with 139 defined entities (fhem.pl:26248/2022-07-19 perl:5.032001 os:linux user:fhem pid:4695)
2023.05.27 21:14:02.674 1: HMUARTLGW myRemoteHmUART failed to enter App!
2023.05.27 22:28:01.932 1: PERL WARNING: Subroutine myUtils_Initialize redefined at ./FHEM/99_myUtils.pm line 14.
2023.05.27 22:28:01.933 1: PERL WARNING: Subroutine SetTempList_Heizungen redefined at ./FHEM/99_myUtils.pm line 23.
2023.05.27 22:28:01.934 1: PERL WARNING: Subroutine Urlaub redefined at ./FHEM/99_myUtils.pm line 165.
2023.05.28 01:19:00.435 1: HMUARTLGW myRemoteHmUART did not respond for the 1. time, resending
2023.05.28 01:19:03.438 1: HMUARTLGW myRemoteHmUART did not respond for the 2. time, resending
2023.05.28 01:19:06.440 1: HMUARTLGW myRemoteHmUART did not respond for the 3. time, resending
2023.05.28 01:19:09.443 1: HMUARTLGW myRemoteHmUART did not respond after all, reopening
2023.05.28 08:00:23.178 1: 192.168.178.230:20108 reappeared (myRemoteHmUART)
2023.05.28 08:15:58.003 1: HMUARTLGW myRemoteHmUART did not respond for the 1. time, resending
2023.05.28 17:04:10.642 1: Tür im SZ schließen
2023.05.28 20:59:52.129 1: Tür im SZ schließen
2023.05.29 00:00:52.235 1: HMUARTLGW myRemoteHmUART did not respond for the 1. time, resending
2023.05.29 00:00:55.238 1: HMUARTLGW myRemoteHmUART did not respond for the 2. time, resending
2023.05.29 00:00:58.241 1: HMUARTLGW myRemoteHmUART did not respond for the 3. time, resending
2023.05.29 00:01:01.245 1: HMUARTLGW myRemoteHmUART did not respond after all, reopening
2023.05.29 01:04:57.886 1: Hohe Luftfeuchtigkeit im Wohnzimmer
2023.05.29 06:00:56.401 1: 192.168.178.230:20108 reappeared (myRemoteHmUART)
2023.05.29 06:32:01.454 1: HMUARTLGW myRemoteHmUART did not respond for the 1. time, resending
2023.05.29 07:06:07.624 1: Hohe Luftfeuchtigkeit im Wohnzimmer
2023.05.29 08:44:31.215 1: HMUARTLGW myRemoteHmUART did not respond for the 1. time, resending
2023.05.29 08:44:34.219 1: HMUARTLGW myRemoteHmUART did not respond for the 2. time, resending
2023.05.29 08:44:37.221 1: HMUARTLGW myRemoteHmUART did not respond for the 3. time, resending
2023.05.29 08:44:40.224 1: HMUARTLGW myRemoteHmUART did not respond after all, reopening
2023.05.29 08:44:40.233 1: 192.168.178.230:20108 reappeared (myRemoteHmUART)
2023.05.29 08:45:59.892 1: HMUARTLGW myRemoteHmUART did not respond for the 1. time, resending
2023.05.29 08:46:26.906 1: HMUARTLGW myRemoteHmUART did not respond for the 1. time, resending
2023.05.29 08:46:29.909 1: HMUARTLGW myRemoteHmUART did not respond for the 2. time, resending
2023.05.29 08:46:32.912 1: HMUARTLGW myRemoteHmUART did not respond for the 3. time, resending
2023.05.29 08:46:35.914 1: HMUARTLGW myRemoteHmUART did not respond after all, reopening
2023.05.29 08:46:35.922 1: 192.168.178.230:20108 reappeared (myRemoteHmUART)
2023.05.29 09:00:55.752 1: HMUARTLGW myRemoteHmUART did not respond for the 1. time, resending
2023.05.29 09:25:18.131 1: Tür im WZ offen
2023.05.29 12:11:59.908 1: Fenster KB offen


SIGTERM signal received, sending "shutdown" command to FHEM!

Waiting for FHEM process to terminate before stopping container:

2023.05.29 15:04:18.869 2: DbLog logdb - Last database write cycle due to shutdown ...
2023.05.29 15:04:18.881 1: Server shutdown delayed due to logdb for max 10 sec
2023.05.29 15:04:18.898 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 2584.

2023.05.29 15:04:18.904 2: DbLog logdb - Last database write cycle done
Preparing user environment ...
1. Creating group 'fhem' with GID 1000 ...
2. Enforcing GID for group 'bluetooth' to 6001 ...
3. Creating user 'fhem' with UID 1000 ...
4. Creating log directory /opt/fhem/./log ...
5. Enforcing user and group ownership for /opt/fhem to fhem:fhem ...
6. Enforcing file and directory permissions for /opt/fhem ...
7. Correcting group ownership for /dev/tty* ...
8. Correcting group ownership for /dev/serial/* ...
9. Found GPIO: Correcting group permissions in /dev and /sys to 'gpio' with GID 997 ...
10. Found I2C: Correcting group permissions in /dev to 'i2c' with GID 6003 ...
11. Updating /etc/sudoers.d/fhem-docker ...
12. Adding gateway.docker.internal to /etc/hosts ...
13. Adding host.docker.internal to /etc/hosts ...
14. Pre-authorizing SSH to Docker host for user 'fhem' ...
15. Updating SSH key pinning and SSH client permissions for user 'fhem' ...



Preparing configuration ... done

Starting FHEM ...
2023.05.29 15:05:22.946 1: Including fhem.cfg
2023.05.29 15:05:23.249 2: eventTypes: loaded 1852 lines from ./log/eventTypes.txt
2023.05.29 15:05:30.788 1: Including ./log/fhem.save


SIGTERM signal received, sending "shutdown" command to FHEM!

Waiting for FHEM process to terminate before stopping container:

2023.05.29 15:05:40.798 0: Featurelevel: 6.1
2023.05.29 15:05:40.798 0: Server started with 139 defined entities (fhem.pl:26248/2022-07-19 perl:5.032001 os:linux user:fhem pid:4706)
2023.05.29 15:05:40.990 1: HMUARTLGW myRemoteHmUART failed to enter App!
2023.05.29 15:05:40.994 2: DbLog logdb - Last database write cycle due to shutdown ...
2023.05.29 15:05:41.008 1: Server shutdown delayed due to logdb for max 10 sec
2023.05.29 15:05:47.594 2: DbLog logdb -> Error commit history - DBD::mysql::db commit failed: Turning on AutoCommit failed at ./FHEM/93_DbLog.pm line 2928.

2023.05.29 15:05:47.605 2: DbLog logdb - Last database write cycle done
2023.05.29 15:05:48.032 0: Server shutdown

Das der HMUARTLGW teilweise nicht antwortet ist ok, das WLAN ist von 1 Uhr bis 6 Uhr deaktiviert. Er scheint vereinzelt auch an anderen Zeitpunkten mal auszusetzen.. Sieht für mich jedoch nicht kritisch aus(?!)

Details des Containers:
{
    "AppArmorProfile": "",
    "Args": [
        "start"
    ],
    "Config": {
        "AttachStderr": false,
        "AttachStdin": false,
        "AttachStdout": false,
        "Cmd": [
            "start"
        ],
        "Domainname": "",
        "Entrypoint": [
            "/entry.sh"
        ],
        "Env": [
            "TZ=Europe/Berlin",
            "PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            "LANG=en_US.UTF-8",
            "LANGUAGE=en_US:en",
            "LC_ADDRESS=de_DE.UTF-8",
            "LC_MEASUREMENT=de_DE.UTF-8",
            "LC_MESSAGES=en_DK.UTF-8",
            "LC_MONETARY=de_DE.UTF-8",
            "LC_NAME=de_DE.UTF-8",
            "LC_NUMERIC=de_DE.UTF-8",
            "LC_PAPER=de_DE.UTF-8",
            "LC_TELEPHONE=de_DE.UTF-8",
            "LC_TIME=de_DE.UTF-8",
            "TERM=xterm",
            "LOGFILE=./log/fhem-%Y-%m-%d.log",
            "TELNETPORT=7072",
            "FHEM_PERM_DIR=0750",
            "FHEM_PERM_FILE=0640",
            "UMASK=0037",
            "BLUETOOTH_GID=6001",
            "GPIO_GID=997",
            "I2C_GID=6003",
            "TIMEOUT=10",
            "CONFIGTYPE=fhem.cfg",
            "FHEM_UID=1000",
            "FHEM_GID=1000"
        ],
        "ExposedPorts": {
            "8083/tcp": {}
        },
        "Healthcheck": {
            "Interval": 20000000000,
            "Retries": 5,
            "StartPeriod": 60000000000,
            "Test": [
                "CMD-SHELL",
                "/health-check.sh"
            ],
            "Timeout": 10000000000
        },
        "Hostname": "525198e32cc2",
        "Image": "ghcr.io/fhem/fhem/fhem-docker:bullseye",
        "Labels": {
            "org.fhem.authors": "https://fhem.de/MAINTAINER.txt",
            "org.fhem.description": "FHEM (TM) is a GPL'd perl server for house automation. It is used to automate some common tasks in the household like switching lamps / shutters / heating / etc. and to log events like temperature / humidity / power consumption.",
            "org.fhem.documentation": "https://fhem.de/#Documentation",
            "org.fhem.licenses": "GPL-2.0",
            "org.fhem.revision": "",
            "org.fhem.source": "https://svn.fhem.de/",
            "org.fhem.url": "https://fhem.de/",
            "org.fhem.vendor": "FHEM e.V.",
            "org.fhem.version": "",
            "org.opencontainers.image.authors": "https://github.com/fhem/fhem-docker/graphs/contributors",
            "org.opencontainers.image.created": "2022-05-16T19:37:52.035Z",
            "org.opencontainers.image.description": "A basic Docker image for FHEM house automation system, based on Debian Linux.",
            "org.opencontainers.image.documentation": "https://github.com/fhem/fhem-docker/blob/dbbe3d6d5b5d777e1c7baead0336ec820632920c/README.md",
            "org.opencontainers.image.licenses": "MIT",
            "org.opencontainers.image.revision": "dbbe3d6d5b5d777e1c7baead0336ec820632920c",
            "org.opencontainers.image.source": "https://github.com/fhem/fhem-docker",
            "org.opencontainers.image.title": "fhem-docker",
            "org.opencontainers.image.url": "https://github.com/fhem/fhem-docker",
            "org.opencontainers.image.vendor": "Julian Pawlowski",
            "org.opencontainers.image.version": "bullseye"
        },
        "OnBuild": null,
        "OpenStdin": false,
        "StdinOnce": false,
        "Tty": false,
        "User": "",
        "Volumes": {
            "/opt/fhem": {},
            "/sys/class/gpio": {},
            "/sys/devices/platform": {}
        },
        "WorkingDir": "/opt/fhem"
    },
    "Created": "2023-01-05T19:15:42.831896838Z",
    "Driver": "overlay2",
    "ExecIDs": null,
    "GraphDriver": {
        "Data": {
            "LowerDir": "/var/lib/docker/overlay2/b13380e500e859bfde969de2112c4e06b1c0b576251783a848747ccecbe0f715-init/diff:/var/lib/docker/overlay2/9a0a38ea2996d16d6fc5977c5a14b5cc50429c9d665fbf099b559527196458b7/diff:/var/lib/docker/overlay2/57d0db77ea8110b4800528d648f9910aed25f6f409da56919a8a4fd3c773faad/diff:/var/lib/docker/overlay2/dadc8b7ecd19e7ffc57171a5eddfce64f557c6492d625aedc790767a868b70a9/diff:/var/lib/docker/overlay2/2a8332c287fa08ab1fdc5d4441b5e3e833c883251769975b9d657161d9b1921a/diff:/var/lib/docker/overlay2/f3c66d185575b7ad053c0aaeb89a994b766e41351db2372ff17a8b5567ac2bf6/diff:/var/lib/docker/overlay2/39b0811c6c1d28e85f6fafc3200a8b6351360d823d86a1d121c09998699e4da7/diff:/var/lib/docker/overlay2/255fedc065b547f0268431e720dcdf3c879e7fa0badc6adfc895e7a3add1f72f/diff:/var/lib/docker/overlay2/1b095c1823d931e790db5cc863ab9e33dfabf10183b524de26e1c90858302795/diff:/var/lib/docker/overlay2/7cb91c7fe0f3cc4b17d3ce8ded7ccdc0bd7c4562dfc68c41ed88ecf3cf12f54d/diff:/var/lib/docker/overlay2/93738f85bc0579cb148404d2536d12e0bcfe986dba8a9c6e7f5cd1c0bde2df18/diff:/var/lib/docker/overlay2/fbf05d6515ba2ea283ddc4d690d67bb6c14cafe972abed87dea75b0d64832c9f/diff:/var/lib/docker/overlay2/64ace27737fd54f65bbf26a0c91b9a0e2922150ba0e13f2ff5f0873fd405ea01/diff:/var/lib/docker/overlay2/80c5347a366f63e0df37174f07ea234d4cf76da14c417a0d8a6ee98a8b8b30a5/diff:/var/lib/docker/overlay2/d046a9fa848970968b5bc86213426088128b3b6d0c3abbeb38b8cace5a19438b/diff:/var/lib/docker/overlay2/5dea1060497a3e8138bf6311ec3e0aad2ae5a03982c583a44939a99cf18cc0a4/diff",
            "MergedDir": "/var/lib/docker/overlay2/b13380e500e859bfde969de2112c4e06b1c0b576251783a848747ccecbe0f715/merged",
            "UpperDir": "/var/lib/docker/overlay2/b13380e500e859bfde969de2112c4e06b1c0b576251783a848747ccecbe0f715/diff",
            "WorkDir": "/var/lib/docker/overlay2/b13380e500e859bfde969de2112c4e06b1c0b576251783a848747ccecbe0f715/work"
        },
        "Name": "overlay2"
    },
    "HostConfig": {
        "AutoRemove": false,
        "Binds": [
            "/home/piuser1/docker/fhem:/opt/fhem",
            "/sys/class/gpio:/sys/class/gpio",
            "/sys/devices/platform:/sys/devices/platform"
        ],
        "BlkioDeviceReadBps": null,
        "BlkioDeviceReadIOps": null,
        "BlkioDeviceWriteBps": null,
        "BlkioDeviceWriteIOps": null,
        "BlkioWeight": 0,
        "BlkioWeightDevice": null,
        "CapAdd": [
            "AUDIT_WRITE",
            "CHOWN",
            "DAC_OVERRIDE",
            "FOWNER",
            "FSETID",
            "KILL",
            "MKNOD",
            "NET_BIND_SERVICE",
            "NET_RAW",
            "SETFCAP",
            "SETGID",
            "SETPCAP",
            "SETUID",
            "SYS_CHROOT"
        ],
        "CapDrop": [
            "AUDIT_CONTROL",
            "BLOCK_SUSPEND",
            "DAC_READ_SEARCH",
            "IPC_LOCK",
            "IPC_OWNER",
            "LEASE",
            "LINUX_IMMUTABLE",
            "MAC_ADMIN",
            "MAC_OVERRIDE",
            "NET_ADMIN",
            "NET_BROADCAST",
            "SYSLOG",
            "SYS_ADMIN",
            "SYS_BOOT",
            "SYS_MODULE",
            "SYS_NICE",
            "SYS_PACCT",
            "SYS_PTRACE",
            "SYS_RAWIO",
            "SYS_RESOURCE",
            "SYS_TIME",
            "SYS_TTY_CONFIG",
            "WAKE_ALARM"
        ],
        "Cgroup": "",
        "CgroupParent": "",
        "CgroupnsMode": "private",
        "ConsoleSize": [
            0,
            0
        ],
        "ContainerIDFile": "",
        "CpuCount": 0,
        "CpuPercent": 0,
        "CpuPeriod": 0,
        "CpuQuota": 0,
        "CpuRealtimePeriod": 0,
        "CpuRealtimeRuntime": 0,
        "CpuShares": 0,
        "CpusetCpus": "",
        "CpusetMems": "",
        "DeviceCgroupRules": null,
        "DeviceRequests": null,
        "Devices": [
            {
                "CgroupPermissions": "rwm",
                "PathInContainer": "/dev/serial/by-id/usb-1a86_USB_Serial-if00-port0",
                "PathOnHost": "/dev/serial/by-id/usb-1a86_USB_Serial-if00-port0"
            },
            {
                "CgroupPermissions": "rwm",
                "PathInContainer": "/dev/ttyAMA0",
                "PathOnHost": "/dev/ttyAMA0"
            },
            {
                "CgroupPermissions": "rwm",
                "PathInContainer": "/dev/serial/by-id/usb-FTDI_FT232R_USB_UART_AI05CB8G-if00-port0",
                "PathOnHost": "/dev/serial/by-id/usb-FTDI_FT232R_USB_UART_AI05CB8G-if00-port0"
            }
        ],
        "Dns": [],
        "DnsOptions": [],
        "DnsSearch": [],
        "ExtraHosts": [],
        "GroupAdd": null,
        "IOMaximumBandwidth": 0,
        "IOMaximumIOps": 0,
        "Init": false,
        "IpcMode": "private",
        "Isolation": "",
        "Links": null,
        "LogConfig": {
            "Config": {},
            "Type": "json-file"
        },
        "MaskedPaths": [
            "/proc/asound",
            "/proc/acpi",
            "/proc/kcore",
            "/proc/keys",
            "/proc/latency_stats",
            "/proc/timer_list",
            "/proc/timer_stats",
            "/proc/sched_debug",
            "/proc/scsi",
            "/sys/firmware"
        ],
        "Memory": 0,
        "MemoryReservation": 0,
        "MemorySwap": 0,
        "MemorySwappiness": null,
        "NanoCpus": 0,
        "NetworkMode": "fhem-network",
        "OomKillDisable": null,
        "OomScoreAdj": 0,
        "PidMode": "",
        "PidsLimit": null,
        "PortBindings": {
            "8083/tcp": [
                {
                    "HostIp": "",
                    "HostPort": "8083"
                }
            ]
        },
        "Privileged": false,
        "PublishAllPorts": false,
        "ReadonlyPaths": [
            "/proc/bus",
            "/proc/fs",
            "/proc/irq",
            "/proc/sys",
            "/proc/sysrq-trigger"
        ],
        "ReadonlyRootfs": false,
        "RestartPolicy": {
            "MaximumRetryCount": 0,
            "Name": "always"
        },
        "Runtime": "runc",
        "SecurityOpt": null,
        "ShmSize": 67108864,
        "UTSMode": "",
        "Ulimits": null,
        "UsernsMode": "",
        "VolumeDriver": "",
        "VolumesFrom": null
    },
    "HostnamePath": "/var/lib/docker/containers/5cd5ffe5503031bfa1ea54bed0668514b71b265ee18cb415a43b0c0a916371b7/hostname",
    "HostsPath": "/var/lib/docker/containers/5cd5ffe5503031bfa1ea54bed0668514b71b265ee18cb415a43b0c0a916371b7/hosts",
    "Id": "5cd5ffe5503031bfa1ea54bed0668514b71b265ee18cb415a43b0c0a916371b7",
    "Image": "sha256:3f929e0caae9feec1a7e52c6e7bc78a985750873f441c46b1b7dfc5f7dd899b5",
    "LogPath": "/var/lib/docker/containers/5cd5ffe5503031bfa1ea54bed0668514b71b265ee18cb415a43b0c0a916371b7/5cd5ffe5503031bfa1ea54bed0668514b71b265ee18cb415a43b0c0a916371b7-json.log",
    "MountLabel": "",
    "Mounts": [
        {
            "Destination": "/sys/class/gpio",
            "Mode": "",
            "Propagation": "rprivate",
            "RW": true,
            "Source": "/sys/class/gpio",
            "Type": "bind"
        },
        {
            "Destination": "/sys/devices/platform",
            "Mode": "",
            "Propagation": "rprivate",
            "RW": true,
            "Source": "/sys/devices/platform",
            "Type": "bind"
        },
        {
            "Destination": "/opt/fhem",
            "Mode": "",
            "Propagation": "rprivate",
            "RW": true,
            "Source": "/home/piuser1/docker/fhem",
            "Type": "bind"
        }
    ],
    "Name": "/fhem3",
    "NetworkSettings": {
        "Bridge": "",
        "EndpointID": "",
        "Gateway": "",
        "GlobalIPv6Address": "",
        "GlobalIPv6PrefixLen": 0,
        "HairpinMode": false,
        "IPAddress": "",
        "IPPrefixLen": 0,
        "IPv6Gateway": "",
        "LinkLocalIPv6Address": "",
        "LinkLocalIPv6PrefixLen": 0,
        "MacAddress": "",
        "Networks": {
            "fhem-network": {
                "Aliases": [
                    "525198e32cc2",
                    "5cd5ffe55030"
                ],
                "DriverOpts": null,
                "EndpointID": "",
                "Gateway": "",
                "GlobalIPv6Address": "",
                "GlobalIPv6PrefixLen": 0,
                "IPAMConfig": {},
                "IPAddress": "",
                "IPPrefixLen": 0,
                "IPv6Gateway": "",
                "Links": null,
                "MacAddress": "",
                "NetworkID": "5ca1b7c73c4640168d81c4574c2cac1c656caf0b1111f3ccaf4f6751e84437b5"
            }
        },
        "Ports": {},
        "SandboxID": "eebdba8ed81d11edf9369f148ac15dc8de85885cb6f1e5d4060111e56d61a89c",
        "SandboxKey": "/var/run/docker/netns/eebdba8ed81d",
        "SecondaryIPAddresses": null,
        "SecondaryIPv6Addresses": null
    },
    "Path": "/entry.sh",
    "Platform": "linux",
    "Portainer": {
        "ResourceControl": {
            "Id": 85,
            "ResourceId": "5cd5ffe5503031bfa1ea54bed0668514b71b265ee18cb415a43b0c0a916371b7",
            "SubResourceIds": [],
            "Type": 1,
            "UserAccesses": [],
            "TeamAccesses": [],
            "Public": false,
            "AdministratorsOnly": true,
            "System": false
        }
    },
    "ProcessLabel": "",
    "ResolvConfPath": "/var/lib/docker/containers/5cd5ffe5503031bfa1ea54bed0668514b71b265ee18cb415a43b0c0a916371b7/resolv.conf",
    "RestartCount": 0,
    "State": {
        "Dead": false,
        "Error": "error gathering device information while adding custom device \"/dev/serial/by-id/usb-1a86_USB_Serial-if00-port0\": no such file or directory",
        "ExitCode": 128,
        "FinishedAt": "2023-05-29T13:06:24.254037985Z",
        "Health": {
            "FailingStreak": 0,
            "Log": [
                {
                    "End": "2023-05-29T15:03:00.58823314+02:00",
                    "ExitCode": 0,
                    "Output": "Telnet(7072): OK; WEB(8083): OK; DockerImageInfo:OK;",
                    "Start": "2023-05-29T15:02:59.475599379+02:00"
                },
                {
                    "End": "2023-05-29T15:03:26.546655011+02:00",
                    "ExitCode": 0,
                    "Output": "Telnet(7072): OK; WEB(8083): OK; DockerImageInfo:OK;",
                    "Start": "2023-05-29T15:03:23.924054036+02:00"
                },
                {
                    "End": "2023-05-29T15:03:48.44898727+02:00",
                    "ExitCode": 0,
                    "Output": "Telnet(7072): OK; WEB(8083): OK; DockerImageInfo:OK;",
                    "Start": "2023-05-29T15:03:47.239371302+02:00"
                },
                {
                    "End": "2023-05-29T15:04:10.374276085+02:00",
                    "ExitCode": 0,
                    "Output": "Telnet(7072): OK; WEB(8083): OK; DockerImageInfo:OK;",
                    "Start": "2023-05-29T15:04:09.09633076+02:00"
                },
                {
                    "End": "2023-05-29T15:05:03.438646885+02:00",
                    "ExitCode": 1,
                    "Output": "Telnet(7072): FAILED;",
                    "Start": "2023-05-29T15:05:02.334482992+02:00"
                }
            ],
            "Status": "starting"
        },
        "OOMKilled": false,
        "Paused": false,
        "Pid": 0,
        "Restarting": false,
        "Running": false,
        "StartedAt": "2023-05-29T13:04:42.334054038Z",
        "Status": "exited"
    }
}

Kann der Fehler mit meinem Datenbank-Problem zusammenhängen, dass ich in diesem Post beschrieben habe --> https://forum.fhem.de/index.php?topic=133740.msg1277015#msg1277015
Oder sieht für euch sonst etwas unstimmig aus?

Wernieman

SIGTERM signal received, sending "shutdown" command to FHEM!Irgendetwas beendet den Container von außen ... hast Du einen WatchDog laufen? Probleme mit Aussetzern/Hängern in FHEM?
- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

fhemjan

Hallo Wernieman,
mir ist zumindest bisher nichts in Richtung Aussetzern/Hängern aufgefallen.
Ich komme leider grade so wenig dazu mich mit dem Thema zu befassen.

Tatsächlich ist gerade der Stand, das ich den Container nur durch Aufspielen eines Backups wieder zum Laufen bekommen hab. Dann läuft er ein paar Tage und steigt dann mit dem gleichen Fehlerbild wieder aus.

Die MariaDB (s. auch anderer Post) funktioniert dabei nicht. Mehr dazu im entsprechenden Post --> https://forum.fhem.de/index.php?topic=133740.0#msg1278942

Wernieman

- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

fhemjan

#4
Hi Wernieman,
steh grad etwas auf dem Schlauch. Kann ich das in den Containeroptionen ändern? Bekomme den FHEM Container überhaupt nicht mehr zum Laufen. Ich bekomme in Portainer die Info:
Request failed with status code 500
Ich habe gerade noch mal in die Logs geschaut, hier finde ich im FHEM log in Portainer allerhand betreffend DbLog:
2023.06.05 15:01:34.985 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 2584.
2023.06.05 15:01:38.218 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 3285.
2023.06.05 15:01:43.225 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 3285.
2023.06.05 15:01:48.229 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 3285.
2023.06.05 15:01:52.231 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 2584.
2023.06.05 15:01:53.233 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 3285.
2023.06.05 15:02:05.441 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 3285.
2023.06.05 15:02:10.445 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 3285.
2023.06.05 15:02:14.150 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 2584.
2023.06.05 15:02:17.351 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 3285.
2023.06.05 15:02:22.356 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 3285.
2023.06.05 15:02:48.779 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 2584.
2023.06.05 15:02:51.401 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 2584.
2023.06.05 15:02:53.584 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 3285.
2023.06.05 15:02:58.591 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 3285.
2023.06.05 15:03:03.597 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 3285.
2023.06.05 15:03:06.880 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 115 at ./FHEM/93_DbLog.pm line 2584.
2023.06.05 15:03:08.601 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 3285.
2023.06.05 15:03:13.605 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 3285.
2023.06.05 15:03:18.611 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 3285.
2023.06.05 15:03:35.825 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 2584.
2023.06.05 15:03:40.674 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 3285.
2023.06.05 15:03:45.679 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 3285.
2023.06.05 15:03:58.998 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 3285.
2023.06.05 15:04:04.002 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 3285.
2023.06.05 15:04:05.833 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 2584.
2023.06.05 15:04:09.006 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 3285.
2023.06.05 15:04:14.011 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 3285.
2023.06.05 15:04:18.362 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 2584.
2023.06.05 15:04:19.016 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 3285.
2023.06.05 15:04:24.022 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 3285.
SIGTERM signal received, sending "shutdown" command to FHEM!
Waiting for FHEM process to terminate before stopping container:
2023.06.05 15:04:25.341 2: DbLog logdb - Last database write cycle due to shutdown ...
2023.06.05 15:04:25.436 1: Server shutdown delayed due to logdb for max 10 sec
2023.06.05 15:04:25.464 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 2584.
2023.06.05 15:04:25.788 2: DbLog logdb - Last database write cycle done
2023.06.05 15:04:26.453 0: Server shutdown
2023.06.05 15:04:29.026 2: DbLog logdb - Error: DBI connect('database=fhem;host=192.168.178.210;port=3306','fhemuser',...) failed: Lost connection to MySQL server at 'handshake: reading initial communication packet', system error: 11 at ./FHEM/93_DbLog.pm line 3285.
FHEM process terminated, stopping container. Bye!
Preparing user environment ...
1. Creating group 'fhem' with GID 1000 ...
2. Enforcing GID for group 'bluetooth' to 6001 ...
3. Creating user 'fhem' with UID 1000 ...
4. Creating log directory /opt/fhem/./log ...
5. Enforcing user and group ownership for /opt/fhem to fhem:fhem ...
6. Enforcing file and directory permissions for /opt/fhem ...
7. Correcting group ownership for /dev/tty* ...
8. Correcting group ownership for /dev/serial/* ...
9. Found GPIO: Correcting group permissions in /dev and /sys to 'gpio' with GID 997 ...
10. Found I2C: Correcting group permissions in /dev to 'i2c' with GID 6003 ...
11. Updating /etc/sudoers.d/fhem-docker ...
12. Adding gateway.docker.internal to /etc/hosts ...
13. Adding host.docker.internal to /etc/hosts ...
14. Pre-authorizing SSH to Docker host for user 'fhem' ...
15. Updating SSH key pinning and SSH client permissions for user 'fhem' ...
Preparing configuration ... done
Starting FHEM ...
2023.06.05 15:06:34.348 1: Including fhem.cfg

CoolTux

Das dblog Device vorerst aus der Konfig nehmen.
Hast Du configdb oder configfile?
Du musst nicht wissen wie es geht! Du musst nur wissen wo es steht, wie es geht.
Support me to buy new test hardware for development: https://www.paypal.com/paypalme/MOldenburg
My FHEM Git: https://git.cooltux.net/FHEM/
Das TuxNet Wiki:
https://www.cooltux.net

Wernieman

- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

fhemjan

Hallo zusammen,
ich kann (halb) Entwarnung geben: ich hab FHEM heute wieder zum Laufen bekommen.
Fehler Nr. 1: Irgendwie hat MariaDB gesponnen.. Ich habe eine neue Datenbank aufgesetzt und konnte dann auch wieder über phpMyAdmin drauf zugreifen. Habe die FHEM Tabellen neu erstellt und das läuft.
Fehler Nr. 2 lag beim JeeLink. Ich habe ihn über /dev/serial/by-id/ eingebunden und der Eintrag wurde nun nicht mehr gefunden und dementsprechend wurde der Container nicht gestartet. Das führt mich allerdings zum nächsten Problem: Die Abfrage ls -l /dev/serial/by-id/ funktioniert generell nicht mehr. Ich bekomme den Fehler ls: cannot access '/dev/serial/by-id': No such file or directory. Finde bei Google ähnliche Probleme bei Zigbees und irgendwelchen Printern. Kennt jemand von euch das Problem?

CoolTux

Hierzu gibt es im Forum bereits Einträge. Bitte einmal nach suchen. Danke
Du musst nicht wissen wie es geht! Du musst nur wissen wo es steht, wie es geht.
Support me to buy new test hardware for development: https://www.paypal.com/paypalme/MOldenburg
My FHEM Git: https://git.cooltux.net/FHEM/
Das TuxNet Wiki:
https://www.cooltux.net

fhemjan

Zitat von: CoolTux am 23 September 2023, 22:07:37Hierzu gibt es im Forum bereits Einträge. Bitte einmal nach suchen. Danke
Gefunden --> Funktioniert --> Ich danke dir!
Das Thema ist damit für mich geschlossen. Danke an alle Beteiligten!