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

[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)/2113/changes>

Changes:

[joris.van.remoortere] Windows: Added stub implementations of `fcntl.hpp` functions.

[vinodkone] Fixed a typo when run 'mesos slave'.

[vinodkone] Used `collect` for waiting on establishing connection.

[vinodkone] Added framework failover timeout validation.

[alexr] Updated `createFrameworkInfo()` in hierarchical_allocator_tests.cpp.

------------------------------------------
[...truncated 30655 lines...]
I0513 19:11:53.423811 27931 http.cpp:188] HTTP POST for /slave(1)/api/v1/executor from 172.17.0.3:56402
I0513 19:11:53.424048 27931 slave.cpp:3231] Handling status update TASK_FINISHED (UUID: 91572801-4f71-4053-a4bb-b73bbef03b8b) for task 2 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.425845 27931 http.cpp:188] HTTP POST for /slave(1)/api/v1/executor from 172.17.0.3:56402
I0513 19:11:53.426043 27931 slave.cpp:3231] Handling status update TASK_RUNNING (UUID: 10381208-e1c2-4a07-892c-6577221131de) for task 3 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.426537 27931 slave.cpp:3629] Forwarding the update TASK_RUNNING (UUID: fe3735ce-b3fe-411d-b97f-72aec97b6ff4) for task 2 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 to master@172.17.0.3:35356
I0513 19:11:53.426709 27931 slave.cpp:3523] Status update manager successfully handled status update TASK_RUNNING (UUID: fe3735ce-b3fe-411d-b97f-72aec97b6ff4) for task 2 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.427999 27931 http.cpp:188] HTTP POST for /slave(1)/api/v1/executor from 172.17.0.3:56402
I0513 19:11:53.428179 27931 slave.cpp:3231] Handling status update TASK_FINISHED (UUID: bde34393-c518-40ab-8064-adb186116194) for task 3 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.428658 27931 slave.cpp:5951] Terminating task 2
I0513 19:11:53.428972 27932 master.cpp:5103] Status update TASK_RUNNING (UUID: fe3735ce-b3fe-411d-b97f-72aec97b6ff4) for task 2 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 from agent 9e76be7e-645d-4067-8c12-82cb8938f445-S1 at slave(1)@172.17.0.3:35356 (46f53c9b159a)
I0513 19:11:53.429028 27932 master.cpp:5151] Forwarding status update TASK_RUNNING (UUID: fe3735ce-b3fe-411d-b97f-72aec97b6ff4) for task 2 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.429419 27932 master.cpp:6759] Updating the state of task 2 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0513 19:11:53.432150 27922 status_update_manager.cpp:320] Received status update TASK_RUNNING (UUID: 10381208-e1c2-4a07-892c-6577221131de) for task 3 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.432237 27922 status_update_manager.cpp:497] Creating StatusUpdate stream for task 3 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.432816 28059 executor.cpp:695] Enqueuing event ACKNOWLEDGED received from http://172.17.0.3:35356/slave(1)/api/v1/executor
I0513 19:11:53.432844 27922 status_update_manager.cpp:374] Forwarding update TASK_RUNNING (UUID: 10381208-e1c2-4a07-892c-6577221131de) for task 3 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 to the agent
I0513 19:11:53.433276 27922 status_update_manager.cpp:320] Received status update TASK_FINISHED (UUID: 91572801-4f71-4053-a4bb-b73bbef03b8b) for task 2 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.433604 27918 slave.cpp:3629] Forwarding the update TASK_RUNNING (UUID: 10381208-e1c2-4a07-892c-6577221131de) for task 3 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 to master@172.17.0.3:35356
Received an ACKNOWLEDGED event
I0513 19:11:53.434109 27930 scheduler.cpp:662] Enqueuing event UPDATE received from http://172.17.0.3:35356/master/api/v1/scheduler

