せでぃのブログ

ブログ初心者おいどんのどうでもいい愚痴やどうでもいい愚痴やどうでもいいマメ知識などを披露するチラシの裏です。

DNS_PROBE_FINISHED_BAD_CONFIGでインターネットが頻繁に切断するようになったらDNS手動設定で問題を切り分けしよう

PC関係のトラブルシュート

20160204修正：記事を全面的に修正
20160206追記：解決に完全解決を追記
20160209修正：解決してなかったので修正
20160210修正：今度こそ解決したので完全解決を追記

症状

jigemon.com
インターネットの接続がランダムに遮断される | 公式 Apple サポートコミュニティ
　ここら辺と同様の症状に悩んでいた。こちらはChrome、Safariを使っていると2,30分おきくらいでDNSの応答がない→当然ブラウザの表示がなくなる→ルータ再起動により完全に切断→再起動後、接続復旧という症状。chromeだと、DNS_PROBE_FINISHED_BAD_CONFIGと表示される。
f:id:Sediment:20160204034315p:plain


　家の環境は以下の通り。こちらはMacBookProとルータをLANケーブルで接続していたので、無線は関係なし。Apple Hardware Testの詳細もオールグリーン。
f:id:Sediment:20160129234024p:plain

環境

・Macについて
MacBookPro (Mac OS X 10.11.2)
Intel Core i5
プロセッサ速度： 2.5 GHz
メモリ： 8 GB
容量：444.68GB(うち空き領域：498.88GB)
・ブラウザについて
GoogleChrome(48.0.2564.82)
Safari(9.0.2)
Adobe Flash Player(20,0,0,286)
・回線について
　フレッツ光ネクスト1GB
・ONU兼ルータ
PR-500MI

調査結果

　DNSのエラーが出ても、疎通は全く問題なく、宅内ルータがDNSのフォワーディング（中継）をしてくれていないことがわかった。IPアドレスをDHCPではなく手動設定にして、DNSをISPのDNSサーバや、グーグルの公開DNSサーバに向けると、問題なく解決していた。
f:id:Sediment:20160214010802p:plain
　DNSのエラーが出た後、しばらくするとルータのランプが全てオレンジ色になった後全て消灯して順次、緑色のランプがついていく。そうすると復旧するのだ。最初はPPPoEのリンクを張り直しているんだろうくらいに考えていたら、ルータのログをきちんと見るとルータ再起動してるじゃん……。リンクの張り直し、DNS、DHCPのリース切れ・再割り当てでルータが再起動するか？　いやしないな、と思ってファームウェアが最新なのを確認して、おいどんは匙を投げた。
　よし、NTTにまた電話しよう。さっき、電話壊れたんだけどな！！

正常時のpingとdig

mac$ ping -c 5 toppa.excite.co.jp
PING cemetery.excite.co.jp （サーバアドレス）: 56 data bytes
64 bytes from （サーバアドレス）: icmp_seq=0 ttl=49 time=19.549 ms
64 bytes from （サーバアドレス）: icmp_seq=1 ttl=49 time=16.098 ms
64 bytes from （サーバアドレス）: icmp_seq=2 ttl=49 time=16.276 ms
64 bytes from （サーバアドレス）: icmp_seq=3 ttl=49 time=16.080 ms
64 bytes from （サーバアドレス）: icmp_seq=4 ttl=49 time=16.778 ms

--- cemetery.excite.co.jp ping statistics ---
5 packets transmitted, 5 packets received, 0.0% packet loss
round-trip min/avg/max/stddev = 16.080/16.956/19.549/1.321 ms

mac$ ping -c 5 ISPのDNSアドレス
PING ISPのDNSアドレス (ISPのDNSアドレス): 56 data bytes
64 bytes from （ISPのDNSアドレス）: icmp_seq=0 ttl=58 time=12.482 ms
64 bytes from （ISPのDNSアドレス）: icmp_seq=1 ttl=58 time=12.739 ms
64 bytes from （ISPのDNSアドレス）: icmp_seq=2 ttl=58 time=12.361 ms
64 bytes from （ISPのDNSアドレス）: icmp_seq=3 ttl=58 time=12.280 ms
64 bytes from （ISPのDNSアドレス）: icmp_seq=4 ttl=58 time=12.498 ms

