Oct 27 16:03:22 server1 cib: [1770]: info: cib_stats: Processed 168 operations (714.00us average, 0% utilization) in the last 10min Oct 27 16:03:48 server1 lrmd: [1772]: info: rsc:resDRBDr1:0 monitor[10] (pid 32422) Oct 27 16:03:48 server1 lrmd: [1772]: info: operation monitor[10] on resDRBDr1:0 for client 1776: pid 32422 exited with return code 8 Oct 27 16:04:15 server1 lrmd: [1772]: info: rsc:resOCFS2r1:0 monitor[12] (pid 32620) Oct 27 16:04:15 server1 lrmd: [1772]: info: operation monitor[12] on resOCFS2r1:0 for client 1776: pid 32620 exited with return code 0 Oct 27 16:05:53 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:05:53 server1 named[1563]: internal_send: 2001:500:2f::f#53: Network is down Oct 27 16:05:53 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:05:53 server1 named[1563]: internal_send: 2001:500:2f::f#53: Network is down Oct 27 16:05:53 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:05:53 server1 named[1563]: internal_send: 2001:7fd::1#53: Network is down Oct 27 16:05:53 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:05:53 server1 named[1563]: internal_send: 2001:7fd::1#53: Network is down Oct 27 16:05:57 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:05:57 server1 named[1563]: internal_send: 2001:500:3::42#53: Network is down Oct 27 16:05:57 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:05:57 server1 named[1563]: internal_send: 2001:500:3::42#53: Network is down Oct 27 16:05:58 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:05:58 server1 named[1563]: internal_send: 2001:503:ba3e::2:30#53: Network is down Oct 27 16:05:58 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:05:58 server1 named[1563]: internal_send: 2001:503:ba3e::2:30#53: Network is down Oct 27 16:05:59 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:05:59 server1 named[1563]: internal_send: 2001:500:1::803f:235#53: Network is down Oct 27 16:05:59 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:05:59 server1 named[1563]: internal_send: 2001:500:1::803f:235#53: Network is down Oct 27 16:06:02 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:02 server1 named[1563]: internal_send: 2001:503:c27::2:30#53: Network is down Oct 27 16:06:02 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:02 server1 named[1563]: internal_send: 2001:503:c27::2:30#53: Network is down Oct 27 16:06:05 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:05 server1 named[1563]: internal_send: 2001:7fe::53#53: Network is down Oct 27 16:06:05 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:05 server1 named[1563]: internal_send: 2001:7fe::53#53: Network is down Oct 27 16:06:05 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:05 server1 named[1563]: internal_send: 2001:dc3::35#53: Network is down Oct 27 16:06:05 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:05 server1 named[1563]: internal_send: 2001:dc3::35#53: Network is down Oct 27 16:06:09 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:09 server1 named[1563]: internal_send: 2001:500:2f::f#53: Network is down Oct 27 16:06:09 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:09 server1 named[1563]: internal_send: 2001:500:2f::f#53: Network is down Oct 27 16:06:09 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:09 server1 named[1563]: internal_send: 2001:500:2f::f#53: Network is down Oct 27 16:06:09 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:09 server1 named[1563]: internal_send: 2001:500:2f::f#53: Network is down Oct 27 16:06:09 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:09 server1 named[1563]: internal_send: 2001:500:2f::f#53: Network is down Oct 27 16:06:09 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:09 server1 named[1563]: internal_send: 2001:500:2f::f#53: Network is down Oct 27 16:06:09 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:09 server1 named[1563]: internal_send: 2001:500:2f::f#53: Network is down Oct 27 16:06:09 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:09 server1 named[1563]: internal_send: 2001:7fd::1#53: Network is down Oct 27 16:06:09 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:09 server1 named[1563]: internal_send: 2001:7fd::1#53: Network is down Oct 27 16:06:09 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:09 server1 named[1563]: internal_send: 2001:7fd::1#53: Network is down Oct 27 16:06:09 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:09 server1 named[1563]: internal_send: 2001:7fd::1#53: Network is down Oct 27 16:06:09 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:09 server1 named[1563]: internal_send: 2001:7fd::1#53: Network is down Oct 27 16:06:09 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:09 server1 named[1563]: internal_send: 2001:7fd::1#53: Network is down Oct 27 16:06:09 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:09 server1 named[1563]: internal_send: 2001:7fd::1#53: Network is down Oct 27 16:06:10 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:10 server1 named[1563]: internal_send: 2001:500:3::42#53: Network is down Oct 27 16:06:10 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:10 server1 named[1563]: internal_send: 2001:500:3::42#53: Network is down Oct 27 16:06:10 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:10 server1 named[1563]: internal_send: 2001:500:3::42#53: Network is down Oct 27 16:06:10 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:10 server1 named[1563]: internal_send: 2001:500:3::42#53: Network is down Oct 27 16:06:10 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:10 server1 named[1563]: internal_send: 2001:500:3::42#53: Network is down Oct 27 16:06:10 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:10 server1 named[1563]: internal_send: 2001:500:3::42#53: Network is down Oct 27 16:06:10 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:10 server1 named[1563]: internal_send: 2001:500:3::42#53: Network is down Oct 27 16:06:11 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:11 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:11 server1 named[1563]: internal_send: 2001:dc3::35#53: Network is down Oct 27 16:06:11 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:11 server1 named[1563]: internal_send: 2001:dc3::35#53: Network is down Oct 27 16:06:11 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:11 server1 named[1563]: internal_send: 2001:dc3::35#53: Network is down Oct 27 16:06:11 server1 named[1563]: internal_send: 2001:dc3::35#53: Network is down Oct 27 16:06:11 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:11 server1 named[1563]: internal_send: 2001:dc3::35#53: Network is down Oct 27 16:06:11 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:11 server1 named[1563]: internal_send: 2001:dc3::35#53: Network is down Oct 27 16:06:11 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:11 server1 named[1563]: internal_send: 2001:dc3::35#53: Network is down Oct 27 16:06:12 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:12 server1 named[1563]: internal_send: 2001:7fe::53#53: Network is down Oct 27 16:06:12 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:12 server1 named[1563]: internal_send: 2001:7fe::53#53: Network is down Oct 27 16:06:12 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:12 server1 named[1563]: internal_send: 2001:7fe::53#53: Network is down Oct 27 16:06:12 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:12 server1 named[1563]: internal_send: 2001:7fe::53#53: Network is down Oct 27 16:06:12 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:12 server1 named[1563]: internal_send: 2001:7fe::53#53: Network is down Oct 27 16:06:12 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:12 server1 named[1563]: internal_send: 2001:7fe::53#53: Network is down Oct 27 16:06:12 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:12 server1 named[1563]: internal_send: 2001:7fe::53#53: Network is down Oct 27 16:06:13 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:13 server1 named[1563]: internal_send: 2001:503:ba3e::2:30#53: Network is down Oct 27 16:06:13 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:13 server1 named[1563]: internal_send: 2001:503:ba3e::2:30#53: Network is down Oct 27 16:06:13 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:13 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:13 server1 named[1563]: internal_send: 2001:503:ba3e::2:30#53: Network is down Oct 27 16:06:13 server1 named[1563]: internal_send: 2001:503:ba3e::2:30#53: Network is down Oct 27 16:06:13 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:13 server1 named[1563]: internal_send: 2001:503:ba3e::2:30#53: Network is down Oct 27 16:06:13 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:13 server1 named[1563]: internal_send: 2001:503:ba3e::2:30#53: Network is down Oct 27 16:06:13 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:13 server1 named[1563]: internal_send: 2001:503:ba3e::2:30#53: Network is down Oct 27 16:06:13 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:13 server1 named[1563]: internal_send: 2001:500:1::803f:235#53: Network is down Oct 27 16:06:13 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:13 server1 named[1563]: internal_send: 2001:500:1::803f:235#53: Network is down Oct 27 16:06:13 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:13 server1 named[1563]: internal_send: 2001:500:1::803f:235#53: Network is down Oct 27 16:06:13 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:13 server1 named[1563]: internal_send: 2001:500:1::803f:235#53: Network is down Oct 27 16:06:13 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:13 server1 named[1563]: internal_send: 2001:500:1::803f:235#53: Network is down Oct 27 16:06:13 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:13 server1 named[1563]: internal_send: 2001:500:1::803f:235#53: Network is down Oct 27 16:06:13 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:13 server1 named[1563]: internal_send: 2001:500:1::803f:235#53: Network is down Oct 27 16:06:14 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:14 server1 named[1563]: internal_send: 2001:503:c27::2:30#53: Network is down Oct 27 16:06:14 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:14 server1 named[1563]: internal_send: 2001:503:c27::2:30#53: Network is down Oct 27 16:06:14 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:14 server1 named[1563]: internal_send: 2001:503:c27::2:30#53: Network is down Oct 27 16:06:14 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:14 server1 named[1563]: internal_send: 2001:503:c27::2:30#53: Network is down Oct 27 16:06:14 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:14 server1 named[1563]: internal_send: 2001:503:c27::2:30#53: Network is down Oct 27 16:06:14 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:14 server1 named[1563]: internal_send: 2001:503:c27::2:30#53: Network is down Oct 27 16:06:14 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:14 server1 named[1563]: internal_send: 2001:503:c27::2:30#53: Network is down Oct 27 16:06:22 server1 named[1563]: managed-keys-zone ./IN: Unable to fetch DNSKEY set '.': timed out Oct 27 16:06:25 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:25 server1 named[1563]: internal_send: 2001:500:2f::f#53: Network is down Oct 27 16:06:25 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:25 server1 named[1563]: internal_send: 2001:500:2f::f#53: Network is down Oct 27 16:06:25 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:25 server1 named[1563]: internal_send: 2001:500:2f::f#53: Network is down Oct 27 16:06:25 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:25 server1 named[1563]: internal_send: 2001:500:2f::f#53: Network is down Oct 27 16:06:25 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:25 server1 named[1563]: internal_send: 2001:500:2f::f#53: Network is down Oct 27 16:06:25 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:25 server1 named[1563]: internal_send: 2001:500:2f::f#53: Network is down Oct 27 16:06:26 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:26 server1 named[1563]: internal_send: 2001:7fd::1#53: Network is down Oct 27 16:06:26 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:26 server1 named[1563]: internal_send: 2001:7fd::1#53: Network is down Oct 27 16:06:26 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:26 server1 named[1563]: internal_send: 2001:7fd::1#53: Network is down Oct 27 16:06:26 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:26 server1 named[1563]: internal_send: 2001:7fd::1#53: Network is down Oct 27 16:06:26 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:26 server1 named[1563]: internal_send: 2001:7fd::1#53: Network is down Oct 27 16:06:26 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:26 server1 named[1563]: internal_send: 2001:7fd::1#53: Network is down Oct 27 16:06:27 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:27 server1 named[1563]: internal_send: 2001:500:3::42#53: Network is down Oct 27 16:06:27 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:27 server1 named[1563]: internal_send: 2001:500:3::42#53: Network is down Oct 27 16:06:27 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:27 server1 named[1563]: internal_send: 2001:500:3::42#53: Network is down Oct 27 16:06:27 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:27 server1 named[1563]: internal_send: 2001:500:3::42#53: Network is down Oct 27 16:06:27 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:27 server1 named[1563]: internal_send: 2001:500:3::42#53: Network is down Oct 27 16:06:27 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:27 server1 named[1563]: internal_send: 2001:500:3::42#53: Network is down Oct 27 16:06:28 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:28 server1 named[1563]: internal_send: 2001:dc3::35#53: Network is down Oct 27 16:06:28 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:28 server1 named[1563]: internal_send: 2001:dc3::35#53: Network is down Oct 27 16:06:28 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:28 server1 named[1563]: internal_send: 2001:dc3::35#53: Network is down Oct 27 16:06:28 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:28 server1 named[1563]: internal_send: 2001:dc3::35#53: Network is down Oct 27 16:06:28 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:28 server1 named[1563]: internal_send: 2001:dc3::35#53: Network is down Oct 27 16:06:28 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:28 server1 named[1563]: internal_send: 2001:dc3::35#53: Network is down Oct 27 16:06:29 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:29 server1 named[1563]: internal_send: 2001:7fe::53#53: Network is down Oct 27 16:06:29 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:29 server1 named[1563]: internal_send: 2001:7fe::53#53: Network is down Oct 27 16:06:29 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:29 server1 named[1563]: internal_send: 2001:7fe::53#53: Network is down Oct 27 16:06:29 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:29 server1 named[1563]: internal_send: 2001:7fe::53#53: Network is down Oct 27 16:06:29 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:29 server1 named[1563]: internal_send: 2001:7fe::53#53: Network is down Oct 27 16:06:29 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:29 server1 named[1563]: internal_send: 2001:7fe::53#53: Network is down Oct 27 16:06:29 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:29 server1 named[1563]: internal_send: 2001:503:ba3e::2:30#53: Network is down Oct 27 16:06:29 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:29 server1 named[1563]: internal_send: 2001:503:ba3e::2:30#53: Network is down Oct 27 16:06:29 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:29 server1 named[1563]: internal_send: 2001:503:ba3e::2:30#53: Network is down Oct 27 16:06:29 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:29 server1 named[1563]: internal_send: 2001:503:ba3e::2:30#53: Network is down Oct 27 16:06:29 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:29 server1 named[1563]: internal_send: 2001:503:ba3e::2:30#53: Network is down Oct 27 16:06:29 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:29 server1 named[1563]: internal_send: 2001:503:ba3e::2:30#53: Network is down Oct 27 16:06:30 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:30 server1 named[1563]: internal_send: 2001:500:1::803f:235#53: Network is down Oct 27 16:06:30 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:30 server1 named[1563]: internal_send: 2001:500:1::803f:235#53: Network is down Oct 27 16:06:30 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:30 server1 named[1563]: internal_send: 2001:500:1::803f:235#53: Network is down Oct 27 16:06:30 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:30 server1 named[1563]: internal_send: 2001:500:1::803f:235#53: Network is down Oct 27 16:06:30 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:30 server1 named[1563]: internal_send: 2001:500:1::803f:235#53: Network is down Oct 27 16:06:30 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:30 server1 named[1563]: internal_send: 2001:500:1::803f:235#53: Network is down Oct 27 16:06:31 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:31 server1 named[1563]: internal_send: 2001:503:c27::2:30#53: Network is down Oct 27 16:06:31 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:31 server1 named[1563]: internal_send: 2001:503:c27::2:30#53: Network is down Oct 27 16:06:31 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:31 server1 named[1563]: internal_send: 2001:503:c27::2:30#53: Network is down Oct 27 16:06:31 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:31 server1 named[1563]: internal_send: 2001:503:c27::2:30#53: Network is down Oct 27 16:06:31 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:31 server1 named[1563]: internal_send: 2001:503:c27::2:30#53: Network is down Oct 27 16:06:31 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:31 server1 named[1563]: internal_send: 2001:503:c27::2:30#53: Network is down Oct 27 16:06:42 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:42 server1 named[1563]: internal_send: 2001:dc3::35#53: Network is down Oct 27 16:06:43 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:43 server1 named[1563]: internal_send: 2001:500:1::803f:235#53: Network is down Oct 27 16:06:44 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:44 server1 named[1563]: internal_send: 2001:503:ba3e::2:30#53: Network is down Oct 27 16:06:45 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:45 server1 named[1563]: internal_send: 2001:500:3::42#53: Network is down Oct 27 16:06:45 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:45 server1 named[1563]: internal_send: 2001:500:2f::f#53: Network is down Oct 27 16:06:46 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:46 server1 named[1563]: internal_send: 2001:503:c27::2:30#53: Network is down Oct 27 16:06:47 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:47 server1 named[1563]: internal_send: 2001:7fd::1#53: Network is down Oct 27 16:06:48 server1 named[1563]: socket.c:1890: unexpected error: Oct 27 16:06:48 server1 named[1563]: internal_send: 2001:7fe::53#53: Network is down Oct 27 16:08:19 server1 kernel: [18331.079936] tg3 0000:02:00.1: eth1: Link is down Oct 27 16:08:19 server1 kernel: [18331.081336] xenbr0: port 1(eth1) entering forwarding state Oct 27 16:08:22 server1 corosync[1722]: [TOTEM ] A processor failed, forming new configuration. Oct 27 16:08:25 server1 corosync[1722]: [pcmk ] notice: pcmk_peer_update: Transitional membership event on ring 2540: memb=1, new=0, lost=1 Oct 27 16:08:25 server1 corosync[1722]: [pcmk ] info: pcmk_peer_update: memb: server1 16777226 Oct 27 16:08:25 server1 corosync[1722]: [pcmk ] info: pcmk_peer_update: lost: server2 33554442 Oct 27 16:08:25 server1 corosync[1722]: [pcmk ] notice: pcmk_peer_update: Stable membership event on ring 2540: memb=1, new=0, lost=0 Oct 27 16:08:25 server1 corosync[1722]: [pcmk ] info: pcmk_peer_update: MEMB: server1 16777226 Oct 27 16:08:25 server1 corosync[1722]: [pcmk ] info: ais_mark_unseen_peer_dead: Node server2 was not seen in the previous transition Oct 27 16:08:25 server1 corosync[1722]: [pcmk ] info: update_member: Node 33554442/server2 is now: lost Oct 27 16:08:25 server1 corosync[1722]: [pcmk ] info: send_member_notification: Sending membership update 2540 to 2 children Oct 27 16:08:25 server1 corosync[1722]: [TOTEM ] A processor joined or left the membership and a new membership was formed. Oct 27 16:08:25 server1 cib: [1770]: notice: ais_dispatch_message: Membership 2540: quorum lost Oct 27 16:08:25 server1 cib: [1770]: info: crm_update_peer: Node server2: id=33554442 state=lost (new) addr=r(0) ip(10.0.0.2) votes=1 born=2408 seen=2536 proc=00000000000000000000000000111312 Oct 27 16:08:25 server1 crmd: [1776]: notice: ais_dispatch_message: Membership 2540: quorum lost Oct 27 16:08:25 server1 crmd: [1776]: info: ais_status_callback: status: server2 is now lost (was member) Oct 27 16:08:25 server1 crmd: [1776]: info: crm_update_peer: Node server2: id=33554442 state=lost (new) addr=r(0) ip(10.0.0.2) votes=1 born=2408 seen=2536 proc=00000000000000000000000000111312 Oct 27 16:08:25 server1 crmd: [1776]: WARN: check_dead_member: Our DC node (server2) left the cluster Oct 27 16:08:25 server1 corosync[1722]: [CPG ] chosen downlist: sender r(0) ip(10.0.0.1) ; members(old:2 left:1) Oct 27 16:08:25 server1 corosync[1722]: [MAIN ] Completed service synchronization, ready to provide service. Oct 27 16:08:25 server1 crmd: [1776]: info: do_state_transition: State transition S_NOT_DC -> S_ELECTION [ input=I_ELECTION cause=C_FSA_INTERNAL origin=check_dead_member ] Oct 27 16:08:25 server1 crmd: [1776]: info: update_dc: Unset DC server2 Oct 27 16:08:25 server1 crmd: [1776]: info: do_state_transition: State transition S_ELECTION -> S_INTEGRATION [ input=I_ELECTION_DC cause=C_FSA_INTERNAL origin=do_election_check ] Oct 27 16:08:25 server1 crmd: [1776]: info: do_te_control: Registering TE UUID: d90217df-08e6-4cbc-a252-7f6555c9927d Oct 27 16:08:25 server1 crmd: [1776]: info: set_graph_functions: Setting custom graph functions Oct 27 16:08:25 server1 crmd: [1776]: info: unpack_graph: Unpacked transition -1: 0 actions in 0 synapses Oct 27 16:08:25 server1 crmd: [1776]: info: do_dc_takeover: Taking over DC status for this partition Oct 27 16:08:25 server1 cib: [1770]: info: cib_process_readwrite: We are now in R/W mode Oct 27 16:08:25 server1 cib: [1770]: info: cib_process_request: Operation complete: op cib_master for section 'all' (origin=local/crmd/170, version=0.70.80): ok (rc=0) Oct 27 16:08:25 server1 cib: [1770]: info: cib_process_request: Operation complete: op cib_modify for section cib (origin=local/crmd/171, version=0.70.81): ok (rc=0) Oct 27 16:08:25 server1 cib: [1770]: info: cib_process_request: Operation complete: op cib_modify for section crm_config (origin=local/crmd/173, version=0.70.82): ok (rc=0) Oct 27 16:08:25 server1 crmd: [1776]: info: join_make_offer: Making join offers based on membership 2540 Oct 27 16:08:25 server1 cib: [1770]: info: cib_process_request: Operation complete: op cib_modify for section crm_config (origin=local/crmd/175, version=0.70.83): ok (rc=0) Oct 27 16:08:25 server1 crmd: [1776]: info: do_dc_join_offer_all: join-4: Waiting on 1 outstanding join acks Oct 27 16:08:25 server1 crmd: [1776]: info: config_query_callback: Shutdown escalation occurs after: 1200000ms Oct 27 16:08:25 server1 crmd: [1776]: info: config_query_callback: Checking for expired actions every 900000ms Oct 27 16:08:25 server1 crmd: [1776]: info: config_query_callback: Sending expected-votes=2 to corosync Oct 27 16:08:25 server1 crmd: [1776]: info: ais_dispatch_message: Membership 2540: quorum still lost Oct 27 16:08:25 server1 crmd: [1776]: info: crmd_ais_dispatch: Setting expected votes to 2 Oct 27 16:08:25 server1 crmd: [1776]: info: ais_dispatch_message: Membership 2540: quorum still lost Oct 27 16:08:25 server1 cib: [1770]: info: cib_process_request: Operation complete: op cib_modify for section crm_config (origin=local/crmd/178, version=0.70.84): ok (rc=0) Oct 27 16:08:25 server1 crmd: [1776]: info: crmd_ais_dispatch: Setting expected votes to 2 Oct 27 16:08:25 server1 crmd: [1776]: info: update_dc: Set DC to server1 (3.0.5) Oct 27 16:08:25 server1 cib: [1770]: info: cib_process_request: Operation complete: op cib_modify for section crm_config (origin=local/crmd/180, version=0.70.85): ok (rc=0) Oct 27 16:08:25 server1 crmd: [1776]: info: do_state_transition: State transition S_INTEGRATION -> S_FINALIZE_JOIN [ input=I_INTEGRATED cause=C_FSA_INTERNAL origin=check_join_state ] Oct 27 16:08:25 server1 crmd: [1776]: info: do_state_transition: All 1 cluster nodes responded to the join offer. Oct 27 16:08:25 server1 crmd: [1776]: info: do_dc_join_finalize: join-4: Syncing the CIB from server1 to the rest of the cluster Oct 27 16:08:25 server1 cib: [1770]: info: cib_process_request: Operation complete: op cib_sync for section 'all' (origin=local/crmd/182, version=0.70.85): ok (rc=0) Oct 27 16:08:25 server1 cib: [1770]: info: cib_process_request: Operation complete: op cib_modify for section nodes (origin=local/crmd/183, version=0.70.86): ok (rc=0) Oct 27 16:08:25 server1 crmd: [1776]: info: do_dc_join_ack: join-4: Updating node state to member for server1 Oct 27 16:08:25 server1 cib: [1770]: info: cib_process_request: Operation complete: op cib_delete for section //node_state[@uname='server1']/lrm (origin=local/crmd/184, version=0.70.87): ok (rc=0) Oct 27 16:08:25 server1 crmd: [1776]: info: erase_xpath_callback: Deletion of "//node_state[@uname='server1']/lrm": ok (rc=0) Oct 27 16:08:25 server1 crmd: [1776]: info: do_state_transition: State transition S_FINALIZE_JOIN -> S_POLICY_ENGINE [ input=I_FINALIZED cause=C_FSA_INTERNAL origin=check_join_state ] Oct 27 16:08:25 server1 crmd: [1776]: info: do_state_transition: All 1 cluster nodes are eligible to run resources. Oct 27 16:08:25 server1 crmd: [1776]: info: do_dc_join_final: Ensuring DC, quorum and node attributes are up-to-date Oct 27 16:08:25 server1 crmd: [1776]: info: crm_update_quorum: Updating quorum status to false (call=188) Oct 27 16:08:25 server1 crmd: [1776]: info: abort_transition_graph: do_te_invoke:167 - Triggered transition abort (complete=1) : Peer Cancelled Oct 27 16:08:25 server1 crmd: [1776]: info: do_pe_invoke: Query 189: Requesting the current CIB: S_POLICY_ENGINE Oct 27 16:08:25 server1 attrd: [1773]: notice: attrd_local_callback: Sending full refresh (origin=crmd) Oct 27 16:08:25 server1 attrd: [1773]: notice: attrd_trigger_update: Sending flush op to all hosts for: master-resDRBDr1:0 (10000) Oct 27 16:08:25 server1 cib: [1770]: info: cib_process_request: Operation complete: op cib_modify for section nodes (origin=local/crmd/186, version=0.70.89): ok (rc=0) Oct 27 16:08:25 server1 crmd: [1776]: WARN: match_down_event: No match for shutdown action on server2 Oct 27 16:08:25 server1 crmd: [1776]: info: te_update_diff: Stonith/shutdown of server2 not matched Oct 27 16:08:25 server1 crmd: [1776]: info: abort_transition_graph: te_update_diff:215 - Triggered transition abort (complete=1, tag=node_state, id=server2, magic=NA, cib=0.70.90) : Node failure Oct 27 16:08:25 server1 crmd: [1776]: info: do_pe_invoke: Query 190: Requesting the current CIB: S_POLICY_ENGINE Oct 27 16:08:25 server1 cib: [1770]: info: cib_process_request: Operation complete: op cib_modify for section cib (origin=local/crmd/188, version=0.70.91): ok (rc=0) Oct 27 16:08:25 server1 crmd: [1776]: info: do_pe_invoke_callback: Invoking the PE: query=190, ref=pe_calc-dc-1414406305-110, seq=2540, quorate=0 Oct 27 16:08:25 server1 pengine: [1774]: notice: unpack_config: On loss of CCM Quorum: Ignore Oct 27 16:08:25 server1 pengine: [1774]: notice: LogActions: Leave resXen1#011(Started server1) Oct 27 16:08:25 server1 pengine: [1774]: notice: LogActions: Leave resDRBDr1:0#011(Master server1) Oct 27 16:08:25 server1 pengine: [1774]: notice: LogActions: Leave resDRBDr1:1#011(Stopped) Oct 27 16:08:25 server1 pengine: [1774]: notice: LogActions: Leave resOCFS2r1:0#011(Started server1) Oct 27 16:08:25 server1 pengine: [1774]: notice: LogActions: Leave resOCFS2r1:1#011(Stopped) Oct 27 16:08:25 server1 attrd: [1773]: notice: attrd_trigger_update: Sending flush op to all hosts for: probe_complete (true) Oct 27 16:08:25 server1 crmd: [1776]: info: do_state_transition: State transition S_POLICY_ENGINE -> S_TRANSITION_ENGINE [ input=I_PE_SUCCESS cause=C_IPC_MESSAGE origin=handle_response ] Oct 27 16:08:25 server1 crmd: [1776]: info: unpack_graph: Unpacked transition 27: 0 actions in 0 synapses Oct 27 16:08:25 server1 crmd: [1776]: info: do_te_invoke: Processing graph 27 (ref=pe_calc-dc-1414406305-110) derived from /var/lib/pengine/pe-input-352.bz2 Oct 27 16:08:25 server1 crmd: [1776]: info: run_graph: ==================================================== Oct 27 16:08:25 server1 crmd: [1776]: notice: run_graph: Transition 27 (Complete=0, Pending=0, Fired=0, Skipped=0, Incomplete=0, Source=/var/lib/pengine/pe-input-352.bz2): Complete Oct 27 16:08:25 server1 crmd: [1776]: info: te_graph_trigger: Transition 27 is now complete Oct 27 16:08:25 server1 crmd: [1776]: info: notify_crmd: Transition 27 status: done - Oct 27 16:08:25 server1 crmd: [1776]: info: do_state_transition: State transition S_TRANSITION_ENGINE -> S_IDLE [ input=I_TE_SUCCESS cause=C_FSA_INTERNAL origin=notify_crmd ] Oct 27 16:08:25 server1 crmd: [1776]: info: do_state_transition: Starting PEngine Recheck Timer Oct 27 16:08:25 server1 pengine: [1774]: notice: process_pe_message: Transition 27: PEngine Input stored in: /var/lib/pengine/pe-input-352.bz2 Oct 27 16:08:29 server1 kernel: [18340.798361] tg3 0000:02:00.0: eth0: Link is down Oct 27 16:08:29 server1 kernel: [18340.799713] xenbr1: port 1(eth0) entering forwarding state Oct 27 16:08:31 server1 kernel: [18343.491258] tg3 0000:02:00.0: eth0: Link is up at 100 Mbps, full duplex Oct 27 16:08:31 server1 kernel: [18343.491263] tg3 0000:02:00.0: eth0: Flow control is on for TX and on for RX Oct 27 16:08:31 server1 kernel: [18343.491267] tg3 0000:02:00.0: eth0: EEE is disabled Oct 27 16:08:31 server1 kernel: [18343.492578] xenbr1: port 1(eth0) entering forwarding state Oct 27 16:08:31 server1 kernel: [18343.492591] xenbr1: port 1(eth0) entering forwarding state Oct 27 16:11:55 server1 dhclient: Internet Systems Consortium DHCP Client 4.1-ESV-R4 Oct 27 16:11:55 server1 dhclient: Copyright 2004-2011 Internet Systems Consortium. Oct 27 16:11:55 server1 dhclient: All rights reserved. Oct 27 16:11:55 server1 dhclient: For info, please visit https://www.isc.org/software/dhcp/ Oct 27 16:11:55 server1 dhclient: Usage: dhclient [-4|-6] [-SNTP1dvrx] [-nw] [-p ]#012 [-s server-addr] [-cf config-file] [-lf lease-file]#012 [-pf pid-file] [--no-pid] [-e VAR=val]#012 [-sf script-file] [interface] Oct 27 16:12:18 server1 dhclient: can't create /var/lib/dhcp/dhclient.leases: Permission denied Oct 27 16:12:18 server1 dhclient: Open a socket for LPF: Operation not permitted Oct 27 16:16:09 server1 kernel: imklog 5.8.6, log source = /proc/kmsg started. Oct 27 16:16:09 server1 rsyslogd: [origin software="rsyslogd" swVersion="5.8.6" x-pid="1047" x-info="http://www.rsyslog.com"] start Oct 27 16:16:09 server1 rsyslogd: rsyslogd's groupid changed to 103 Oct 27 16:16:09 server1 rsyslogd: rsyslogd's userid changed to 101 Oct 27 16:16:09 server1 rsyslogd-2039: Could not open output pipe '/dev/xconsole' [try http://www.rsyslog.com/e/2039 ] Oct 27 16:16:09 server1 kernel: [ 0.000000] Initializing cgroup subsys cpuset Oct 27 16:16:09 server1 kernel: [ 0.000000] Initializing cgroup subsys cpu Oct 27 16:16:09 server1 kernel: [ 0.000000] Linux version 3.2.0-23-generic (buildd@crested) (gcc version 4.6.3 (Ubuntu/Linaro 4.6.3-1ubuntu4) ) #36-Ubuntu SMP Tue Apr 10 20:39:51 UTC 2012 (Ubuntu 3.2.0-23.36-generic 3.2.14) Oct 27 16:16:09 server1 kernel: [ 0.000000] Command line: placeholder root=UUID=104a708a-6bee-4b7a-9665-1d3b765c66e1 ro Oct 27 16:16:09 server1 kernel: [ 0.000000] KERNEL supported cpus: Oct 27 16:16:09 server1 kernel: [ 0.000000] Intel GenuineIntel Oct 27 16:16:09 server1 kernel: [ 0.000000] AMD AuthenticAMD Oct 27 16:16:09 server1 kernel: [ 0.000000] Centaur CentaurHauls Oct 27 16:16:09 server1 kernel: [ 0.000000] Freeing 98-100 pfn range: 104 pages freed Oct 27 16:16:09 server1 kernel: [ 0.000000] 1-1 mapping on 98->100 Oct 27 16:16:09 server1 kernel: [ 0.000000] Freeing cd2f0-100000 pfn range: 208144 pages freed Oct 27 16:16:09 server1 kernel: [ 0.000000] 1-1 mapping on cd2f0->100000 Oct 27 16:16:09 server1 kernel: [ 0.000000] Released 208248 pages of unused memory Oct 27 16:16:09 server1 kernel: [ 0.000000] Set 208248 page(s) to 1-1 mapping Oct 27 16:16:09 server1 kernel: [ 0.000000] BIOS-provided physical RAM map: Oct 27 16:16:09 server1 kernel: [ 0.000000] Xen: 0000000000000000 - 0000000000098000 (usable) Oct 27 16:16:09 server1 kernel: [ 0.000000] Xen: 00000000000a0000 - 0000000000100000 (reserved) Oct 27 16:16:09 server1 kernel: [ 0.000000] Xen: 0000000000100000 - 00000000cd2f0000 (usable) Oct 27 16:16:09 server1 kernel: [ 0.000000] Xen: 00000000cd2f0000 - 00000000cd31c000 (reserved) Oct 27 16:16:09 server1 kernel: [ 0.000000] Xen: 00000000cd31c000 - 00000000cd35b000 (ACPI data) Oct 27 16:16:09 server1 kernel: [ 0.000000] Xen: 00000000cd35b000 - 00000000d0000000 (reserved) Oct 27 16:16:09 server1 kernel: [ 0.000000] Xen: 00000000e0000000 - 00000000f0000000 (reserved) Oct 27 16:16:09 server1 kernel: [ 0.000000] Xen: 00000000fe000000 - 0000000100000000 (reserved) Oct 27 16:16:09 server1 kernel: [ 0.000000] Xen: 0000000100000000 - 0000000430000000 (usable) Oct 27 16:16:09 server1 kernel: [ 0.000000] NX (Execute Disable) protection: active Oct 27 16:16:09 server1 kernel: [ 0.000000] DMI 2.7 present. Oct 27 16:16:09 server1 kernel: [ 0.000000] DMI: Dell Inc. PowerEdge R320/08VT7V, BIOS 2.1.3 05/21/2014 Oct 27 16:16:09 server1 kernel: [ 0.000000] e820 update range: 0000000000000000 - 0000000000010000 (usable) ==> (reserved) Oct 27 16:16:09 server1 kernel: [ 0.000000] e820 remove range: 00000000000a0000 - 0000000000100000 (usable) Oct 27 16:16:09 server1 kernel: [ 0.000000] No AGP bridge found Oct 27 16:16:09 server1 kernel: [ 0.000000] last_pfn = 0x430000 max_arch_pfn = 0x400000000 Oct 27 16:16:09 server1 kernel: [ 0.000000] x2apic enabled by BIOS, switching to x2apic ops Oct 27 16:16:09 server1 kernel: [ 0.000000] last_pfn = 0xcd2f0 max_arch_pfn = 0x400000000 Oct 27 16:16:09 server1 kernel: [ 0.000000] found SMP MP-table at [ffff8800000fe710] fe710 Oct 27 16:16:09 server1 kernel: [ 0.000000] initial memory mapped : 0 - 04630000 Oct 27 16:16:09 server1 kernel: [ 0.000000] Base memory trampoline at [ffff880000093000] 93000 size 20480 Oct 27 16:16:09 server1 kernel: [ 0.000000] init_memory_mapping: 0000000000000000-00000000cd2f0000 Oct 27 16:16:09 server1 kernel: [ 0.000000] 0000000000 - 00cd2f0000 page 4k Oct 27 16:16:09 server1 kernel: [ 0.000000] kernel direct mapping tables up to cd2f0000 @ 991000-1000000 Oct 27 16:16:09 server1 kernel: [ 0.000000] xen: setting RW the range fc6000 - 1000000 Oct 27 16:16:09 server1 kernel: [ 0.000000] init_memory_mapping: 0000000100000000-0000000430000000 Oct 27 16:16:09 server1 kernel: [ 0.000000] 0100000000 - 0430000000 page 4k Oct 27 16:16:09 server1 kernel: [ 0.000000] kernel direct mapping tables up to 430000000 @ cb15e000-cd2f0000 Oct 27 16:16:09 server1 kernel: [ 0.000000] xen: setting RW the range ccaeb000 - cd2f0000 Oct 27 16:16:09 server1 kernel: [ 0.000000] RAMDISK: 0205f000 - 04630000 Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: RSDP 00000000000f1100 00024 (v02 DELL ) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: XSDT 00000000000f1248 000A4 (v01 DELL PE_SC3 00000001 DELL 00000001) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: FACP 00000000cd33534c 000F4 (v03 DELL PE_SC3 00000001 DELL 00000001) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: DSDT 00000000cd31c000 072F1 (v01 DELL PE_SC3 00000001 INTL 20110211) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: FACS 00000000cd337000 00040 Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: APIC 00000000cd334478 001DE (v01 DELL PE_SC3 00000001 DELL 00000001) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: SPCR 00000000cd334664 00050 (v01 DELL PE_SC3 00000001 DELL 00000001) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: HPET 00000000cd3346b8 00038 (v01 DELL PE_SC3 00000001 DELL 00000001) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: XMAR 00000000cd3346f4 000D8 (v01 DELL PE_SC3 00000001 DELL 00000001) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: MCFG 00000000cd334a10 0003C (v01 DELL PE_SC3 00000001 DELL 00000001) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: WD__ 00000000cd334a50 00134 (v01 DELL PE_SC3 00000001 DELL 00000001) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: SLIC 00000000cd334b88 00176 (v01 DELL PE_SC3 00000001 DELL 00000001) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: ERST 00000000cd3234b4 00270 (v01 DELL PE_SC3 00000001 DELL 00000001) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: HEST 00000000cd323724 00578 (v01 DELL PE_SC3 00000001 DELL 00000001) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: BERT 00000000cd3232f4 00030 (v01 DELL PE_SC3 00000001 DELL 00000001) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: EINJ 00000000cd323324 00190 (v01 DELL PE_SC3 00000001 DELL 00000001) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: TCPA 00000000cd3352e4 00064 (v02 DELL PE_SC3 00000001 DELL 00000001) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: PC__ 00000000cd335274 0006E (v01 DELL PE_SC3 00000001 DELL 00000001) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: SRAT 00000000cd334db0 004C0 (v01 DELL PE_SC3 00000001 DELL 00000001) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: SSDT 00000000cd338000 00ED0 (v01 INTEL PPM RCM 80000001 INTL 20061109) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: Local APIC address 0xfee00000 Oct 27 16:16:09 server1 kernel: [ 0.000000] Setting APIC routing to cluster x2apic. Oct 27 16:16:09 server1 kernel: [ 0.000000] No NUMA configuration found Oct 27 16:16:09 server1 kernel: [ 0.000000] Faking a node at 0000000000000000-0000000430000000 Oct 27 16:16:09 server1 kernel: [ 0.000000] Initmem setup node 0 0000000000000000-0000000430000000 Oct 27 16:16:09 server1 kernel: [ 0.000000] NODE_DATA [00000003e7881000 - 00000003e7885fff] Oct 27 16:16:09 server1 kernel: [ 0.000000] Zone PFN ranges: Oct 27 16:16:09 server1 kernel: [ 0.000000] DMA 0x00000010 -> 0x00001000 Oct 27 16:16:09 server1 kernel: [ 0.000000] DMA32 0x00001000 -> 0x00100000 Oct 27 16:16:09 server1 kernel: [ 0.000000] Normal 0x00100000 -> 0x00430000 Oct 27 16:16:09 server1 kernel: [ 0.000000] Movable zone start PFN for each node Oct 27 16:16:09 server1 kernel: [ 0.000000] early_node_map[3] active PFN ranges Oct 27 16:16:09 server1 kernel: [ 0.000000] 0: 0x00000010 -> 0x00000098 Oct 27 16:16:09 server1 kernel: [ 0.000000] 0: 0x00000100 -> 0x000cd2f0 Oct 27 16:16:09 server1 kernel: [ 0.000000] 0: 0x00100000 -> 0x00430000 Oct 27 16:16:09 server1 kernel: [ 0.000000] On node 0 totalpages: 4182648 Oct 27 16:16:09 server1 kernel: [ 0.000000] DMA zone: 64 pages used for memmap Oct 27 16:16:09 server1 kernel: [ 0.000000] DMA zone: 1594 pages reserved Oct 27 16:16:09 server1 kernel: [ 0.000000] DMA zone: 2318 pages, LIFO batch:0 Oct 27 16:16:09 server1 kernel: [ 0.000000] DMA32 zone: 16320 pages used for memmap Oct 27 16:16:09 server1 kernel: [ 0.000000] DMA32 zone: 820016 pages, LIFO batch:31 Oct 27 16:16:09 server1 kernel: [ 0.000000] Normal zone: 52224 pages used for memmap Oct 27 16:16:09 server1 kernel: [ 0.000000] Normal zone: 3290112 pages, LIFO batch:31 Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: PM-Timer IO Port: 0x808 Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: Local APIC address 0xfee00000 Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x01] lapic_id[0x00] enabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x02] lapic_id[0x02] enabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x03] lapic_id[0x04] enabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x04] lapic_id[0x06] enabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x05] lapic_id[0x44] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x06] lapic_id[0x45] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x07] lapic_id[0x46] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x08] lapic_id[0x47] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x09] lapic_id[0x48] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x0a] lapic_id[0x49] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x0b] lapic_id[0x4a] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x0c] lapic_id[0x4b] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x0d] lapic_id[0x4c] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x0e] lapic_id[0x4d] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x0f] lapic_id[0x4e] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x10] lapic_id[0x4f] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x11] lapic_id[0x50] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x12] lapic_id[0x51] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x13] lapic_id[0x52] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x14] lapic_id[0x53] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x15] lapic_id[0x54] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x16] lapic_id[0x55] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x17] lapic_id[0x56] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x18] lapic_id[0x57] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x19] lapic_id[0x58] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x1a] lapic_id[0x59] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x1b] lapic_id[0x5a] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x1c] lapic_id[0x5b] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x1d] lapic_id[0x5c] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x1e] lapic_id[0x5d] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x1f] lapic_id[0x5e] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x20] lapic_id[0x5f] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x21] lapic_id[0x60] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x22] lapic_id[0x61] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x23] lapic_id[0x62] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x24] lapic_id[0x63] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x25] lapic_id[0x64] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x26] lapic_id[0x65] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x27] lapic_id[0x66] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x28] lapic_id[0x67] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x29] lapic_id[0x68] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x2a] lapic_id[0x69] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x2b] lapic_id[0x6a] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x2c] lapic_id[0x6b] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x2d] lapic_id[0x6c] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x2e] lapic_id[0x6d] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x2f] lapic_id[0x6e] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC (acpi_id[0x30] lapic_id[0x6f] disabled) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] high edge lint[0x1]) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: IOAPIC (id[0x00] address[0xfec00000] gsi_base[0]) Oct 27 16:16:09 server1 kernel: [ 0.000000] IOAPIC[0]: apic_id 0, version 255, address 0xfec00000, GSI 0-255 Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: IOAPIC (id[0x01] address[0xfec3f000] gsi_base[32]) Oct 27 16:16:09 server1 kernel: [ 0.000000] IOAPIC[1]: apic_id 1, version 255, address 0xfec3f000, GSI 32-287 Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: IRQ0 used by override. Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: IRQ2 used by override. Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: IRQ9 used by override. Oct 27 16:16:09 server1 kernel: [ 0.000000] Using ACPI (MADT) for SMP configuration information Oct 27 16:16:09 server1 kernel: [ 0.000000] ACPI: HPET id: 0x8086a701 base: 0xfed00000 Oct 27 16:16:09 server1 kernel: [ 0.000000] SMP: Allowing 48 CPUs, 44 hotplug CPUs Oct 27 16:16:09 server1 kernel: [ 0.000000] nr_irqs_gsi: 304 Oct 27 16:16:09 server1 kernel: [ 0.000000] PM: Registered nosave memory: 0000000000098000 - 00000000000a0000 Oct 27 16:16:09 server1 kernel: [ 0.000000] PM: Registered nosave memory: 00000000000a0000 - 0000000000100000 Oct 27 16:16:09 server1 kernel: [ 0.000000] PM: Registered nosave memory: 00000000cd2f0000 - 00000000cd31c000 Oct 27 16:16:09 server1 kernel: [ 0.000000] PM: Registered nosave memory: 00000000cd31c000 - 00000000cd35b000 Oct 27 16:16:09 server1 kernel: [ 0.000000] PM: Registered nosave memory: 00000000cd35b000 - 00000000d0000000 Oct 27 16:16:09 server1 kernel: [ 0.000000] PM: Registered nosave memory: 00000000d0000000 - 00000000e0000000 Oct 27 16:16:09 server1 kernel: [ 0.000000] PM: Registered nosave memory: 00000000e0000000 - 00000000f0000000 Oct 27 16:16:09 server1 kernel: [ 0.000000] PM: Registered nosave memory: 00000000f0000000 - 00000000fe000000 Oct 27 16:16:09 server1 kernel: [ 0.000000] PM: Registered nosave memory: 00000000fe000000 - 0000000100000000 Oct 27 16:16:09 server1 kernel: [ 0.000000] Allocating PCI resources starting at d0000000 (gap: d0000000:10000000) Oct 27 16:16:09 server1 kernel: [ 0.000000] Booting paravirtualized kernel on Xen Oct 27 16:16:09 server1 kernel: [ 0.000000] Xen version: 4.1.6.1 (preserve-AD) Oct 27 16:16:09 server1 kernel: [ 0.000000] setup_percpu: NR_CPUS:256 nr_cpumask_bits:256 nr_cpu_ids:48 nr_node_ids:1 Oct 27 16:16:09 server1 kernel: [ 0.000000] PERCPU: Embedded 28 pages/cpu @ffff8803d6abc000 s83072 r8192 d23424 u114688 Oct 27 16:16:09 server1 kernel: [ 0.000000] pcpu-alloc: s83072 r8192 d23424 u114688 alloc=28*4096 Oct 27 16:16:09 server1 kernel: [ 0.000000] pcpu-alloc: [0] 00 [0] 01 [0] 02 [0] 03 [0] 04 [0] 05 [0] 06 [0] 07 Oct 27 16:16:09 server1 kernel: [ 0.000000] pcpu-alloc: [0] 08 [0] 09 [0] 10 [0] 11 [0] 12 [0] 13 [0] 14 [0] 15 Oct 27 16:16:09 server1 kernel: [ 0.000000] pcpu-alloc: [0] 16 [0] 17 [0] 18 [0] 19 [0] 20 [0] 21 [0] 22 [0] 23 Oct 27 16:16:09 server1 kernel: [ 0.000000] pcpu-alloc: [0] 24 [0] 25 [0] 26 [0] 27 [0] 28 [0] 29 [0] 30 [0] 31 Oct 27 16:16:09 server1 kernel: [ 0.000000] pcpu-alloc: [0] 32 [0] 33 [0] 34 [0] 35 [0] 36 [0] 37 [0] 38 [0] 39 Oct 27 16:16:09 server1 kernel: [ 0.000000] pcpu-alloc: [0] 40 [0] 41 [0] 42 [0] 43 [0] 44 [0] 45 [0] 46 [0] 47 Oct 27 16:16:09 server1 kernel: [ 3.932656] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 4112446 Oct 27 16:16:09 server1 kernel: [ 3.932661] Policy zone: Normal Oct 27 16:16:09 server1 kernel: [ 3.932664] Kernel command line: placeholder root=UUID=104a708a-6bee-4b7a-9665-1d3b765c66e1 ro Oct 27 16:16:09 server1 kernel: [ 3.933285] PID hash table entries: 4096 (order: 3, 32768 bytes) Oct 27 16:16:09 server1 kernel: [ 3.981887] Placing 64MB software IO TLB between ffff8803d2abc000 - ffff8803d6abc000 Oct 27 16:16:09 server1 kernel: [ 3.981891] software IO TLB at phys 0x3d2abc000 - 0x3d6abc000 Oct 27 16:16:09 server1 kernel: [ 4.049992] Memory: 15089728k/17563648k available (6566k kernel code, 833056k absent, 1640864k reserved, 6637k data, 920k init) Oct 27 16:16:09 server1 kernel: [ 4.050101] SLUB: Genslabs=15, HWalign=64, Order=0-3, MinObjects=0, CPUs=48, Nodes=1 Oct 27 16:16:09 server1 kernel: [ 4.050142] Hierarchical RCU implementation. Oct 27 16:16:09 server1 kernel: [ 4.050144] RCU dyntick-idle grace-period acceleration is enabled. Oct 27 16:16:09 server1 kernel: [ 4.050157] NR_IRQS:16640 nr_irqs:5552 16 Oct 27 16:16:09 server1 kernel: [ 4.050251] xen: sci override: global_irq=9 trigger=0 polarity=0 Oct 27 16:16:09 server1 kernel: [ 4.050256] xen: registering gsi 9 triggering 0 polarity 0 Oct 27 16:16:09 server1 kernel: [ 4.050268] xen: --> pirq=9 -> irq=9 (gsi=9) Oct 27 16:16:09 server1 kernel: [ 4.050295] xen: acpi sci 9 Oct 27 16:16:09 server1 kernel: [ 4.050301] xen: --> pirq=1 -> irq=1 (gsi=1) Oct 27 16:16:09 server1 kernel: [ 4.050306] xen: --> pirq=2 -> irq=2 (gsi=2) Oct 27 16:16:09 server1 kernel: [ 4.050311] xen: --> pirq=3 -> irq=3 (gsi=3) Oct 27 16:16:09 server1 kernel: [ 4.050315] xen: --> pirq=4 -> irq=4 (gsi=4) Oct 27 16:16:09 server1 kernel: [ 4.050320] xen: --> pirq=5 -> irq=5 (gsi=5) Oct 27 16:16:09 server1 kernel: [ 4.050325] xen: --> pirq=6 -> irq=6 (gsi=6) Oct 27 16:16:09 server1 kernel: [ 4.050329] xen: --> pirq=7 -> irq=7 (gsi=7) Oct 27 16:16:09 server1 kernel: [ 4.050334] xen: --> pirq=8 -> irq=8 (gsi=8) Oct 27 16:16:09 server1 kernel: [ 4.050337] xen_map_pirq_gsi: returning irq 9 for gsi 9 Oct 27 16:16:09 server1 kernel: [ 4.050340] xen: --> pirq=9 -> irq=9 (gsi=9) Oct 27 16:16:09 server1 kernel: [ 4.050345] xen: --> pirq=10 -> irq=10 (gsi=10) Oct 27 16:16:09 server1 kernel: [ 4.050350] xen: --> pirq=11 -> irq=11 (gsi=11) Oct 27 16:16:09 server1 kernel: [ 4.050354] xen: --> pirq=12 -> irq=12 (gsi=12) Oct 27 16:16:09 server1 kernel: [ 4.050359] xen: --> pirq=13 -> irq=13 (gsi=13) Oct 27 16:16:09 server1 kernel: [ 4.050364] xen: --> pirq=14 -> irq=14 (gsi=14) Oct 27 16:16:09 server1 kernel: [ 4.050369] xen: --> pirq=15 -> irq=15 (gsi=15) Oct 27 16:16:09 server1 kernel: [ 4.053441] Console: colour VGA+ 80x25 Oct 27 16:16:09 server1 kernel: [ 4.070006] console [tty0] enabled Oct 27 16:16:09 server1 kernel: [ 4.091647] allocated 134217728 bytes of page_cgroup Oct 27 16:16:09 server1 kernel: [ 4.091760] please try 'cgroup_disable=memory' option if you don't want memory cgroups Oct 27 16:16:09 server1 kernel: [ 4.091942] Xen: using vcpuop timer interface Oct 27 16:16:09 server1 kernel: [ 4.091950] installing Xen timer for CPU 0 Oct 27 16:16:09 server1 kernel: [ 4.092088] Detected 1800.071 MHz processor. Oct 27 16:16:09 server1 kernel: [ 4.092196] Calibrating delay loop (skipped), value calculated using timer frequency.. 3600.14 BogoMIPS (lpj=7200284) Oct 27 16:16:09 server1 kernel: [ 4.092411] pid_max: default: 32768 minimum: 301 Oct 27 16:16:09 server1 kernel: [ 4.092555] Security Framework initialized Oct 27 16:16:09 server1 kernel: [ 4.092669] AppArmor: AppArmor initialized Oct 27 16:16:09 server1 kernel: [ 4.092772] Yama: becoming mindful. Oct 27 16:16:09 server1 kernel: [ 4.099045] Dentry cache hash table entries: 2097152 (order: 12, 16777216 bytes) Oct 27 16:16:09 server1 kernel: [ 4.106837] Inode-cache hash table entries: 1048576 (order: 11, 8388608 bytes) Oct 27 16:16:09 server1 kernel: [ 4.109336] Mount-cache hash table entries: 256 Oct 27 16:16:09 server1 kernel: [ 4.109660] Initializing cgroup subsys cpuacct Oct 27 16:16:09 server1 kernel: [ 4.109769] Initializing cgroup subsys memory Oct 27 16:16:09 server1 kernel: [ 4.109888] Initializing cgroup subsys devices Oct 27 16:16:09 server1 kernel: [ 4.109995] Initializing cgroup subsys freezer Oct 27 16:16:09 server1 kernel: [ 4.111938] Initializing cgroup subsys blkio Oct 27 16:16:09 server1 kernel: [ 4.112118] Initializing cgroup subsys perf_event Oct 27 16:16:09 server1 kernel: [ 4.112312] CPU: Physical Processor ID: 0 Oct 27 16:16:09 server1 kernel: [ 4.112414] CPU: Processor Core ID: 0 Oct 27 16:16:09 server1 kernel: [ 4.116986] ACPI: Core revision 20110623 Oct 27 16:16:09 server1 kernel: [ 4.124778] ftrace: allocating 27049 entries in 107 pages Oct 27 16:16:09 server1 kernel: [ 4.136700] cpu 0 spinlock event irq 305 Oct 27 16:16:09 server1 kernel: [ 4.136846] Performance Events: unsupported p6 CPU model 62 no PMU driver, software events only. Oct 27 16:16:09 server1 kernel: [ 4.137277] NMI watchdog disabled (cpu0): hardware events not enabled Oct 27 16:16:09 server1 kernel: [ 4.137484] installing Xen timer for CPU 1 Oct 27 16:16:09 server1 kernel: [ 4.137598] cpu 1 spinlock event irq 311 Oct 27 16:16:09 server1 kernel: [ 4.138974] NMI watchdog disabled (cpu1): hardware events not enabled Oct 27 16:16:09 server1 kernel: [ 4.139185] installing Xen timer for CPU 2 Oct 27 16:16:09 server1 kernel: [ 4.139299] cpu 2 spinlock event irq 317 Oct 27 16:16:09 server1 kernel: [ 4.140632] NMI watchdog disabled (cpu2): hardware events not enabled Oct 27 16:16:09 server1 kernel: [ 4.140843] installing Xen timer for CPU 3 Oct 27 16:16:09 server1 kernel: [ 4.140957] cpu 3 spinlock event irq 323 Oct 27 16:16:09 server1 kernel: [ 4.142280] NMI watchdog disabled (cpu3): hardware events not enabled Oct 27 16:16:09 server1 kernel: [ 4.142417] Brought up 4 CPUs Oct 27 16:16:09 server1 kernel: [ 4.142841] devtmpfs: initialized Oct 27 16:16:09 server1 kernel: [ 4.144542] EVM: security.selinux Oct 27 16:16:09 server1 kernel: [ 4.144644] EVM: security.SMACK64 Oct 27 16:16:09 server1 kernel: [ 4.144745] EVM: security.capability Oct 27 16:16:09 server1 kernel: [ 4.145829] Grant table initialized Oct 27 16:16:09 server1 kernel: [ 4.145987] print_constraints: dummy: Oct 27 16:16:09 server1 kernel: [ 4.146136] RTC time: 16:16:01, date: 10/27/14 Oct 27 16:16:09 server1 kernel: [ 4.146284] NET: Registered protocol family 16 Oct 27 16:16:09 server1 kernel: [ 4.146488] Trying to unpack rootfs image as initramfs... Oct 27 16:16:09 server1 kernel: [ 4.157337] ACPI FADT declares the system doesn't support PCIe ASPM, so disable it Oct 27 16:16:09 server1 kernel: [ 4.157479] ACPI: bus type pci registered Oct 27 16:16:09 server1 kernel: [ 4.157699] PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xe0000000-0xefffffff] (base 0xe0000000) Oct 27 16:16:09 server1 kernel: [ 4.157840] PCI: MMCONFIG at [mem 0xe0000000-0xefffffff] reserved in E820 Oct 27 16:16:09 server1 kernel: [ 4.250708] Freeing initrd memory: 38724k freed Oct 27 16:16:09 server1 kernel: [ 4.313477] PCI: Using configuration type 1 for base access Oct 27 16:16:09 server1 kernel: [ 4.313846] PCI: Dell System detected, enabling pci=bfsort. Oct 27 16:16:09 server1 kernel: [ 4.315363] bio: create slab at 0 Oct 27 16:16:09 server1 kernel: [ 4.315602] ACPI: Added _OSI(Module Device) Oct 27 16:16:09 server1 kernel: [ 4.315707] ACPI: Added _OSI(Processor Device) Oct 27 16:16:09 server1 kernel: [ 4.315812] ACPI: Added _OSI(3.0 _SCP Extensions) Oct 27 16:16:09 server1 kernel: [ 4.315918] ACPI: Added _OSI(Processor Aggregator Device) Oct 27 16:16:09 server1 kernel: [ 4.318021] ACPI: EC: Look up EC in DSDT Oct 27 16:16:09 server1 kernel: [ 4.321289] [Firmware Bug]: ACPI: BIOS _OSI(Linux) query ignored Oct 27 16:16:09 server1 kernel: [ 4.324347] ACPI: Interpreter enabled Oct 27 16:16:09 server1 kernel: [ 4.324454] ACPI: (supports S0 S4 S5) Oct 27 16:16:09 server1 kernel: [ 4.324781] ACPI: Using IOAPIC for interrupt routing Oct 27 16:16:09 server1 kernel: [ 4.330824] ACPI: No dock devices found. Oct 27 16:16:09 server1 kernel: [ 4.331230] HEST: Table parsing has been initialized. Oct 27 16:16:09 server1 kernel: [ 4.331339] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Oct 27 16:16:09 server1 kernel: [ 4.340623] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-3e]) Oct 27 16:16:09 server1 kernel: [ 4.342588] pci_root PNP0A08:00: host bridge window [io 0x0000-0x03af] Oct 27 16:16:09 server1 kernel: [ 4.342699] pci_root PNP0A08:00: host bridge window [io 0x03e0-0x0cf7] Oct 27 16:16:09 server1 kernel: [ 4.342810] pci_root PNP0A08:00: host bridge window [io 0x03b0-0x03df] Oct 27 16:16:09 server1 kernel: [ 4.342920] pci_root PNP0A08:00: host bridge window [io 0x0d00-0x1fff] Oct 27 16:16:09 server1 kernel: [ 4.343030] pci_root PNP0A08:00: host bridge window [io 0x2000-0xffff] Oct 27 16:16:09 server1 kernel: [ 4.343141] pci_root PNP0A08:00: host bridge window [mem 0x000a0000-0x000bffff] Oct 27 16:16:09 server1 kernel: [ 4.343277] pci_root PNP0A08:00: host bridge window [mem 0xd0000000-0xfbffffff] Oct 27 16:16:09 server1 kernel: [ 4.343412] pci_root PNP0A08:00: host bridge window [mem 0xfed40000-0xfed44fff] Oct 27 16:16:09 server1 kernel: [ 4.343575] pci 0000:00:00.0: [8086:0e00] type 0 class 0x000600 Oct 27 16:16:09 server1 kernel: [ 4.343733] pci 0000:00:00.0: PME# supported from D0 D3hot D3cold Oct 27 16:16:09 server1 kernel: [ 4.343741] pci 0000:00:00.0: PME# disabled Oct 27 16:16:09 server1 kernel: [ 4.343803] pci 0000:00:01.0: [8086:0e02] type 1 class 0x000604 Oct 27 16:16:09 server1 kernel: [ 4.343982] pci 0000:00:01.0: PME# supported from D0 D3hot D3cold Oct 27 16:16:09 server1 kernel: [ 4.343989] pci 0000:00:01.0: PME# disabled Oct 27 16:16:09 server1 kernel: [ 4.344070] pci 0000:00:03.0: [8086:0e08] type 1 class 0x000604 Oct 27 16:16:09 server1 kernel: [ 4.344250] pci 0000:00:03.0: PME# supported from D0 D3hot D3cold Oct 27 16:16:09 server1 kernel: [ 4.344258] pci 0000:00:03.0: PME# disabled Oct 27 16:16:09 server1 kernel: [ 4.344328] pci 0000:00:05.0: [8086:0e28] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.344534] pci 0000:00:05.2: [8086:0e2a] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.344773] pci 0000:00:11.0: [8086:1d3e] type 1 class 0x000604 Oct 27 16:16:09 server1 kernel: [ 4.344975] pci 0000:00:11.0: PME# supported from D0 D3hot D3cold Oct 27 16:16:09 server1 kernel: [ 4.344983] pci 0000:00:11.0: PME# disabled Oct 27 16:16:09 server1 kernel: [ 4.345055] pci 0000:00:16.0: [8086:1d3a] type 0 class 0x000780 Oct 27 16:16:09 server1 kernel: [ 4.345103] pci 0000:00:16.0: reg 10: [mem 0xdf0fb000-0xdf0fb00f 64bit] Oct 27 16:16:09 server1 kernel: [ 4.345270] pci 0000:00:16.0: PME# supported from D0 D3hot D3cold Oct 27 16:16:09 server1 kernel: [ 4.345278] pci 0000:00:16.0: PME# disabled Oct 27 16:16:09 server1 kernel: [ 4.345319] pci 0000:00:16.1: [8086:1d3b] type 0 class 0x000780 Oct 27 16:16:09 server1 kernel: [ 4.345367] pci 0000:00:16.1: reg 10: [mem 0xdf0fc000-0xdf0fc00f 64bit] Oct 27 16:16:09 server1 kernel: [ 4.345533] pci 0000:00:16.1: PME# supported from D0 D3hot D3cold Oct 27 16:16:09 server1 kernel: [ 4.345541] pci 0000:00:16.1: PME# disabled Oct 27 16:16:09 server1 kernel: [ 4.345612] pci 0000:00:1a.0: [8086:1d2d] type 0 class 0x000c03 Oct 27 16:16:09 server1 kernel: [ 4.345660] pci 0000:00:1a.0: reg 10: [mem 0xdf0fd000-0xdf0fd3ff] Oct 27 16:16:09 server1 kernel: [ 4.345874] pci 0000:00:1a.0: PME# supported from D0 D3hot D3cold Oct 27 16:16:09 server1 kernel: [ 4.345882] pci 0000:00:1a.0: PME# disabled Oct 27 16:16:09 server1 kernel: [ 4.345933] pci 0000:00:1c.0: [8086:1d10] type 1 class 0x000604 Oct 27 16:16:09 server1 kernel: [ 4.346125] pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold Oct 27 16:16:09 server1 kernel: [ 4.346133] pci 0000:00:1c.0: PME# disabled Oct 27 16:16:09 server1 kernel: [ 4.346194] pci 0000:00:1c.4: [8086:1d18] type 1 class 0x000604 Oct 27 16:16:09 server1 kernel: [ 4.346386] pci 0000:00:1c.4: PME# supported from D0 D3hot D3cold Oct 27 16:16:09 server1 kernel: [ 4.346394] pci 0000:00:1c.4: PME# disabled Oct 27 16:16:09 server1 kernel: [ 4.346451] pci 0000:00:1c.7: [8086:1d1e] type 1 class 0x000604 Oct 27 16:16:09 server1 kernel: [ 4.346643] pci 0000:00:1c.7: PME# supported from D0 D3hot D3cold Oct 27 16:16:09 server1 kernel: [ 4.346651] pci 0000:00:1c.7: PME# disabled Oct 27 16:16:09 server1 kernel: [ 4.346712] pci 0000:00:1d.0: [8086:1d26] type 0 class 0x000c03 Oct 27 16:16:09 server1 kernel: [ 4.346760] pci 0000:00:1d.0: reg 10: [mem 0xdf0fe000-0xdf0fe3ff] Oct 27 16:16:09 server1 kernel: [ 4.346974] pci 0000:00:1d.0: PME# supported from D0 D3hot D3cold Oct 27 16:16:09 server1 kernel: [ 4.346983] pci 0000:00:1d.0: PME# disabled Oct 27 16:16:09 server1 kernel: [ 4.347025] pci 0000:00:1e.0: [8086:244e] type 1 class 0x000604 Oct 27 16:16:09 server1 kernel: [ 4.347185] pci 0000:00:1f.0: [8086:1d41] type 0 class 0x000601 Oct 27 16:16:09 server1 kernel: [ 4.347454] pci 0000:00:1f.2: [8086:1d04] type 0 class 0x000104 Oct 27 16:16:09 server1 kernel: [ 4.347504] pci 0000:00:1f.2: reg 10: [io 0xece8-0xecef] Oct 27 16:16:09 server1 kernel: [ 4.347523] pci 0000:00:1f.2: reg 14: [io 0xecf8-0xecfb] Oct 27 16:16:09 server1 kernel: [ 4.347545] pci 0000:00:1f.2: reg 18: [io 0xecf0-0xecf7] Oct 27 16:16:09 server1 kernel: [ 4.347565] pci 0000:00:1f.2: reg 1c: [io 0xecfc-0xecff] Oct 27 16:16:09 server1 kernel: [ 4.347585] pci 0000:00:1f.2: reg 20: [io 0xecc0-0xecdf] Oct 27 16:16:09 server1 kernel: [ 4.347605] pci 0000:00:1f.2: reg 24: [mem 0xdf0ff000-0xdf0ff7ff] Oct 27 16:16:09 server1 kernel: [ 4.347733] pci 0000:00:1f.2: PME# supported from D3hot Oct 27 16:16:09 server1 kernel: [ 4.347740] pci 0000:00:1f.2: PME# disabled Oct 27 16:16:09 server1 kernel: [ 4.347901] pci 0000:01:00.0: [1000:005b] type 0 class 0x000104 Oct 27 16:16:09 server1 kernel: [ 4.347924] pci 0000:01:00.0: reg 10: [io 0xfc00-0xfcff] Oct 27 16:16:09 server1 kernel: [ 4.347949] pci 0000:01:00.0: reg 14: [mem 0xdcffc000-0xdcffffff 64bit] Oct 27 16:16:09 server1 kernel: [ 4.347975] pci 0000:01:00.0: reg 1c: [mem 0xdcf80000-0xdcfbffff 64bit] Oct 27 16:16:09 server1 kernel: [ 4.348007] pci 0000:01:00.0: reg 30: [mem 0xdc000000-0xdc01ffff pref] Oct 27 16:16:09 server1 kernel: [ 4.348114] pci 0000:01:00.0: supports D1 D2 Oct 27 16:16:09 server1 kernel: [ 4.348193] pci 0000:00:01.0: PCI bridge to [bus 01-01] Oct 27 16:16:09 server1 kernel: [ 4.348305] pci 0000:00:01.0: bridge window [io 0xf000-0xffff] Oct 27 16:16:09 server1 kernel: [ 4.348313] pci 0000:00:01.0: bridge window [mem 0xdc000000-0xdcffffff] Oct 27 16:16:09 server1 kernel: [ 4.348431] pci 0000:00:03.0: PCI bridge to [bus 08-08] Oct 27 16:16:09 server1 kernel: [ 4.348666] pci 0000:00:11.0: PCI bridge to [bus 09-09] Oct 27 16:16:09 server1 kernel: [ 4.348898] pci 0000:00:1c.0: PCI bridge to [bus 0a-0a] Oct 27 16:16:09 server1 kernel: [ 4.349181] pci 0000:02:00.0: [14e4:165f] type 0 class 0x000200 Oct 27 16:16:09 server1 kernel: [ 4.349230] pci 0000:02:00.0: reg 10: [mem 0xd90a0000-0xd90affff 64bit pref] Oct 27 16:16:09 server1 kernel: [ 4.349269] pci 0000:02:00.0: reg 18: [mem 0xd90b0000-0xd90bffff 64bit pref] Oct 27 16:16:09 server1 kernel: [ 4.349309] pci 0000:02:00.0: reg 20: [mem 0xd90c0000-0xd90cffff 64bit pref] Oct 27 16:16:09 server1 kernel: [ 4.349335] pci 0000:02:00.0: reg 30: [mem 0xdd000000-0xdd03ffff pref] Oct 27 16:16:09 server1 kernel: [ 4.349500] pci 0000:02:00.0: PME# supported from D0 D3hot D3cold Oct 27 16:16:09 server1 kernel: [ 4.349510] pci 0000:02:00.0: PME# disabled Oct 27 16:16:09 server1 kernel: [ 4.349604] pci 0000:02:00.1: [14e4:165f] type 0 class 0x000200 Oct 27 16:16:09 server1 kernel: [ 4.349651] pci 0000:02:00.1: reg 10: [mem 0xd90d0000-0xd90dffff 64bit pref] Oct 27 16:16:09 server1 kernel: [ 4.349691] pci 0000:02:00.1: reg 18: [mem 0xd90e0000-0xd90effff 64bit pref] Oct 27 16:16:09 server1 kernel: [ 4.349730] pci 0000:02:00.1: reg 20: [mem 0xd90f0000-0xd90fffff 64bit pref] Oct 27 16:16:09 server1 kernel: [ 4.349756] pci 0000:02:00.1: reg 30: [mem 0xdd000000-0xdd03ffff pref] Oct 27 16:16:09 server1 kernel: [ 4.349921] pci 0000:02:00.1: PME# supported from D0 D3hot D3cold Oct 27 16:16:09 server1 kernel: [ 4.349930] pci 0000:02:00.1: PME# disabled Oct 27 16:16:09 server1 kernel: [ 4.350045] pci 0000:00:1c.4: PCI bridge to [bus 02-02] Oct 27 16:16:09 server1 kernel: [ 4.350162] pci 0000:00:1c.4: bridge window [mem 0xdd000000-0xdd7fffff] Oct 27 16:16:09 server1 kernel: [ 4.350175] pci 0000:00:1c.4: bridge window [mem 0xd9000000-0xd90fffff 64bit pref] Oct 27 16:16:09 server1 kernel: [ 4.350652] pci 0000:03:00.0: [1912:0013] type 1 class 0x000604 Oct 27 16:16:09 server1 kernel: [ 4.353123] pci 0000:03:00.0: PME# supported from D0 D3hot D3cold Oct 27 16:16:09 server1 kernel: [ 4.353197] pci 0000:03:00.0: PME# disabled Oct 27 16:16:09 server1 kernel: [ 4.361188] pci 0000:00:1c.7: PCI bridge to [bus 03-07] Oct 27 16:16:09 server1 kernel: [ 4.361305] pci 0000:00:1c.7: bridge window [mem 0xdd800000-0xdeffffff] Oct 27 16:16:09 server1 kernel: [ 4.361319] pci 0000:00:1c.7: bridge window [mem 0xd8000000-0xd8ffffff 64bit pref] Oct 27 16:16:09 server1 kernel: [ 4.363144] pci 0000:04:00.0: [1912:0013] type 1 class 0x000604 Oct 27 16:16:09 server1 kernel: [ 4.365979] pci 0000:04:00.0: PME# supported from D0 D3hot D3cold Oct 27 16:16:09 server1 kernel: [ 4.366055] pci 0000:04:00.0: PME# disabled Oct 27 16:16:09 server1 kernel: [ 4.366962] pci 0000:04:01.0: [1912:0013] type 1 class 0x000604 Oct 27 16:16:09 server1 kernel: [ 4.369808] pci 0000:04:01.0: PME# supported from D0 D3hot D3cold Oct 27 16:16:09 server1 kernel: [ 4.369886] pci 0000:04:01.0: PME# disabled Oct 27 16:16:09 server1 kernel: [ 4.372168] pci 0000:03:00.0: PCI bridge to [bus 04-07] Oct 27 16:16:09 server1 kernel: [ 4.372467] pci 0000:03:00.0: bridge window [mem 0xdd800000-0xdeffffff] Oct 27 16:16:09 server1 kernel: [ 4.372592] pci 0000:03:00.0: bridge window [mem 0xd8000000-0xd8ffffff 64bit pref] Oct 27 16:16:09 server1 kernel: [ 4.374557] pci 0000:05:00.0: [1912:0012] type 1 class 0x000604 Oct 27 16:16:09 server1 kernel: [ 4.378385] pci 0000:04:00.0: PCI bridge to [bus 05-06] Oct 27 16:16:09 server1 kernel: [ 4.378707] pci 0000:04:00.0: bridge window [mem 0xdd800000-0xde7fffff] Oct 27 16:16:09 server1 kernel: [ 4.378852] pci 0000:04:00.0: bridge window [mem 0xd8000000-0xd8ffffff 64bit pref] Oct 27 16:16:09 server1 kernel: [ 4.380649] pci 0000:06:00.0: [102b:0534] type 0 class 0x000300 Oct 27 16:16:09 server1 kernel: [ 4.381133] pci 0000:06:00.0: reg 10: [mem 0xd8000000-0xd8ffffff pref] Oct 27 16:16:09 server1 kernel: [ 4.381394] pci 0000:06:00.0: reg 14: [mem 0xde7fc000-0xde7fffff] Oct 27 16:16:09 server1 kernel: [ 4.381654] pci 0000:06:00.0: reg 18: [mem 0xdd800000-0xddffffff] Oct 27 16:16:09 server1 kernel: [ 4.385726] pci 0000:05:00.0: PCI bridge to [bus 06-06] Oct 27 16:16:09 server1 kernel: [ 4.386055] pci 0000:05:00.0: bridge window [mem 0xdd800000-0xde7fffff] Oct 27 16:16:09 server1 kernel: [ 4.386200] pci 0000:05:00.0: bridge window [mem 0xd8000000-0xd8ffffff 64bit pref] Oct 27 16:16:09 server1 kernel: [ 4.388124] pci 0000:04:01.0: PCI bridge to [bus 07-07] Oct 27 16:16:09 server1 kernel: [ 4.388449] pci 0000:04:01.0: bridge window [mem 0xdef00000-0xdeffffff] Oct 27 16:16:09 server1 kernel: [ 4.389694] pci 0000:00:1e.0: PCI bridge to [bus 0b-0b] (subtractive decode) Oct 27 16:16:09 server1 kernel: [ 4.389824] pci 0000:00:1e.0: bridge window [io 0x0000-0x03af] (subtractive decode) Oct 27 16:16:09 server1 kernel: [ 4.389828] pci 0000:00:1e.0: bridge window [io 0x03e0-0x0cf7] (subtractive decode) Oct 27 16:16:09 server1 kernel: [ 4.389831] pci 0000:00:1e.0: bridge window [io 0x03b0-0x03df] (subtractive decode) Oct 27 16:16:09 server1 kernel: [ 4.389834] pci 0000:00:1e.0: bridge window [io 0x0d00-0x1fff] (subtractive decode) Oct 27 16:16:09 server1 kernel: [ 4.389837] pci 0000:00:1e.0: bridge window [io 0x2000-0xffff] (subtractive decode) Oct 27 16:16:09 server1 kernel: [ 4.389841] pci 0000:00:1e.0: bridge window [mem 0x000a0000-0x000bffff] (subtractive decode) Oct 27 16:16:09 server1 kernel: [ 4.389844] pci 0000:00:1e.0: bridge window [mem 0xd0000000-0xfbffffff] (subtractive decode) Oct 27 16:16:09 server1 kernel: [ 4.389847] pci 0000:00:1e.0: bridge window [mem 0xfed40000-0xfed44fff] (subtractive decode) Oct 27 16:16:09 server1 kernel: [ 4.389924] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT] Oct 27 16:16:09 server1 kernel: [ 4.390190] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEX1._PRT] Oct 27 16:16:09 server1 kernel: [ 4.390269] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEX3._PRT] Oct 27 16:16:09 server1 kernel: [ 4.390347] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEX6._PRT] Oct 27 16:16:09 server1 kernel: [ 4.390418] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEX7._PRT] Oct 27 16:16:09 server1 kernel: [ 4.390506] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEX9._PRT] Oct 27 16:16:09 server1 kernel: [ 4.390803] pci0000:00: Requesting ACPI _OSC control (0x15) Oct 27 16:16:09 server1 kernel: [ 4.391284] pci0000:00: ACPI _OSC control (0x15) granted Oct 27 16:16:09 server1 kernel: [ 4.396603] ACPI: PCI Root Bridge [P0B1] (domain 0000 [bus 3f]) Oct 27 16:16:09 server1 kernel: [ 4.396920] pci 0000:3f:08.0: [8086:0e80] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.397072] pci 0000:3f:09.0: [8086:0e90] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.397218] pci 0000:3f:0a.0: [8086:0ec0] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.397346] pci 0000:3f:0a.1: [8086:0ec1] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.397474] pci 0000:3f:0a.2: [8086:0ec2] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.397602] pci 0000:3f:0a.3: [8086:0ec3] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.397737] pci 0000:3f:0b.0: [8086:0e1e] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.397865] pci 0000:3f:0b.3: [8086:0e1f] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.398000] pci 0000:3f:0c.0: [8086:0ee0] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.398138] pci 0000:3f:0c.1: [8086:0ee2] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.398277] pci 0000:3f:0d.0: [8086:0ee1] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.398402] pci 0000:3f:0d.1: [8086:0ee3] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.398540] pci 0000:3f:0e.0: [8086:0ea0] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.398672] pci 0000:3f:0e.1: [8086:0e30] type 0 class 0x001101 Oct 27 16:16:09 server1 kernel: [ 4.398824] pci 0000:3f:0f.0: [8086:0ea8] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.398997] pci 0000:3f:0f.1: [8086:0e71] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.399169] pci 0000:3f:0f.2: [8086:0eaa] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.399344] pci 0000:3f:0f.3: [8086:0eab] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.399516] pci 0000:3f:0f.4: [8086:0eac] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.399689] pci 0000:3f:0f.5: [8086:0ead] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.399866] pci 0000:3f:10.0: [8086:0eb0] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.400039] pci 0000:3f:10.1: [8086:0eb1] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.400211] pci 0000:3f:10.2: [8086:0eb2] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.400385] pci 0000:3f:10.3: [8086:0eb3] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.400557] pci 0000:3f:10.4: [8086:0eb4] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.400732] pci 0000:3f:10.5: [8086:0eb5] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.400907] pci 0000:3f:10.7: [8086:0eb7] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.401076] pci 0000:3f:13.0: [8086:0e1d] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.401202] pci 0000:3f:13.1: [8086:0e34] type 0 class 0x001101 Oct 27 16:16:09 server1 kernel: [ 4.401332] pci 0000:3f:13.4: [8086:0e81] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.401459] pci 0000:3f:13.5: [8086:0e36] type 0 class 0x001101 Oct 27 16:16:09 server1 kernel: [ 4.401595] pci 0000:3f:16.0: [8086:0ec8] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.401721] pci 0000:3f:16.1: [8086:0ec9] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.401849] pci 0000:3f:16.2: [8086:0eca] type 0 class 0x000880 Oct 27 16:16:09 server1 kernel: [ 4.402213] pci0000:3f: Requesting ACPI _OSC control (0x15) Oct 27 16:16:09 server1 kernel: [ 4.402688] pci0000:3f: ACPI _OSC control (0x15) granted Oct 27 16:16:09 server1 kernel: [ 4.406666] ACPI: PCI Root Bridge [P1B1] (domain 0000 [bus 7f]) Oct 27 16:16:09 server1 kernel: [ 4.407098] pci0000:7f: Requesting ACPI _OSC control (0x15) Oct 27 16:16:09 server1 kernel: [ 4.407572] pci0000:7f: ACPI _OSC control (0x15) granted Oct 27 16:16:09 server1 kernel: [ 4.408176] ACPI: PCI Interrupt Link [LK00] (IRQs 3 4 5 6 7 11 14 *15) Oct 27 16:16:09 server1 kernel: [ 4.409067] ACPI: PCI Interrupt Link [LK01] (IRQs 3 4 5 6 7 11 *14 15) Oct 27 16:16:09 server1 kernel: [ 4.409956] ACPI: PCI Interrupt Link [LK02] (IRQs 3 4 5 6 7 11 14 15) *0, disabled. Oct 27 16:16:09 server1 kernel: [ 4.411018] ACPI: PCI Interrupt Link [LK03] (IRQs 3 4 5 6 7 *11 14 15) Oct 27 16:16:09 server1 kernel: [ 4.411901] ACPI: PCI Interrupt Link [LK04] (IRQs 3 4 *5 6 7 11 14 15) Oct 27 16:16:09 server1 kernel: [ 4.412787] ACPI: PCI Interrupt Link [LK05] (IRQs 3 4 5 6 7 11 14 15) *0, disabled. Oct 27 16:16:09 server1 kernel: [ 4.413836] ACPI: PCI Interrupt Link [LK06] (IRQs 3 4 5 *6 7 11 14 15) Oct 27 16:16:09 server1 kernel: [ 4.414722] ACPI: PCI Interrupt Link [LK07] (IRQs 3 4 5 6 7 11 *14 15) Oct 27 16:16:09 server1 kernel: [ 4.415576] xen/balloon: Initialising balloon driver. Oct 27 16:16:09 server1 kernel: [ 4.420127] xen-balloon: Initialising balloon driver. Oct 27 16:16:09 server1 kernel: [ 4.420258] xen/balloon: Xen selfballooning driver disabled for domain0. Oct 27 16:16:09 server1 kernel: [ 4.420655] vgaarb: device added: PCI:0000:06:00.0,decodes=io+mem,owns=io+mem,locks=none Oct 27 16:16:09 server1 kernel: [ 4.420817] vgaarb: loaded Oct 27 16:16:09 server1 kernel: [ 4.420917] vgaarb: bridge control possible 0000:06:00.0 Oct 27 16:16:09 server1 kernel: [ 4.421138] i2c-core: driver [aat2870] using legacy suspend method Oct 27 16:16:09 server1 kernel: [ 4.421247] i2c-core: driver [aat2870] using legacy resume method Oct 27 16:16:09 server1 kernel: [ 4.421424] SCSI subsystem initialized Oct 27 16:16:09 server1 kernel: [ 4.421611] libata version 3.00 loaded. Oct 27 16:16:09 server1 kernel: [ 4.421662] usbcore: registered new interface driver usbfs Oct 27 16:16:09 server1 kernel: [ 4.421781] usbcore: registered new interface driver hub Oct 27 16:16:09 server1 kernel: [ 4.421938] usbcore: registered new device driver usb Oct 27 16:16:09 server1 kernel: [ 4.422179] PCI: Using ACPI for IRQ routing Oct 27 16:16:09 server1 kernel: [ 4.439244] PCI: pci_cache_line_size set to 64 bytes Oct 27 16:16:09 server1 kernel: [ 4.439904] reserve RAM buffer: 0000000000098000 - 000000000009ffff Oct 27 16:16:09 server1 kernel: [ 4.439907] reserve RAM buffer: 00000000cd2f0000 - 00000000cfffffff Oct 27 16:16:09 server1 kernel: [ 4.440045] NetLabel: Initializing Oct 27 16:16:09 server1 kernel: [ 4.440148] NetLabel: domain hash size = 128 Oct 27 16:16:09 server1 kernel: [ 4.440252] NetLabel: protocols = UNLABELED CIPSOv4 Oct 27 16:16:09 server1 kernel: [ 4.440369] NetLabel: unlabeled traffic allowed by default Oct 27 16:16:09 server1 kernel: [ 4.440587] Switching to clocksource xen Oct 27 16:16:09 server1 kernel: [ 4.448663] AppArmor: AppArmor Filesystem Enabled Oct 27 16:16:09 server1 kernel: [ 4.448802] pnp: PnP ACPI init Oct 27 16:16:09 server1 kernel: [ 4.448915] ACPI: bus type pnp registered Oct 27 16:16:09 server1 kernel: [ 4.450046] pnp 00:00: [bus 00-3e] Oct 27 16:16:09 server1 kernel: [ 4.450050] pnp 00:00: [io 0x0cf8-0x0cff] Oct 27 16:16:09 server1 kernel: [ 4.450053] pnp 00:00: [io 0x0000-0x03af window] Oct 27 16:16:09 server1 kernel: [ 4.450056] pnp 00:00: [io 0x03e0-0x0cf7 window] Oct 27 16:16:09 server1 kernel: [ 4.450059] pnp 00:00: [io 0x03b0-0x03df window] Oct 27 16:16:09 server1 kernel: [ 4.450062] pnp 00:00: [io 0x0d00-0x1fff window] Oct 27 16:16:09 server1 kernel: [ 4.450065] pnp 00:00: [io 0x2000-0xffff window] Oct 27 16:16:09 server1 kernel: [ 4.450067] pnp 00:00: [io 0x0000 window] Oct 27 16:16:09 server1 kernel: [ 4.450070] pnp 00:00: [io 0x0000 window] Oct 27 16:16:09 server1 kernel: [ 4.450073] pnp 00:00: [io 0x0000 window] Oct 27 16:16:09 server1 kernel: [ 4.450075] pnp 00:00: [io 0x0000 window] Oct 27 16:16:09 server1 kernel: [ 4.450078] pnp 00:00: [io 0x0000 window] Oct 27 16:16:09 server1 kernel: [ 4.450081] pnp 00:00: [io 0x0000 window] Oct 27 16:16:09 server1 kernel: [ 4.450084] pnp 00:00: [mem 0x000a0000-0x000bffff window] Oct 27 16:16:09 server1 kernel: [ 4.450087] pnp 00:00: [mem 0xd0000000-0xfbffffff window] Oct 27 16:16:09 server1 kernel: [ 4.450090] pnp 00:00: [mem 0x00000000 window] Oct 27 16:16:09 server1 kernel: [ 4.450093] pnp 00:00: [mem 0x00000000 window] Oct 27 16:16:09 server1 kernel: [ 4.450095] pnp 00:00: [mem 0x00000000 window] Oct 27 16:16:09 server1 kernel: [ 4.450098] pnp 00:00: [mem 0x00000000 window] Oct 27 16:16:09 server1 kernel: [ 4.450101] pnp 00:00: [mem 0x00000000 window] Oct 27 16:16:09 server1 kernel: [ 4.450104] pnp 00:00: [mem 0x00000000 window] Oct 27 16:16:09 server1 kernel: [ 4.450110] pnp 00:00: [mem 0x00000000 window] Oct 27 16:16:09 server1 kernel: [ 4.450113] pnp 00:00: [mem 0x00000000 window] Oct 27 16:16:09 server1 kernel: [ 4.450115] pnp 00:00: [mem 0xfed40000-0xfed44fff window] Oct 27 16:16:09 server1 kernel: [ 4.450219] pnp 00:00: Plug and Play ACPI device, IDs PNP0a08 PNP0a03 (active) Oct 27 16:16:09 server1 kernel: [ 4.450329] pnp 00:01: [io 0x0080-0x009f] Oct 27 16:16:09 server1 kernel: [ 4.450331] pnp 00:01: [io 0x0000-0x001f] Oct 27 16:16:09 server1 kernel: [ 4.450334] pnp 00:01: [io 0x00c0-0x00df] Oct 27 16:16:09 server1 kernel: [ 4.450337] pnp 00:01: [dma 4] Oct 27 16:16:09 server1 kernel: [ 4.450400] pnp 00:01: Plug and Play ACPI device, IDs PNP0200 (active) Oct 27 16:16:09 server1 kernel: [ 4.450430] pnp 00:02: [io 0x00f0-0x00ff] Oct 27 16:16:09 server1 kernel: [ 4.450435] xen: registering gsi 13 triggering 1 polarity 0 Oct 27 16:16:09 server1 kernel: [ 4.450442] xen_map_pirq_gsi: returning irq 13 for gsi 13 Oct 27 16:16:09 server1 kernel: [ 4.450550] xen: --> pirq=13 -> irq=13 (gsi=13) Oct 27 16:16:09 server1 kernel: [ 4.450578] pnp 00:02: [irq 13] Oct 27 16:16:09 server1 kernel: [ 4.450638] pnp 00:02: Plug and Play ACPI device, IDs PNP0c04 (active) Oct 27 16:16:09 server1 kernel: [ 4.450673] pnp 00:03: [io 0x0061] Oct 27 16:16:09 server1 kernel: [ 4.450783] system 00:03: Plug and Play ACPI device, IDs PNP0c01 (active) Oct 27 16:16:09 server1 kernel: [ 4.450815] pnp 00:04: [io 0x0070-0x007f] Oct 27 16:16:09 server1 kernel: [ 4.450818] xen: registering gsi 8 triggering 1 polarity 0 Oct 27 16:16:09 server1 kernel: [ 4.450822] xen_map_pirq_gsi: returning irq 8 for gsi 8 Oct 27 16:16:09 server1 kernel: [ 4.450929] xen: --> pirq=8 -> irq=8 (gsi=8) Oct 27 16:16:09 server1 kernel: [ 4.450954] pnp 00:04: [irq 8] Oct 27 16:16:09 server1 kernel: [ 4.451018] pnp 00:04: Plug and Play ACPI device, IDs PNP0b00 (active) Oct 27 16:16:09 server1 kernel: [ 4.451284] pnp 00:05: [io 0x02f8-0x02ff] Oct 27 16:16:09 server1 kernel: [ 4.451287] xen: registering gsi 3 triggering 1 polarity 0 Oct 27 16:16:09 server1 kernel: [ 4.451291] xen_map_pirq_gsi: returning irq 3 for gsi 3 Oct 27 16:16:09 server1 kernel: [ 4.451398] xen: --> pirq=3 -> irq=3 (gsi=3) Oct 27 16:16:09 server1 kernel: [ 4.451422] pnp 00:05: [irq 3] Oct 27 16:16:09 server1 kernel: [ 4.451537] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active) Oct 27 16:16:09 server1 kernel: [ 4.451791] pnp 00:06: [io 0x03f8-0x03ff] Oct 27 16:16:09 server1 kernel: [ 4.451795] xen: registering gsi 4 triggering 1 polarity 0 Oct 27 16:16:09 server1 kernel: [ 4.451798] xen_map_pirq_gsi: returning irq 4 for gsi 4 Oct 27 16:16:09 server1 kernel: [ 4.451905] xen: --> pirq=4 -> irq=4 (gsi=4) Oct 27 16:16:09 server1 kernel: [ 4.451929] pnp 00:06: [irq 4] Oct 27 16:16:09 server1 kernel: [ 4.452045] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active) Oct 27 16:16:09 server1 kernel: [ 4.452440] pnp 00:07: [io 0x0800-0x087f] Oct 27 16:16:09 server1 kernel: [ 4.452443] pnp 00:07: [io 0x00e0-0x00e7] Oct 27 16:16:09 server1 kernel: [ 4.452446] pnp 00:07: [io 0x0880-0x08ff] Oct 27 16:16:09 server1 kernel: [ 4.452449] pnp 00:07: [io 0x0900-0x091f] Oct 27 16:16:09 server1 kernel: [ 4.452451] pnp 00:07: [io 0x0920-0x0923] Oct 27 16:16:09 server1 kernel: [ 4.452454] pnp 00:07: [io 0x0924] Oct 27 16:16:09 server1 kernel: [ 4.452459] pnp 00:07: [io 0x0370-0x0377] Oct 27 16:16:09 server1 kernel: [ 4.452462] pnp 00:07: [io 0x0ca0-0x0ca7] Oct 27 16:16:09 server1 kernel: [ 4.452464] pnp 00:07: [io 0x0ca9-0x0cab] Oct 27 16:16:09 server1 kernel: [ 4.452467] pnp 00:07: [io 0x0cad-0x0caf] Oct 27 16:16:09 server1 kernel: [ 4.452470] pnp 00:07: [io 0x0cb0-0x0cbf] Oct 27 16:16:09 server1 kernel: [ 4.452473] pnp 00:07: [io 0x0060-0x005f disabled] Oct 27 16:16:09 server1 kernel: [ 4.452475] pnp 00:07: [io 0x0064-0x0063 disabled] Oct 27 16:16:09 server1 kernel: [ 4.452589] system 00:07: [io 0x0800-0x087f] has been reserved Oct 27 16:16:09 server1 kernel: [ 4.452700] system 00:07: [io 0x0880-0x08ff] has been reserved Oct 27 16:16:09 server1 kernel: [ 4.452808] system 00:07: [io 0x0900-0x091f] has been reserved Oct 27 16:16:09 server1 kernel: [ 4.452917] system 00:07: [io 0x0920-0x0923] has been reserved Oct 27 16:16:09 server1 kernel: [ 4.453026] system 00:07: [io 0x0924] has been reserved Oct 27 16:16:09 server1 kernel: [ 4.453133] system 00:07: [io 0x0370-0x0377] has been reserved Oct 27 16:16:09 server1 kernel: [ 4.453242] system 00:07: [io 0x0ca0-0x0ca7] has been reserved Oct 27 16:16:09 server1 kernel: [ 4.453350] system 00:07: [io 0x0ca9-0x0cab] has been reserved Oct 27 16:16:09 server1 kernel: [ 4.453459] system 00:07: [io 0x0cad-0x0caf] has been reserved Oct 27 16:16:09 server1 kernel: [ 4.453567] system 00:07: [io 0x0cb0-0x0cbf] has been reserved Oct 27 16:16:09 server1 kernel: [ 4.453768] system 00:07: Plug and Play ACPI device, IDs PNP0c01 (active) Oct 27 16:16:09 server1 kernel: [ 4.453830] pnp 00:08: [io 0x0ca8] Oct 27 16:16:09 server1 kernel: [ 4.453833] pnp 00:08: [io 0x0cac] Oct 27 16:16:09 server1 kernel: [ 4.453836] xen: registering gsi 10 triggering 1 polarity 0 Oct 27 16:16:09 server1 kernel: [ 4.453851] xen_map_pirq_gsi: returning irq 10 for gsi 10 Oct 27 16:16:09 server1 kernel: [ 4.453958] xen: --> pirq=10 -> irq=10 (gsi=10) Oct 27 16:16:09 server1 kernel: [ 4.453983] pnp 00:08: [irq 10] Oct 27 16:16:09 server1 kernel: [ 4.454094] system 00:08: [io 0x0ca8] has been reserved Oct 27 16:16:09 server1 kernel: [ 4.454202] system 00:08: [io 0x0cac] has been reserved Oct 27 16:16:09 server1 kernel: [ 4.454310] system 00:08: Plug and Play ACPI device, IDs IPI0001 PNP0c01 (active) Oct 27 16:16:09 server1 kernel: [ 4.454709] pnp 00:09: [mem 0xe0000000-0xe3efffff] Oct 27 16:16:09 server1 kernel: [ 4.454819] system 00:09: [mem 0xe0000000-0xe3efffff] has been reserved Oct 27 16:16:09 server1 kernel: [ 4.454931] system 00:09: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 27 16:16:09 server1 kernel: [ 4.455032] pnp 00:0a: [bus 3f] Oct 27 16:16:09 server1 kernel: [ 4.455107] pnp 00:0a: Plug and Play ACPI device, IDs PNP0a08 PNP0a03 (active) Oct 27 16:16:09 server1 kernel: [ 4.455144] pnp 00:0b: [mem 0xe3f00000-0xe3ffffff] Oct 27 16:16:09 server1 kernel: [ 4.455253] system 00:0b: [mem 0xe3f00000-0xe3ffffff] has been reserved Oct 27 16:16:09 server1 kernel: [ 4.455366] system 00:0b: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 27 16:16:09 server1 kernel: [ 4.455415] pnp 00:0c: [mem 0xdf100000-0xdf101fff] Oct 27 16:16:09 server1 kernel: [ 4.455523] system 00:0c: [mem 0xdf100000-0xdf101fff] has been reserved Oct 27 16:16:09 server1 kernel: [ 4.455635] system 00:0c: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 27 16:16:09 server1 kernel: [ 4.455696] pnp 00:0d: [bus 7f] Oct 27 16:16:09 server1 kernel: [ 4.455774] pnp 00:0d: Plug and Play ACPI device, IDs PNP0a08 PNP0a03 (active) Oct 27 16:16:09 server1 kernel: [ 4.455842] pnp 00:0e: [mem 0xfed00000-0xfed003ff] Oct 27 16:16:09 server1 kernel: [ 4.455914] pnp 00:0e: Plug and Play ACPI device, IDs PNP0103 (active) Oct 27 16:16:09 server1 kernel: [ 4.456161] pnp: PnP ACPI: found 15 devices Oct 27 16:16:09 server1 kernel: [ 4.456265] ACPI: ACPI bus type pnp unregistered Oct 27 16:16:09 server1 kernel: [ 4.465721] PM-Timer failed consistency check (0x0xffffff) - aborting. Oct 27 16:16:09 server1 kernel: [ 4.465847] pci 0000:02:00.1: address space collision: [mem 0xdd000000-0xdd03ffff pref] conflicts with 0000:02:00.0 [mem 0xdd000000-0xdd03ffff pref] Oct 27 16:16:09 server1 kernel: [ 4.466022] PCI: max bus depth: 4 pci_try_num: 5 Oct 27 16:16:09 server1 kernel: [ 4.467074] pci 0000:00:01.0: PCI bridge to [bus 01-01] Oct 27 16:16:09 server1 kernel: [ 4.467184] pci 0000:00:01.0: bridge window [io 0xf000-0xffff] Oct 27 16:16:09 server1 kernel: [ 4.467300] pci 0000:00:01.0: bridge window [mem 0xdc000000-0xdcffffff] Oct 27 16:16:09 server1 kernel: [ 4.467424] pci 0000:00:03.0: PCI bridge to [bus 08-08] Oct 27 16:16:09 server1 kernel: [ 4.467552] pci 0000:00:11.0: PCI bridge to [bus 09-09] Oct 27 16:16:09 server1 kernel: [ 4.467683] pci 0000:00:1c.0: PCI bridge to [bus 0a-0a] Oct 27 16:16:09 server1 kernel: [ 4.467818] pci 0000:02:00.1: BAR 6: assigned [mem 0xd9000000-0xd903ffff pref] Oct 27 16:16:09 server1 kernel: [ 4.468038] pci 0000:00:1c.4: PCI bridge to [bus 02-02] Oct 27 16:16:09 server1 kernel: [ 4.468152] pci 0000:00:1c.4: bridge window [mem 0xdd000000-0xdd7fffff] Oct 27 16:16:09 server1 kernel: [ 4.468268] pci 0000:00:1c.4: bridge window [mem 0xd9000000-0xd90fffff 64bit pref] Oct 27 16:16:09 server1 kernel: [ 4.468417] pci 0000:05:00.0: PCI bridge to [bus 06-06] Oct 27 16:16:09 server1 kernel: [ 4.468667] pci 0000:05:00.0: bridge window [mem 0xdd800000-0xde7fffff] Oct 27 16:16:09 server1 kernel: [ 4.468871] pci 0000:05:00.0: bridge window [mem 0xd8000000-0xd8ffffff 64bit pref] Oct 27 16:16:09 server1 kernel: [ 4.469200] pci 0000:04:00.0: PCI bridge to [bus 05-06] Oct 27 16:16:09 server1 kernel: [ 4.469450] pci 0000:04:00.0: bridge window [mem 0xdd800000-0xde7fffff] Oct 27 16:16:09 server1 kernel: [ 4.469654] pci 0000:04:00.0: bridge window [mem 0xd8000000-0xd8ffffff 64bit pref] Oct 27 16:16:09 server1 kernel: [ 4.469982] pci 0000:04:01.0: PCI bridge to [bus 07-07] Oct 27 16:16:09 server1 kernel: [ 4.470232] pci 0000:04:01.0: bridge window [mem 0xdef00000-0xdeffffff] Oct 27 16:16:09 server1 kernel: [ 4.470692] pci 0000:03:00.0: PCI bridge to [bus 04-07] Oct 27 16:16:09 server1 kernel: [ 4.470928] pci 0000:03:00.0: bridge window [mem 0xdd800000-0xdeffffff] Oct 27 16:16:09 server1 kernel: [ 4.471123] pci 0000:03:00.0: bridge window [mem 0xd8000000-0xd8ffffff 64bit pref] Oct 27 16:16:09 server1 kernel: [ 4.471496] pci 0000:00:1c.7: PCI bridge to [bus 03-07] Oct 27 16:16:09 server1 kernel: [ 4.471612] pci 0000:00:1c.7: bridge window [mem 0xdd800000-0xdeffffff] Oct 27 16:16:09 server1 kernel: [ 4.471726] pci 0000:00:1c.7: bridge window [mem 0xd8000000-0xd8ffffff 64bit pref] Oct 27 16:16:09 server1 kernel: [ 4.471871] pci 0000:00:1e.0: PCI bridge to [bus 0b-0b] Oct 27 16:16:09 server1 kernel: [ 4.472012] xen: registering gsi 53 triggering 0 polarity 1 Oct 27 16:16:09 server1 kernel: [ 4.472031] xen: --> pirq=53 -> irq=53 (gsi=53) Oct 27 16:16:09 server1 kernel: [ 4.472054] pci 0000:00:01.0: PCI INT A -> GSI 53 (level, low) -> IRQ 53 Oct 27 16:16:09 server1 kernel: [ 4.472171] pci 0000:00:01.0: setting latency timer to 64 Oct 27 16:16:09 server1 kernel: [ 4.472183] xen: registering gsi 53 triggering 0 polarity 1 Oct 27 16:16:09 server1 kernel: [ 4.472187] xen_map_pirq_gsi: returning irq 53 for gsi 53 Oct 27 16:16:09 server1 kernel: [ 4.472293] xen: --> pirq=53 -> irq=53 (gsi=53) Oct 27 16:16:09 server1 kernel: [ 4.472296] Already setup the GSI :53 Oct 27 16:16:09 server1 kernel: [ 4.472399] pci 0000:00:03.0: PCI INT A -> GSI 53 (level, low) -> IRQ 53 Oct 27 16:16:09 server1 kernel: [ 4.472514] pci 0000:00:03.0: setting latency timer to 64 Oct 27 16:16:09 server1 kernel: [ 4.472526] xen: registering gsi 16 triggering 0 polarity 1 Oct 27 16:16:09 server1 kernel: [ 4.472533] xen: --> pirq=16 -> irq=16 (gsi=16) Oct 27 16:16:09 server1 kernel: [ 4.472556] pci 0000:00:11.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 Oct 27 16:16:09 server1 kernel: [ 4.472672] pci 0000:00:11.0: setting latency timer to 64 Oct 27 16:16:09 server1 kernel: [ 4.472689] pci 0000:00:1c.0: setting latency timer to 64 Oct 27 16:16:09 server1 kernel: [ 4.472701] xen: registering gsi 16 triggering 0 polarity 1 Oct 27 16:16:09 server1 kernel: [ 4.472704] xen_map_pirq_gsi: returning irq 16 for gsi 16 Oct 27 16:16:09 server1 kernel: [ 4.472810] xen: --> pirq=16 -> irq=16 (gsi=16) Oct 27 16:16:09 server1 kernel: [ 4.472818] Already setup the GSI :16 Oct 27 16:16:09 server1 kernel: [ 4.472922] pci 0000:00:1c.4: PCI INT A -> GSI 16 (level, low) -> IRQ 16 Oct 27 16:16:09 server1 kernel: [ 4.473038] pci 0000:00:1c.4: setting latency timer to 64 Oct 27 16:16:09 server1 kernel: [ 4.473050] xen: registering gsi 19 triggering 0 polarity 1 Oct 27 16:16:09 server1 kernel: [ 4.473057] xen: --> pirq=19 -> irq=19 (gsi=19) Oct 27 16:16:09 server1 kernel: [ 4.473080] pci 0000:00:1c.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 Oct 27 16:16:09 server1 kernel: [ 4.473195] pci 0000:00:1c.7: setting latency timer to 64 Oct 27 16:16:09 server1 kernel: [ 4.473322] pci 0000:03:00.0: setting latency timer to 64 Oct 27 16:16:09 server1 kernel: [ 4.473500] pci 0000:04:00.0: setting latency timer to 64 Oct 27 16:16:09 server1 kernel: [ 4.473685] pci 0000:05:00.0: setting latency timer to 64 Oct 27 16:16:09 server1 kernel: [ 4.473869] pci 0000:04:01.0: setting latency timer to 64 Oct 27 16:16:09 server1 kernel: [ 4.473917] pci 0000:00:1e.0: setting latency timer to 64 Oct 27 16:16:09 server1 kernel: [ 4.473924] pci_bus 0000:00: resource 4 [io 0x0000-0x03af] Oct 27 16:16:09 server1 kernel: [ 4.473928] pci_bus 0000:00: resource 5 [io 0x03e0-0x0cf7] Oct 27 16:16:09 server1 kernel: [ 4.473931] pci_bus 0000:00: resource 6 [io 0x03b0-0x03df] Oct 27 16:16:09 server1 kernel: [ 4.473934] pci_bus 0000:00: resource 7 [io 0x0d00-0x1fff] Oct 27 16:16:09 server1 kernel: [ 4.473937] pci_bus 0000:00: resource 8 [io 0x2000-0xffff] Oct 27 16:16:09 server1 kernel: [ 4.473940] pci_bus 0000:00: resource 9 [mem 0x000a0000-0x000bffff] Oct 27 16:16:09 server1 kernel: [ 4.473943] pci_bus 0000:00: resource 10 [mem 0xd0000000-0xfbffffff] Oct 27 16:16:09 server1 kernel: [ 4.473946] pci_bus 0000:00: resource 11 [mem 0xfed40000-0xfed44fff] Oct 27 16:16:09 server1 kernel: [ 4.473949] pci_bus 0000:01: resource 0 [io 0xf000-0xffff] Oct 27 16:16:09 server1 kernel: [ 4.473952] pci_bus 0000:01: resource 1 [mem 0xdc000000-0xdcffffff] Oct 27 16:16:09 server1 kernel: [ 4.473956] pci_bus 0000:02: resource 1 [mem 0xdd000000-0xdd7fffff] Oct 27 16:16:09 server1 kernel: [ 4.473959] pci_bus 0000:02: resource 2 [mem 0xd9000000-0xd90fffff 64bit pref] Oct 27 16:16:09 server1 kernel: [ 4.473963] pci_bus 0000:03: resource 1 [mem 0xdd800000-0xdeffffff] Oct 27 16:16:09 server1 kernel: [ 4.473966] pci_bus 0000:03: resource 2 [mem 0xd8000000-0xd8ffffff 64bit pref] Oct 27 16:16:09 server1 kernel: [ 4.473969] pci_bus 0000:04: resource 1 [mem 0xdd800000-0xdeffffff] Oct 27 16:16:09 server1 kernel: [ 4.473973] pci_bus 0000:04: resource 2 [mem 0xd8000000-0xd8ffffff 64bit pref] Oct 27 16:16:09 server1 kernel: [ 4.473976] pci_bus 0000:05: resource 1 [mem 0xdd800000-0xde7fffff] Oct 27 16:16:09 server1 kernel: [ 4.473979] pci_bus 0000:05: resource 2 [mem 0xd8000000-0xd8ffffff 64bit pref] Oct 27 16:16:09 server1 kernel: [ 4.473982] pci_bus 0000:06: resource 1 [mem 0xdd800000-0xde7fffff] Oct 27 16:16:09 server1 kernel: [ 4.473986] pci_bus 0000:06: resource 2 [mem 0xd8000000-0xd8ffffff 64bit pref] Oct 27 16:16:09 server1 kernel: [ 4.473989] pci_bus 0000:07: resource 1 [mem 0xdef00000-0xdeffffff] Oct 27 16:16:09 server1 kernel: [ 4.473992] pci_bus 0000:0b: resource 4 [io 0x0000-0x03af] Oct 27 16:16:09 server1 kernel: [ 4.473996] pci_bus 0000:0b: resource 5 [io 0x03e0-0x0cf7] Oct 27 16:16:09 server1 kernel: [ 4.473999] pci_bus 0000:0b: resource 6 [io 0x03b0-0x03df] Oct 27 16:16:09 server1 kernel: [ 4.474002] pci_bus 0000:0b: resource 7 [io 0x0d00-0x1fff] Oct 27 16:16:09 server1 kernel: [ 4.474004] pci_bus 0000:0b: resource 8 [io 0x2000-0xffff] Oct 27 16:16:09 server1 kernel: [ 4.474008] pci_bus 0000:0b: resource 9 [mem 0x000a0000-0x000bffff] Oct 27 16:16:09 server1 kernel: [ 4.474011] pci_bus 0000:0b: resource 10 [mem 0xd0000000-0xfbffffff] Oct 27 16:16:09 server1 kernel: [ 4.474014] pci_bus 0000:0b: resource 11 [mem 0xfed40000-0xfed44fff] Oct 27 16:16:09 server1 kernel: [ 4.474055] NET: Registered protocol family 2 Oct 27 16:16:09 server1 kernel: [ 4.486868] IP route cache hash table entries: 524288 (order: 10, 4194304 bytes) Oct 27 16:16:09 server1 kernel: [ 4.490612] TCP established hash table entries: 524288 (order: 11, 8388608 bytes) Oct 27 16:16:09 server1 kernel: [ 4.492446] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes) Oct 27 16:16:09 server1 kernel: [ 4.492713] TCP: Hash tables configured (established 524288 bind 65536) Oct 27 16:16:09 server1 kernel: [ 4.492826] TCP reno registered Oct 27 16:16:09 server1 kernel: [ 4.493029] UDP hash table entries: 8192 (order: 6, 262144 bytes) Oct 27 16:16:09 server1 kernel: [ 4.493301] UDP-Lite hash table entries: 8192 (order: 6, 262144 bytes) Oct 27 16:16:09 server1 kernel: [ 4.493546] NET: Registered protocol family 1 Oct 27 16:16:09 server1 kernel: [ 4.493708] xen: registering gsi 23 triggering 0 polarity 1 Oct 27 16:16:09 server1 kernel: [ 4.493723] xen: --> pirq=23 -> irq=23 (gsi=23) Oct 27 16:16:09 server1 kernel: [ 4.493753] pci 0000:00:1a.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23 Oct 27 16:16:09 server1 kernel: [ 4.508791] pci 0000:00:1a.0: PCI INT A disabled Oct 27 16:16:09 server1 kernel: [ 4.508922] xen: registering gsi 22 triggering 0 polarity 1 Oct 27 16:16:09 server1 kernel: [ 4.508931] xen: --> pirq=22 -> irq=22 (gsi=22) Oct 27 16:16:09 server1 kernel: [ 4.508955] pci 0000:00:1d.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22 Oct 27 16:16:09 server1 kernel: [ 4.509121] pci 0000:00:1d.0: PCI INT A disabled Oct 27 16:16:09 server1 kernel: [ 4.509532] pci 0000:06:00.0: Boot video device Oct 27 16:16:09 server1 kernel: [ 4.509676] PCI: CLS 64 bytes, default 64 Oct 27 16:16:09 server1 kernel: [ 4.510188] audit: initializing netlink socket (disabled) Oct 27 16:16:09 server1 kernel: [ 4.510304] type=2000 audit(1414426562.463:1): initialized Oct 27 16:16:09 server1 kernel: [ 4.564853] HugeTLB registered 2 MB page size, pre-allocated 0 pages Oct 27 16:16:09 server1 kernel: [ 4.566735] VFS: Disk quotas dquot_6.5.2 Oct 27 16:16:09 server1 kernel: [ 4.566903] Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 27 16:16:09 server1 kernel: [ 4.567569] fuse init (API version 7.17) Oct 27 16:16:09 server1 kernel: [ 4.567816] msgmni has been set to 29547 Oct 27 16:16:09 server1 kernel: [ 4.568478] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253) Oct 27 16:16:09 server1 kernel: [ 4.568657] io scheduler noop registered Oct 27 16:16:09 server1 kernel: [ 4.568762] io scheduler deadline registered Oct 27 16:16:09 server1 kernel: [ 4.568911] io scheduler cfq registered (default) Oct 27 16:16:09 server1 kernel: [ 4.569245] pcieport 0000:00:01.0: setting latency timer to 64 Oct 27 16:16:09 server1 kernel: [ 4.569522] pcieport 0000:00:03.0: setting latency timer to 64 Oct 27 16:16:09 server1 kernel: [ 4.569767] pcieport 0000:00:11.0: setting latency timer to 64 Oct 27 16:16:09 server1 kernel: [ 4.570071] pcieport 0000:00:1c.0: setting latency timer to 64 Oct 27 16:16:09 server1 kernel: [ 4.570321] pcieport 0000:00:1c.4: setting latency timer to 64 Oct 27 16:16:09 server1 kernel: [ 4.570570] pcieport 0000:00:1c.7: setting latency timer to 64 Oct 27 16:16:09 server1 kernel: [ 4.574763] pcieport 0000:00:01.0: Signaling PME through PCIe PME interrupt Oct 27 16:16:09 server1 kernel: [ 4.574874] pci 0000:01:00.0: Signaling PME through PCIe PME interrupt Oct 27 16:16:09 server1 kernel: [ 4.574990] pcie_pme 0000:00:01.0:pcie01: service driver pcie_pme loaded Oct 27 16:16:09 server1 kernel: [ 4.575038] pcieport 0000:00:03.0: Signaling PME through PCIe PME interrupt Oct 27 16:16:09 server1 kernel: [ 4.575153] pcie_pme 0000:00:03.0:pcie01: service driver pcie_pme loaded Oct 27 16:16:09 server1 kernel: [ 4.575197] pcieport 0000:00:11.0: Signaling PME through PCIe PME interrupt Oct 27 16:16:09 server1 kernel: [ 4.575313] pcie_pme 0000:00:11.0:pcie01: service driver pcie_pme loaded Oct 27 16:16:09 server1 kernel: [ 4.575354] pcieport 0000:00:1c.0: Signaling PME through PCIe PME interrupt Oct 27 16:16:09 server1 kernel: [ 4.575470] pcie_pme 0000:00:1c.0:pcie01: service driver pcie_pme loaded Oct 27 16:16:09 server1 kernel: [ 4.575511] pcieport 0000:00:1c.4: Signaling PME through PCIe PME interrupt Oct 27 16:16:09 server1 kernel: [ 4.575621] pci 0000:02:00.0: Signaling PME through PCIe PME interrupt Oct 27 16:16:09 server1 kernel: [ 4.575731] pci 0000:02:00.1: Signaling PME through PCIe PME interrupt Oct 27 16:16:09 server1 kernel: [ 4.575846] pcie_pme 0000:00:1c.4:pcie01: service driver pcie_pme loaded Oct 27 16:16:09 server1 kernel: [ 4.575887] pcieport 0000:00:1c.7: Signaling PME through PCIe PME interrupt Oct 27 16:16:09 server1 kernel: [ 4.575998] pcieport 0000:03:00.0: Signaling PME through PCIe PME interrupt Oct 27 16:16:09 server1 kernel: [ 4.576108] pcieport 0000:04:00.0: Signaling PME through PCIe PME interrupt Oct 27 16:16:09 server1 kernel: [ 4.576219] pci 0000:05:00.0: Signaling PME through PCIe PME interrupt Oct 27 16:16:09 server1 kernel: [ 4.576329] pci 0000:06:00.0: Signaling PME through PCIe PME interrupt Oct 27 16:16:09 server1 kernel: [ 4.576439] pcieport 0000:04:01.0: Signaling PME through PCIe PME interrupt Oct 27 16:16:09 server1 kernel: [ 4.576555] pcie_pme 0000:00:1c.7:pcie01: service driver pcie_pme loaded Oct 27 16:16:09 server1 kernel: [ 4.576582] pci_hotplug: PCI Hot Plug PCI Core version: 0.5 Oct 27 16:16:09 server1 kernel: [ 4.576711] pciehp: PCI Express Hot Plug Controller Driver version: 0.4 Oct 27 16:16:09 server1 kernel: [ 4.577004] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 Oct 27 16:16:09 server1 kernel: [ 4.577142] ACPI: Power Button [PWRF] Oct 27 16:16:09 server1 kernel: [ 4.580680] ERST: Error Record Serialization Table (ERST) support is initialized. Oct 27 16:16:09 server1 kernel: [ 4.581141] GHES: APEI firmware first mode is enabled by APEI bit and WHEA _OSC. Oct 27 16:16:09 server1 kernel: [ 4.581761] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled Oct 27 16:16:09 server1 kernel: [ 4.602664] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A Oct 27 16:16:09 server1 kernel: [ 4.669449] serial8250: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A Oct 27 16:16:09 server1 kernel: [ 4.792207] 00:05: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A Oct 27 16:16:09 server1 kernel: [ 4.857528] 00:06: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A Oct 27 16:16:09 server1 kernel: [ 4.905105] hpet_acpi_add: no address or irqs in _CRS Oct 27 16:16:09 server1 kernel: [ 4.905224] Linux agpgart interface v0.103 Oct 27 16:16:09 server1 kernel: [ 4.907104] brd: module loaded Oct 27 16:16:09 server1 kernel: [ 4.908128] loop: module loaded Oct 27 16:16:09 server1 kernel: [ 4.908450] ahci 0000:00:1f.2: version 3.0 Oct 27 16:16:09 server1 kernel: [ 4.908466] xen: registering gsi 20 triggering 0 polarity 1 Oct 27 16:16:09 server1 kernel: [ 4.908479] xen: --> pirq=20 -> irq=20 (gsi=20) Oct 27 16:16:09 server1 kernel: [ 4.908506] ahci 0000:00:1f.2: PCI INT A -> GSI 20 (level, low) -> IRQ 20 Oct 27 16:16:09 server1 kernel: [ 4.924796] ahci 0000:00:1f.2: AHCI 0001.0300 32 slots 6 ports 3 Gbps 0x1f impl RAID mode Oct 27 16:16:09 server1 kernel: [ 4.924935] ahci 0000:00:1f.2: flags: 64bit ncq sntf pm led clo pio slum part ems apst Oct 27 16:16:09 server1 kernel: [ 4.925076] ahci 0000:00:1f.2: setting latency timer to 64 Oct 27 16:16:09 server1 kernel: [ 4.957290] scsi0 : ahci Oct 27 16:16:09 server1 kernel: [ 4.957495] scsi1 : ahci Oct 27 16:16:09 server1 kernel: [ 4.957688] scsi2 : ahci Oct 27 16:16:09 server1 kernel: [ 4.957877] scsi3 : ahci Oct 27 16:16:09 server1 kernel: [ 4.958069] scsi4 : ahci Oct 27 16:16:09 server1 kernel: [ 4.958253] scsi5 : ahci Oct 27 16:16:09 server1 kernel: [ 4.958400] ata1: SATA max UDMA/133 abar m2048@0xdf0ff000 port 0xdf0ff100 irq 336 Oct 27 16:16:09 server1 kernel: [ 4.958536] ata2: SATA max UDMA/133 abar m2048@0xdf0ff000 port 0xdf0ff180 irq 336 Oct 27 16:16:09 server1 kernel: [ 4.958672] ata3: SATA max UDMA/133 abar m2048@0xdf0ff000 port 0xdf0ff200 irq 336 Oct 27 16:16:09 server1 kernel: [ 4.958807] ata4: SATA max UDMA/133 abar m2048@0xdf0ff000 port 0xdf0ff280 irq 336 Oct 27 16:16:09 server1 kernel: [ 4.958943] ata5: SATA max UDMA/133 abar m2048@0xdf0ff000 port 0xdf0ff300 irq 336 Oct 27 16:16:09 server1 kernel: [ 4.959078] ata6: DUMMY Oct 27 16:16:09 server1 kernel: [ 4.959720] Fixed MDIO Bus: probed Oct 27 16:16:09 server1 kernel: [ 4.959839] tun: Universal TUN/TAP device driver, 1.6 Oct 27 16:16:09 server1 kernel: [ 4.959945] tun: (C) 1999-2004 Max Krasnyansky Oct 27 16:16:09 server1 kernel: [ 4.960130] PPP generic driver version 2.4.2 Oct 27 16:16:09 server1 kernel: [ 4.960381] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Oct 27 16:16:09 server1 kernel: [ 4.960511] xen: registering gsi 23 triggering 0 polarity 1 Oct 27 16:16:09 server1 kernel: [ 4.960516] xen_map_pirq_gsi: returning irq 23 for gsi 23 Oct 27 16:16:09 server1 kernel: [ 4.960622] xen: --> pirq=23 -> irq=23 (gsi=23) Oct 27 16:16:09 server1 kernel: [ 4.960625] Already setup the GSI :23 Oct 27 16:16:09 server1 kernel: [ 4.960729] ehci_hcd 0000:00:1a.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23 Oct 27 16:16:09 server1 kernel: [ 4.960877] ehci_hcd 0000:00:1a.0: setting latency timer to 64 Oct 27 16:16:09 server1 kernel: [ 4.960884] ehci_hcd 0000:00:1a.0: EHCI Host Controller Oct 27 16:16:09 server1 kernel: [ 4.961055] ehci_hcd 0000:00:1a.0: new USB bus registered, assigned bus number 1 Oct 27 16:16:09 server1 kernel: [ 4.961253] ehci_hcd 0000:00:1a.0: debug port 2 Oct 27 16:16:09 server1 kernel: [ 4.965241] ehci_hcd 0000:00:1a.0: cache line size of 64 is not supported Oct 27 16:16:09 server1 kernel: [ 4.965296] ehci_hcd 0000:00:1a.0: irq 23, io mem 0xdf0fd000 Oct 27 16:16:09 server1 kernel: [ 4.980764] ehci_hcd 0000:00:1a.0: USB 2.0 started, EHCI 1.00 Oct 27 16:16:09 server1 kernel: [ 4.981037] hub 1-0:1.0: USB hub found Oct 27 16:16:09 server1 kernel: [ 4.981144] hub 1-0:1.0: 2 ports detected Oct 27 16:16:09 server1 kernel: [ 4.981339] xen: registering gsi 22 triggering 0 polarity 1 Oct 27 16:16:09 server1 kernel: [ 4.981344] xen_map_pirq_gsi: returning irq 22 for gsi 22 Oct 27 16:16:09 server1 kernel: [ 4.981450] xen: --> pirq=22 -> irq=22 (gsi=22) Oct 27 16:16:09 server1 kernel: [ 4.981453] Already setup the GSI :22 Oct 27 16:16:09 server1 kernel: [ 4.981557] ehci_hcd 0000:00:1d.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22 Oct 27 16:16:09 server1 kernel: [ 4.981691] ehci_hcd 0000:00:1d.0: setting latency timer to 64 Oct 27 16:16:09 server1 kernel: [ 4.981696] ehci_hcd 0000:00:1d.0: EHCI Host Controller Oct 27 16:16:09 server1 kernel: [ 4.981870] ehci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 Oct 27 16:16:09 server1 kernel: [ 4.982057] ehci_hcd 0000:00:1d.0: debug port 2 Oct 27 16:16:09 server1 kernel: [ 4.986054] ehci_hcd 0000:00:1d.0: cache line size of 64 is not supported Oct 27 16:16:09 server1 kernel: [ 4.986110] ehci_hcd 0000:00:1d.0: irq 22, io mem 0xdf0fe000 Oct 27 16:16:09 server1 kernel: [ 5.000764] ehci_hcd 0000:00:1d.0: USB 2.0 started, EHCI 1.00 Oct 27 16:16:09 server1 kernel: [ 5.001016] hub 2-0:1.0: USB hub found Oct 27 16:16:09 server1 kernel: [ 5.001125] hub 2-0:1.0: 2 ports detected Oct 27 16:16:09 server1 kernel: [ 5.001323] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver Oct 27 16:16:09 server1 kernel: [ 5.001451] uhci_hcd: USB Universal Host Controller Interface driver Oct 27 16:16:09 server1 kernel: [ 5.001621] usbcore: registered new interface driver libusual Oct 27 16:16:09 server1 kernel: [ 5.001768] i8042: PNP: No PS/2 controller found. Probing ports directly. Oct 27 16:16:09 server1 bluetoothd[1036]: Failed to init gatt_example plugin Oct 27 16:16:09 server1 avahi-daemon[1062]: Found user 'avahi' (UID 105) and group 'avahi' (GID 114). Oct 27 16:16:09 server1 avahi-daemon[1062]: Successfully dropped root privileges. Oct 27 16:16:09 server1 avahi-daemon[1062]: avahi-daemon 0.6.30 starting up. Oct 27 16:16:09 server1 avahi-daemon[1062]: Successfully called chroot(). Oct 27 16:16:09 server1 avahi-daemon[1062]: Successfully dropped remaining capabilities. Oct 27 16:16:09 server1 avahi-daemon[1062]: Loading service file /services/udisks.service. Oct 27 16:16:09 server1 kernel: [ 5.002763] i8042: No controller found Oct 27 16:16:09 server1 kernel: [ 5.002972] mousedev: PS/2 mouse device common for all mice Oct 27 16:16:09 server1 kernel: [ 5.003220] rtc_cmos 00:04: RTC can wake from S4 Oct 27 16:16:09 server1 kernel: [ 5.003483] rtc_cmos 00:04: rtc core: registered rtc_cmos as rtc0 Oct 27 16:16:09 server1 kernel: [ 5.003660] rtc0: alarms up to one day, y3k, 242 bytes nvram Oct 27 16:16:09 server1 kernel: [ 5.003853] device-mapper: uevent: version 1.0.3 Oct 27 16:16:09 server1 kernel: [ 5.004044] device-mapper: ioctl: 4.22.0-ioctl (2011-10-19) initialised: dm-devel@redhat.com Oct 27 16:16:09 server1 kernel: [ 5.004186] EFI Variables Facility v0.08 2004-May-17 Oct 27 16:16:09 server1 kernel: [ 5.004559] TCP cubic registered Oct 27 16:16:09 server1 kernel: [ 5.004769] NET: Registered protocol family 10 Oct 27 16:16:09 server1 kernel: [ 5.005493] NET: Registered protocol family 17 Oct 27 16:16:09 server1 kernel: [ 5.005615] Registering the dns_resolver key type Oct 27 16:16:09 server1 kernel: [ 5.005883] PM: Hibernation image not present or could not be loaded. Oct 27 16:16:09 server1 kernel: [ 5.005896] registered taskstats version 1 Oct 27 16:16:09 server1 kernel: [ 5.023377] Magic number: 2:471:288 Oct 27 16:16:09 server1 kernel: [ 5.023497] tty tty21: hash matches Oct 27 16:16:09 server1 kernel: [ 5.023678] rtc_cmos 00:04: setting system clock to 2014-10-27 16:16:02 UTC (1414426562) Oct 27 16:16:09 server1 kernel: [ 5.023849] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found Oct 27 16:16:09 server1 kernel: [ 5.023957] EDD information not available. Oct 27 16:16:09 server1 kernel: [ 5.276772] ata1: SATA link down (SStatus 0 SControl 300) Oct 27 16:16:09 server1 kernel: [ 5.276911] ata4: SATA link down (SStatus 0 SControl 300) Oct 27 16:16:09 server1 kernel: [ 5.277036] ata3: SATA link down (SStatus 0 SControl 300) Oct 27 16:16:09 server1 kernel: [ 5.277164] ata5: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Oct 27 16:16:09 server1 kernel: [ 5.277291] ata2: SATA link down (SStatus 0 SControl 300) Oct 27 16:16:09 server1 kernel: [ 5.281728] ata5.00: ATAPI: TSSTcorp DVD+/-RW SN-208FB, D150, max UDMA/100 Oct 27 16:16:09 server1 kernel: [ 5.286293] ata5.00: configured for UDMA/100 Oct 27 16:16:09 server1 kernel: [ 5.291867] scsi 4:0:0:0: CD-ROM TSSTcorp DVD+-RW SN-208FB D150 PQ: 0 ANSI: 5 Oct 27 16:16:09 server1 kernel: [ 5.292769] usb 1-1: new high-speed USB device number 2 using ehci_hcd Oct 27 16:16:09 server1 kernel: [ 5.297276] sr0: scsi3-mmc drive: 24x/24x writer dvd-ram cd/rw xa/form2 cdda tray Oct 27 16:16:09 server1 kernel: [ 5.297413] cdrom: Uniform CD-ROM driver Revision: 3.20 Oct 27 16:16:09 server1 kernel: [ 5.297653] sr 4:0:0:0: Attached scsi CD-ROM sr0 Oct 27 16:16:09 server1 kernel: [ 5.297735] sr 4:0:0:0: Attached scsi generic sg0 type 5 Oct 27 16:16:09 server1 kernel: [ 5.298373] Freeing unused kernel memory: 920k freed Oct 27 16:16:09 server1 kernel: [ 5.298655] Write protecting the kernel read-only data: 12288k Oct 27 16:16:09 server1 kernel: [ 5.305980] Freeing unused kernel memory: 1608k freed Oct 27 16:16:09 server1 kernel: [ 5.306978] Freeing unused kernel memory: 1196k freed Oct 27 16:16:09 server1 kernel: [ 5.414656] megasas: 00.00.06.12-rc1 Wed. Oct. 5 17:00:00 PDT 2011 Oct 27 16:16:09 server1 kernel: [ 5.414795] megasas: 0x1000:0x005b:0x1028:0x1f38: bus 1:slot 0:func 0 Oct 27 16:16:09 server1 kernel: [ 5.414987] xen: registering gsi 34 triggering 0 polarity 1 Oct 27 16:16:09 server1 kernel: [ 5.415002] xen: --> pirq=34 -> irq=34 (gsi=34) Oct 27 16:16:09 server1 kernel: [ 5.415030] megaraid_sas 0000:01:00.0: PCI INT A -> GSI 34 (level, low) -> IRQ 34 Oct 27 16:16:09 server1 kernel: [ 5.415179] megaraid_sas 0000:01:00.0: setting latency timer to 64 Oct 27 16:16:09 server1 kernel: [ 5.416052] megasas: FW now in Ready state Oct 27 16:16:09 server1 kernel: [ 5.425487] hub 1-1:1.0: USB hub found Oct 27 16:16:09 server1 kernel: [ 5.425695] hub 1-1:1.0: 6 ports detected Oct 27 16:16:09 server1 kernel: [ 5.440801] megasas:IOC Init cmd success Oct 27 16:16:09 server1 kernel: [ 5.462031] tg3.c:v3.121 (November 2, 2011) Oct 27 16:16:09 server1 kernel: [ 5.462158] xen: registering gsi 16 triggering 0 polarity 1 Oct 27 16:16:09 server1 kernel: [ 5.462166] xen_map_pirq_gsi: returning irq 16 for gsi 16 Oct 27 16:16:09 server1 kernel: [ 5.462272] xen: --> pirq=16 -> irq=16 (gsi=16) Oct 27 16:16:09 server1 kernel: [ 5.462276] Already setup the GSI :16 Oct 27 16:16:09 server1 kernel: [ 5.462383] tg3 0000:02:00.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 Oct 27 16:16:09 server1 kernel: [ 5.462508] tg3 0000:02:00.0: setting latency timer to 64 Oct 27 16:16:09 server1 kernel: [ 5.468850] megasas: INIT adapter done Oct 27 16:16:09 server1 kernel: [ 5.474775] tg3 0000:02:00.0: eth0: Tigon3 [partno(BCM95720) rev 5720000] (PCI Express) MAC address c8:1f:66:c0:0f:8c Oct 27 16:16:09 server1 kernel: [ 5.474923] tg3 0000:02:00.0: eth0: attached PHY is 5720C (10/100/1000Base-T Ethernet) (WireSpeed[1], EEE[1]) Oct 27 16:16:09 server1 kernel: [ 5.475074] tg3 0000:02:00.0: eth0: RXcsums[1] LinkChgREG[0] MIirq[0] ASF[1] TSOcap[1] Oct 27 16:16:09 server1 kernel: [ 5.475216] tg3 0000:02:00.0: eth0: dma_rwctrl[00000001] dma_mask[64-bit] Oct 27 16:16:09 server1 kernel: [ 5.475465] xen: registering gsi 17 triggering 0 polarity 1 Oct 27 16:16:09 server1 kernel: [ 5.475479] xen: --> pirq=17 -> irq=17 (gsi=17) Oct 27 16:16:09 server1 kernel: [ 5.475506] tg3 0000:02:00.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 Oct 27 16:16:09 server1 kernel: [ 5.475626] tg3 0000:02:00.1: setting latency timer to 64 Oct 27 16:16:09 server1 kernel: [ 5.500329] tg3 0000:02:00.1: eth1: Tigon3 [partno(BCM95720) rev 5720000] (PCI Express) MAC address c8:1f:66:c0:0f:8d Oct 27 16:16:09 server1 kernel: [ 5.500480] tg3 0000:02:00.1: eth1: attached PHY is 5720C (10/100/1000Base-T Ethernet) (WireSpeed[1], EEE[1]) Oct 27 16:16:09 server1 kernel: [ 5.500630] tg3 0000:02:00.1: eth1: RXcsums[1] LinkChgREG[0] MIirq[0] ASF[1] TSOcap[1] Oct 27 16:16:09 server1 kernel: [ 5.512385] tg3 0000:02:00.1: eth1: dma_rwctrl[00000001] dma_mask[64-bit] Oct 27 16:16:09 server1 kernel: [ 5.536795] usb 2-1: new high-speed USB device number 2 using ehci_hcd Oct 27 16:16:09 server1 kernel: [ 5.540961] scsi6 : LSI SAS based MegaRAID driver Oct 27 16:16:09 server1 kernel: [ 5.541677] scsi 6:0:0:0: Direct-Access DELL PERC H710 3.13 PQ: 0 ANSI: 5 Oct 27 16:16:09 server1 kernel: [ 5.557284] scsi 6:2:0:0: Direct-Access DELL PERC H710 3.13 PQ: 0 ANSI: 5 Oct 27 16:16:09 server1 kernel: [ 5.571246] sd 6:2:0:0: [sda] 2341994496 512-byte logical blocks: (1.19 TB/1.08 TiB) Oct 27 16:16:09 server1 kernel: [ 5.571494] sd 6:2:0:0: [sda] Write Protect is off Oct 27 16:16:09 server1 kernel: [ 5.571601] sd 6:2:0:0: [sda] Mode Sense: 1f 00 00 08 Oct 27 16:16:09 server1 kernel: [ 5.571650] sd 6:2:0:0: Attached scsi generic sg1 type 0 Oct 27 16:16:09 server1 kernel: [ 5.571781] sd 6:2:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Oct 27 16:16:09 server1 kernel: [ 5.580427] sda: sda1 sda2 < sda5 > sda3 Oct 27 16:16:09 server1 kernel: [ 5.581891] sd 6:2:0:0: [sda] Attached SCSI disk Oct 27 16:16:09 server1 kernel: [ 5.669387] hub 2-1:1.0: USB hub found Oct 27 16:16:09 server1 kernel: [ 5.669597] hub 2-1:1.0: 8 ports detected Oct 27 16:16:09 server1 kernel: [ 5.730212] EXT4-fs (sda1): INFO: recovery required on readonly filesystem Oct 27 16:16:09 server1 kernel: [ 5.730326] EXT4-fs (sda1): write access will be enabled during recovery Oct 27 16:16:09 server1 kernel: [ 5.740846] usb 1-1.6: new high-speed USB device number 3 using ehci_hcd Oct 27 16:16:09 server1 kernel: [ 5.834683] hub 1-1.6:1.0: USB hub found Oct 27 16:16:09 server1 kernel: [ 5.835091] hub 1-1.6:1.0: 6 ports detected Oct 27 16:16:09 server1 kernel: [ 5.940841] usb 2-1.2: new full-speed USB device number 3 using ehci_hcd Oct 27 16:16:09 server1 kernel: [ 6.033629] hub 2-1.2:1.0: USB hub found Oct 27 16:16:09 server1 kernel: [ 6.033836] hub 2-1.2:1.0: 4 ports detected Oct 27 16:16:09 server1 kernel: [ 6.099580] EXT4-fs (sda1): orphan cleanup on readonly fs Oct 27 16:16:09 server1 kernel: [ 6.099700] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2361173 Oct 27 16:16:09 server1 kernel: [ 6.099785] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2361129 Oct 27 16:16:09 server1 kernel: [ 6.099801] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2361177 Oct 27 16:16:09 server1 kernel: [ 6.099816] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2361176 Oct 27 16:16:09 server1 kernel: [ 6.099829] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2361174 Oct 27 16:16:09 server1 kernel: [ 6.099843] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2361163 Oct 27 16:16:09 server1 kernel: [ 6.099858] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2361149 Oct 27 16:16:09 server1 kernel: [ 6.099873] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2361168 Oct 27 16:16:09 server1 kernel: [ 6.099886] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2361148 Oct 27 16:16:09 server1 kernel: [ 6.099900] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2359754 Oct 27 16:16:09 server1 kernel: [ 6.099914] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2361159 Oct 27 16:16:09 server1 kernel: [ 6.099928] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2359448 Oct 27 16:16:09 server1 kernel: [ 6.099942] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2361158 Oct 27 16:16:09 server1 kernel: [ 6.099967] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2360084 Oct 27 16:16:09 server1 kernel: [ 6.099982] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2359435 Oct 27 16:16:09 server1 kernel: [ 6.099996] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2361152 Oct 27 16:16:09 server1 kernel: [ 6.100010] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2361120 Oct 27 16:16:09 server1 kernel: [ 6.100024] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2360051 Oct 27 16:16:09 server1 kernel: [ 6.100039] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2361147 Oct 27 16:16:09 server1 kernel: [ 6.100052] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2360078 Oct 27 16:16:09 server1 kernel: [ 6.100067] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2359433 Oct 27 16:16:09 server1 kernel: [ 6.100080] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2360080 Oct 27 16:16:09 server1 kernel: [ 6.100094] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2360074 Oct 27 16:16:09 server1 kernel: [ 6.100108] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2360634 Oct 27 16:16:09 server1 kernel: [ 6.100122] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2361118 Oct 27 16:16:09 server1 kernel: [ 6.100136] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2360952 Oct 27 16:16:09 server1 kernel: [ 6.100175] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2360956 Oct 27 16:16:09 server1 kernel: [ 6.100189] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2360085 Oct 27 16:16:09 server1 kernel: [ 6.100202] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2360636 Oct 27 16:16:09 server1 kernel: [ 6.100217] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2360572 Oct 27 16:16:09 server1 kernel: [ 6.100231] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2360087 Oct 27 16:16:09 server1 kernel: [ 6.100245] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2360070 Oct 27 16:16:09 server1 kernel: [ 6.100259] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2360082 Oct 27 16:16:09 server1 kernel: [ 6.100273] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2360083 Oct 27 16:16:09 server1 kernel: [ 6.100295] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2360081 Oct 27 16:16:09 server1 kernel: [ 6.100309] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2360053 Oct 27 16:16:09 server1 kernel: [ 6.100323] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2359755 Oct 27 16:16:09 server1 kernel: [ 6.100390] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2359373 Oct 27 16:16:09 server1 kernel: [ 6.100405] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2359748 Oct 27 16:16:09 server1 kernel: [ 6.100419] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2359308 Oct 27 16:16:09 server1 kernel: [ 6.100433] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2359375 Oct 27 16:16:09 server1 kernel: [ 6.100446] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2359371 Oct 27 16:16:09 server1 kernel: [ 6.100460] EXT4-fs (sda1): ext4_orphan_cleanup: deleting unreferenced inode 2359374 Oct 27 16:16:09 server1 kernel: [ 6.100491] EXT4-fs (sda1): 43 orphan inodes deleted Oct 27 16:16:09 server1 kernel: [ 6.100597] EXT4-fs (sda1): recovery complete Oct 27 16:16:09 server1 kernel: [ 6.104838] usb 2-1.8: new low-speed USB device number 4 using ehci_hcd Oct 27 16:16:09 server1 kernel: [ 6.109321] EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: (null) Oct 27 16:16:09 server1 kernel: [ 6.282952] usb 1-1.6.1: new high-speed USB device number 4 using ehci_hcd Oct 27 16:16:09 server1 kernel: [ 6.456947] usb 2-1.2.1: new low-speed USB device number 5 using ehci_hcd Oct 27 16:16:09 server1 kernel: [ 10.303059] ADDRCONF(NETDEV_UP): eth0: link is not ready Oct 27 16:16:09 server1 kernel: [ 10.303068] ADDRCONF(NETDEV_UP): eth1: link is not ready Oct 27 16:16:09 server1 kernel: [ 10.319746] Adding 7811068k swap on /dev/sda5. Priority:-1 extents:1 across:7811068k Oct 27 16:16:09 server1 kernel: [ 10.347197] lp: driver loaded but no devices found Oct 27 16:16:09 server1 kernel: [ 10.407534] wmi: Mapper loaded Oct 27 16:16:09 server1 kernel: [ 10.414868] ACPI Error: No handler for Region [SYSI] (ffff8803c884b1b0) [IPMI] (20110623/evregion-373) Oct 27 16:16:09 server1 kernel: [ 10.414878] ACPI Error: Region IPMI (ID=7) has no handler (20110623/exfldio-292) Oct 27 16:16:09 server1 kernel: [ 10.414888] ACPI Error: Method parse/execution failed [\_SB_.PMI0._GHL] (Node ffff8803c884e050), AE_NOT_EXIST (20110623/psparse-536) Oct 27 16:16:09 server1 kernel: [ 10.414907] ACPI Error: Method parse/execution failed [\_SB_.PMI0._PMC] (Node ffff8803c884afa0), AE_NOT_EXIST (20110623/psparse-536) Oct 27 16:16:09 server1 kernel: [ 10.414923] ACPI Exception: AE_NOT_EXIST, Evaluating _PMC (20110623/power_meter-773) Oct 27 16:16:09 server1 kernel: [ 10.447088] usbhid 2-1.8:1.0: couldn't find an input interrupt endpoint Oct 27 16:16:09 server1 kernel: [ 10.457188] input: Avocent Keyboard/Mouse Function as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.6/1-1.6.1/1-1.6.1:1.0/input/input1 Oct 27 16:16:09 server1 kernel: [ 10.459226] generic-usb 0003:0624:0249.0001: input,hidraw0: USB HID v1.00 Keyboard [Avocent Keyboard/Mouse Function] on usb-0000:00:1a.0-1.6.1/input0 Oct 27 16:16:09 server1 kernel: [ 10.468986] input: Avocent Keyboard/Mouse Function as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.6/1-1.6.1/1-1.6.1:1.1/input/input2 Oct 27 16:16:09 server1 kernel: [ 10.469128] generic-usb 0003:0624:0249.0002: input,hidraw1: USB HID v1.00 Mouse [Avocent Keyboard/Mouse Function] on usb-0000:00:1a.0-1.6.1/input1 Oct 27 16:16:09 server1 kernel: [ 10.471014] input: Avocent Keyboard/Mouse Function as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.6/1-1.6.1/1-1.6.1:1.2/input/input3 Oct 27 16:16:09 server1 kernel: [ 10.471152] generic-usb 0003:0624:0249.0003: input,hidraw2: USB HID v1.00 Mouse [Avocent Keyboard/Mouse Function] on usb-0000:00:1a.0-1.6.1/input2 Oct 27 16:16:09 server1 kernel: [ 10.471258] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 Oct 27 16:16:09 server1 kernel: [ 10.518147] input: ATEN International Co. Ltd CL5708 V1.6.151 as /devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2/2-1.2.1/2-1.2.1:1.0/input/input4 Oct 27 16:16:09 server1 kernel: [ 10.518683] generic-usb 0003:0557:2263.0004: input,hidraw3: USB HID v1.00 Keyboard [ATEN International Co. Ltd CL5708 V1.6.151] on usb-0000:00:1d.0-1.2.1/input0 Oct 27 16:16:09 server1 kernel: [ 10.545156] input: ATEN International Co. Ltd CL5708 V1.6.151 as /devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2/2-1.2.1/2-1.2.1:1.1/input/input5 Oct 27 16:16:09 server1 kernel: [ 10.545431] generic-usb 0003:0557:2263.0005: input,hidraw4: USB HID v1.00 Device [ATEN International Co. Ltd CL5708 V1.6.151] on usb-0000:00:1d.0-1.2.1/input1 Oct 27 16:16:09 server1 kernel: [ 10.564894] input: ATEN International Co. Ltd CL5708 V1.6.151 as /devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2/2-1.2.1/2-1.2.1:1.2/input/input6 Oct 27 16:16:09 server1 kernel: [ 10.565217] generic-usb 0003:0557:2263.0006: input,hidraw5: USB HID v1.10 Mouse [ATEN International Co. Ltd CL5708 V1.6.151] on usb-0000:00:1d.0-1.2.1/input2 Oct 27 16:16:09 server1 kernel: [ 10.566879] Bridge firewalling registered Oct 27 16:16:09 server1 kernel: [ 10.574601] device eth1 entered promiscuous mode Oct 27 16:16:09 server1 kernel: [ 10.675497] dcdbas dcdbas: Dell Systems Management Base Driver (version 5.6.0-3.2) Oct 27 16:16:09 server1 kernel: [ 10.725972] input: ATEN International Co. Ltd CL5708 V1.6.151 as /devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2/2-1.2.1/2-1.2.1:1.3/input/input7 Oct 27 16:16:09 server1 kernel: [ 10.753412] generic-usb 0003:0557:2263.0007: input,hidraw6: USB HID v1.10 Mouse [ATEN International Co. Ltd CL5708 V1.6.151] on usb-0000:00:1d.0-1.2.1/input3 Oct 27 16:16:09 server1 kernel: [ 10.753479] usbcore: registered new interface driver usbhid Oct 27 16:16:09 server1 kernel: [ 10.753481] usbhid: USB HID core driver Oct 27 16:16:09 server1 kernel: [ 10.797606] type=1400 audit(1414406768.270:2): apparmor="STATUS" operation="profile_load" name="/sbin/dhclient" pid=687 comm="apparmor_parser" Oct 27 16:16:09 server1 kernel: [ 10.798054] type=1400 audit(1414406768.270:3): apparmor="STATUS" operation="profile_load" name="/usr/lib/NetworkManager/nm-dhcp-client.action" pid=687 comm="apparmor_parser" Oct 27 16:16:09 server1 kernel: [ 10.798310] type=1400 audit(1414406768.270:4): apparmor="STATUS" operation="profile_load" name="/usr/lib/connman/scripts/dhclient-script" pid=687 comm="apparmor_parser" Oct 27 16:16:09 server1 kernel: [ 11.694332] ADDRCONF(NETDEV_UP): eth1: link is not ready Oct 27 16:16:09 server1 kernel: [ 11.697359] ADDRCONF(NETDEV_UP): xenbr0: link is not ready Oct 27 16:16:09 server1 kernel: [ 11.784888] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro Oct 27 16:16:09 server1 kernel: [ 12.134118] ppdev: user-space parallel port driver Oct 27 16:16:09 server1 kernel: [ 12.145549] Bluetooth: Core ver 2.16 Oct 27 16:16:09 server1 kernel: [ 12.147285] NET: Registered protocol family 31 Oct 27 16:16:09 server1 kernel: [ 12.147290] Bluetooth: HCI device and connection manager initialized Oct 27 16:16:09 server1 kernel: [ 12.147293] Bluetooth: HCI socket layer initialized Oct 27 16:16:09 server1 kernel: [ 12.147296] Bluetooth: L2CAP socket layer initialized Oct 27 16:16:09 server1 kernel: [ 12.147656] Bluetooth: SCO socket layer initialized Oct 27 16:16:09 server1 kernel: [ 12.164858] Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Oct 27 16:16:09 server1 kernel: [ 12.164870] Bluetooth: BNEP filters: protocol multicast Oct 27 16:16:09 server1 kernel: [ 12.201566] type=1400 audit(1414406769.674:5): apparmor="STATUS" operation="profile_load" name="/usr/lib/cups/backend/cups-pdf" pid=1068 comm="apparmor_parser" Oct 27 16:16:09 server1 kernel: [ 12.202130] type=1400 audit(1414406769.674:6): apparmor="STATUS" operation="profile_load" name="/usr/sbin/cupsd" pid=1068 comm="apparmor_parser" Oct 27 16:16:09 server1 kernel: [ 12.214133] Bluetooth: RFCOMM TTY layer initialized Oct 27 16:16:09 server1 kernel: [ 12.214139] Bluetooth: RFCOMM socket layer initialized Oct 27 16:16:09 server1 kernel: [ 12.214142] Bluetooth: RFCOMM ver 1.11 Oct 27 16:16:10 server1 avahi-daemon[1062]: Network interface enumeration completed. Oct 27 16:16:10 server1 avahi-daemon[1062]: Registering HINFO record with values 'X86_64'/'LINUX'. Oct 27 16:16:10 server1 avahi-daemon[1062]: Server startup complete. Host name is server1.local. Local service cookie is 3973797089. Oct 27 16:16:10 server1 avahi-daemon[1062]: Service "server1" (/services/udisks.service) successfully established. Oct 27 16:16:10 server1 kernel: [ 12.942347] ADDRCONF(NETDEV_UP): eth0: link is not ready Oct 27 16:16:10 server1 dhclient: DHCPREQUEST of 192.168.2.49 on eth0 to 255.255.255.255 port 67 Oct 27 16:16:10 server1 kernel: [ 13.245968] init: udev-fallback-graphics main process (1112) terminated with status 1 Oct 27 16:16:12 server1 kernel: [ 14.562614] tg3 0000:02:00.0: eth0: Link is up at 100 Mbps, full duplex Oct 27 16:16:12 server1 kernel: [ 14.562619] tg3 0000:02:00.0: eth0: Flow control is on for TX and on for RX Oct 27 16:16:12 server1 kernel: [ 14.562622] tg3 0000:02:00.0: eth0: EEE is disabled Oct 27 16:16:12 server1 kernel: [ 14.563907] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Oct 27 16:16:13 server1 avahi-daemon[1062]: Joining mDNS multicast group on interface eth0.IPv6 with address fe80::ca1f:66ff:fec0:f8c. Oct 27 16:16:13 server1 avahi-daemon[1062]: New relevant interface eth0.IPv6 for mDNS. Oct 27 16:16:13 server1 avahi-daemon[1062]: Registering new address record for fe80::ca1f:66ff:fec0:f8c on eth0.*. Oct 27 16:16:13 server1 dhclient: DHCPREQUEST of 192.168.2.49 on eth0 to 255.255.255.255 port 67 Oct 27 16:16:13 server1 dhclient: DHCPACK of 192.168.2.49 from 192.168.2.1 Oct 27 16:16:13 server1 avahi-daemon[1062]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.2.49. Oct 27 16:16:13 server1 avahi-daemon[1062]: New relevant interface eth0.IPv4 for mDNS. Oct 27 16:16:13 server1 avahi-daemon[1062]: Registering new address record for 192.168.2.49 on eth0.IPv4. Oct 27 16:16:13 server1 dhclient: bound to 192.168.2.49 -- renewal in 35295 seconds. Oct 27 16:16:43 server1 avahi-daemon[1062]: Joining mDNS multicast group on interface xenbr0.IPv4 with address 10.0.0.1. Oct 27 16:16:43 server1 avahi-daemon[1062]: New relevant interface xenbr0.IPv4 for mDNS. Oct 27 16:16:43 server1 avahi-daemon[1062]: Registering new address record for 10.0.0.1 on xenbr0.IPv4. Oct 27 16:16:43 server1 kernel: [ 46.379933] init: failsafe main process (1003) killed by TERM signal Oct 27 16:16:43 server1 kernel: [ 46.472945] type=1400 audit(1414406803.946:7): apparmor="STATUS" operation="profile_replace" name="/sbin/dhclient" pid=2562 comm="apparmor_parser" Oct 27 16:16:43 server1 kernel: [ 46.473460] type=1400 audit(1414406803.946:8): apparmor="STATUS" operation="profile_replace" name="/usr/lib/NetworkManager/nm-dhcp-client.action" pid=2562 comm="apparmor_parser" Oct 27 16:16:43 server1 kernel: [ 46.473527] type=1400 audit(1414406803.946:9): apparmor="STATUS" operation="profile_load" name="/usr/lib/lightdm/lightdm/lightdm-guest-session-wrapper" pid=2561 comm="apparmor_parser" Oct 27 16:16:43 server1 kernel: [ 46.473721] type=1400 audit(1414406803.946:10): apparmor="STATUS" operation="profile_replace" name="/usr/lib/connman/scripts/dhclient-script" pid=2562 comm="apparmor_parser" Oct 27 16:16:43 server1 kernel: [ 46.473904] type=1400 audit(1414406803.946:11): apparmor="STATUS" operation="profile_load" name="/usr/lib/lightdm/lightdm/lightdm-guest-session-wrapper//chromium_browser" pid=2561 comm="apparmor_parser" Oct 27 16:16:43 server1 kernel: [ 46.478367] type=1400 audit(1414406803.950:12): apparmor="STATUS" operation="profile_load" name="/usr/lib/libvirt/virt-aa-helper" pid=2565 comm="apparmor_parser" Oct 27 16:16:43 server1 kernel: [ 46.480767] type=1400 audit(1414406803.954:13): apparmor="STATUS" operation="profile_load" name="/usr/lib/telepathy/mission-control-5" pid=2566 comm="apparmor_parser" Oct 27 16:16:43 server1 kernel: [ 46.481424] type=1400 audit(1414406803.954:14): apparmor="STATUS" operation="profile_load" name="/usr/lib/telepathy/telepathy-*" pid=2566 comm="apparmor_parser" Oct 27 16:16:43 server1 kernel: [ 46.481550] type=1400 audit(1414406803.954:15): apparmor="STATUS" operation="profile_replace" name="/usr/lib/cups/backend/cups-pdf" pid=2567 comm="apparmor_parser" Oct 27 16:16:43 server1 kernel: [ 46.482116] type=1400 audit(1414406803.954:16): apparmor="STATUS" operation="profile_replace" name="/usr/sbin/cupsd" pid=2567 comm="apparmor_parser" Oct 27 16:16:44 server1 kernel: [ 46.600583] OCFS2 Node Manager 1.5.0 Oct 27 16:16:44 server1 kernel: [ 46.603831] OCFS2 DLM 1.5.0 Oct 27 16:16:44 server1 kernel: [ 46.604999] ocfs2: Registered cluster interface o2cb Oct 27 16:16:44 server1 kernel: [ 46.628461] OCFS2 DLMFS 1.5.0 Oct 27 16:16:44 server1 kernel: [ 46.628574] OCFS2 User DLM kernel interface loaded Oct 27 16:16:44 server1 named[2667]: starting BIND 9.8.1-P1 -u bind Oct 27 16:16:44 server1 named[2667]: built with '--prefix=/usr' '--mandir=/usr/share/man' '--infodir=/usr/share/info' '--sysconfdir=/etc/bind' '--localstatedir=/var' '--enable-threads' '--enable-largefile' '--with-libtool' '--enable-shared' '--enable-static' '--with-openssl=/usr' '--with-gssapi=/usr' '--with-gnu-ld' '--with-geoip=/usr' '--enable-ipv6' 'CFLAGS=-fno-strict-aliasing -DDIG_SIGCHASE -O2' 'LDFLAGS=-Wl,-Bsymbolic-functions -Wl,-z,relro' 'CPPFLAGS=-D_FORTIFY_SOURCE=2' Oct 27 16:16:44 server1 named[2667]: adjusted limit on open files from 4096 to 1048576 Oct 27 16:16:44 server1 named[2667]: found 4 CPUs, using 4 worker threads Oct 27 16:16:44 server1 named[2667]: using up to 4096 sockets Oct 27 16:16:44 server1 named[2667]: loading configuration from '/etc/bind/named.conf' Oct 27 16:16:44 server1 named[2667]: reading built-in trusted keys from file '/etc/bind/bind.keys' Oct 27 16:16:44 server1 named[2667]: using default UDP/IPv4 port range: [1024, 65535] Oct 27 16:16:44 server1 named[2667]: using default UDP/IPv6 port range: [1024, 65535] Oct 27 16:16:44 server1 named[2667]: listening on IPv6 interfaces, port 53 Oct 27 16:16:44 server1 named[2667]: listening on IPv4 interface lo, 127.0.0.1#53 Oct 27 16:16:44 server1 named[2667]: listening on IPv4 interface eth0, 192.168.2.49#53 Oct 27 16:16:44 server1 named[2667]: listening on IPv4 interface xenbr0, 10.0.0.1#53 Oct 27 16:16:44 server1 named[2667]: generating session key for dynamic DNS Oct 27 16:16:44 server1 named[2667]: sizing zone task pool based on 5 zones Oct 27 16:16:44 server1 named[2667]: using built-in root key for view _default Oct 27 16:16:44 server1 named[2667]: set up managed keys zone for view _default, file 'managed-keys.bind' Oct 27 16:16:44 server1 named[2667]: Warning: 'empty-zones-enable/disable-empty-zone' not set: disabling RFC 1918 empty zones Oct 27 16:16:44 server1 named[2667]: automatic empty zone: 254.169.IN-ADDR.ARPA Oct 27 16:16:44 server1 named[2667]: automatic empty zone: 2.0.192.IN-ADDR.ARPA Oct 27 16:16:44 server1 named[2667]: automatic empty zone: 100.51.198.IN-ADDR.ARPA Oct 27 16:16:44 server1 named[2667]: automatic empty zone: 113.0.203.IN-ADDR.ARPA Oct 27 16:16:44 server1 named[2667]: automatic empty zone: 255.255.255.255.IN-ADDR.ARPA Oct 27 16:16:44 server1 named[2667]: automatic empty zone: 0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.IP6.ARPA Oct 27 16:16:44 server1 named[2667]: automatic empty zone: 1.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.IP6.ARPA Oct 27 16:16:44 server1 named[2667]: automatic empty zone: D.F.IP6.ARPA Oct 27 16:16:44 server1 named[2667]: automatic empty zone: 8.E.F.IP6.ARPA Oct 27 16:16:44 server1 named[2667]: automatic empty zone: 9.E.F.IP6.ARPA Oct 27 16:16:44 server1 named[2667]: automatic empty zone: A.E.F.IP6.ARPA Oct 27 16:16:44 server1 named[2667]: automatic empty zone: B.E.F.IP6.ARPA Oct 27 16:16:44 server1 named[2667]: automatic empty zone: 8.B.D.0.1.0.0.2.IP6.ARPA Oct 27 16:16:44 server1 named[2667]: command channel listening on 127.0.0.1#953 Oct 27 16:16:44 server1 named[2667]: command channel listening on ::1#953 Oct 27 16:16:44 server1 named[2667]: zone 0.in-addr.arpa/IN: loaded serial 1 Oct 27 16:16:44 server1 named[2667]: zone 127.in-addr.arpa/IN: loaded serial 1 Oct 27 16:16:44 server1 named[2667]: zone 255.in-addr.arpa/IN: loaded serial 1 Oct 27 16:16:44 server1 named[2667]: zone localhost/IN: loaded serial 2 Oct 27 16:16:44 server1 anacron[2692]: Anacron 2.3 started on 2014-10-27 Oct 27 16:16:44 server1 cron[2655]: (CRON) INFO (pidfile fd = 3) Oct 27 16:16:44 server1 named[2667]: managed-keys-zone ./IN: loaded serial 95 Oct 27 16:16:44 server1 named[2667]: running Oct 27 16:16:44 server1 acpid: starting up with proc fs Oct 27 16:16:44 server1 acpid: 1 rule loaded Oct 27 16:16:44 server1 acpid: waiting for events: event logging is off Oct 27 16:16:44 server1 cron[2696]: (CRON) STARTUP (fork ok) Oct 27 16:16:44 server1 cron[2696]: (CRON) INFO (Running @reboot jobs) Oct 27 16:16:44 server1 anacron[2692]: Normal exit (0 jobs run) Oct 27 16:16:44 server1 acpid: client connected from 2758[0:0] Oct 27 16:16:44 server1 acpid: 1 client rule loaded Oct 27 16:16:44 server1 kernel: [ 47.019846] ip_tables: (C) 2000-2006 Netfilter Core Team Oct 27 16:16:44 server1 kernel: [ 47.099737] nf_conntrack version 0.5.0 (16384 buckets, 65536 max) Oct 27 16:16:44 server1 corosync[2815]: [MAIN ] Corosync Cluster Engine ('1.4.2'): started and ready to provide service. Oct 27 16:16:44 server1 corosync[2815]: [MAIN ] Corosync built-in features: nss Oct 27 16:16:44 server1 corosync[2815]: [MAIN ] Successfully read main configuration file '/etc/corosync/corosync.conf'. Oct 27 16:16:44 server1 corosync[2815]: [TOTEM ] Initializing transport (UDP/IP Multicast). Oct 27 16:16:44 server1 corosync[2815]: [TOTEM ] Initializing transmit/receive security: libtomcrypt SOBER128/SHA1HMAC (mode 0). Oct 27 16:16:44 server1 avahi-daemon[1062]: Joining mDNS multicast group on interface virbr0.IPv4 with address 192.168.122.1. Oct 27 16:16:44 server1 avahi-daemon[1062]: New relevant interface virbr0.IPv4 for mDNS. Oct 27 16:16:44 server1 avahi-daemon[1062]: Registering new address record for 192.168.122.1 on virbr0.IPv4. Oct 27 16:16:44 server1 kernel: [ 47.154704] ADDRCONF(NETDEV_UP): virbr0: link is not ready Oct 27 16:16:44 server1 dnsmasq[2836]: started, version 2.59 cachesize 150 Oct 27 16:16:44 server1 dnsmasq[2836]: compile time options: IPv6 GNU-getopt DBus i18n DHCP TFTP conntrack IDN Oct 27 16:16:44 server1 dnsmasq-dhcp[2836]: DHCP, IP range 192.168.122.2 -- 192.168.122.254, lease time 1h Oct 27 16:16:44 server1 dnsmasq[2836]: reading /etc/resolv.conf Oct 27 16:16:44 server1 dnsmasq[2836]: using nameserver 192.168.2.1#53 Oct 27 16:16:44 server1 dnsmasq[2836]: read /etc/hosts - 8 addresses Oct 27 16:16:44 server1 logd: [2839]: info: logd started with /etc/logd.cf. Oct 27 16:16:44 server1 openhpid: ERROR: (init.c, 76, OpenHPI is not configured. See openhpi.conf file.) Oct 27 16:16:44 server1 openhpid: ERROR: (openhpid.cpp, 270, There was an error initializing OpenHPI) Oct 27 16:16:44 server1 corosync[2815]: [TOTEM ] The network interface [10.0.0.1] is now up. Oct 27 16:16:44 server1 kernel: [ 47.251557] Event-channel device installed. Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: process_ais_conf: Reading configure Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: config_find_init: Local handle: 4730966301143465987 for logging Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: config_find_next: Processing additional logging options... Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: get_config_opt: Found 'off' for option: debug Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: get_config_opt: Found 'no' for option: to_logfile Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: get_config_opt: Found 'yes' for option: to_syslog Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: get_config_opt: Found 'daemon' for option: syslog_facility Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: config_find_init: Local handle: 7739444317642555396 for quorum Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: config_find_next: No additional configuration supplied for: quorum Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: get_config_opt: No default for option: provider Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: config_find_init: Local handle: 5650605097994944517 for service Oct 27 16:16:44 server1 stonith-ng: [2861]: info: Invoked: /usr/lib/heartbeat/stonithd Oct 27 16:16:44 server1 stonith-ng: [2861]: info: crm_log_init_worker: Changed active directory to /var/lib/heartbeat/cores/root Oct 27 16:16:44 server1 stonith-ng: [2861]: info: get_cluster_type: Cluster type is: 'openais' Oct 27 16:16:44 server1 stonith-ng: [2861]: notice: crm_cluster_connect: Connecting to cluster infrastructure: classic openais (with plugin) Oct 27 16:16:44 server1 stonith-ng: [2861]: info: init_ais_connection_classic: Creating connection to our Corosync plugin Oct 27 16:16:44 server1 cib: [2863]: info: crm_log_init_worker: Changed active directory to /var/lib/heartbeat/cores/hacluster Oct 27 16:16:44 server1 cib: [2863]: info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml (digest: /var/lib/heartbeat/crm/cib.xml.sig) Oct 27 16:16:44 server1 xenstored: Checking store ... Oct 27 16:16:44 server1 lrmd: [2864]: info: enabling coredumps Oct 27 16:16:44 server1 lrmd: [2864]: info: Started. Oct 27 16:16:44 server1 attrd: [2865]: info: Invoked: /usr/lib/heartbeat/attrd Oct 27 16:16:44 server1 attrd: [2865]: notice: crm_cluster_connect: Connecting to cluster infrastructure: classic openais (with plugin) Oct 27 16:16:44 server1 pengine: [2867]: info: Invoked: /usr/lib/heartbeat/pengine Oct 27 16:16:44 server1 xenstored: Checking store complete. Oct 27 16:16:44 server1 kernel: [ 47.331150] XENBUS: Unable to read cpu state Oct 27 16:16:44 server1 kernel: [ 47.331335] XENBUS: Unable to read cpu state Oct 27 16:16:44 server1 kernel: [ 47.331496] XENBUS: Unable to read cpu state Oct 27 16:16:44 server1 kernel: [ 47.331651] XENBUS: Unable to read cpu state Oct 27 16:16:44 server1 crmd: [2868]: info: Invoked: /usr/lib/heartbeat/crmd Oct 27 16:16:44 server1 crmd: [2868]: info: crm_log_init_worker: Changed active directory to /var/lib/heartbeat/cores/hacluster Oct 27 16:16:44 server1 crmd: [2868]: info: main: CRM Hg Version: 9971ebba4494012a93c03b40a2c58ec0eb60f50c Oct 27 16:16:44 server1 crmd: [2868]: info: crmd_init: Starting crmd Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: config_find_next: Processing additional service options... Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: get_config_opt: Found '0' for option: ver Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: get_config_opt: Defaulting to 'pcmk' for option: clustername Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: get_config_opt: Defaulting to 'no' for option: use_logd Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: get_config_opt: Defaulting to 'no' for option: use_mgmtd Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: pcmk_startup: CRM: Initialized Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] Logging: Initialized pcmk_startup Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: pcmk_startup: Maximum core file size is: 18446744073709551615 Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: pcmk_startup: Service: 9 Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: pcmk_startup: Local hostname: server1 Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: pcmk_update_nodeid: Local node id: 16777226 Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: update_member: Creating entry for node 16777226 born on 0 Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: update_member: 0xc3f640 Node 16777226 now known as server1 (was: (null)) Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: update_member: Node server1 now has 1 quorum votes (was 0) Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: update_member: Node 16777226/server1 is now: member Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: spawn_child: Forked child 2861 for process stonith-ng Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: spawn_child: Forked child 2863 for process cib Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: spawn_child: Forked child 2864 for process lrmd Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: spawn_child: Forked child 2865 for process attrd Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: spawn_child: Forked child 2867 for process pengine Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: spawn_child: Forked child 2868 for process crmd Oct 27 16:16:44 server1 corosync[2815]: [SERV ] Service engine loaded: Pacemaker Cluster Manager 1.1.6 Oct 27 16:16:44 server1 corosync[2815]: [SERV ] Service engine loaded: corosync extended virtual synchrony service Oct 27 16:16:44 server1 corosync[2815]: [SERV ] Service engine loaded: corosync configuration service Oct 27 16:16:44 server1 corosync[2815]: [SERV ] Service engine loaded: corosync cluster closed process group service v1.01 Oct 27 16:16:44 server1 corosync[2815]: [SERV ] Service engine loaded: corosync cluster config database access v1.01 Oct 27 16:16:44 server1 corosync[2815]: [SERV ] Service engine loaded: corosync profile loading service Oct 27 16:16:44 server1 corosync[2815]: [SERV ] Service engine loaded: corosync cluster quorum service v0.1 Oct 27 16:16:44 server1 corosync[2815]: [MAIN ] Compatibility mode set to whitetank. Using V1 and V2 of the synchronization engine. Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] notice: pcmk_peer_update: Transitional membership event on ring 2544: memb=0, new=0, lost=0 Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] notice: pcmk_peer_update: Stable membership event on ring 2544: memb=1, new=1, lost=0 Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: pcmk_peer_update: NEW: server1 16777226 Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: pcmk_peer_update: MEMB: server1 16777226 Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: update_member: Node server1 now has process list: 00000000000000000000000000111312 (1118994) Oct 27 16:16:44 server1 corosync[2815]: [TOTEM ] A processor joined or left the membership and a new membership was formed. Oct 27 16:16:44 server1 corosync[2815]: [CPG ] chosen downlist: sender r(0) ip(10.0.0.1) ; members(old:0 left:0) Oct 27 16:16:44 server1 corosync[2815]: [MAIN ] Completed service synchronization, ready to provide service. Oct 27 16:16:44 server1 cib: [2863]: info: validate_with_relaxng: Creating RNG parser context Oct 27 16:16:44 server1 cib: [2863]: info: startCib: CIB Initialization completed successfully Oct 27 16:16:44 server1 cib: [2863]: info: get_cluster_type: Cluster type is: 'openais' Oct 27 16:16:44 server1 cib: [2863]: notice: crm_cluster_connect: Connecting to cluster infrastructure: classic openais (with plugin) Oct 27 16:16:44 server1 cib: [2863]: info: init_ais_connection_classic: Creating connection to our Corosync plugin Oct 27 16:16:44 server1 stonith-ng: [2861]: info: init_ais_connection_classic: AIS connection established Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: pcmk_ipc: Recorded connection 0xc48e10 for stonith-ng/2861 Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: pcmk_ipc: Recorded connection 0xc4d170 for attrd/2865 Oct 27 16:16:44 server1 cib: [2863]: info: init_ais_connection_classic: AIS connection established Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: pcmk_ipc: Recorded connection 0xc51990 for cib/2863 Oct 27 16:16:44 server1 corosync[2815]: [pcmk ] info: pcmk_ipc: Sending membership update 2544 to cib Oct 27 16:16:44 server1 stonith-ng: [2861]: info: get_ais_nodeid: Server details: id=16777226 uname=server1 cname=pcmk Oct 27 16:16:44 server1 stonith-ng: [2861]: info: init_ais_connection_once: Connection to 'classic openais (with plugin)': established Oct 27 16:16:44 server1 stonith-ng: [2861]: info: crm_new_peer: Node server1 now has id: 16777226 Oct 27 16:16:44 server1 stonith-ng: [2861]: info: crm_new_peer: Node 16777226 is now known as server1 Oct 27 16:16:44 server1 stonith-ng: [2861]: info: main: Starting stonith-ng mainloop Oct 27 16:16:44 server1 attrd: [2865]: notice: main: Starting mainloop... Oct 27 16:16:44 server1 cib: [2863]: info: get_ais_nodeid: Server details: id=16777226 uname=server1 cname=pcmk Oct 27 16:16:44 server1 cib: [2863]: info: init_ais_connection_once: Connection to 'classic openais (with plugin)': established Oct 27 16:16:44 server1 cib: [2863]: info: crm_new_peer: Node server1 now has id: 16777226 Oct 27 16:16:44 server1 cib: [2863]: info: crm_new_peer: Node 16777226 is now known as server1 Oct 27 16:16:44 server1 cib: [2863]: info: cib_init: Starting cib mainloop Oct 27 16:16:44 server1 cib: [2863]: info: ais_dispatch_message: Membership 2544: quorum still lost Oct 27 16:16:44 server1 cib: [2863]: info: crm_update_peer: Node server1: id=16777226 state=member (new) addr=r(0) ip(10.0.0.1) (new) votes=1 (new) born=0 seen=2544 proc=00000000000000000000000000111312 (new) Oct 27 16:16:45 server1 kernel: [ 47.683333] Ebtables v2.0 registered Oct 27 16:16:45 server1 kernel: [ 47.709335] ip6_tables: (C) 2000-2006 Netfilter Core Team Oct 27 16:16:45 server1 dbus[1023]: [system] Activating service name='org.freedesktop.Accounts' (using servicehelper) Oct 27 16:16:45 server1 dbus[1023]: [system] Successfully activated service 'org.freedesktop.Accounts' Oct 27 16:16:45 server1 dbus[1023]: [system] Activating service name='org.freedesktop.PolicyKit1' (using servicehelper) Oct 27 16:16:45 server1 polkitd[3011]: started daemon version 0.104 using authority implementation `local' version `0.104' Oct 27 16:16:45 server1 dbus[1023]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Oct 27 16:16:45 server1 accounts-daemon[3007]: started daemon version 0.6.15 Oct 27 16:16:45 server1 dbus[1023]: [system] Activating service name='org.freedesktop.ConsoleKit' (using servicehelper) Oct 27 16:16:45 server1 dbus[1023]: [system] Successfully activated service 'org.freedesktop.ConsoleKit' Oct 27 16:16:45 server1 crmd: [2868]: info: do_cib_control: CIB connection established Oct 27 16:16:45 server1 crmd: [2868]: info: get_cluster_type: Cluster type is: 'openais' Oct 27 16:16:45 server1 crmd: [2868]: notice: crm_cluster_connect: Connecting to cluster infrastructure: classic openais (with plugin) Oct 27 16:16:45 server1 crmd: [2868]: info: init_ais_connection_classic: Creating connection to our Corosync plugin Oct 27 16:16:45 server1 crmd: [2868]: info: init_ais_connection_classic: AIS connection established Oct 27 16:16:45 server1 corosync[2815]: [pcmk ] info: pcmk_ipc: Recorded connection 0xc561c0 for crmd/2868 Oct 27 16:16:45 server1 corosync[2815]: [pcmk ] info: pcmk_ipc: Sending membership update 2544 to crmd Oct 27 16:16:45 server1 crmd: [2868]: info: get_ais_nodeid: Server details: id=16777226 uname=server1 cname=pcmk Oct 27 16:16:45 server1 crmd: [2868]: info: init_ais_connection_once: Connection to 'classic openais (with plugin)': established Oct 27 16:16:45 server1 crmd: [2868]: info: crm_new_peer: Node server1 now has id: 16777226 Oct 27 16:16:45 server1 crmd: [2868]: info: crm_new_peer: Node 16777226 is now known as server1 Oct 27 16:16:45 server1 crmd: [2868]: info: ais_status_callback: status: server1 is now unknown Oct 27 16:16:45 server1 crmd: [2868]: info: do_ha_control: Connected to the cluster Oct 27 16:16:45 server1 crmd: [2868]: info: do_started: Delaying start, no membership data (0000000000100000) Oct 27 16:16:45 server1 crmd: [2868]: info: crmd_init: Starting crmd's mainloop Oct 27 16:16:45 server1 crmd: [2868]: info: ais_dispatch_message: Membership 2544: quorum still lost Oct 27 16:16:45 server1 crmd: [2868]: notice: crmd_peer_update: Status update: Client server1/crmd now has status [online] (DC=) Oct 27 16:16:45 server1 crmd: [2868]: info: ais_status_callback: status: server1 is now member (was unknown) Oct 27 16:16:45 server1 crmd: [2868]: info: crm_update_peer: Node server1: id=16777226 state=member (new) addr=r(0) ip(10.0.0.1) (new) votes=1 (new) born=0 seen=2544 proc=00000000000000000000000000111312 (new) Oct 27 16:16:45 server1 crmd: [2868]: info: do_started: Delaying start, Config not read (0000000000000040) Oct 27 16:16:45 server1 crmd: [2868]: info: config_query_callback: Shutdown escalation occurs after: 1200000ms Oct 27 16:16:45 server1 crmd: [2868]: info: config_query_callback: Checking for expired actions every 900000ms Oct 27 16:16:45 server1 crmd: [2868]: info: config_query_callback: Sending expected-votes=2 to corosync Oct 27 16:16:45 server1 crmd: [2868]: info: do_started: The local CRM is operational Oct 27 16:16:45 server1 crmd: [2868]: info: do_state_transition: State transition S_STARTING -> S_PENDING [ input=I_PENDING cause=C_FSA_INTERNAL origin=do_started ] Oct 27 16:16:46 server1 dbus[1023]: [system] Activating service name='org.freedesktop.UPower' (using servicehelper) Oct 27 16:16:46 server1 dbus[1023]: [system] Successfully activated service 'org.freedesktop.UPower' Oct 27 16:16:46 server1 anacron[3267]: Anacron 2.3 started on 2014-10-27 Oct 27 16:16:46 server1 anacron[3267]: Normal exit (0 jobs run) Oct 27 16:16:46 server1 dbus[1023]: [system] Activating service name='org.freedesktop.ColorManager' (using servicehelper) Oct 27 16:16:46 server1 dbus[1023]: [system] Successfully activated service 'org.freedesktop.ColorManager' Oct 27 16:16:46 server1 pulseaudio[3491]: [pulseaudio] pid.c: Daemon already running. Oct 27 16:16:46 server1 crmd: [2868]: info: ais_dispatch_message: Membership 2544: quorum still lost Oct 27 16:16:46 server1 crmd: [2868]: info: te_connect_stonith: Attempting connection to fencing daemon... Oct 27 16:16:47 server1 crmd: [2868]: info: te_connect_stonith: Connected Oct 27 16:16:52 server1 kernel: [ 55.454992] init: plymouth-stop pre-start process (3642) terminated with status 1 Oct 27 16:16:57 server1 gnome-session[3682]: WARNING: Session 'gnome' runnable check failed: Exited with code 1 Oct 27 16:16:58 server1 dbus[1023]: [system] Activating service name='org.freedesktop.UDisks' (using servicehelper) Oct 27 16:16:58 server1 dbus[1023]: [system] Successfully activated service 'org.freedesktop.UDisks' Oct 27 16:17:01 server1 CRON[3856]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly) Oct 27 16:17:06 server1 pulseaudio[3765]: [pulseaudio] module.c: Failed to open module "module-x11-publish": file not found Oct 27 16:17:06 server1 crmd: [2868]: info: crm_timer_popped: Election Trigger (I_DC_TIMEOUT) just popped (20000ms) Oct 27 16:17:06 server1 crmd: [2868]: WARN: do_log: FSA: Input I_DC_TIMEOUT from crm_timer_popped() received in state S_PENDING Oct 27 16:17:06 server1 crmd: [2868]: info: do_state_transition: State transition S_PENDING -> S_ELECTION [ input=I_DC_TIMEOUT cause=C_TIMER_POPPED origin=crm_timer_popped ] Oct 27 16:17:06 server1 crmd: [2868]: info: do_state_transition: State transition S_ELECTION -> S_INTEGRATION [ input=I_ELECTION_DC cause=C_FSA_INTERNAL origin=do_election_check ] Oct 27 16:17:06 server1 crmd: [2868]: info: do_te_control: Registering TE UUID: 6c0717b4-0a6e-4cb3-a958-8dd0a19f83bc Oct 27 16:17:06 server1 crmd: [2868]: info: set_graph_functions: Setting custom graph functions Oct 27 16:17:06 server1 crmd: [2868]: info: unpack_graph: Unpacked transition -1: 0 actions in 0 synapses Oct 27 16:17:06 server1 crmd: [2868]: info: do_dc_takeover: Taking over DC status for this partition Oct 27 16:17:06 server1 cib: [2863]: info: cib_process_readwrite: We are now in R/W mode Oct 27 16:17:06 server1 cib: [2863]: info: cib_process_request: Operation complete: op cib_master for section 'all' (origin=local/crmd/5, version=0.70.1): ok (rc=0) Oct 27 16:17:06 server1 cib: [2863]: info: cib_process_request: Operation complete: op cib_modify for section cib (origin=local/crmd/6, version=0.70.2): ok (rc=0) Oct 27 16:17:06 server1 cib: [2863]: info: cib_process_request: Operation complete: op cib_modify for section crm_config (origin=local/crmd/8, version=0.70.3): ok (rc=0) Oct 27 16:17:06 server1 crmd: [2868]: info: join_make_offer: Making join offers based on membership 2544 Oct 27 16:17:06 server1 cib: [2863]: info: cib_process_request: Operation complete: op cib_modify for section crm_config (origin=local/crmd/10, version=0.70.4): ok (rc=0) Oct 27 16:17:06 server1 crmd: [2868]: info: do_dc_join_offer_all: join-1: Waiting on 1 outstanding join acks Oct 27 16:17:06 server1 crmd: [2868]: info: ais_dispatch_message: Membership 2544: quorum still lost Oct 27 16:17:06 server1 crmd: [2868]: info: crmd_ais_dispatch: Setting expected votes to 2 Oct 27 16:17:06 server1 crmd: [2868]: info: update_dc: Set DC to server1 (3.0.5) Oct 27 16:17:06 server1 crmd: [2868]: info: config_query_callback: Shutdown escalation occurs after: 1200000ms Oct 27 16:17:06 server1 crmd: [2868]: info: config_query_callback: Checking for expired actions every 900000ms Oct 27 16:17:06 server1 crmd: [2868]: info: config_query_callback: Sending expected-votes=2 to corosync Oct 27 16:17:06 server1 cib: [2863]: info: cib_process_request: Operation complete: op cib_modify for section crm_config (origin=local/crmd/13, version=0.70.5): ok (rc=0) Oct 27 16:17:06 server1 crmd: [2868]: info: ais_dispatch_message: Membership 2544: quorum still lost Oct 27 16:17:06 server1 cib: [2863]: info: cib_process_request: Operation complete: op cib_modify for section crm_config (origin=local/crmd/16, version=0.70.6): ok (rc=0) Oct 27 16:17:06 server1 crmd: [2868]: info: crmd_ais_dispatch: Setting expected votes to 2 Oct 27 16:17:06 server1 crmd: [2868]: info: do_state_transition: State transition S_INTEGRATION -> S_FINALIZE_JOIN [ input=I_INTEGRATED cause=C_FSA_INTERNAL origin=check_join_state ] Oct 27 16:17:06 server1 crmd: [2868]: info: do_state_transition: All 1 cluster nodes responded to the join offer. Oct 27 16:17:06 server1 crmd: [2868]: info: do_dc_join_finalize: join-1: Syncing the CIB from server1 to the rest of the cluster Oct 27 16:17:06 server1 cib: [2863]: info: cib_process_request: Operation complete: op cib_sync for section 'all' (origin=local/crmd/17, version=0.70.6): ok (rc=0) Oct 27 16:17:06 server1 cib: [2863]: info: cib_process_request: Operation complete: op cib_modify for section nodes (origin=local/crmd/18, version=0.70.7): ok (rc=0) Oct 27 16:17:06 server1 crmd: [2868]: info: update_attrd: Connecting to attrd... Oct 27 16:17:06 server1 cib: [2863]: info: cib_process_request: Operation complete: op cib_delete for section //node_state[@uname='server1']/transient_attributes (origin=local/crmd/19, version=0.70.8): ok (rc=0) Oct 27 16:17:06 server1 crmd: [2868]: info: erase_xpath_callback: Deletion of "//node_state[@uname='server1']/transient_attributes": ok (rc=0) Oct 27 16:17:06 server1 crmd: [2868]: info: do_dc_join_ack: join-1: Updating node state to member for server1 Oct 27 16:17:06 server1 cib: [2863]: info: cib_process_request: Operation complete: op cib_delete for section //node_state[@uname='server1']/lrm (origin=local/crmd/20, version=0.70.9): ok (rc=0) Oct 27 16:17:06 server1 crmd: [2868]: info: erase_xpath_callback: Deletion of "//node_state[@uname='server1']/lrm": ok (rc=0) Oct 27 16:17:06 server1 crmd: [2868]: info: do_state_transition: State transition S_FINALIZE_JOIN -> S_POLICY_ENGINE [ input=I_FINALIZED cause=C_FSA_INTERNAL origin=check_join_state ] Oct 27 16:17:06 server1 crmd: [2868]: info: do_state_transition: All 1 cluster nodes are eligible to run resources. Oct 27 16:17:06 server1 crmd: [2868]: info: do_dc_join_final: Ensuring DC, quorum and node attributes are up-to-date Oct 27 16:17:06 server1 crmd: [2868]: info: crm_update_quorum: Updating quorum status to false (call=24) Oct 27 16:17:06 server1 crmd: [2868]: info: abort_transition_graph: do_te_invoke:167 - Triggered transition abort (complete=1) : Peer Cancelled Oct 27 16:17:06 server1 crmd: [2868]: info: do_pe_invoke: Query 25: Requesting the current CIB: S_POLICY_ENGINE Oct 27 16:17:06 server1 attrd: [2865]: notice: attrd_local_callback: Sending full refresh (origin=crmd) Oct 27 16:17:06 server1 cib: [2863]: info: cib_process_request: Operation complete: op cib_modify for section nodes (origin=local/crmd/22, version=0.70.11): ok (rc=0) Oct 27 16:17:06 server1 cib: [2863]: info: cib_process_request: Operation complete: op cib_modify for section cib (origin=local/crmd/24, version=0.70.13): ok (rc=0) Oct 27 16:17:06 server1 crmd: [2868]: info: do_pe_invoke_callback: Invoking the PE: query=25, ref=pe_calc-dc-1414406826-7, seq=2544, quorate=0 Oct 27 16:17:06 server1 pengine: [2867]: notice: unpack_config: On loss of CCM Quorum: Ignore Oct 27 16:17:06 server1 pengine: [2867]: notice: RecurringOp: Start recurring monitor (30s) for resDRBDr1:0 on server1 Oct 27 16:17:06 server1 pengine: [2867]: notice: RecurringOp: Start recurring monitor (30s) for resDRBDr1:0 on server1 Oct 27 16:17:06 server1 pengine: [2867]: notice: LogActions: Leave resXen1#011(Stopped) Oct 27 16:17:06 server1 pengine: [2867]: notice: LogActions: Start resDRBDr1:0#011(server1) Oct 27 16:17:06 server1 pengine: [2867]: notice: LogActions: Leave resDRBDr1:1#011(Stopped) Oct 27 16:17:06 server1 pengine: [2867]: notice: LogActions: Leave resOCFS2r1:0#011(Stopped) Oct 27 16:17:06 server1 pengine: [2867]: notice: LogActions: Leave resOCFS2r1:1#011(Stopped) Oct 27 16:17:06 server1 crmd: [2868]: info: do_state_transition: State transition S_POLICY_ENGINE -> S_TRANSITION_ENGINE [ input=I_PE_SUCCESS cause=C_IPC_MESSAGE origin=handle_response ] Oct 27 16:17:06 server1 crmd: [2868]: info: unpack_graph: Unpacked transition 0: 14 actions in 14 synapses Oct 27 16:17:06 server1 crmd: [2868]: info: do_te_invoke: Processing graph 0 (ref=pe_calc-dc-1414406826-7) derived from /var/lib/pengine/pe-input-353.bz2 Oct 27 16:17:06 server1 crmd: [2868]: info: te_rsc_command: Initiating action 4: monitor resXen1_monitor_0 on server1 (local) Oct 27 16:17:06 server1 crmd: [2868]: info: do_lrm_rsc_op: Performing key=4:0:7:6c0717b4-0a6e-4cb3-a958-8dd0a19f83bc op=resXen1_monitor_0 ) Oct 27 16:17:06 server1 lrmd: [2864]: info: rsc:resXen1 probe[2] (pid 3862) Oct 27 16:17:06 server1 crmd: [2868]: info: te_rsc_command: Initiating action 5: monitor resDRBDr1:0_monitor_0 on server1 (local) Oct 27 16:17:06 server1 crmd: [2868]: info: do_lrm_rsc_op: Performing key=5:0:7:6c0717b4-0a6e-4cb3-a958-8dd0a19f83bc op=resDRBDr1:0_monitor_0 ) Oct 27 16:17:06 server1 lrmd: [2864]: info: rsc:resDRBDr1:0 probe[3] (pid 3863) Oct 27 16:17:06 server1 crmd: [2868]: info: te_pseudo_action: Pseudo action 11 fired and confirmed Oct 27 16:17:06 server1 crmd: [2868]: info: te_rsc_command: Initiating action 6: monitor resOCFS2r1:0_monitor_0 on server1 (local) Oct 27 16:17:06 server1 pengine: [2867]: notice: process_pe_message: Transition 0: PEngine Input stored in: /var/lib/pengine/pe-input-353.bz2 Oct 27 16:17:06 server1 crmd: [2868]: info: do_lrm_rsc_op: Performing key=6:0:7:6c0717b4-0a6e-4cb3-a958-8dd0a19f83bc op=resOCFS2r1:0_monitor_0 ) Oct 27 16:17:06 server1 lrmd: [2864]: info: rsc:resOCFS2r1:0 probe[4] (pid 3864) Oct 27 16:17:06 server1 crmd: [2868]: info: te_pseudo_action: Pseudo action 12 fired and confirmed Oct 27 16:17:06 server1 crmd: [2868]: info: te_pseudo_action: Pseudo action 9 fired and confirmed Oct 27 16:17:06 server1 Filesystem[3864]: WARNING: Couldn't find device [/dev/drbd/by-res/r0]. Expected /dev/??? to exist Oct 27 16:17:07 server1 lrmd: [2864]: info: operation monitor[4] on resOCFS2r1:0 for client 2868: pid 3864 exited with return code 7 Oct 27 16:17:07 server1 crmd: [2868]: info: process_lrm_event: LRM operation resOCFS2r1:0_monitor_0 (call=4, rc=7, cib-update=26, confirmed=true) not running Oct 27 16:17:07 server1 crmd: [2868]: info: match_graph_event: Action resOCFS2r1:0_monitor_0 (6) confirmed on server1 (rc=0) Oct 27 16:17:07 server1 crm_attribute: [3962]: info: Invoked: crm_attribute -N server1 -n master-resDRBDr1:0 -l reboot -D Oct 27 16:17:07 server1 lrmd: [2864]: info: operation monitor[3] on resDRBDr1:0 for client 2868: pid 3863 exited with return code 7 Oct 27 16:17:07 server1 crmd: [2868]: info: process_lrm_event: LRM operation resDRBDr1:0_monitor_0 (call=3, rc=7, cib-update=27, confirmed=true) not running Oct 27 16:17:07 server1 crmd: [2868]: info: match_graph_event: Action resDRBDr1:0_monitor_0 (5) confirmed on server1 (rc=0) Oct 27 16:17:07 server1 lrmd: [2864]: info: operation monitor[2] on resXen1 for client 2868: pid 3862 exited with return code 7 Oct 27 16:17:07 server1 crmd: [2868]: info: process_lrm_event: LRM operation resXen1_monitor_0 (call=2, rc=7, cib-update=28, confirmed=true) not running Oct 27 16:17:07 server1 crmd: [2868]: info: match_graph_event: Action resXen1_monitor_0 (4) confirmed on server1 (rc=0) Oct 27 16:17:07 server1 crmd: [2868]: info: te_rsc_command: Initiating action 3: probe_complete probe_complete on server1 (local) - no waiting Oct 27 16:17:07 server1 crmd: [2868]: info: te_pseudo_action: Pseudo action 2 fired and confirmed Oct 27 16:17:07 server1 crmd: [2868]: info: te_rsc_command: Initiating action 7: start resDRBDr1:0_start_0 on server1 (local) Oct 27 16:17:07 server1 attrd: [2865]: notice: attrd_trigger_update: Sending flush op to all hosts for: probe_complete (true) Oct 27 16:17:07 server1 crmd: [2868]: info: do_lrm_rsc_op: Performing key=7:0:0:6c0717b4-0a6e-4cb3-a958-8dd0a19f83bc op=resDRBDr1:0_start_0 ) Oct 27 16:17:07 server1 lrmd: [2864]: info: rsc:resDRBDr1:0 start[5] (pid 3980) Oct 27 16:17:07 server1 attrd: [2865]: notice: attrd_perform_update: Sent update 4: probe_complete=true Oct 27 16:17:07 server1 lrmd: [2864]: info: RA output: (resDRBDr1:0:start:stdout) allow-two-primaries; Oct 27 16:17:07 server1 lrmd: [2864]: info: RA output: (resDRBDr1:0:start:stdout) Oct 27 16:17:07 server1 kernel: [ 70.032954] drbd: initialized. Version: 8.3.11 (api:88/proto:86-96) Oct 27 16:17:07 server1 kernel: [ 70.032959] drbd: srcversion: 71955441799F513ACA6DA60 Oct 27 16:17:07 server1 kernel: [ 70.032962] drbd: registered as block device major 147 Oct 27 16:17:07 server1 kernel: [ 70.032965] drbd: minor_table @ 0xffff8803a3d1ee00 Oct 27 16:17:07 server1 lrmd: [2864]: info: RA output: (resDRBDr1:0:start:stdout) Oct 27 16:17:07 server1 lrmd: [2864]: info: RA output: (resDRBDr1:0:start:stdout) Oct 27 16:17:07 server1 kernel: [ 70.094125] block drbd0: Starting worker thread (from drbdsetup [4031]) Oct 27 16:17:07 server1 kernel: [ 70.094276] block drbd0: disk( Diskless -> Attaching ) Oct 27 16:17:07 server1 kernel: [ 70.101539] block drbd0: Found 15 transactions (670 active extents) in activity log. Oct 27 16:17:07 server1 kernel: [ 70.101545] block drbd0: Method to ensure write ordering: flush Oct 27 16:17:07 server1 kernel: [ 70.101549] block drbd0: max BIO size = 131072 Oct 27 16:17:07 server1 kernel: [ 70.101554] block drbd0: drbd_bm_resize called with capacity == 1562451312 Oct 27 16:17:07 server1 kernel: [ 70.107273] block drbd0: resync bitmap: bits=195306414 words=3051663 pages=5961 Oct 27 16:17:07 server1 kernel: [ 70.107282] block drbd0: size = 745 GB (781225656 KB) Oct 27 16:17:07 server1 kernel: [ 70.188719] block drbd0: bitmap READ of 5961 pages took 20 jiffies Oct 27 16:17:07 server1 kernel: [ 70.195946] block drbd0: recounting of set bits took additional 2 jiffies Oct 27 16:17:07 server1 kernel: [ 70.195951] block drbd0: 0 KB (0 bits) marked out-of-sync by on disk bit-map. Oct 27 16:17:07 server1 kernel: [ 70.196124] block drbd0: Marked additional 2660 MB as out-of-sync based on AL. Oct 27 16:17:07 server1 kernel: [ 70.196179] block drbd0: bitmap WRITE of 0 pages took 0 jiffies Oct 27 16:17:07 server1 kernel: [ 70.196213] block drbd0: 2660 MB (680960 bits) marked out-of-sync by on disk bit-map. Oct 27 16:17:07 server1 kernel: [ 70.196221] block drbd0: disk( Attaching -> UpToDate ) Oct 27 16:17:07 server1 kernel: [ 70.196225] block drbd0: attached to UUIDs 0BFBE719D83052A5:2993123AE1C2B18A:652D8E05DFECE38C:652C8E05DFECE38C Oct 27 16:17:07 server1 lrmd: [2864]: info: RA output: (resDRBDr1:0:start:stdout) Oct 27 16:17:07 server1 lrmd: [2864]: info: RA output: (resDRBDr1:0:start:stdout) Oct 27 16:17:07 server1 kernel: [ 70.229560] block drbd0: conn( StandAlone -> Unconnected ) Oct 27 16:17:07 server1 kernel: [ 70.229583] block drbd0: Starting receiver thread (from drbd0_worker [4032]) Oct 27 16:17:07 server1 kernel: [ 70.229695] block drbd0: receiver (re)started Oct 27 16:17:07 server1 kernel: [ 70.229703] block drbd0: conn( Unconnected -> WFConnection ) Oct 27 16:17:07 server1 attrd: [2865]: notice: attrd_trigger_update: Sending flush op to all hosts for: master-resDRBDr1:0 (1000) Oct 27 16:17:07 server1 attrd: [2865]: notice: attrd_perform_update: Sent update 7: master-resDRBDr1:0=1000 Oct 27 16:17:07 server1 crmd: [2868]: info: abort_transition_graph: te_update_diff:164 - Triggered transition abort (complete=0, tag=nvpair, id=status-server1-master-resDRBDr1.0, name=master-resDRBDr1:0, value=1000, magic=NA, cib=0.70.18) : Transient attribute: update Oct 27 16:17:07 server1 crmd: [2868]: info: update_abort_priority: Abort priority upgraded from 0 to 1000000 Oct 27 16:17:07 server1 crmd: [2868]: info: update_abort_priority: Abort action done superceeded by restart Oct 27 16:17:07 server1 lrmd: [2864]: info: operation start[5] on resDRBDr1:0 for client 2868: pid 3980 exited with return code 0 Oct 27 16:17:07 server1 lrmd: [2864]: info: RA output: (resDRBDr1:0:start:stdout) Oct 27 16:17:07 server1 crmd: [2868]: info: process_lrm_event: LRM operation resDRBDr1:0_start_0 (call=5, rc=0, cib-update=29, confirmed=true) ok Oct 27 16:17:07 server1 crmd: [2868]: info: match_graph_event: Action resDRBDr1:0_start_0 (7) confirmed on server1 (rc=0) Oct 27 16:17:07 server1 crmd: [2868]: info: te_pseudo_action: Pseudo action 10 fired and confirmed Oct 27 16:17:07 server1 crmd: [2868]: info: te_pseudo_action: Pseudo action 13 fired and confirmed Oct 27 16:17:07 server1 crmd: [2868]: info: te_rsc_command: Initiating action 46: notify resDRBDr1:0_post_notify_start_0 on server1 (local) Oct 27 16:17:07 server1 crmd: [2868]: info: do_lrm_rsc_op: Performing key=46:0:0:6c0717b4-0a6e-4cb3-a958-8dd0a19f83bc op=resDRBDr1:0_notify_0 ) Oct 27 16:17:07 server1 lrmd: [2864]: info: rsc:resDRBDr1:0 notify[6] (pid 4070) Oct 27 16:17:07 server1 lrmd: [2864]: info: RA output: (resDRBDr1:0:notify:stdout) Oct 27 16:17:07 server1 lrmd: [2864]: info: operation notify[6] on resDRBDr1:0 for client 2868: pid 4070 exited with return code 0 Oct 27 16:17:07 server1 crmd: [2868]: info: send_direct_ack: ACK'ing resource op resDRBDr1:0_notify_0 from 46:0:0:6c0717b4-0a6e-4cb3-a958-8dd0a19f83bc: lrm_invoke-lrmd-1414406827-14 Oct 27 16:17:07 server1 crmd: [2868]: info: process_te_message: Processing (N)ACK lrm_invoke-lrmd-1414406827-14 from server1 Oct 27 16:17:07 server1 crmd: [2868]: info: match_graph_event: Action resDRBDr1:0_notify_0 (46) confirmed on server1 (rc=0) Oct 27 16:17:07 server1 crmd: [2868]: info: process_lrm_event: LRM operation resDRBDr1:0_notify_0 (call=6, rc=0, cib-update=0, confirmed=true) ok Oct 27 16:17:07 server1 crmd: [2868]: info: te_pseudo_action: Pseudo action 14 fired and confirmed Oct 27 16:17:07 server1 crmd: [2868]: info: run_graph: ==================================================== Oct 27 16:17:07 server1 crmd: [2868]: notice: run_graph: Transition 0 (Complete=13, Pending=0, Fired=0, Skipped=1, Incomplete=0, Source=/var/lib/pengine/pe-input-353.bz2): Stopped Oct 27 16:17:07 server1 crmd: [2868]: info: te_graph_trigger: Transition 0 is now complete Oct 27 16:17:07 server1 crmd: [2868]: info: do_state_transition: State transition S_TRANSITION_ENGINE -> S_POLICY_ENGINE [ input=I_PE_CALC cause=C_FSA_INTERNAL origin=notify_crmd ] Oct 27 16:17:07 server1 crmd: [2868]: info: do_state_transition: All 1 cluster nodes are eligible to run resources. Oct 27 16:17:07 server1 crmd: [2868]: info: do_pe_invoke: Query 30: Requesting the current CIB: S_POLICY_ENGINE Oct 27 16:17:07 server1 pengine: [2867]: notice: unpack_config: On loss of CCM Quorum: Ignore Oct 27 16:17:07 server1 pengine: [2867]: notice: RecurringOp: Start recurring monitor (20s) for resXen1 on server1 Oct 27 16:17:07 server1 pengine: [2867]: notice: RecurringOp: Start recurring monitor (20s) for resDRBDr1:0 on server1 Oct 27 16:17:07 server1 pengine: [2867]: notice: RecurringOp: Start recurring monitor (20s) for resDRBDr1:0 on server1 Oct 27 16:17:07 server1 pengine: [2867]: notice: RecurringOp: Start recurring monitor (10s) for resOCFS2r1:0 on server1 Oct 27 16:17:07 server1 pengine: [2867]: notice: LogActions: Start resXen1#011(server1) Oct 27 16:17:07 server1 pengine: [2867]: notice: LogActions: Promote resDRBDr1:0#011(Slave -> Master server1) Oct 27 16:17:07 server1 pengine: [2867]: notice: LogActions: Leave resDRBDr1:1#011(Stopped) Oct 27 16:17:07 server1 pengine: [2867]: notice: LogActions: Start resOCFS2r1:0#011(server1) Oct 27 16:17:07 server1 pengine: [2867]: notice: LogActions: Leave resOCFS2r1:1#011(Stopped) Oct 27 16:17:07 server1 crmd: [2868]: info: do_pe_invoke_callback: Invoking the PE: query=30, ref=pe_calc-dc-1414406827-15, seq=2544, quorate=0 Oct 27 16:17:07 server1 crmd: [2868]: info: do_state_transition: State transition S_POLICY_ENGINE -> S_TRANSITION_ENGINE [ input=I_PE_SUCCESS cause=C_IPC_MESSAGE origin=handle_response ] Oct 27 16:17:07 server1 crmd: [2868]: info: unpack_graph: Unpacked transition 1: 16 actions in 16 synapses Oct 27 16:17:07 server1 crmd: [2868]: info: do_te_invoke: Processing graph 1 (ref=pe_calc-dc-1414406827-15) derived from /var/lib/pengine/pe-input-354.bz2 Oct 27 16:17:07 server1 crmd: [2868]: info: te_pseudo_action: Pseudo action 25 fired and confirmed Oct 27 16:17:07 server1 crmd: [2868]: info: te_rsc_command: Initiating action 51: notify resDRBDr1:0_pre_notify_promote_0 on server1 (local) Oct 27 16:17:07 server1 crmd: [2868]: info: do_lrm_rsc_op: Performing key=51:1:0:6c0717b4-0a6e-4cb3-a958-8dd0a19f83bc op=resDRBDr1:0_notify_0 ) Oct 27 16:17:07 server1 lrmd: [2864]: info: rsc:resDRBDr1:0 notify[7] (pid 4100) Oct 27 16:17:07 server1 pengine: [2867]: notice: process_pe_message: Transition 1: PEngine Input stored in: /var/lib/pengine/pe-input-354.bz2 Oct 27 16:17:07 server1 lrmd: [2864]: info: operation notify[7] on resDRBDr1:0 for client 2868: pid 4100 exited with return code 0 Oct 27 16:17:07 server1 crmd: [2868]: info: send_direct_ack: ACK'ing resource op resDRBDr1:0_notify_0 from 51:1:0:6c0717b4-0a6e-4cb3-a958-8dd0a19f83bc: lrm_invoke-lrmd-1414406827-17 Oct 27 16:17:07 server1 crmd: [2868]: info: process_te_message: Processing (N)ACK lrm_invoke-lrmd-1414406827-17 from server1 Oct 27 16:17:07 server1 crmd: [2868]: info: match_graph_event: Action resDRBDr1:0_notify_0 (51) confirmed on server1 (rc=0) Oct 27 16:17:07 server1 crmd: [2868]: info: process_lrm_event: LRM operation resDRBDr1:0_notify_0 (call=7, rc=0, cib-update=0, confirmed=true) ok Oct 27 16:17:07 server1 crmd: [2868]: info: te_pseudo_action: Pseudo action 26 fired and confirmed Oct 27 16:17:07 server1 crmd: [2868]: info: te_pseudo_action: Pseudo action 23 fired and confirmed Oct 27 16:17:07 server1 crmd: [2868]: info: te_rsc_command: Initiating action 9: promote resDRBDr1:0_promote_0 on server1 (local) Oct 27 16:17:07 server1 crmd: [2868]: info: do_lrm_rsc_op: Performing key=9:1:0:6c0717b4-0a6e-4cb3-a958-8dd0a19f83bc op=resDRBDr1:0_promote_0 ) Oct 27 16:17:07 server1 lrmd: [2864]: info: rsc:resDRBDr1:0 promote[8] (pid 4123) Oct 27 16:17:08 server1 lrmd: [2864]: info: RA output: (resDRBDr1:0:promote:stdout) allow-two-primaries; Oct 27 16:17:08 server1 kernel: [ 70.571766] block drbd0: role( Secondary -> Primary ) Oct 27 16:17:08 server1 lrmd: [2864]: info: RA output: (resDRBDr1:0:promote:stdout) Oct 27 16:17:08 server1 lrmd: [2864]: info: operation promote[8] on resDRBDr1:0 for client 2868: pid 4123 exited with return code 0 Oct 27 16:17:08 server1 crmd: [2868]: info: process_lrm_event: LRM operation resDRBDr1:0_promote_0 (call=8, rc=0, cib-update=31, confirmed=true) ok Oct 27 16:17:08 server1 crmd: [2868]: info: match_graph_event: Action resDRBDr1:0_promote_0 (9) confirmed on server1 (rc=0) Oct 27 16:17:08 server1 crmd: [2868]: info: te_pseudo_action: Pseudo action 24 fired and confirmed Oct 27 16:17:08 server1 crmd: [2868]: info: te_pseudo_action: Pseudo action 27 fired and confirmed Oct 27 16:17:08 server1 crmd: [2868]: info: te_rsc_command: Initiating action 52: notify resDRBDr1:0_post_notify_promote_0 on server1 (local) Oct 27 16:17:08 server1 crmd: [2868]: info: do_lrm_rsc_op: Performing key=52:1:0:6c0717b4-0a6e-4cb3-a958-8dd0a19f83bc op=resDRBDr1:0_notify_0 ) Oct 27 16:17:08 server1 lrmd: [2864]: info: rsc:resDRBDr1:0 notify[9] (pid 4154) Oct 27 16:17:08 server1 attrd: [2865]: notice: attrd_trigger_update: Sending flush op to all hosts for: master-resDRBDr1:0 (10000) Oct 27 16:17:08 server1 attrd: [2865]: notice: attrd_perform_update: Sent update 9: master-resDRBDr1:0=10000 Oct 27 16:17:08 server1 crmd: [2868]: info: abort_transition_graph: te_update_diff:164 - Triggered transition abort (complete=0, tag=nvpair, id=status-server1-master-resDRBDr1.0, name=master-resDRBDr1:0, value=10000, magic=NA, cib=0.70.21) : Transient attribute: update Oct 27 16:17:08 server1 crmd: [2868]: info: update_abort_priority: Abort priority upgraded from 0 to 1000000 Oct 27 16:17:08 server1 crmd: [2868]: info: update_abort_priority: Abort action done superceeded by restart Oct 27 16:17:08 server1 lrmd: [2864]: info: operation notify[9] on resDRBDr1:0 for client 2868: pid 4154 exited with return code 0 Oct 27 16:17:08 server1 lrmd: [2864]: info: RA output: (resDRBDr1:0:notify:stdout) Oct 27 16:17:08 server1 crmd: [2868]: info: send_direct_ack: ACK'ing resource op resDRBDr1:0_notify_0 from 52:1:0:6c0717b4-0a6e-4cb3-a958-8dd0a19f83bc: lrm_invoke-lrmd-1414406828-20 Oct 27 16:17:08 server1 crmd: [2868]: info: process_te_message: Processing (N)ACK lrm_invoke-lrmd-1414406828-20 from server1 Oct 27 16:17:08 server1 crmd: [2868]: info: match_graph_event: Action resDRBDr1:0_notify_0 (52) confirmed on server1 (rc=0) Oct 27 16:17:08 server1 crmd: [2868]: info: process_lrm_event: LRM operation resDRBDr1:0_notify_0 (call=9, rc=0, cib-update=0, confirmed=true) ok Oct 27 16:17:08 server1 crmd: [2868]: info: te_pseudo_action: Pseudo action 28 fired and confirmed Oct 27 16:17:08 server1 crmd: [2868]: info: run_graph: ==================================================== Oct 27 16:17:08 server1 crmd: [2868]: notice: run_graph: Transition 1 (Complete=9, Pending=0, Fired=0, Skipped=6, Incomplete=1, Source=/var/lib/pengine/pe-input-354.bz2): Stopped Oct 27 16:17:08 server1 crmd: [2868]: info: te_graph_trigger: Transition 1 is now complete Oct 27 16:17:08 server1 crmd: [2868]: info: do_state_transition: State transition S_TRANSITION_ENGINE -> S_POLICY_ENGINE [ input=I_PE_CALC cause=C_FSA_INTERNAL origin=notify_crmd ] Oct 27 16:17:08 server1 crmd: [2868]: info: do_state_transition: All 1 cluster nodes are eligible to run resources. Oct 27 16:17:08 server1 crmd: [2868]: info: do_pe_invoke: Query 32: Requesting the current CIB: S_POLICY_ENGINE Oct 27 16:17:08 server1 crmd: [2868]: info: do_pe_invoke_callback: Invoking the PE: query=32, ref=pe_calc-dc-1414406828-21, seq=2544, quorate=0 Oct 27 16:17:08 server1 pengine: [2867]: notice: unpack_config: On loss of CCM Quorum: Ignore Oct 27 16:17:08 server1 pengine: [2867]: notice: RecurringOp: Start recurring monitor (20s) for resXen1 on server1 Oct 27 16:17:08 server1 pengine: [2867]: notice: RecurringOp: Start recurring monitor (20s) for resDRBDr1:0 on server1 Oct 27 16:17:08 server1 pengine: [2867]: notice: RecurringOp: Start recurring monitor (20s) for resDRBDr1:0 on server1 Oct 27 16:17:08 server1 pengine: [2867]: notice: RecurringOp: Start recurring monitor (10s) for resOCFS2r1:0 on server1 Oct 27 16:17:08 server1 pengine: [2867]: notice: LogActions: Start resXen1#011(server1) Oct 27 16:17:08 server1 pengine: [2867]: notice: LogActions: Leave resDRBDr1:0#011(Master server1) Oct 27 16:17:08 server1 pengine: [2867]: notice: LogActions: Leave resDRBDr1:1#011(Stopped) Oct 27 16:17:08 server1 pengine: [2867]: notice: LogActions: Start resOCFS2r1:0#011(server1) Oct 27 16:17:08 server1 pengine: [2867]: notice: LogActions: Leave resOCFS2r1:1#011(Stopped) Oct 27 16:17:08 server1 crmd: [2868]: info: do_state_transition: State transition S_POLICY_ENGINE -> S_TRANSITION_ENGINE [ input=I_PE_SUCCESS cause=C_IPC_MESSAGE origin=handle_response ] Oct 27 16:17:08 server1 crmd: [2868]: info: unpack_graph: Unpacked transition 2: 7 actions in 7 synapses Oct 27 16:17:08 server1 crmd: [2868]: info: do_te_invoke: Processing graph 2 (ref=pe_calc-dc-1414406828-21) derived from /var/lib/pengine/pe-input-355.bz2 Oct 27 16:17:08 server1 crmd: [2868]: info: te_rsc_command: Initiating action 10: monitor resDRBDr1:0_monitor_20000 on server1 (local) Oct 27 16:17:08 server1 crmd: [2868]: info: do_lrm_rsc_op: Performing key=10:2:8:6c0717b4-0a6e-4cb3-a958-8dd0a19f83bc op=resDRBDr1:0_monitor_20000 ) Oct 27 16:17:08 server1 lrmd: [2864]: info: rsc:resDRBDr1:0 monitor[10] (pid 4189) Oct 27 16:17:08 server1 crmd: [2868]: info: te_pseudo_action: Pseudo action 37 fired and confirmed Oct 27 16:17:08 server1 crmd: [2868]: info: te_rsc_command: Initiating action 35: start resOCFS2r1:0_start_0 on server1 (local) Oct 27 16:17:08 server1 crmd: [2868]: info: do_lrm_rsc_op: Performing key=35:2:0:6c0717b4-0a6e-4cb3-a958-8dd0a19f83bc op=resOCFS2r1:0_start_0 ) Oct 27 16:17:08 server1 lrmd: [2864]: info: rsc:resOCFS2r1:0 start[11] (pid 4190) Oct 27 16:17:08 server1 pengine: [2867]: notice: process_pe_message: Transition 2: PEngine Input stored in: /var/lib/pengine/pe-input-355.bz2 Oct 27 16:17:08 server1 Filesystem[4190]: INFO: Running start for /dev/drbd/by-res/r0 on /cluster Oct 27 16:17:08 server1 lrmd: [2864]: info: RA output: (resOCFS2r1:0:start:stderr) FATAL: Module scsi_hostadapter not found. Oct 27 16:17:08 server1 lrmd: [2864]: info: operation monitor[10] on resDRBDr1:0 for client 2868: pid 4189 exited with return code 8 Oct 27 16:17:08 server1 crmd: [2868]: info: process_lrm_event: LRM operation resDRBDr1:0_monitor_20000 (call=10, rc=8, cib-update=33, confirmed=false) master Oct 27 16:17:08 server1 crmd: [2868]: info: match_graph_event: Action resDRBDr1:0_monitor_20000 (10) confirmed on server1 (rc=0) Oct 27 16:17:08 server1 kernel: [ 70.843387] OCFS2 1.5.0 Oct 27 16:17:14 server1 kernel: [ 76.945321] o2dlm: Joining domain 09946B7E9F8243729A55D49B9B21749F ( 0 ) 1 nodes Oct 27 16:17:14 server1 kernel: [ 76.945627] ocfs2: Slot 1 on device (147,0) was already allocated to this node! Oct 27 16:17:14 server1 kernel: [ 76.946403] ocfs2: File system on device (147,0) was not unmounted cleanly, recovering it. Oct 27 16:17:14 server1 kernel: [ 77.042443] ocfs2: Mounting device (147,0) on (node 0, slot 1) with ordered data mode. Oct 27 16:17:14 server1 lrmd: [2864]: info: operation start[11] on resOCFS2r1:0 for client 2868: pid 4190 exited with return code 0 Oct 27 16:17:14 server1 crmd: [2868]: info: process_lrm_event: LRM operation resOCFS2r1:0_start_0 (call=11, rc=0, cib-update=34, confirmed=true) ok Oct 27 16:17:14 server1 crmd: [2868]: info: match_graph_event: Action resOCFS2r1:0_start_0 (35) confirmed on server1 (rc=0) Oct 27 16:17:14 server1 crmd: [2868]: info: te_rsc_command: Initiating action 36: monitor resOCFS2r1:0_monitor_10000 on server1 (local) Oct 27 16:17:14 server1 crmd: [2868]: info: do_lrm_rsc_op: Performing key=36:2:0:6c0717b4-0a6e-4cb3-a958-8dd0a19f83bc op=resOCFS2r1:0_monitor_10000 ) Oct 27 16:17:14 server1 lrmd: [2864]: info: rsc:resOCFS2r1:0 monitor[12] (pid 4292) Oct 27 16:17:14 server1 crmd: [2868]: info: te_pseudo_action: Pseudo action 38 fired and confirmed Oct 27 16:17:14 server1 crmd: [2868]: info: te_rsc_command: Initiating action 4: start resXen1_start_0 on server1 (local) Oct 27 16:17:14 server1 crmd: [2868]: info: do_lrm_rsc_op: Performing key=4:2:0:6c0717b4-0a6e-4cb3-a958-8dd0a19f83bc op=resXen1_start_0 ) Oct 27 16:17:14 server1 lrmd: [2864]: info: rsc:resXen1 start[13] (pid 4293) Oct 27 16:17:14 server1 lrmd: [2864]: info: operation monitor[12] on resOCFS2r1:0 for client 2868: pid 4292 exited with return code 0 Oct 27 16:17:14 server1 crmd: [2868]: info: process_lrm_event: LRM operation resOCFS2r1:0_monitor_10000 (call=12, rc=0, cib-update=35, confirmed=false) ok Oct 27 16:17:14 server1 crmd: [2868]: info: match_graph_event: Action resOCFS2r1:0_monitor_10000 (36) confirmed on server1 (rc=0) Oct 27 16:17:17 server1 logger: /etc/xen/scripts/block: add XENBUS_PATH=backend/vbd/1/768 Oct 27 16:17:17 server1 logger: /etc/xen/scripts/block: add XENBUS_PATH=backend/vbd/1/5632 Oct 27 16:17:17 server1 avahi-daemon[1062]: Withdrawing workstation service for tap1.0. Oct 27 16:17:17 server1 logger: /etc/xen/scripts/vif-bridge: online type_if=vif XENBUS_PATH=backend/vif/1/0 Oct 27 16:17:17 server1 logger: /etc/xen/scripts/vif-bridge: add type_if=tap XENBUS_PATH=