Received an UPDATE event
Task 2 is in state TASK_RUNNING
I0513 19:11:53.435329 27918 slave.cpp:3523] Status update manager successfully handled status update TASK_RUNNING (UUID: 10381208-e1c2-4a07-892c-6577221131de) for task 3 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.435652 27920 master.cpp:5103] Status update TASK_RUNNING (UUID: 10381208-e1c2-4a07-892c-6577221131de) for task 3 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 from agent 9e76be7e-645d-4067-8c12-82cb8938f445-S1 at slave(1)@172.17.0.3:35356 (46f53c9b159a)
I0513 19:11:53.435706 27920 master.cpp:5151] Forwarding status update TASK_RUNNING (UUID: 10381208-e1c2-4a07-892c-6577221131de) for task 3 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.436084 27918 slave.cpp:3523] Status update manager successfully handled status update TASK_FINISHED (UUID: 91572801-4f71-4053-a4bb-b73bbef03b8b) for task 2 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.436115 27920 master.cpp:6759] Updating the state of task 3 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0513 19:11:53.437160 27920 slave.cpp:5951] Terminating task 3
I0513 19:11:53.435380 27930 scheduler.cpp:246] Sending ACKNOWLEDGE call to http://172.17.0.3:35356/master/api/v1/scheduler
I0513 19:11:53.438623 28066 executor.cpp:695] Enqueuing event ACKNOWLEDGED received from http://172.17.0.3:35356/slave(1)/api/v1/executor
I0513 19:11:53.439385 27929 status_update_manager.cpp:320] Received status update TASK_FINISHED (UUID: bde34393-c518-40ab-8064-adb186116194) for task 3 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.439548 27919 process.cpp:3247] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0513 19:11:53.439946 28060 executor.cpp:695] Enqueuing event ACKNOWLEDGED received from http://172.17.0.3:35356/slave(1)/api/v1/executor
Received an ACKNOWLEDGED event
I0513 19:11:53.441045 27928 scheduler.cpp:662] Enqueuing event UPDATE received from http://172.17.0.3:35356/master/api/v1/scheduler
Received an ACKNOWLEDGED event

Received an UPDATE event
Task 3 is in state TASK_RUNNING
I0513 19:11:53.442320 27920 scheduler.cpp:246] Sending ACKNOWLEDGE call to http://172.17.0.3:35356/master/api/v1/scheduler
I0513 19:11:53.442800 27925 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:56397
I0513 19:11:53.442984 27925 master.cpp:4258] Processing ACKNOWLEDGE call fe3735ce-b3fe-411d-b97f-72aec97b6ff4 for task 2 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 (Event Call Scheduler using libprocess (C++)) on agent 9e76be7e-645d-4067-8c12-82cb8938f445-S1
I0513 19:11:53.442946 27926 slave.cpp:3523] Status update manager successfully handled status update TASK_FINISHED (UUID: bde34393-c518-40ab-8064-adb186116194) for task 3 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.443596 27925 status_update_manager.cpp:392] Received status update acknowledgement (UUID: fe3735ce-b3fe-411d-b97f-72aec97b6ff4) for task 2 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.444953 27925 status_update_manager.cpp:374] Forwarding update TASK_FINISHED (UUID: 91572801-4f71-4053-a4bb-b73bbef03b8b) for task 2 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 to the agent
I0513 19:11:53.445327 27920 slave.cpp:3629] Forwarding the update TASK_FINISHED (UUID: 91572801-4f71-4053-a4bb-b73bbef03b8b) for task 2 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 to master@172.17.0.3:35356
I0513 19:11:53.445832 27920 slave.cpp:2641] Status update manager successfully handled status update acknowledgement (UUID: fe3735ce-b3fe-411d-b97f-72aec97b6ff4) for task 2 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.446192 28068 executor.cpp:695] Enqueuing event ACKNOWLEDGED received from http://172.17.0.3:35356/slave(1)/api/v1/executor
I0513 19:11:53.446182 27918 master.cpp:5103] Status update TASK_FINISHED (UUID: 91572801-4f71-4053-a4bb-b73bbef03b8b) for task 2 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 from agent 9e76be7e-645d-4067-8c12-82cb8938f445-S1 at slave(1)@172.17.0.3:35356 (46f53c9b159a)
I0513 19:11:53.446494 27918 master.cpp:5151] Forwarding status update TASK_FINISHED (UUID: 91572801-4f71-4053-a4bb-b73bbef03b8b) for task 2 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
Received an ACKNOWLEDGED event
I0513 19:11:53.447098 27918 master.cpp:6759] Updating the state of task 2 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 (latest state: TASK_FINISHED, status update state: TASK_FINISHED)
I0513 19:11:53.447602 27927 hierarchical.cpp:891] Recovered cpus(*):1; mem(*):128 (total: cpus(*):2; mem(*):10240; disk(*):3.70122e+06; ports(*):[31000-32000], allocated: cpus(*):1; mem(*):128) on agent 9e76be7e-645d-4067-8c12-82cb8938f445-S1 from framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.447954 27925 process.cpp:3247] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0513 19:11:53.450428 27918 scheduler.cpp:662] Enqueuing event UPDATE received from http://172.17.0.3:35356/master/api/v1/scheduler
I0513 19:11:53.450588 27929 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:56397
I0513 19:11:53.450861 27929 master.cpp:4258] Processing ACKNOWLEDGE call 10381208-e1c2-4a07-892c-6577221131de for task 3 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 (Event Call Scheduler using libprocess (C++)) on agent 9e76be7e-645d-4067-8c12-82cb8938f445-S1
I0513 19:11:53.451206 27923 status_update_manager.cpp:392] Received status update acknowledgement (UUID: 10381208-e1c2-4a07-892c-6577221131de) for task 3 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.451478 27923 status_update_manager.cpp:374] Forwarding update TASK_FINISHED (UUID: bde34393-c518-40ab-8064-adb186116194) for task 3 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 to the agent
I0513 19:11:53.451642 27929 scheduler.cpp:246] Sending ACKNOWLEDGE call to http://172.17.0.3:35356/master/api/v1/scheduler
I0513 19:11:53.451774 27926 slave.cpp:3629] Forwarding the update TASK_FINISHED (UUID: bde34393-c518-40ab-8064-adb186116194) for task 3 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 to master@172.17.0.3:35356