--- （ISPのDNSアドレス） ping statistics ---
5 packets transmitted, 5 packets received, 0.0% packet loss
round-trip min/avg/max/stddev = 12.280/12.472/12.739/0.156 ms

mac$ dig +rec @192.168.1.1 toppa.excite.co.jp

; <<>> DiG 9.8.3-P1 <<>> +rec @192.168.1.1 toppa.excite.co.jp
; (1 server found)
;; global options: +cmd
;; Got answer:
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 26871
;; flags: qr rd ra; QUERY: 1, ANSWER: 2, AUTHORITY: 3, ADDITIONAL: 3

;; QUESTION SECTION:
;toppa.excite.co.jp.		IN	A

;; ANSWER SECTION:
toppa.excite.co.jp.	442	IN	CNAME	cemetery.excite.co.jp.
cemetery.excite.co.jp.	1689	IN	A	（サーバアドレス）

;; AUTHORITY SECTION:
excite.co.jp.		73883	IN	NS	asia3.akam.net.
excite.co.jp.		73883	IN	NS	ns1-215.akam.net.
excite.co.jp.		73883	IN	NS	use5.akam.net.

;; ADDITIONAL SECTION:
use5.akam.net.		56949	IN	A	（サーバアドレスB）
use5.akam.net.		108737	IN	AAAA	（サーバIPv6アドレスA）
asia3.akam.net.		59824	IN	A	（サーバアドレスC）

;; Query time: 15 msec
;; SERVER: 192.168.1.1#53(192.168.1.1)
;; WHEN: Tue Feb  2 16:06:49 2016
;; MSG SIZE  rcvd: 204

DNS_ERROR時のpingとdig

mac$ ping -c 5 toppa.excite.co.jp
ping: cannot resolve toppa.excite.co.jp: Unknown host

// ☆☆☆☆☆☆☆☆☆☆
// 名前解決できていないが、ISPのDNSとは疎通が取れている
// ☆☆☆☆☆☆☆☆☆☆
mac$ ping -c 5 （ISPのDNSアドレス）
PING （ISPのDNSアドレス）（ISPのDNSアドレス）: 56 data bytes
64 bytes from （ISPのDNSアドレス）: icmp_seq=0 ttl=58 time=12.444 ms
64 bytes from （ISPのDNSアドレス）: icmp_seq=1 ttl=58 time=12.390 ms
64 bytes from （ISPのDNSアドレス）: icmp_seq=2 ttl=58 time=12.409 ms
64 bytes from （ISPのDNSアドレス）: icmp_seq=3 ttl=58 time=12.535 ms
64 bytes from （ISPのDNSアドレス）: icmp_seq=4 ttl=58 time=12.294 ms

--- （ISPのDNSアドレス） ping statistics ---
5 packets transmitted, 5 packets received, 0.0% packet loss
round-trip min/avg/max/stddev = 12.294/12.414/12.535/0.078 ms

mac$ dig +rec @192.168.1.1 toppa.excite.co.jp

; <<>> DiG 9.8.3-P1 <<>> +rec @192.168.1.1 toppa.excite.co.jp
; (1 server found)
;; global options: +cmd
;; connection timed out; no servers could be reached

// ☆☆☆☆☆☆☆☆☆☆
// DNSの再帰問い合わせに対して、自宅ルータ（192.168.1.1）だけ応答していない
// ☆☆☆☆☆☆☆☆☆☆
mac$ dig +rec @（ISPのDNSアドレス） toppa.excite.co.jp

; <<>> DiG 9.8.3-P1 <<>> +rec @（ISPのDNSアドレス） toppa.excite.co.jp
; (1 server found)
;; global options: +cmd
;; Got answer:
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 39045
;; flags: qr rd ra; QUERY: 1, ANSWER: 2, AUTHORITY: 3, ADDITIONAL: 5

;; QUESTION SECTION:
;toppa.excite.co.jp.		IN	A

;; ANSWER SECTION:
toppa.excite.co.jp.	2638	IN	CNAME	cemetery.excite.co.jp.
cemetery.excite.co.jp.	3421	IN	A	（サーバアドレス）

