You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2016/04/15 23:56:20 UTC

Build failed in Jenkins: Mesos » gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1) #2000

See <https://builds.apache.org/job/Mesos/COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)/2000/changes>

Changes:

[vinodkone] Simplified a conditional check while validating framework id.

[vinodkone] Explicitly set `FrameworkInfo.principal` if AuthN is enabled.

[vinodkone] Fixed per framework principal metrics for HTTP frameworks.

[vinodkone] Added flags for authenticating HTTP frameworks to master.

[vinodkone] Added documentation around using AuthN for HTTP frameworks.

[vinodkone] Added AuthN for HTTP based frameworks.

[vinodkone] Added basic authentication scheme to the scheduler library.

[vinodkone] Added `None()` for credentials when creating scheduler lib.

[vinodkone] Fixed tests impacted by enabling AuthN for HTTP frameworks.

------------------------------------------
[...truncated 180980 lines...]
I0415 21:56:22.211819 31933 scheduler.cpp:670] Enqueuing event SUBSCRIBED received from http://172.17.0.3:38555/master/api/v1/scheduler
I0415 21:56:22.212419 31933 scheduler.cpp:670] Enqueuing event HEARTBEAT received from http://172.17.0.3:38555/master/api/v1/scheduler
I0415 21:56:22.213102 31931 scheduler.cpp:236] Sending REQUEST call to http://172.17.0.3:38555/master/api/v1/scheduler
I0415 21:56:22.213927 31929 process.cpp:3170] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0415 21:56:22.214412 31935 http.cpp:313] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:40330
I0415 21:56:22.214666 31935 master.cpp:2907] Processing REQUEST call for framework a7bb6a13-9407-43f7-a9b2-bb3b3d31a233-0000 (default)
I0415 21:56:22.214880 31940 hierarchical.cpp:589] Received resource request from framework a7bb6a13-9407-43f7-a9b2-bb3b3d31a233-0000
I0415 21:56:22.217173 31928 master.cpp:1375] Framework a7bb6a13-9407-43f7-a9b2-bb3b3d31a233-0000 (default) disconnected
I0415 21:56:22.217198 31928 master.cpp:2764] Disconnecting framework a7bb6a13-9407-43f7-a9b2-bb3b3d31a233-0000 (default)
I0415 21:56:22.217221 31928 master.cpp:2788] Deactivating framework a7bb6a13-9407-43f7-a9b2-bb3b3d31a233-0000 (default)
I0415 21:56:22.217308 31928 master.cpp:1399] Giving framework a7bb6a13-9407-43f7-a9b2-bb3b3d31a233-0000 (default) 0ns to failover
I0415 21:56:22.217347 31939 hierarchical.cpp:375] Deactivated framework a7bb6a13-9407-43f7-a9b2-bb3b3d31a233-0000
I0415 21:56:22.218650 31931 master.cpp:5482] Framework failover timeout, removing framework a7bb6a13-9407-43f7-a9b2-bb3b3d31a233-0000 (default)
I0415 21:56:22.218674 31931 master.cpp:6210] Removing framework a7bb6a13-9407-43f7-a9b2-bb3b3d31a233-0000 (default)
I0415 21:56:22.219000 31934 hierarchical.cpp:326] Removed framework a7bb6a13-9407-43f7-a9b2-bb3b3d31a233-0000
I0415 21:56:22.227354 31907 master.cpp:1189] Master terminating
[       OK ] ContentType/SchedulerTest.Request/1 (75 ms)
[ RUN      ] ContentType/SchedulerTest.SchedulerReconnect/0
I0415 21:56:22.235186 31907 cluster.cpp:149] Creating default 'local' authorizer
I0415 21:56:22.238380 31907 leveldb.cpp:174] Opened db in 2.969032ms
I0415 21:56:22.239339 31907 leveldb.cpp:181] Compacted db in 918807ns
I0415 21:56:22.239400 31907 leveldb.cpp:196] Created db iterator in 25469ns
I0415 21:56:22.239423 31907 leveldb.cpp:202] Seeked to beginning of db in 2953ns
I0415 21:56:22.239434 31907 leveldb.cpp:271] Iterated through 0 keys in the db in 339ns
I0415 21:56:22.239480 31907 replica.cpp:779] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0415 21:56:22.240087 31941 recover.cpp:447] Starting replica recovery
I0415 21:56:22.240489 31926 recover.cpp:473] Replica is in EMPTY status
I0415 21:56:22.241979 31941 replica.cpp:673] Replica in EMPTY status received a broadcasted recover request from (17845)@172.17.0.3:38555
I0415 21:56:22.242491 31928 recover.cpp:193] Received a recover response from a replica in EMPTY status
I0415 21:56:22.243149 31927 recover.cpp:564] Updating replica status to STARTING
I0415 21:56:22.243731 31929 master.cpp:382] Master 926d9f2e-defc-45e1-b26d-fede5d60fd24 (a720f47b45c0) started on 172.17.0.3:38555
I0415 21:56:22.243959 31933 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 580516ns
I0415 21:56:22.244000 31933 replica.cpp:320] Persisted replica status to STARTING
I0415 21:56:22.243762 31929 master.cpp:384] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="true" --authenticate_http="true" --authenticate_http_frameworks="true" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/f0xTGK/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_slave_ping_timeouts="5" --quiet="false" --recovery_slave_removal_limit="100%" --registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="100secs" --registry_strict="true" --root_submissions="true" --slave_ping_timeout="15secs" --slave_reregister_timeout="10mins" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-0.29.0/_inst/share/mesos/webui" --work_dir="/tmp/f0xTGK/master" --zk_session_timeout="10secs"
I0415 21:56:22.244150 31929 master.cpp:433] Master only allowing authenticated frameworks to register
I0415 21:56:22.244174 31929 master.cpp:439] Master only allowing authenticated agents to register
I0415 21:56:22.244190 31929 master.cpp:445] Master only allowing authenticated HTTP frameworks to register
I0415 21:56:22.244209 31929 credentials.hpp:37] Loading credentials for authentication from '/tmp/f0xTGK/credentials'
I0415 21:56:22.244261 31935 recover.cpp:473] Replica is in STARTING status
I0415 21:56:22.244757 31929 master.cpp:489] Using default 'crammd5' authenticator
I0415 21:56:22.244954 31929 master.cpp:560] Using default 'basic' HTTP authenticator
I0415 21:56:22.245164 31929 master.cpp:640] Using default 'basic' HTTP framework authenticator
I0415 21:56:22.245319 31929 master.cpp:687] Authorization enabled
I0415 21:56:22.245416 31932 replica.cpp:673] Replica in STARTING status received a broadcasted recover request from (17846)@172.17.0.3:38555
I0415 21:56:22.245626 31941 hierarchical.cpp:142] Initialized hierarchical allocator process
I0415 21:56:22.245633 31939 whitelist_watcher.cpp:77] No whitelist given
I0415 21:56:22.246163 31926 recover.cpp:193] Received a recover response from a replica in STARTING status
I0415 21:56:22.246726 31938 recover.cpp:564] Updating replica status to VOTING
I0415 21:56:22.247442 31934 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 339810ns
I0415 21:56:22.247478 31934 replica.cpp:320] Persisted replica status to VOTING
I0415 21:56:22.247620 31931 recover.cpp:578] Successfully joined the Paxos group
I0415 21:56:22.247923 31931 recover.cpp:462] Recover process terminated
I0415 21:56:22.248617 31930 master.cpp:1932] The newly elected leader is master@172.17.0.3:38555 with id 926d9f2e-defc-45e1-b26d-fede5d60fd24
I0415 21:56:22.248661 31930 master.cpp:1945] Elected as the leading master!
I0415 21:56:22.248683 31930 master.cpp:1632] Recovering from registrar
I0415 21:56:22.248827 31936 registrar.cpp:331] Recovering registrar
I0415 21:56:22.249511 31931 log.cpp:659] Attempting to start the writer
I0415 21:56:22.251075 31937 replica.cpp:493] Replica received implicit promise request from (17849)@172.17.0.3:38555 with proposal 1
I0415 21:56:22.251456 31937 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 340081ns
I0415 21:56:22.251483 31937 replica.cpp:342] Persisted promised to 1
I0415 21:56:22.252234 31934 coordinator.cpp:238] Coordinator attempting to fill missing positions
I0415 21:56:22.253757 31928 replica.cpp:388] Replica received explicit promise request from (17850)@172.17.0.3:38555 for position 0 with proposal 2
I0415 21:56:22.254137 31928 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 330344ns
I0415 21:56:22.254164 31928 replica.cpp:712] Persisted action at 0
I0415 21:56:22.255221 31930 replica.cpp:537] Replica received write request for position 0 from (17851)@172.17.0.3:38555
I0415 21:56:22.255283 31930 leveldb.cpp:436] Reading position from leveldb took 29122ns
I0415 21:56:22.255640 31930 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 308146ns
I0415 21:56:22.255666 31930 replica.cpp:712] Persisted action at 0
I0415 21:56:22.256228 31939 replica.cpp:691] Replica received learned notice for position 0 from @0.0.0.0:0
I0415 21:56:22.256664 31939 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 401252ns
I0415 21:56:22.256688 31939 replica.cpp:712] Persisted action at 0
I0415 21:56:22.256706 31939 replica.cpp:697] Replica learned NOP action at position 0
I0415 21:56:22.257431 31930 log.cpp:675] Writer started with ending position 0
I0415 21:56:22.258613 31926 leveldb.cpp:436] Reading position from leveldb took 28384ns
I0415 21:56:22.259711 31928 registrar.cpp:364] Successfully fetched the registry (0B) in 10.83904ms
I0415 21:56:22.259825 31928 registrar.cpp:463] Applied 1 operations in 31323ns; attempting to update the 'registry'
I0415 21:56:22.260502 31932 log.cpp:683] Attempting to append 170 bytes to the log
I0415 21:56:22.260654 31927 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I0415 21:56:22.261498 31941 replica.cpp:537] Replica received write request for position 1 from (17852)@172.17.0.3:38555
I0415 21:56:22.261929 31941 leveldb.cpp:341] Persisting action (189 bytes) to leveldb took 376622ns
I0415 21:56:22.261953 31941 replica.cpp:712] Persisted action at 1
I0415 21:56:22.262881 31927 replica.cpp:691] Replica received learned notice for position 1 from @0.0.0.0:0
I0415 21:56:22.263216 31927 leveldb.cpp:341] Persisting action (191 bytes) to leveldb took 302486ns
I0415 21:56:22.263247 31927 replica.cpp:712] Persisted action at 1
I0415 21:56:22.263272 31927 replica.cpp:697] Replica learned APPEND action at position 1
I0415 21:56:22.264391 31931 registrar.cpp:508] Successfully updated the 'registry' in 4.50816ms
I0415 21:56:22.264607 31931 registrar.cpp:394] Successfully recovered registrar
I0415 21:56:22.264753 31934 log.cpp:702] Attempting to truncate the log to 1
I0415 21:56:22.264941 31934 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I0415 21:56:22.265028 31931 master.cpp:1740] Recovered 0 agents from the Registry (131B) ; allowing 10mins for agents to re-register
I0415 21:56:22.265228 31931 hierarchical.cpp:169] Skipping recovery of hierarchical allocator: nothing to recover
I0415 21:56:22.265964 31941 replica.cpp:537] Replica received write request for position 2 from (17853)@172.17.0.3:38555
I0415 21:56:22.266377 31941 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 372863ns
I0415 21:56:22.266409 31941 replica.cpp:712] Persisted action at 2
I0415 21:56:22.267094 31940 replica.cpp:691] Replica received learned notice for position 2 from @0.0.0.0:0
I0415 21:56:22.267431 31940 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 307240ns
I0415 21:56:22.267491 31940 leveldb.cpp:399] Deleting ~1 keys from leveldb took 34540ns
I0415 21:56:22.267534 31940 replica.cpp:712] Persisted action at 2
I0415 21:56:22.267593 31940 replica.cpp:697] Replica learned TRUNCATE action at position 2
I0415 21:56:22.276242 31907 scheduler.cpp:177] Version: 0.29.0
I0415 21:56:22.276808 31932 scheduler.cpp:479] New master detected at master@172.17.0.3:38555
I0415 21:56:22.278631 31933 scheduler.cpp:368] Connected with the master at http://172.17.0.3:38555/master/api/v1/scheduler
I0415 21:56:22.280652 31930 scheduler.cpp:450] Re-detecting master
I0415 21:56:22.280997 31930 scheduler.cpp:401] Ignoring disconnection attempt from stale connection
I0415 21:56:22.281057 31930 scheduler.cpp:401] Ignoring disconnection attempt from stale connection
I0415 21:56:22.281218 31930 scheduler.cpp:479] New master detected at master@172.17.0.3:38555
I0415 21:56:22.282691 31927 scheduler.cpp:368] Connected with the master at http://172.17.0.3:38555/master/api/v1/scheduler
I0415 21:56:22.284432 31933 scheduler.cpp:454] Lost leading master
I0415 21:56:22.284662 31933 scheduler.cpp:401] Ignoring disconnection attempt from stale connection
I0415 21:56:22.284817 31933 scheduler.cpp:401] Ignoring disconnection attempt from stale connection
I0415 21:56:22.285279 31931 scheduler.cpp:288] Ignoring reconnect request from scheduler since we are disconnected
I0415 21:56:22.305968 31929 master.cpp:1189] Master terminating
[       OK ] ContentType/SchedulerTest.SchedulerReconnect/0 (78 ms)
[ RUN      ] ContentType/SchedulerTest.SchedulerReconnect/1
I0415 21:56:22.313801 31907 cluster.cpp:149] Creating default 'local' authorizer
I0415 21:56:22.316771 31907 leveldb.cpp:174] Opened db in 2.714792ms
I0415 21:56:22.317824 31907 leveldb.cpp:181] Compacted db in 1.011345ms
I0415 21:56:22.317898 31907 leveldb.cpp:196] Created db iterator in 25647ns
I0415 21:56:22.317932 31907 leveldb.cpp:202] Seeked to beginning of db in 2532ns
I0415 21:56:22.317955 31907 leveldb.cpp:271] Iterated through 0 keys in the db in 420ns
I0415 21:56:22.318024 31907 replica.cpp:779] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0415 21:56:22.318542 31928 recover.cpp:447] Starting replica recovery
I0415 21:56:22.318824 31927 recover.cpp:473] Replica is in EMPTY status
I0415 21:56:22.320125 31928 replica.cpp:673] Replica in EMPTY status received a broadcasted recover request from (17857)@172.17.0.3:38555
I0415 21:56:22.320587 31936 recover.cpp:193] Received a recover response from a replica in EMPTY status
I0415 21:56:22.321036 31938 recover.cpp:564] Updating replica status to STARTING
I0415 21:56:22.321609 31937 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 373951ns
I0415 21:56:22.321635 31937 replica.cpp:320] Persisted replica status to STARTING
I0415 21:56:22.321763 31937 recover.cpp:473] Replica is in STARTING status
I0415 21:56:22.322211 31930 master.cpp:382] Master 44cd6301-f78e-4d57-b8d2-75cce9162490 (a720f47b45c0) started on 172.17.0.3:38555
I0415 21:56:22.322235 31930 master.cpp:384] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="true" --authenticate_http="true" --authenticate_http_frameworks="true" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/8N3nX6/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_slave_ping_timeouts="5" --quiet="false" --recovery_slave_removal_limit="100%" --registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="100secs" --registry_strict="true" --root_submissions="true" --slave_ping_timeout="15secs" --slave_reregister_timeout="10mins" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-0.29.0/_inst/share/mesos/webui" --work_dir="/tmp/8N3nX6/master" --zk_session_timeout="10secs"
I0415 21:56:22.322679 31930 master.cpp:433] Master only allowing authenticated frameworks to register
I0415 21:56:22.322693 31930 master.cpp:439] Master only allowing authenticated agents to register
I0415 21:56:22.322702 31930 master.cpp:445] Master only allowing authenticated HTTP frameworks to register
I0415 21:56:22.322708 31930 credentials.hpp:37] Loading credentials for authentication from '/tmp/8N3nX6/credentials'
I0415 21:56:22.322968 31938 replica.cpp:673] Replica in STARTING status received a broadcasted recover request from (17858)@172.17.0.3:38555
I0415 21:56:22.323048 31930 master.cpp:489] Using default 'crammd5' authenticator
I0415 21:56:22.323179 31930 master.cpp:560] Using default 'basic' HTTP authenticator
I0415 21:56:22.323266 31931 recover.cpp:193] Received a recover response from a replica in STARTING status
I0415 21:56:22.323331 31930 master.cpp:640] Using default 'basic' HTTP framework authenticator
I0415 21:56:22.323541 31930 master.cpp:687] Authorization enabled
I0415 21:56:22.323729 31936 hierarchical.cpp:142] Initialized hierarchical allocator process
I0415 21:56:22.323740 31935 whitelist_watcher.cpp:77] No whitelist given
I0415 21:56:22.323822 31936 recover.cpp:564] Updating replica status to VOTING
I0415 21:56:22.324353 31935 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 312253ns
I0415 21:56:22.324375 31935 replica.cpp:320] Persisted replica status to VOTING
I0415 21:56:22.325541 31933 recover.cpp:578] Successfully joined the Paxos group
I0415 21:56:22.325810 31933 recover.cpp:462] Recover process terminated
I0415 21:56:22.325819 31935 master.cpp:1932] The newly elected leader is master@172.17.0.3:38555 with id 44cd6301-f78e-4d57-b8d2-75cce9162490
I0415 21:56:22.325850 31935 master.cpp:1945] Elected as the leading master!
I0415 21:56:22.325871 31935 master.cpp:1632] Recovering from registrar
I0415 21:56:22.326043 31931 registrar.cpp:331] Recovering registrar
I0415 21:56:22.326555 31932 log.cpp:659] Attempting to start the writer
I0415 21:56:22.327628 31926 replica.cpp:493] Replica received implicit promise request from (17861)@172.17.0.3:38555 with proposal 1
I0415 21:56:22.328021 31926 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 356302ns
I0415 21:56:22.328047 31926 replica.cpp:342] Persisted promised to 1
I0415 21:56:22.328582 31936 coordinator.cpp:238] Coordinator attempting to fill missing positions
I0415 21:56:22.329701 31941 replica.cpp:388] Replica received explicit promise request from (17862)@172.17.0.3:38555 for position 0 with proposal 2
I0415 21:56:22.330034 31941 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 290197ns
I0415 21:56:22.330057 31941 replica.cpp:712] Persisted action at 0
I0415 21:56:22.331218 31940 replica.cpp:537] Replica received write request for position 0 from (17863)@172.17.0.3:38555
I0415 21:56:22.331295 31940 leveldb.cpp:436] Reading position from leveldb took 40208ns
I0415 21:56:22.331652 31940 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 314768ns
I0415 21:56:22.331676 31940 replica.cpp:712] Persisted action at 0
I0415 21:56:22.332221 31933 replica.cpp:691] Replica received learned notice for position 0 from @0.0.0.0:0
I0415 21:56:22.332649 31933 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 361122ns
I0415 21:56:22.332731 31933 replica.cpp:712] Persisted action at 0
I0415 21:56:22.332765 31933 replica.cpp:697] Replica learned NOP action at position 0
I0415 21:56:22.333233 31927 log.cpp:675] Writer started with ending position 0
I0415 21:56:22.334404 31939 leveldb.cpp:436] Reading position from leveldb took 24561ns
I0415 21:56:22.335867 31933 registrar.cpp:364] Successfully fetched the registry (0B) in 9.77408ms
I0415 21:56:22.336014 31933 registrar.cpp:463] Applied 1 operations in 38376ns; attempting to update the 'registry'
I0415 21:56:22.336793 31929 log.cpp:683] Attempting to append 170 bytes to the log
I0415 21:56:22.336917 31937 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I0415 21:56:22.337811 31933 replica.cpp:537] Replica received write request for position 1 from (17864)@172.17.0.3:38555
I0415 21:56:22.338225 31933 leveldb.cpp:341] Persisting action (189 bytes) to leveldb took 377217ns
I0415 21:56:22.338248 31933 replica.cpp:712] Persisted action at 1
I0415 21:56:22.338896 31929 replica.cpp:691] Replica received learned notice for position 1 from @0.0.0.0:0
I0415 21:56:22.339308 31929 leveldb.cpp:341] Persisting action (191 bytes) to leveldb took 381837ns
I0415 21:56:22.339331 31929 replica.cpp:712] Persisted action at 1
I0415 21:56:22.339346 31929 replica.cpp:697] Replica learned APPEND action at position 1
I0415 21:56:22.340257 31935 registrar.cpp:508] Successfully updated the 'registry' in 4.180992ms
I0415 21:56:22.340396 31935 registrar.cpp:394] Successfully recovered registrar
I0415 21:56:22.340613 31933 log.cpp:702] Attempting to truncate the log to 1
I0415 21:56:22.340936 31936 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I0415 21:56:22.341220 31929 master.cpp:1740] Recovered 0 agents from the Registry (131B) ; allowing 10mins for agents to re-register
I0415 21:56:22.341246 31928 hierarchical.cpp:169] Skipping recovery of hierarchical allocator: nothing to recover
I0415 21:56:22.341840 31940 replica.cpp:537] Replica received write request for position 2 from (17865)@172.17.0.3:38555
I0415 21:56:22.342177 31940 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 301827ns
I0415 21:56:22.342207 31940 replica.cpp:712] Persisted action at 2
I0415 21:56:22.342957 31933 replica.cpp:691] Replica received learned notice for position 2 from @0.0.0.0:0
I0415 21:56:22.343389 31933 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 389659ns
I0415 21:56:22.343453 31933 leveldb.cpp:399] Deleting ~1 keys from leveldb took 34859ns
I0415 21:56:22.343477 31933 replica.cpp:712] Persisted action at 2
I0415 21:56:22.343499 31933 replica.cpp:697] Replica learned TRUNCATE action at position 2
I0415 21:56:22.352370 31907 scheduler.cpp:177] Version: 0.29.0
I0415 21:56:22.353008 31934 scheduler.cpp:479] New master detected at master@172.17.0.3:38555
I0415 21:56:22.354946 31940 scheduler.cpp:368] Connected with the master at http://172.17.0.3:38555/master/api/v1/scheduler
I0415 21:56:22.357331 31939 scheduler.cpp:450] Re-detecting master
I0415 21:56:22.357764 31939 scheduler.cpp:401] Ignoring disconnection attempt from stale connection
I0415 21:56:22.357815 31939 scheduler.cpp:401] Ignoring disconnection attempt from stale connection
I0415 21:56:22.357903 31939 scheduler.cpp:479] New master detected at master@172.17.0.3:38555
I0415 21:56:22.359789 31929 scheduler.cpp:368] Connected with the master at http://172.17.0.3:38555/master/api/v1/scheduler
I0415 21:56:22.361841 31940 scheduler.cpp:454] Lost leading master
I0415 21:56:22.362220 31940 scheduler.cpp:401] Ignoring disconnection attempt from stale connection
I0415 21:56:22.362262 31940 scheduler.cpp:401] Ignoring disconnection attempt from stale connection
I0415 21:56:22.362951 31939 scheduler.cpp:288] Ignoring reconnect request from scheduler since we are disconnected
I0415 21:56:22.384313 31907 master.cpp:1189] Master terminating
[       OK ] ContentType/SchedulerTest.SchedulerReconnect/1 (79 ms)
[----------] 28 tests from ContentType/SchedulerTest (3338 ms total)