Received an UPDATE event
Task 2 is in state TASK_FINISHED
I0513 19:11:53.451995 27926 slave.cpp:2641] Status update manager successfully handled status update acknowledgement (UUID: 10381208-e1c2-4a07-892c-6577221131de) for task 3 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.452178 27931 master.cpp:5103] Status update TASK_FINISHED (UUID: bde34393-c518-40ab-8064-adb186116194) for task 3 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 from agent 9e76be7e-645d-4067-8c12-82cb8938f445-S1 at slave(1)@172.17.0.3:35356 (46f53c9b159a)
I0513 19:11:53.452222 27931 master.cpp:5151] Forwarding status update TASK_FINISHED (UUID: bde34393-c518-40ab-8064-adb186116194) for task 3 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.452605 27931 master.cpp:6759] Updating the state of task 3 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 (latest state: TASK_FINISHED, status update state: TASK_FINISHED)
I0513 19:11:53.453002 27931 process.cpp:3247] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0513 19:11:53.453073 27926 hierarchical.cpp:891] Recovered cpus(*):1; mem(*):128 (total: cpus(*):2; mem(*):10240; disk(*):3.70122e+06; ports(*):[31000-32000], allocated: ) on agent 9e76be7e-645d-4067-8c12-82cb8938f445-S1 from framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.453763 27925 scheduler.cpp:662] Enqueuing event UPDATE received from http://172.17.0.3:35356/master/api/v1/scheduler

Received an UPDATE event
Task 3 is in state TASK_FINISHED
I0513 19:11:53.453989 27926 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:56397
I0513 19:11:53.454130 27926 master.cpp:4258] Processing ACKNOWLEDGE call 91572801-4f71-4053-a4bb-b73bbef03b8b for task 2 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 (Event Call Scheduler using libprocess (C++)) on agent 9e76be7e-645d-4067-8c12-82cb8938f445-S1
I0513 19:11:53.454195 27926 master.cpp:6825] Removing task 2 with resources cpus(*):1; mem(*):128 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 on agent 9e76be7e-645d-4067-8c12-82cb8938f445-S1 at slave(1)@172.17.0.3:35356 (46f53c9b159a)
I0513 19:11:53.454890 27930 scheduler.cpp:246] Sending ACKNOWLEDGE call to http://172.17.0.3:35356/master/api/v1/scheduler
I0513 19:11:53.455073 27923 status_update_manager.cpp:392] Received status update acknowledgement (UUID: 91572801-4f71-4053-a4bb-b73bbef03b8b) for task 2 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.455224 27923 status_update_manager.cpp:528] Cleaning up status update stream for task 2 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.455611 27917 slave.cpp:2641] Status update manager successfully handled status update acknowledgement (UUID: 91572801-4f71-4053-a4bb-b73bbef03b8b) for task 2 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.455687 27917 slave.cpp:5992] Completing task 2
I0513 19:11:53.455848 27929 process.cpp:3247] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0513 19:11:53.456656 27927 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:56397
I0513 19:11:53.456796 27927 master.cpp:4258] Processing ACKNOWLEDGE call bde34393-c518-40ab-8064-adb186116194 for task 3 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 (Event Call Scheduler using libprocess (C++)) on agent 9e76be7e-645d-4067-8c12-82cb8938f445-S1
I0513 19:11:53.456845 27927 master.cpp:6825] Removing task 3 with resources cpus(*):1; mem(*):128 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 on agent 9e76be7e-645d-4067-8c12-82cb8938f445-S1 at slave(1)@172.17.0.3:35356 (46f53c9b159a)
I0513 19:11:53.457182 27922 status_update_manager.cpp:392] Received status update acknowledgement (UUID: bde34393-c518-40ab-8064-adb186116194) for task 3 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.457381 27922 status_update_manager.cpp:528] Cleaning up status update stream for task 3 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.457742 27918 slave.cpp:2641] Status update manager successfully handled status update acknowledgement (UUID: bde34393-c518-40ab-8064-adb186116194) for task 3 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.457854 27918 slave.cpp:5992] Completing task 3
I0513 19:11:53.731370 27927 hierarchical.cpp:1674] Filtered offer with ports(*):[31000-32000]; mem(*):9984; disk(*):3.70122e+06 on agent 9e76be7e-645d-4067-8c12-82cb8938f445-S2 for framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.731592 27927 hierarchical.cpp:1583] No inverse offers to send out!
I0513 19:11:53.731809 27927 hierarchical.cpp:1139] Performed allocation for 3 agents in 1.879103ms
I0513 19:11:53.732348 27923 master.cpp:5664] Sending 2 offers to framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 (Event Call Scheduler using libprocess (C++))
I0513 19:11:53.734959 27929 scheduler.cpp:662] Enqueuing event OFFERS received from http://172.17.0.3:35356/master/api/v1/scheduler

