mcrest_kozawa
2023年3月15日 23時08分
DHCPに設定しても、固定IPアドレスに設定してもネットワークインターフェースがDown状態となります。
/var/log/messagesには以下のメッセージが出るのですが対処方法おわかりでしょうか。
--
Mar 15 07:02:50 hoge NetworkManager[763]: [1661551370.3541] policy: auto-activating connection 'ethernet-eth0'
Mar 15 07:02:50 hoge NetworkManager[763]: [1661551370.3633] device (eth0): Activation: starting connection 'ethernet-eth0' (15d88435-fadd-4904-91e4-1ed49b00a29c)
Mar 15 07:02:50 hoge NetworkManager[763]: [1661551370.3657] device (eth0): state change: disconnected -> prepare (reason 'none') [30 40 0]
Mar 15 07:02:50 hoge NetworkManager[763]: [1661551370.3701] device (eth0): state change: prepare -> config (reason 'none') [40 50 0]
Mar 15 07:02:50 hoge NetworkManager[763]: [1661551370.3770] device (eth0): state change: config -> ip-config (reason 'none') [50 70 0]
Mar 15 07:02:50 hoge NetworkManager[763]: [1661551370.3800] dhcp4 (eth0): activation: beginning transaction (timeout in 45 seconds)
Mar 15 07:02:50 hoge NetworkManager[763]: [1661551370.3891] dhcp4 (eth0): dhclient started with pid 2520
Mar 15 07:02:50 hoge NetworkManager[763]: [1661551370.4900] dhcp4 (eth0): address 192.168.102.49
Mar 15 07:02:50 hoge NetworkManager[763]: [1661551370.4908] dhcp4 (eth0): plen 24 (255.255.255.0)
Mar 15 07:02:50 hoge NetworkManager[763]: [1661551370.4910] dhcp4 (eth0): gateway 192.168.102.1
Mar 15 07:02:50 hoge NetworkManager[763]: [1661551370.4910] dhcp4 (eth0): server identifier 192.168.2.189
Mar 15 07:02:50 hoge NetworkManager[763]: [1661551370.4912] dhcp4 (eth0): lease time 10800
Mar 15 07:02:50 hoge NetworkManager[763]: [1661551370.4913] dhcp4 (eth0): nameserver '192.168.2.140'
Mar 15 07:02:50 hoge NetworkManager[763]: [1661551370.4913] dhcp4 (eth0): nameserver '192.168.2.141'
Mar 15 07:02:50 hoge NetworkManager[763]: [1661551370.4914] dhcp4 (eth0): state changed unknown -> bound
Mar 15 07:02:50 hoge NetworkManager[763]: [1661551370.5040] device (eth0): state change: ip-config -> failed (reason 'ip-config-unavailable') [70 120 5]
Mar 15 07:02:50 hoge NetworkManager[763]: [1661551370.5068] device (eth0): Activation: failed for connection 'ethernet-eth0'
Mar 15 07:02:50 hoge NetworkManager[763]: [1661551370.5212] device (eth0): state change: failed -> disconnected (reason 'none') [120 30 0]
Mar 15 07:02:50 hoge NetworkManager[763]: [1661551370.5886] dhcp4 (eth0): canceled DHCP transaction, DHCP client pid 2520
Mar 15 07:02:50 hoge NetworkManager[763]: [1661551370.5887] dhcp4 (eth0): state changed bound -> done
--
コメント
at_dominique.m…
mcrest_kozawa さん、
お世話になっています、
アットマークテクノのマルティネです。
> Mar 15 07:02:50 hoge NetworkManager[763]: [1661551370.5040] device (eth0): state change: ip-config -> failed (reason 'ip-config-unavailable') [70 120 5]
IP を取得した後に何らかの理由で失敗していますね。
その理由を分かるためにログを少し増やしてもらえたら助かります。
/etc/NetworkManager/NetworkManager.conf に以下の内容を追加して、systemctl restart NetworkManager か再起動で適用された後にもう一度試してログを提供していただけますか？
[logging] level=TRACE
よろしくお願いします。
mcrest_kozawa
頂いた内容を設定してみました。
以下ログになります。
Mar 17 09:37:46 hoge NetworkManager[10881]: [1679013466.0963] policy: auto-activating connection 'ethernet-eth0'
Mar 17 09:37:46 hoge NetworkManager[10881]: [1679013466.1060] device (eth0): Activation: starting connection 'ethernet-eth0' (15d88435-fadd-4904-91e4-1ed49b00a29c)
Mar 17 09:37:46 hoge NetworkManager[10881]: [1679013466.1081] device (eth0): state change: disconnected -> prepare (reason 'none') [30 40 0]
Mar 17 09:37:46 hoge NetworkManager[10881]: [1679013466.1125] device (eth0): state change: prepare -> config (reason 'none') [40 50 0]
Mar 17 09:37:46 hoge NetworkManager[10881]: [1679013466.1210] device (eth0): state change: config -> ip-config (reason 'none') [50 70 0]
Mar 17 09:37:46 hoge NetworkManager[10881]: [1679013466.1238] dhcp4 (eth0): activation: beginning transaction (timeout in 45 seconds)
Mar 17 09:37:46 hoge NetworkManager[10881]: [1679013466.1332] dhcp4 (eth0): dhclient started with pid 12005
Mar 17 09:37:46 hoge NetworkManager[10881]: [1679013466.2567] dhcp4 (eth0): address 192.168.102.49
Mar 17 09:37:46 hoge NetworkManager[10881]: [1679013466.2568] dhcp4 (eth0): plen 24 (255.255.255.0)
Mar 17 09:37:46 hoge NetworkManager[10881]: [1679013466.2569] dhcp4 (eth0): gateway 192.168.102.1
Mar 17 09:37:46 hoge NetworkManager[10881]: [1679013466.2569] dhcp4 (eth0): server identifier 192.168.2.189
Mar 17 09:37:46 hoge NetworkManager[10881]: [1679013466.2571] dhcp4 (eth0): lease time 10800
Mar 17 09:37:46 hoge NetworkManager[10881]: [1679013466.2572] dhcp4 (eth0): nameserver '192.168.2.140'
Mar 17 09:37:46 hoge NetworkManager[10881]: [1679013466.2573] dhcp4 (eth0): nameserver '192.168.2.141'
Mar 17 09:37:46 hoge NetworkManager[10881]: [1679013466.2574] dhcp4 (eth0): state changed unknown -> bound
Mar 17 09:37:46 hoge NetworkManager[10881]: [1679013466.2812] device (eth0): state change: ip-config -> failed (reason 'ip-config-unavailable') [70 120 5]
Mar 17 09:37:46 hoge NetworkManager[10881]: [1679013466.2842] device (eth0): Activation: failed for connection 'ethernet-eth0'
Mar 17 09:37:46 hoge NetworkManager[10881]: [1679013466.2913] device (eth0): state change: failed -> disconnected (reason 'none') [120 30 0]
Mar 17 09:37:47 hoge NetworkManager[10881]: [1679013466.3345] dhcp4 (eth0): canceled DHCP transaction, DHCP client pid 12005
Mar 17 09:37:47 hoge NetworkManager[10881]: [1679013466.3346] dhcp4 (eth0): state changed bound -> done
Mar 17 09:37:47 hoge NetworkManager[10881]: [1679013466.3740] policy: auto-activating connection 'ethernet-eth0'
Mar 17 09:37:47 hoge NetworkManager[10881]: [1679013466.3841] device (eth0): Activation: starting connection 'ethernet-eth0' (15d88435-fadd-4904-91e4-1ed49b00a29c)
Mar 17 09:37:47 hoge NetworkManager[10881]: [1679013466.3863] device (eth0): state change: disconnected -> prepare (reason 'none') [30 40 0]
Mar 17 09:37:47 hoge NetworkManager[10881]: [1679013466.3918] device (eth0): state change: prepare -> config (reason 'none') [40 50 0]
Mar 17 09:37:47 hoge NetworkManager[10881]: [1679013466.4231] device (eth0): state change: config -> ip-config (reason 'none') [50 70 0]
Mar 17 09:37:47 hoge NetworkManager[10881]: [1679013466.4295] dhcp4 (eth0): activation: beginning transaction (timeout in 45 seconds)
Mar 17 09:37:47 hoge NetworkManager[10881]: [1679013466.4510] dhcp4 (eth0): dhclient started with pid 12014
Mar 17 09:37:47 hoge NetworkManager[10881]: [1679013466.6229] dhcp4 (eth0): address 192.168.102.49
Mar 17 09:37:47 hoge NetworkManager[10881]: [1679013466.6230] dhcp4 (eth0): plen 24 (255.255.255.0)
Mar 17 09:37:47 hoge NetworkManager[10881]: [1679013466.6231] dhcp4 (eth0): gateway 192.168.102.1
Mar 17 09:37:47 hoge NetworkManager[10881]: [1679013466.6231] dhcp4 (eth0): server identifier 192.168.2.189
Mar 17 09:37:47 hoge NetworkManager[10881]: [1679013466.6233] dhcp4 (eth0): lease time 10800
Mar 17 09:37:47 hoge NetworkManager[10881]: [1679013466.6234] dhcp4 (eth0): nameserver '192.168.2.140'
Mar 17 09:37:47 hoge NetworkManager[10881]: [1679013466.6235] dhcp4 (eth0): nameserver '192.168.2.141'
Mar 17 09:37:47 hoge NetworkManager[10881]: [1679013466.6236] dhcp4 (eth0): state changed unknown -> bound
Mar 17 09:37:47 hoge NetworkManager[10881]: [1679013466.7096] device (eth0): state change: ip-config -> failed (reason 'ip-config-unavailable') [70 120 5]
Mar 17 09:37:47 hoge NetworkManager[10881]: [1679013466.7171] policy: disabling autoconnect for connection 'ethernet-eth0'.
Mar 17 09:37:47 hoge NetworkManager[10881]: [1679013466.7197] device (eth0): Activation: failed for connection 'ethernet-eth0'
Mar 17 09:37:47 hoge NetworkManager[10881]: [1679013466.7336] device (eth0): state change: failed -> disconnected (reason 'none') [120 30 0]
Mar 17 09:37:47 hoge NetworkManager[10881]: [1679013466.7900] dhcp4 (eth0): canceled DHCP transaction, DHCP client pid 12014
Mar 17 09:37:47 hoge NetworkManager[10881]: [1679013466.7903] dhcp4 (eth0): state changed bound -> done
Mar 17 09:37:53 hoge NetworkManager[10881]: [1679013473.3082] keyfile: update /etc/NetworkManager/system-connections/ethernet-eth0 (15d88435-fadd-4904-91e4-1ed49b00a29c,"ethernet-eth0")
Mar 17 09:37:53 hoge NetworkManager[10881]: [1679013473.3121] audit: op="connection-update" uuid="15d88435-fadd-4904-91e4-1ed49b00a29c" name="ethernet-eth0" pid=12044 uid=0 result="success"
Mar 17 09:37:53 hoge NetworkManager[10881]: [1679013473.7015] keyfile: update /etc/NetworkManager/system-connections/ethernet-eth0 (15d88435-fadd-4904-91e4-1ed49b00a29c,"ethernet-eth0")
Mar 17 09:37:53 hoge NetworkManager[10881]: [1679013473.7055] audit: op="connection-update" uuid="15d88435-fadd-4904-91e4-1ed49b00a29c" name="ethernet-eth0" pid=12050 uid=0 result="success"
Mar 17 09:37:54 hoge NetworkManager[10881]: [1679013474.1019] keyfile: update /etc/NetworkManager/system-connections/ethernet-eth0 (15d88435-fadd-4904-91e4-1ed49b00a29c,"ethernet-eth0")
Mar 17 09:37:54 hoge NetworkManager[10881]: [1679013474.1099] audit: op="connection-update" uuid="15d88435-fadd-4904-91e4-1ed49b00a29c" name="ethernet-eth0" pid=12054 uid=0 result="success"
Mar 17 09:37:54 hoge NetworkManager[10881]: [1679013474.5084] keyfile: update /etc/NetworkManager/system-connections/ethernet-eth0 (15d88435-fadd-4904-91e4-1ed49b00a29c,"ethernet-eth0")
Mar 17 09:37:54 hoge NetworkManager[10881]: [1679013474.5159] audit: op="connection-update" uuid="15d88435-fadd-4904-91e4-1ed49b00a29c" name="ethernet-eth0" pid=12058 uid=0 result="success"
mcrest_kozawa
/var/log/syslogに
以下ログが出ていました。
Mar 17 06:28:19 kurokogear NetworkManager[13332]: [1679002099.9458] platform-linux: do-add-ip4-route[2: 192.168.0.0/16 100]: failure 101 (Network is unreachable)
Mar 17 06:28:19 kurokogear NetworkManager[13332]: [1679002099.9463] platform-linux: do-add-ip4-route[2: 192.168.2.0/24 100]: failure 101 (Network is unreachable)
静的ルート設定が正しくなく設定に失敗しているから、eth0のインターフェースがDownしてしまうのでしょうか。
at_dominique.m…
mcrest_kozawaさん
マルティネです。
> Mar 17 06:28:19 kurokogear NetworkManager[13332]: [1679002099.9458] platform-linux: do-add-ip4-route[2: 192.168.0.0/16 100]: failure 101 (Network is unreachable)
> Mar 17 06:28:19 kurokogear NetworkManager[13332]: [1679002099.9463] platform-linux: do-add-ip4-route[2: 192.168.2.0/24 100]: failure 101 (Network is unreachable)
>
> 静的ルート設定が正しくなく設定に失敗しているから、eth0のインターフェースがDownしてしまうのでしょうか。
追加のログありがとうございます。これですね。
https://bugzilla.redhat.com/show_bug.cgi?id=1428334 によると、前の NetworkManager のバージョンではこういう失敗を無視していましたが、今では失敗してネットワークが down されます。
Linux では、ルートの next hop (gateway) にすでにルートがない限りそのルートを追加できません。おそらくこの問題だと思いますので、設定を見直せば解決されると思います。
できなかったらコンフィグ（かそれに似たような物）を提供してくだされば具体的な助言はできるかもしれません。
よろしくお願いします。
mcrest_kozawa
mcrest_kozawa
2023年3月15日 23時08分
対象機器ですが、 G3L
になります。