;; AUTHORITY SECTION:
excite.co.jp.		65327	IN	NS	asia3.akam.net.
excite.co.jp.		65327	IN	NS	use5.akam.net.
excite.co.jp.		65327	IN	NS	ns1-215.akam.net.

;; ADDITIONAL SECTION:
use5.akam.net.		25275	IN	A	（サーバアドレスB）
use5.akam.net.		47776	IN	AAAA	（サーバIPv6アドレスA）
asia3.akam.net.		25283	IN	A	（サーバアドレスC）
ns1-215.akam.net.	25408	IN	A	（サーバアドレスD）
ns1-215.akam.net.	43529	IN	AAAA	（サーバIPv6アドレスB）

;; Query time: 14 msec
;; SERVER: （ISPのDNSアドレス）#53（ISPのDNSアドレス）
;; WHEN: Thu Feb  4 03:02:41 2016
;; MSG SIZE  rcvd: 248

mac$ dig +rec @8.8.8.8 toppa.excite.co.jp

; <<>> DiG 9.8.3-P1 <<>> +rec @8.8.8.8 toppa.excite.co.jp
; (1 server found)
;; global options: +cmd
;; Got answer:
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 57054
;; flags: qr rd ra; QUERY: 1, ANSWER: 2, AUTHORITY: 0, ADDITIONAL: 0

;; QUESTION SECTION:
;toppa.excite.co.jp.		IN	A

;; ANSWER SECTION:
toppa.excite.co.jp.	3599	IN	CNAME	cemetery.excite.co.jp.
cemetery.excite.co.jp.	3076	IN	A	（サーバアドレス）

;; Query time: 82 msec
;; SERVER: 8.8.8.8#53(8.8.8.8)
;; WHEN: Thu Feb  4 03:03:30 2016
;; MSG SIZE  rcvd: 75

ルータログ

  1. 2016/02/02 22:32:24 PPPの認証失敗[IPv6セッション]
  2. 2016/02/02 22:32:24 PPP-LCPの確立[IPv6セッション]
  3. 2016/02/02 22:32:23 PPPoE セッション開始成功[IPv6セッション]
  4. 2016/02/02 22:32:23 PPPoE AC発見成功[IPv6セッション]
  5. 2016/02/02 22:25:56 自動無線チャネル設定 チャネル：56  AP数：0 
  6. 2016/02/02 22:25:52 自動無線チャネル設定 チャネル：11  AP数：4 
  7. 2016/02/02 22:25:34 PPP-IPCPの確立[メインセッション]
  8. 2016/02/02 22:25:34 PPPの認証成功[メインセッション]
  9. 2016/02/02 22:25:34 PPP-LCPの確立[メインセッション]
 10. 2016/02/02 22:25:34 PPPoE セッション開始成功[メインセッション]
 11. 2016/02/02 22:25:34 PPPoE AC発見成功[メインセッション]
 12. 2016/02/02 22:25:30 時刻の同期成功
 13. 2016/02/02 22:25:30 電話使用可能
 14. 2013/01/01 00:00:22 DHCPv6アドレス取得
 15. 2013/01/01 00:00:21 DHCPv4アドレス取得
 16. 2013/01/01 00:00:18 WANインタフェース リンクアップ
 17. 2013/01/01 00:00:18 LANインタフェース(port3) リンクアップ
 18. 2013/01/01 00:00:18 LANインタフェース(port2) リンクアップ
 19. 2013/01/01 00:00:14 LANインタフェース(port2) リンクダウン
 20. 2013/01/01 00:00:14 WANインタフェース リンクダウン
 21. 2013/01/01 00:00:14 LANインタフェース(port3) リンクダウン
 22. 2013/01/01 00:00:11 JavaVM active
 23. 2013/01/01 00:00:04 機器起動　　　←勝手に再起動して日付がリセットされた
 24. 2016/02/02 22:24:42 機器再起動
 25. 2016/02/02 22:24:40 JavaVM normal stop
 26. 2016/02/02 17:22:55 LANインタフェース(port3) リンクアップ
 27. 2016/02/02 17:22:52 LANインタフェース(port3) リンクダウン
 28. 2016/02/02 16:20:00 LANインタフェース(port3) リンクアップ
 29. 2016/02/02 16:19:57 LANインタフェース(port3) リンクダウン
 30. 2016/02/02 16:08:40 PPPの認証失敗[IPv6セッション]
 31. 2016/02/02 16:08:40 PPP-LCPの確立[IPv6セッション]
 32. 2016/02/02 16:08:39 PPPoE セッション開始成功[IPv6セッション]
 33. 2016/02/02 16:08:39 PPPoE AC発見成功[IPv6セッション]
 34. 2016/02/02 16:03:56 自動無線チャネル設定 チャネル：56  AP数：0 
 35. 2016/02/02 16:03:50 自動無線チャネル設定 チャネル：11  AP数：2 
 36. 2016/02/02 16:03:33 PPP-IPCPの確立[メインセッション]
 37. 2016/02/02 16:03:33 PPPの認証成功[メインセッション]
 38. 2016/02/02 16:03:33 PPP-LCPの確立[メインセッション]
 39. 2016/02/02 16:03:33 PPPoE セッション開始成功[メインセッション]
 40. 2016/02/02 16:03:33 PPPoE AC発見成功[メインセッション]
 41. 2016/02/02 16:03:29 時刻の同期成功
 42. 2016/02/02 16:03:29 電話使用可能
 43. 2013/01/01 00:00:23 DHCPv6アドレス取得
 44. 2013/01/01 00:00:22 DHCPv4アドレス取得
 45. 2013/01/01 00:00:18 LANインタフェース(port2) リンクアップ
 46. 2013/01/01 00:00:18 WANインタフェース リンクアップ
 47. 2013/01/01 00:00:17 LANインタフェース(port3) リンクアップ
 48. 2013/01/01 00:00:15 LANインタフェース(port2) リンクダウン
 49. 2013/01/01 00:00:14 LANインタフェース(port3) リンクダウン
 50. 2013/01/01 00:00:14 WANインタフェース リンクダウン
 51. 2013/01/01 00:00:10 JavaVM active
 52. 2013/01/01 00:00:04 機器起動　　　←１日に何度も勝手に再起動がかかる
 53. 2016/02/02 16:02:41 機器再起動