Received an OFFERS event
Received offer 9e76be7e-645d-4067-8c12-82cb8938f445-O3 with cpus(*):2; mem(*):10240; disk(*):3.70122e+06; ports(*):[31000-32000]
Received offer 9e76be7e-645d-4067-8c12-82cb8938f445-O4 with cpus(*):2; mem(*):10240; disk(*):3.70122e+06; ports(*):[31000-32000]
I0513 19:11:53.736461 27931 scheduler.cpp:246] Sending ACCEPT call to http://172.17.0.3:35356/master/api/v1/scheduler
I0513 19:11:53.736857 27931 scheduler.cpp:246] Sending ACCEPT call to http://172.17.0.3:35356/master/api/v1/scheduler
I0513 19:11:53.737442 27930 process.cpp:3247] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0513 19:11:53.738487 27918 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:56397
I0513 19:11:53.739244 27918 master.cpp:3438] Processing ACCEPT call for offers: [ 9e76be7e-645d-4067-8c12-82cb8938f445-O3 ] on agent 9e76be7e-645d-4067-8c12-82cb8938f445-S0 at slave(2)@172.17.0.3:35356 (46f53c9b159a) for framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 (Event Call Scheduler using libprocess (C++))
I0513 19:11:53.740315 27925 hierarchical.cpp:891] Recovered cpus(*):2; mem(*):10240; disk(*):3.70122e+06; ports(*):[31000-32000] (total: cpus(*):2; mem(*):10240; disk(*):3.70122e+06; ports(*):[31000-32000], allocated: ) on agent 9e76be7e-645d-4067-8c12-82cb8938f445-S0 from framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.740384 27925 hierarchical.cpp:928] Framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 filtered agent 9e76be7e-645d-4067-8c12-82cb8938f445-S0 for 5secs
I0513 19:11:53.740768 27926 process.cpp:3247] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0513 19:11:53.741616 27927 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:56397
I0513 19:11:53.742179 27927 master.cpp:3438] Processing ACCEPT call for offers: [ 9e76be7e-645d-4067-8c12-82cb8938f445-O4 ] on agent 9e76be7e-645d-4067-8c12-82cb8938f445-S1 at slave(1)@172.17.0.3:35356 (46f53c9b159a) for framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 (Event Call Scheduler using libprocess (C++))
I0513 19:11:53.743306 27932 hierarchical.cpp:891] Recovered cpus(*):2; mem(*):10240; disk(*):3.70122e+06; ports(*):[31000-32000] (total: cpus(*):2; mem(*):10240; disk(*):3.70122e+06; ports(*):[31000-32000], allocated: ) on agent 9e76be7e-645d-4067-8c12-82cb8938f445-S1 from framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.743368 27932 hierarchical.cpp:928] Framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 filtered agent 9e76be7e-645d-4067-8c12-82cb8938f445-S1 for 5secs
WARNING: Logging before InitGoogleLogging() is written to STDERR
I0513 19:11:53.756922 27985 process.cpp:1057] libprocess is initialized on 172.17.0.3:44201 with 16 worker threads
I0513 19:11:53.758270 28087 logging.cpp:195] Logging to STDERR
I0513 19:11:53.758306 28087 executor.cpp:179] Version: 0.29.0
I0513 19:11:53.761997 28075 executor.cpp:380] Connected with the agent
I0513 19:11:53.763447 28085 executor.cpp:281] Sending SUBSCRIBE call to http://172.17.0.3:35356/slave(3)/api/v1/executor
I0513 19:11:53.778224 27924 process.cpp:3247] Handling HTTP event for process 'slave(3)' with path: '/slave(3)/api/v1/executor'
I0513 19:11:53.779536 27923 http.cpp:188] HTTP POST for /slave(3)/api/v1/executor from 172.17.0.3:56403
I0513 19:11:53.780129 27923 slave.cpp:2705] Received Subscribe request for HTTP executor 'default' of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.782315 27920 slave.cpp:2035] Sending queued task '0' to executor 'default' of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 (via HTTP)
I0513 19:11:53.782732 27920 slave.cpp:2035] Sending queued task '1' to executor 'default' of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 (via HTTP)
I0513 19:11:53.786330 28079 executor.cpp:695] Enqueuing event SUBSCRIBED received from http://172.17.0.3:35356/slave(3)/api/v1/executor
Received a SUBSCRIBED event
I0513 19:11:53.787732 28083 executor.cpp:695] Enqueuing event LAUNCH received from http://172.17.0.3:35356/slave(3)/api/v1/executor
I0513 19:11:53.788421 28087 executor.cpp:695] Enqueuing event LAUNCH received from http://172.17.0.3:35356/slave(3)/api/v1/executor
Starting task 0
Finishing task 0
I0513 19:11:53.790827 28085 executor.cpp:281] Sending UPDATE call to http://172.17.0.3:35356/slave(3)/api/v1/executor
Starting task 1
Finishing task 1
I0513 19:11:53.791254 28085 executor.cpp:281] Sending UPDATE call to http://172.17.0.3:35356/slave(3)/api/v1/executor
I0513 19:11:53.791520 28085 executor.cpp:281] Sending UPDATE call to http://172.17.0.3:35356/slave(3)/api/v1/executor
I0513 19:11:53.791812 28085 executor.cpp:281] Sending UPDATE call to http://172.17.0.3:35356/slave(3)/api/v1/executor
I0513 19:11:53.792361 27918 process.cpp:3247] Handling HTTP event for process 'slave(3)' with path: '/slave(3)/api/v1/executor'
I0513 19:11:53.792685 27918 process.cpp:3247] Handling HTTP event for process 'slave(3)' with path: '/slave(3)/api/v1/executor'
I0513 19:11:53.793123 27918 process.cpp:3247] Handling HTTP event for process 'slave(3)' with path: '/slave(3)/api/v1/executor'
I0513 19:11:53.793508 27918 process.cpp:3247] Handling HTTP event for process 'slave(3)' with path: '/slave(3)/api/v1/executor'
I0513 19:11:53.794095 27925 http.cpp:188] HTTP POST for /slave(3)/api/v1/executor from 172.17.0.3:56404
I0513 19:11:53.794359 27925 slave.cpp:3231] Handling status update TASK_RUNNING (UUID: f2dc38b5-04f6-4feb-bd5e-c504b371c59e) for task 0 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.795022 27925 http.cpp:188] HTTP POST for /slave(3)/api/v1/executor from 172.17.0.3:56404
I0513 19:11:53.795202 27925 slave.cpp:3231] Handling status update TASK_FINISHED (UUID: 6287e754-d6dc-4ecf-bb49-bcbf3d01fdb0) for task 0 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.795589 27925 http.cpp:188] HTTP POST for /slave(3)/api/v1/executor from 172.17.0.3:56404
I0513 19:11:53.795805 27925 slave.cpp:3231] Handling status update TASK_RUNNING (UUID: 1b1d1787-df7d-4ba8-9881-0cb255f165ce) for task 1 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.796329 27925 http.cpp:188] HTTP POST for /slave(3)/api/v1/executor from 172.17.0.3:56404
I0513 19:11:53.796586 27925 slave.cpp:3231] Handling status update TASK_FINISHED (UUID: cc373b18-837a-4e2e-bd8e-a5c86a25ad87) for task 1 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.798634 27925 slave.cpp:5951] Terminating task 0
I0513 19:11:53.798794 27923 status_update_manager.cpp:320] Received status update TASK_RUNNING (UUID: f2dc38b5-04f6-4feb-bd5e-c504b371c59e) for task 0 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.798854 27923 status_update_manager.cpp:497] Creating StatusUpdate stream for task 0 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.799466 27923 status_update_manager.cpp:374] Forwarding update TASK_RUNNING (UUID: f2dc38b5-04f6-4feb-bd5e-c504b371c59e) for task 0 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 to the agent
I0513 19:11:53.800040 27925 slave.cpp:3629] Forwarding the update TASK_RUNNING (UUID: f2dc38b5-04f6-4feb-bd5e-c504b371c59e) for task 0 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 to master@172.17.0.3:35356
I0513 19:11:53.800110 27923 status_update_manager.cpp:320] Received status update TASK_RUNNING (UUID: 1b1d1787-df7d-4ba8-9881-0cb255f165ce) for task 1 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.800246 27923 status_update_manager.cpp:497] Creating StatusUpdate stream for task 1 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.800292 27925 slave.cpp:3523] Status update manager successfully handled status update TASK_RUNNING (UUID: f2dc38b5-04f6-4feb-bd5e-c504b371c59e) for task 0 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.800807 27923 status_update_manager.cpp:374] Forwarding update TASK_RUNNING (UUID: 1b1d1787-df7d-4ba8-9881-0cb255f165ce) for task 1 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 to the agent
I0513 19:11:53.801121 27925 master.cpp:5103] Status update TASK_RUNNING (UUID: f2dc38b5-04f6-4feb-bd5e-c504b371c59e) for task 0 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 from agent 9e76be7e-645d-4067-8c12-82cb8938f445-S2 at slave(3)@172.17.0.3:35356 (46f53c9b159a)
I0513 19:11:53.801215 27925 master.cpp:5151] Forwarding status update TASK_RUNNING (UUID: f2dc38b5-04f6-4feb-bd5e-c504b371c59e) for task 0 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.801801 27925 master.cpp:6759] Updating the state of task 0 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 (latest state: TASK_FINISHED, status update state: TASK_RUNNING)
I0513 19:11:53.802536 27925 hierarchical.cpp:891] Recovered cpus(*):1; mem(*):128 (total: cpus(*):2; mem(*):10240; disk(*):3.70122e+06; ports(*):[31000-32000], allocated: cpus(*):1; mem(*):128) on agent 9e76be7e-645d-4067-8c12-82cb8938f445-S2 from framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.802711 27917 slave.cpp:5951] Terminating task 1
I0513 19:11:53.804355 27923 scheduler.cpp:662] Enqueuing event UPDATE received from http://172.17.0.3:35356/master/api/v1/scheduler
I0513 19:11:53.804355 28084 executor.cpp:695] Enqueuing event ACKNOWLEDGED received from http://172.17.0.3:35356/slave(3)/api/v1/executor
I0513 19:11:53.804361 27917 slave.cpp:3629] Forwarding the update TASK_RUNNING (UUID: 1b1d1787-df7d-4ba8-9881-0cb255f165ce) for task 1 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 to master@172.17.0.3:35356
I0513 19:11:53.804603 27917 slave.cpp:3523] Status update manager successfully handled status update TASK_RUNNING (UUID: 1b1d1787-df7d-4ba8-9881-0cb255f165ce) for task 1 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.805169 27930 master.cpp:5103] Status update TASK_RUNNING (UUID: 1b1d1787-df7d-4ba8-9881-0cb255f165ce) for task 1 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 from agent 9e76be7e-645d-4067-8c12-82cb8938f445-S2 at slave(3)@172.17.0.3:35356 (46f53c9b159a)
I0513 19:11:53.805227 27930 master.cpp:5151] Forwarding status update TASK_RUNNING (UUID: 1b1d1787-df7d-4ba8-9881-0cb255f165ce) for task 1 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
Received an ACKNOWLEDGED event
I0513 19:11:53.806408 27930 master.cpp:6759] Updating the state of task 1 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 (latest state: TASK_FINISHED, status update state: TASK_RUNNING)
I0513 19:11:53.806408 27917 status_update_manager.cpp:320] Received status update TASK_FINISHED (UUID: 6287e754-d6dc-4ecf-bb49-bcbf3d01fdb0) for task 0 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.807034 27928 hierarchical.cpp:891] Recovered cpus(*):1; mem(*):128 (total: cpus(*):2; mem(*):10240; disk(*):3.70122e+06; ports(*):[31000-32000], allocated: ) on agent 9e76be7e-645d-4067-8c12-82cb8938f445-S2 from framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.807070 27923 slave.cpp:3523] Status update manager successfully handled status update TASK_FINISHED (UUID: 6287e754-d6dc-4ecf-bb49-bcbf3d01fdb0) for task 0 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.807134 28086 executor.cpp:695] Enqueuing event ACKNOWLEDGED received from http://172.17.0.3:35356/slave(3)/api/v1/executor

