sync_node_time() failed to find available NTP servers

Bug #1471812 reported by Roman Podoliaka
6
This bug affects 1 person
Affects Status Importance Assigned to Milestone
Fuel for OpenStack
Confirmed
High
Fuel DevOps

Bug Description

One of the staging jobs (http://jenkins-product.srt.mirantis.net:8080/job/5.1.2.staging.ubuntu.bvt_2/197/console) failed with:

Shutting down ntpd: [FAILED]
ntpd 4.2.6p5@1.2349-o Sat Nov 23 18:21:48 UTC 2013 (1)
 5 Jul 06:59:24 ntpd[1580]: proto: precision = 0.175 usec
 5 Jul 06:59:24 ntpd[1580]: 0.0.0.0 c01d 0d kern kernel time sync enabled
event at 0 0.0.0.0 c01d 0d kern kernel time sync enabled
Finished Parsing!!
 5 Jul 06:59:24 ntpd[1580]: ntp_io: estimated max descriptors: 1024, initial socket boundary: 16
 5 Jul 06:59:24 ntpd[1580]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123
 5 Jul 06:59:24 ntpd[1580]: Listen and drop on 1 v6wildcard :: UDP 123
 5 Jul 06:59:24 ntpd[1580]: Listen normally on 2 lo 127.0.0.1 UDP 123
restrict: op 1 addr 127.0.0.1 mask 255.255.255.255 mflags 00003000 flags 00000001
 5 Jul 06:59:24 ntpd[1580]: Listen normally on 3 eth0 10.108.5.128 UDP 123
restrict: op 1 addr 10.108.5.128 mask 255.255.255.255 mflags 00003000 flags 00000001
 5 Jul 06:59:24 ntpd[1580]: Listen normally on 4 lo ::1 UDP 123
restrict: op 1 addr ::1 mask ffff:ffff:ffff:ffff:ffff:ffff:ffff:ffff mflags 00003000 flags 00000001
 5 Jul 06:59:24 ntpd[1580]: Listen normally on 5 eth2 fe80::663d:d0ff:fe46:9de0 UDP 123
restrict: op 1 addr fe80::663d:d0ff:fe46:9de0 mask ffff:ffff:ffff:ffff:ffff:ffff:ffff:ffff mflags 00003000 flags 00000001
 5 Jul 06:59:24 ntpd[1580]: Listen normally on 6 eth4 fe80::66c6:fff:fe1a:bf96 UDP 123
restrict: op 1 addr fe80::66c6:fff:fe1a:bf96 mask ffff:ffff:ffff:ffff:ffff:ffff:ffff:ffff mflags 00003000 flags 00000001
 5 Jul 06:59:24 ntpd[1580]: Listen normally on 7 eth3 fe80::66ad:bff:fe6c:7185 UDP 123
restrict: op 1 addr fe80::66ad:bff:fe6c:7185 mask ffff:ffff:ffff:ffff:ffff:ffff:ffff:ffff mflags 00003000 flags 00000001
 5 Jul 06:59:24 ntpd[1580]: Listen normally on 8 eth1 fe80::6690:4eff:fe43:4c60 UDP 123
restrict: op 1 addr fe80::6690:4eff:fe43:4c60 mask ffff:ffff:ffff:ffff:ffff:ffff:ffff:ffff mflags 00003000 flags 00000001
 5 Jul 06:59:24 ntpd[1580]: Listen normally on 9 eth0 fe80::664c:faff:feb2:5b82 UDP 123
restrict: op 1 addr fe80::664c:faff:feb2:5b82 mask ffff:ffff:ffff:ffff:ffff:ffff:ffff:ffff mflags 00003000 flags 00000001
 5 Jul 06:59:24 ntpd[1580]: peers refreshed
 5 Jul 06:59:24 ntpd[1580]: Listening on routing socket on fd #26 for interface updates
restrict: op 1 addr 0.0.0.0 mask 0.0.0.0 mflags 00000000 flags 000005d0
restrict: op 1 addr :: mask 0.0.0.0 mflags 00000000 flags 000005d0
restrict: op 1 addr :: mask :: mflags 00000000 flags 000005d0
restrict: op 1 addr 127.0.0.1 mask 255.255.255.255 mflags 00000000 flags 00000000
restrict: op 1 addr ::1 mask ffff:ffff:ffff:ffff:ffff:ffff:ffff:ffff mflags 00000000 flags 00000000
key_expire: at 0 associd 64419
peer_clear: at 0 next 1 associd 64419 refid INIT
event at 0 10.108.5.2 8011 81 mobilize assoc 64419
newpeer: 10.108.5.128->10.108.5.2 mode 3 vers 4 poll 6 10 flags 0x141 0x1 ttl 0 key 00000000
 5 Jul 06:59:24 ntpd[1580]: 0.0.0.0 c016 06 restart
event at 0 0.0.0.0 c016 06 restart
 5 Jul 06:59:24 ntpd[1580]: 0.0.0.0 c012 02 freq_set kernel 0.000 PPM
event at 0 0.0.0.0 c012 02 freq_set kernel 0.000 PPM
transmit: at 1 10.108.5.128->10.108.5.2 mode 3 len 48
auth_agekeys: at 1 keys 1 expired 0
receive: at 1 10.108.5.128<-10.108.5.2 mode 4 len 48
event at 1 10.108.5.2 8024 84 reachable
clock_filter: n 1 off 0.795257 del 0.000401 dsp 7.937500 jit 0.000000
transmit: at 3 10.108.5.128->10.108.5.2 mode 3 len 48
receive: at 3 10.108.5.128<-10.108.5.2 mode 4 len 48
clock_filter: n 2 off 0.795362 del 0.000364 dsp 3.937508 jit 0.000105
transmit: at 5 10.108.5.128->10.108.5.2 mode 3 len 48
receive: at 5 10.108.5.128<-10.108.5.2 mode 4 len 48
clock_filter: n 3 off 0.795416 del 0.000304 dsp 1.937515 jit 0.000119
transmit: at 7 10.108.5.128->10.108.5.2 mode 3 len 48
receive: at 7 10.108.5.128<-10.108.5.2 mode 4 len 48
clock_filter: n 4 off 0.795458 del 0.000387 dsp 0.937521 jit 0.000131
transmit: at 9 10.108.5.128->10.108.5.2 mode 3 len 48
receive: at 9 10.108.5.128<-10.108.5.2 mode 4 len 48
clock_filter: n 5 off 0.795482 del 0.000362 dsp 0.437525 jit 0.000132
 5 Jul 06:59:35 ntpd[1580]: ntpd: no servers found
ntpd: no servers found

Looks like a temporary connectivity issue on CI.

Tags: staging
Changed in fuel:
milestone: none → 6.1-updates
status: New → Confirmed
Changed in fuel:
milestone: 6.1-updates → 7.0
importance: Undecided → High
To post a comment you must log in.
This report contains Public information  
Everyone can see this information.

Other bug subscribers

Remote bug watches

Bug watches keep track of this bug in other bug trackers.