[----------] Global test environment tear-down
[==========] 1071 tests from 130 test cases ran. (347335 ms total)
[  PASSED  ] 1069 tests.
[  FAILED  ] 2 tests, listed below:
[  FAILED  ] ContentType/SchedulerHttpApiTest.RejectFrameworkWithInvalidRole/0, where GetParam() = "application/x-protobuf"
[  FAILED  ] ContentType/SchedulerHttpApiTest.RejectFrameworkWithInvalidRole/1, where GetParam() = "application/json"

 2 FAILED TESTS
  YOU HAVE 6 DISABLED TESTS

make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-0.29.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-0.29.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-0.29.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-0.29.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1460755366-25254
Untagged: mesos-1460755366-25254:latest
Deleted: a5feb43a8c8602922f837d71a080b5bc36d67d423e17699398a2f6667d40c92a
Deleted: 1c76b900ed67c886f73242b9ccb6493e7e82c3579b0890ddacf0e2d8d2fa2441
Deleted: 77fc579dfc9628f0beffdc26b432e080946337a8e20c03e93bba56b90ec861af
Deleted: 664d998d8df0811e23d57aa1f0f7aed518d8755294e10ecf2e4bb483dd480c4d
Deleted: d9766f14f1ad80bf64bba98eb171cb2afd7d1c988b039a87e1166c077b1606a2
Deleted: 2dd0529f1f0afa5ca6b2c905ca37cd4ff51c8404bf3049d9975b2fd65d4eda16
Deleted: 4c75362425cadd16664a0c96212c34efb6002a8436632d52b5b63680658e8532
Deleted: 58a9a908a38bd23524295e6f9b2a65928f0ca844a919f0d0bad2435a40e0519b
Deleted: 85c22fb46191170caeb49aa822dfded18fd03655a60d85f966fadae351c302e0
Deleted: 7a426b5fd4e91adea117a0adb912d5fbff088f57723d32914d64c6d8cf4b2da6
Deleted: a91180a144225ba12301a168718b4288a425f16f190af26ad9a6321cc5fb24a4
Deleted: 2ba2fd573e3b6f2ff84a8bb9edbf90de2a90c2cbbb396dccf0e9f720f215ab03
Deleted: a6eab6ba0af58a7210d81dddfe8282e5a3b5456dd47aed93c10ec70232de3040
Deleted: dfe6642585d7e411c86c8e46de04a2e9410c7d85c3854d00a96994d998bce12f
Deleted: 7f96aa9c9e51b39e9aacede774a77056f75fcea49105c076561e8430bef139b0
Deleted: 0cf4d586ff6db3e831067f3e86ed0f9b5dee52e2430bde14238da0ffc5ac395c
Build step 'Execute shell' marked build as failure

Jenkins build is back to normal : Mesos » gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1) #2001

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos/COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)/2001/changes>