Received an UPDATE event
Task 0 is in state TASK_RUNNING
I0513 19:11:53.807551 27921 scheduler.cpp:246] Sending ACKNOWLEDGE call to http://172.17.0.3:35356/master/api/v1/scheduler
Received an ACKNOWLEDGED event
I0513 19:11:53.810050 27920 process.cpp:3247] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0513 19:11:53.810581 27920 scheduler.cpp:662] Enqueuing event UPDATE received from http://172.17.0.3:35356/master/api/v1/scheduler
I0513 19:11:53.811023 27919 status_update_manager.cpp:320] Received status update TASK_FINISHED (UUID: cc373b18-837a-4e2e-bd8e-a5c86a25ad87) for task 1 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.811856 27919 slave.cpp:3523] Status update manager successfully handled status update TASK_FINISHED (UUID: cc373b18-837a-4e2e-bd8e-a5c86a25ad87) for task 1 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.812635 28079 executor.cpp:695] Enqueuing event ACKNOWLEDGED received from http://172.17.0.3:35356/slave(3)/api/v1/executor
Received an ACKNOWLEDGED event
I0513 19:11:53.813346 28079 executor.cpp:695] Enqueuing event ACKNOWLEDGED received from http://172.17.0.3:35356/slave(3)/api/v1/executor
Received an ACKNOWLEDGED event
I0513 19:11:53.814224 27928 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:56397
I0513 19:11:53.814502 27928 master.cpp:4258] Processing ACKNOWLEDGE call f2dc38b5-04f6-4feb-bd5e-c504b371c59e for task 0 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 (Event Call Scheduler using libprocess (C++)) on agent 9e76be7e-645d-4067-8c12-82cb8938f445-S2
I0513 19:11:53.814918 27919 status_update_manager.cpp:392] Received status update acknowledgement (UUID: f2dc38b5-04f6-4feb-bd5e-c504b371c59e) for task 0 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.815285 27919 status_update_manager.cpp:374] Forwarding update TASK_FINISHED (UUID: 6287e754-d6dc-4ecf-bb49-bcbf3d01fdb0) for task 0 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 to the agent
I0513 19:11:53.816146 27919 slave.cpp:3629] Forwarding the update TASK_FINISHED (UUID: 6287e754-d6dc-4ecf-bb49-bcbf3d01fdb0) for task 0 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 to master@172.17.0.3:35356
I0513 19:11:53.816385 27919 slave.cpp:2641] Status update manager successfully handled status update acknowledgement (UUID: f2dc38b5-04f6-4feb-bd5e-c504b371c59e) for task 0 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.817150 27928 master.cpp:5103] Status update TASK_FINISHED (UUID: 6287e754-d6dc-4ecf-bb49-bcbf3d01fdb0) for task 0 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 from agent 9e76be7e-645d-4067-8c12-82cb8938f445-S2 at slave(3)@172.17.0.3:35356 (46f53c9b159a)
I0513 19:11:53.817239 27928 master.cpp:5151] Forwarding status update TASK_FINISHED (UUID: 6287e754-d6dc-4ecf-bb49-bcbf3d01fdb0) for task 0 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.817682 27928 master.cpp:6759] Updating the state of task 0 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 (latest state: TASK_FINISHED, status update state: TASK_FINISHED)