暫定解決

　この手の話でよく見かけるグーグルの公開DNSを設定するというのが最善か。おいどんはISPのname serverを拾ったので、それを手動で設定することにした。
　また、NTTの提案通りルータの電源環境を見直すことで完全解決した。OAタップを全て雷サージ対応にしたところ、ルータ再起動とルータがDNSをフォワーディングしない現象全て、解決した。
　ルータの再起動は治ってなかったので、上記のDNSをDHCPではなく固定IPで設定することをお勧めします。

完全解決

　固定IPでDNSを手動で設定して放置したところ、ルータの再起動どころかDNSのエラーすら無くなった！！！　全然意味わからんが、NTTに一報入れとくわ……
　ルータのDNSフォワーディング機能またはDHCP機能自体がルータ再起動の原因ってことでした。いや、それルータの挙動としておかしいだろ。

　ここまでずっとNTTとトラブルシュートをしていたが、PR-500MIのDNSフォワーディング機能が怪しいという話をしたところ、最終的にPR-500KIという同型機種に変えてもらって、完全に解決。DHCPで振ってもDNSエラーや再起動をしなくなった。

　MIとKIは何が違うのかと思ったら、製造を請け負ったメーカーが違うってことか。あちこち、さらっと見た感じ、どっちがいいという訳ではなく相性問題のためにダメだったら別な方を入れてみるためなのかも。
NTTのホームゲートウェイについてです。PR500MIとPR500KI何が... - Yahoo!知恵袋