Received an UPDATE event
Task 1 is in state TASK_RUNNING
I0513 19:11:53.819042 27921 scheduler.cpp:246] Sending ACKNOWLEDGE call to http://172.17.0.3:35356/master/api/v1/scheduler
I0513 19:11:53.821686 27918 process.cpp:3247] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0513 19:11:53.821779 27921 scheduler.cpp:662] Enqueuing event UPDATE received from http://172.17.0.3:35356/master/api/v1/scheduler

Received an UPDATE event
Task 0 is in state TASK_FINISHED
I0513 19:11:53.822870 27930 scheduler.cpp:246] Sending ACKNOWLEDGE call to http://172.17.0.3:35356/master/api/v1/scheduler
I0513 19:11:53.823038 27928 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:56397
I0513 19:11:53.823221 27928 master.cpp:4258] Processing ACKNOWLEDGE call 1b1d1787-df7d-4ba8-9881-0cb255f165ce for task 1 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 (Event Call Scheduler using libprocess (C++)) on agent 9e76be7e-645d-4067-8c12-82cb8938f445-S2
I0513 19:11:53.823684 27930 status_update_manager.cpp:392] Received status update acknowledgement (UUID: 1b1d1787-df7d-4ba8-9881-0cb255f165ce) for task 1 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.825021 27930 status_update_manager.cpp:374] Forwarding update TASK_FINISHED (UUID: cc373b18-837a-4e2e-bd8e-a5c86a25ad87) for task 1 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 to the agent
I0513 19:11:53.825479 27930 slave.cpp:3629] Forwarding the update TASK_FINISHED (UUID: cc373b18-837a-4e2e-bd8e-a5c86a25ad87) for task 1 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 to master@172.17.0.3:35356
I0513 19:11:53.825644 27930 slave.cpp:2641] Status update manager successfully handled status update acknowledgement (UUID: 1b1d1787-df7d-4ba8-9881-0cb255f165ce) for task 1 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.826936 27930 master.cpp:5103] Status update TASK_FINISHED (UUID: cc373b18-837a-4e2e-bd8e-a5c86a25ad87) for task 1 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 from agent 9e76be7e-645d-4067-8c12-82cb8938f445-S2 at slave(3)@172.17.0.3:35356 (46f53c9b159a)
I0513 19:11:53.826989 27930 master.cpp:5151] Forwarding status update TASK_FINISHED (UUID: cc373b18-837a-4e2e-bd8e-a5c86a25ad87) for task 1 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.827415 27930 master.cpp:6759] Updating the state of task 1 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 (latest state: TASK_FINISHED, status update state: TASK_FINISHED)
I0513 19:11:53.829339 27921 process.cpp:3247] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0513 19:11:53.829798 27930 scheduler.cpp:662] Enqueuing event UPDATE received from http://172.17.0.3:35356/master/api/v1/scheduler
I0513 19:11:53.830415 27924 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:56397
I0513 19:11:53.830695 27924 master.cpp:4258] Processing ACKNOWLEDGE call 6287e754-d6dc-4ecf-bb49-bcbf3d01fdb0 for task 0 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 (Event Call Scheduler using libprocess (C++)) on agent 9e76be7e-645d-4067-8c12-82cb8938f445-S2
I0513 19:11:53.830837 27924 master.cpp:6825] Removing task 0 with resources cpus(*):1; mem(*):128 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 on agent 9e76be7e-645d-4067-8c12-82cb8938f445-S2 at slave(3)@172.17.0.3:35356 (46f53c9b159a)