PR-500MI障害ログ
help
トップページ ＞ 情報 ＞ 障害ログ
[ 障害ログ ]
ELOG.LOG : There are 100 entries.

  1. 2016/02/12 12:44:19 LANインタフェース(port3) リンクアップ
  2. 2016/02/12 12:44:16 LANインタフェース(port3) リンクダウン
  3. 2016/02/12 12:25:46 LANインタフェース(port3) リンクアップ
  4. 2016/02/12 12:25:43 LANインタフェース(port3) リンクダウン
  5. 2016/02/12 12:24:48 LANインタフェース(port3) リンクアップ
  6. 2016/02/12 12:24:45 LANインタフェース(port3) リンクダウン
  7. 2016/02/12 10:24:52 LANインタフェース(port3) リンクアップ
  8. 2016/02/12 10:24:50 LANインタフェース(port3) リンクダウン
  9. 2016/02/12 10:23:54 LANインタフェース(port3) リンクアップ
 10. 2016/02/12 10:23:51 LANインタフェース(port3) リンクダウン
 11. 2016/02/12 08:23:59 LANインタフェース(port3) リンクアップ
 12. 2016/02/12 08:23:56 LANインタフェース(port3) リンクダウン
 13. 2016/02/12 08:23:01 LANインタフェース(port3) リンクアップ
 14. 2016/02/12 08:22:57 LANインタフェース(port3) リンクダウン
 15. 2016/02/12 06:23:06 LANインタフェース(port3) リンクアップ
 16. 2016/02/12 06:23:03 LANインタフェース(port3) リンクダウン
 17. 2016/02/12 06:22:08 LANインタフェース(port3) リンクアップ
 18. 2016/02/12 06:22:05 LANインタフェース(port3) リンクダウン
 19. 2016/02/12 04:22:18 LANインタフェース(port3) リンクアップ
 20. 2016/02/12 04:22:15 LANインタフェース(port3) リンクダウン
 21. 2016/02/12 03:50:28 LANインタフェース(port3) リンクアップ
 22. 2016/02/12 03:50:25 LANインタフェース(port3) リンクダウン
 23. 2016/02/12 02:29:48 LANインタフェース(port3) リンクアップ
 24. 2016/02/12 02:29:45 LANインタフェース(port3) リンクダウン
 25. 2016/02/12 01:30:18 自動無線チャネル設定 チャネル：36  AP数：7 
 26. 2016/02/12 01:30:07 自動無線チャネル設定 チャネル：11  AP数：1 
 27. 2016/02/11 22:25:13 LANインタフェース(port3) リンクアップ
 28. 2016/02/11 22:25:10 LANインタフェース(port3) リンクダウン
 29. 2016/02/11 22:24:32 LANインタフェース(port3) リンクアップ
 30. 2016/02/11 12:27:01 LANインタフェース(port3) リンクダウン
 31. 2016/02/11 11:02:48 LANインタフェース(port3) リンクアップ
 32. 2016/02/11 11:02:45 LANインタフェース(port3) リンクダウン
 33. 2016/02/11 09:58:20 LANインタフェース(port3) リンクアップ
 34. 2016/02/11 09:58:17 LANインタフェース(port3) リンクダウン
 35. 2016/02/11 09:57:22 LANインタフェース(port3) リンクアップ
 36. 2016/02/11 09:57:19 LANインタフェース(port3) リンクダウン
 37. 2016/02/11 07:57:28 LANインタフェース(port3) リンクアップ
 38. 2016/02/11 07:57:25 LANインタフェース(port3) リンクダウン
 39. 2016/02/11 07:56:30 LANインタフェース(port3) リンクアップ
 40. 2016/02/11 07:56:26 LANインタフェース(port3) リンクダウン
 41. 2016/02/11 05:56:35 LANインタフェース(port3) リンクアップ
 42. 2016/02/11 05:56:32 LANインタフェース(port3) リンクダウン
 43. 2016/02/11 05:55:37 LANインタフェース(port3) リンクアップ
 44. 2016/02/11 05:55:34 LANインタフェース(port3) リンクダウン
 45. 2016/02/11 03:55:44 LANインタフェース(port3) リンクアップ
 46. 2016/02/11 03:55:42 LANインタフェース(port3) リンクダウン
 47. 2016/02/10 22:10:30 LANインタフェース(port3) リンクアップ
 48. 2016/02/10 22:10:27 LANインタフェース(port3) リンクダウン
 49. 2016/02/10 22:09:48 LANインタフェース(port3) リンクアップ
 50. 2016/02/10 12:27:44 LANインタフェース(port3) リンクダウン
 51. 2016/02/10 11:14:49 LANインタフェース(port3) リンクアップ
 52. 2016/02/10 11:14:46 LANインタフェース(port3) リンクダウン
 53. 2016/02/10 09:28:03 LANインタフェース(port3) リンクアップ
 54. 2016/02/10 09:28:01 LANインタフェース(port3) リンクダウン
 55. 2016/02/10 09:27:05 LANインタフェース(port3) リンクアップ
 56. 2016/02/10 09:27:02 LANインタフェース(port3) リンクダウン
 57. 2016/02/10 07:27:10 LANインタフェース(port3) リンクアップ
 58. 2016/02/10 07:27:08 LANインタフェース(port3) リンクダウン
 59. 2016/02/10 07:26:12 LANインタフェース(port3) リンクアップ
 60. 2016/02/10 07:26:09 LANインタフェース(port3) リンクダウン
 61. 2016/02/10 05:26:19 LANインタフェース(port3) リンクアップ
 62. 2016/02/10 05:26:16 LANインタフェース(port3) リンクダウン
 63. 2016/02/10 05:25:20 LANインタフェース(port3) リンクアップ
 64. 2016/02/10 05:25:17 LANインタフェース(port3) リンクダウン
 65. 2016/02/10 03:25:30 LANインタフェース(port3) リンクアップ
 66. 2016/02/10 03:25:27 LANインタフェース(port3) リンクダウン
 67. 2016/02/10 02:30:19 自動無線チャネル設定 チャネル：52  AP数：0 
 68. 2016/02/10 02:30:07 自動無線チャネル設定 チャネル：11  AP数：1 
 69. 2016/02/10 00:15:29 LANインタフェース(port3) リンクアップ
 70. 2016/02/10 00:15:26 LANインタフェース(port3) リンクダウン
 71. 2016/02/09 23:13:03 LANインタフェース(port3) リンクアップ
 72. 2016/02/09 23:13:00 LANインタフェース(port3) リンクダウン
 73. 2016/02/09 21:24:53 PPPの認証失敗[IPv6セッション]
 74. 2016/02/09 21:24:53 PPP-LCPの確立[IPv6セッション]
 75. 2016/02/09 21:24:52 PPPoE セッション開始成功[IPv6セッション]
 76. 2016/02/09 21:24:52 PPPoE AC発見成功[IPv6セッション]
 77. 2016/02/09 21:16:07 自動無線チャネル設定 チャネル：52  AP数：0 
 78. 2016/02/09 21:16:02 自動無線チャネル設定 チャネル：11  AP数：1 
 79. 2016/02/09 21:15:44 PPP-IPCPの確立[メインセッション]
 80. 2016/02/09 21:15:44 PPPの認証成功[メインセッション]
 81. 2016/02/09 21:15:44 PPP-LCPの確立[メインセッション]
 82. 2016/02/09 21:15:44 PPPoE セッション開始成功[メインセッション]
 83. 2016/02/09 21:15:44 PPPoE AC発見成功[メインセッション]
 84. 2016/02/09 21:15:40 時刻の同期成功
 85. 2016/02/09 21:15:40 電話使用可能
 86. 2013/01/01 00:00:22 DHCPv6アドレス取得
 87. 2013/01/01 00:00:21 DHCPv4アドレス取得
 88. 2013/01/01 00:00:18 WANインタフェース リンクアップ
 89. 2013/01/01 00:00:17 LANインタフェース(port3) リンクアップ
 90. 2013/01/01 00:00:14 LANインタフェース(port3) リンクダウン
 91. 2013/01/01 00:00:14 WANインタフェース リンクダウン
 92. 2013/01/01 00:00:11 JavaVM active
 93. 2013/01/01 00:00:04 機器起動
 94. 2016/02/09 21:14:53 機器再起動
 95. 2016/02/09 21:14:51 JavaVM normal stop
 96. 2016/02/09 20:54:43 PPPの認証失敗[IPv6セッション]
 97. 2016/02/09 20:54:43 PPP-LCPの確立[IPv6セッション]
 98. 2016/02/09 20:54:42 PPPoE セッション開始成功[IPv6セッション]
 99. 2016/02/09 20:54:42 PPPoE AC発見成功[IPv6セッション]
100. 2016/02/09 20:49:59 自動無線チャネル設定 チャネル：52  AP数：0