Received an UPDATE event
Task 1 is in state TASK_FINISHED
I0513 19:11:53.830991 27919 scheduler.cpp:246] Sending ACKNOWLEDGE call to http://172.17.0.3:35356/master/api/v1/scheduler
I0513 19:11:53.831267 27919 scheduler.cpp:246] Sending TEARDOWN call to http://172.17.0.3:35356/master/api/v1/scheduler
I0513 19:11:53.831532 27924 status_update_manager.cpp:392] Received status update acknowledgement (UUID: 6287e754-d6dc-4ecf-bb49-bcbf3d01fdb0) for task 0 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.831765 27924 status_update_manager.cpp:528] Cleaning up status update stream for task 0 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.832191 27919 slave.cpp:2641] Status update manager successfully handled status update acknowledgement (UUID: 6287e754-d6dc-4ecf-bb49-bcbf3d01fdb0) for task 0 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.832252 27919 slave.cpp:5992] Completing task 0
I0513 19:11:53.832394 27922 process.cpp:3247] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0513 19:11:53.833569 27917 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:56397
I0513 19:11:53.833874 27917 master.cpp:4258] Processing ACKNOWLEDGE call cc373b18-837a-4e2e-bd8e-a5c86a25ad87 for task 1 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 (Event Call Scheduler using libprocess (C++)) on agent 9e76be7e-645d-4067-8c12-82cb8938f445-S2
I0513 19:11:53.833951 27917 master.cpp:6825] Removing task 1 with resources cpus(*):1; mem(*):128 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 on agent 9e76be7e-645d-4067-8c12-82cb8938f445-S2 at slave(3)@172.17.0.3:35356 (46f53c9b159a)
I0513 19:11:53.834367 27928 status_update_manager.cpp:392] Received status update acknowledgement (UUID: cc373b18-837a-4e2e-bd8e-a5c86a25ad87) for task 1 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.834538 27917 master.cpp:1191] Master terminating
I0513 19:11:53.834616 27928 status_update_manager.cpp:528] Cleaning up status update stream for task 1 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.834957 27917 master.cpp:6854] Removing executor 'default' with resources  of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 on agent 9e76be7e-645d-4067-8c12-82cb8938f445-S2 at slave(3)@172.17.0.3:35356 (46f53c9b159a)
I0513 19:11:53.835106 27926 slave.cpp:2641] Status update manager successfully handled status update acknowledgement (UUID: cc373b18-837a-4e2e-bd8e-a5c86a25ad87) for task 1 of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
I0513 19:11:53.835198 27926 slave.cpp:5992] Completing task 1
I0513 19:11:53.835467 27930 hierarchical.cpp:505] Removed agent 9e76be7e-645d-4067-8c12-82cb8938f445-S2
I0513 19:11:53.835791 27917 master.cpp:6854] Removing executor 'default' with resources  of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 on agent 9e76be7e-645d-4067-8c12-82cb8938f445-S1 at slave(1)@172.17.0.3:35356 (46f53c9b159a)
I0513 19:11:53.835950 27927 hierarchical.cpp:505] Removed agent 9e76be7e-645d-4067-8c12-82cb8938f445-S1
I0513 19:11:53.836237 27917 master.cpp:6854] Removing executor 'default' with resources  of framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000 on agent 9e76be7e-645d-4067-8c12-82cb8938f445-S0 at slave(2)@172.17.0.3:35356 (46f53c9b159a)
I0513 19:11:53.836575 27928 hierarchical.cpp:505] Removed agent 9e76be7e-645d-4067-8c12-82cb8938f445-S0
I0513 19:11:53.837402 27932 hierarchical.cpp:326] Removed framework 9e76be7e-645d-4067-8c12-82cb8938f445-0000
Build timed out (after 300 minutes). Marking the build as failed.
Build was aborted
++ docker rmi mesos-1463164289-13700
Error response from daemon: conflict: unable to remove repository reference "mesos-1463164289-13700" (must force) - container 46f53c9b159a is using its referenced image 4b9483a9a0b6
Error: failed to remove images: [mesos-1463164289-13700]

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

[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)/2114/changes>