See
<https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,CONFIGURATION=--verbose%20--disable-libtool-wrappers,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4550/display/redirect?page=changes>
Changes:
[yujie.jay] Used a wrapper message for storage resource provider info.
[songzihao1990] Added excluded image parameter to containerizer pruneImages().
[songzihao1990] Added a flag conversion protobuf message 'ImageGcConfig'.
[songzihao1990] Added an optional agent flag '--image_gc_config'.
[songzihao1990] Supported basic auto image gc in the agent.
[songzihao1990] Deleted a redundant line in test/containerizer.hpp.
[songzihao1990] Fixed a typo in gc_test.cpp.
[songzihao1990] Fixed comments for linux MACRO.
[songzihao1990] Tracked layers in memory for provisioned containers.
[mpark] Changed agent reregistration to work with messages directly.
[mpark] Reduced copying of agent data during reregistration.
[mpark] Fixed incorrect testing of existence of variables.
[yujie.jay] Imported and reconcile resources from CSI plugins.
[andrew] Added `curl` executable to Windows build.
[andrew] Renamed CMake `curl` target to `libcurl`.
[andrew] Windows: Enabled HTTP health checks.
------------------------------------------
[...truncated 5.54 MB...]
3: I1207 01:24:44.340024 16043 slave.cpp:979] Successfully attached
'/tmp/PartitionTest_PartitionedSlaveReregistrationMasterFailover_TtBjhU/slaves/cd0a9c18-18a5-40d6-a064-1986155053a4-S0/frameworks/cd0a9c18-18a5-40d6-a064-1986155053a4-0000/executors/8c9391b0-8dd7-4712-8dd0-568f4cfbae2d/runs/0bd20e94-1fd8-4ac0-b370-ae1ba13fa836'
to virtual path
'/tmp/PartitionTest_PartitionedSlaveReregistrationMasterFailover_TtBjhU/slaves/cd0a9c18-18a5-40d6-a064-1986155053a4-S0/frameworks/cd0a9c18-18a5-40d6-a064-1986155053a4-0000/executors/8c9391b0-8dd7-4712-8dd0-568f4cfbae2d/runs/0bd20e94-1fd8-4ac0-b370-ae1ba13fa836'
3: I1207 01:24:44.340773 16052 containerizer.cpp:1373] Checkpointed
ContainerConfig at
'/tmp/PartitionTest_PartitionedSlaveReregistrationMasterFailover_e0oxyE/containers/0bd20e94-1fd8-4ac0-b370-ae1ba13fa836/config'
3: I1207 01:24:44.340811 16052 containerizer.cpp:2930] Transitioning the state
of container 0bd20e94-1fd8-4ac0-b370-ae1ba13fa836 from PROVISIONING to PREPARING
3: I1207 01:24:44.346709 16059 containerizer.cpp:1842] Launching
'mesos-containerizer' with flags '--help="false"
--launch_info="{"command":{"arguments":["mesos-executor","--launcher_dir=\/mesos\/build\/src"],"shell":false,"value":"\/mesos\/build\/src\/mesos-executor"},"environment":{"variables":[{"name":"LIBPROCESS_PORT","type":"VALUE","value":"0"},{"name":"MESOS_AGENT_ENDPOINT","type":"VALUE","value":"172.17.0.4:39462"},{"name":"MESOS_CHECKPOINT","type":"VALUE","value":"0"},{"name":"MESOS_DIRECTORY","type":"VALUE","value":"\/tmp\/PartitionTest_PartitionedSlaveReregistrationMasterFailover_TtBjhU\/slaves\/cd0a9c18-18a5-40d6-a064-1986155053a4-S0\/frameworks\/cd0a9c18-18a5-40d6-a064-1986155053a4-0000\/executors\/8c9391b0-8dd7-4712-8dd0-568f4cfbae2d\/runs\/0bd20e94-1fd8-4ac0-b370-ae1ba13fa836"},{"name":"MESOS_EXECUTOR_ID","type":"VALUE","value":"8c9391b0-8dd7-4712-8dd0-568f4cfbae2d"},{"name":"MESOS_EXECUTOR_SHUTDOWN_GRACE_PERIOD","type":"VALUE","value":"5secs"},{"name":"MESOS_FRAMEWORK_ID","type":"VALUE","value":"cd0a9c18-18a5-40d6-a064-1986155053a4-0000"},{"name":"MESOS_HTTP_COMMAND_EXECUTOR","type":"VALUE","value":"0"},{"name":"MESOS_SLAVE_ID","type":"VALUE","value":"cd0a9c18-18a5-40d6-a064-1986155053a4-S0"},{"name":"MESOS_SLAVE_PID","type":"VALUE","value":"slave(110)@172.17.0.4:39462"},{"name":"MESOS_SANDBOX","type":"VALUE","value":"\/tmp\/PartitionTest_PartitionedSlaveReregistrationMasterFailover_TtBjhU\/slaves\/cd0a9c18-18a5-40d6-a064-1986155053a4-S0\/frameworks\/cd0a9c18-18a5-40d6-a064-1986155053a4-0000\/executors\/8c9391b0-8dd7-4712-8dd0-568f4cfbae2d\/runs\/0bd20e94-1fd8-4ac0-b370-ae1ba13fa836"}]},"task_environment":{},"user":"mesos","working_directory":"\/tmp\/PartitionTest_PartitionedSlaveReregistrationMasterFailover_TtBjhU\/slaves\/cd0a9c18-18a5-40d6-a064-1986155053a4-S0\/frameworks\/cd0a9c18-18a5-40d6-a064-1986155053a4-0000\/executors\/8c9391b0-8dd7-4712-8dd0-568f4cfbae2d\/runs\/0bd20e94-1fd8-4ac0-b370-ae1ba13fa836"}"
--pipe_read="7" --pipe_write="8"
--runtime_directory="/tmp/PartitionTest_PartitionedSlaveReregistrationMasterFailover_e0oxyE/containers/0bd20e94-1fd8-4ac0-b370-ae1ba13fa836"
--unshare_namespace_mnt="false"'
3: I1207 01:24:44.350850 16059 launcher.cpp:140] Forked child with pid '18018'
for container '0bd20e94-1fd8-4ac0-b370-ae1ba13fa836'
3: I1207 01:24:44.351570 16059 containerizer.cpp:2930] Transitioning the state
of container 0bd20e94-1fd8-4ac0-b370-ae1ba13fa836 from PREPARING to ISOLATING
3: I1207 01:24:44.353629 16041 containerizer.cpp:2930] Transitioning the state
of container 0bd20e94-1fd8-4ac0-b370-ae1ba13fa836 from ISOLATING to FETCHING
3: I1207 01:24:44.353922 16052 fetcher.cpp:380] Starting to fetch URIs for
container: 0bd20e94-1fd8-4ac0-b370-ae1ba13fa836, directory:
/tmp/PartitionTest_PartitionedSlaveReregistrationMasterFailover_TtBjhU/slaves/cd0a9c18-18a5-40d6-a064-1986155053a4-S0/frameworks/cd0a9c18-18a5-40d6-a064-1986155053a4-0000/executors/8c9391b0-8dd7-4712-8dd0-568f4cfbae2d/runs/0bd20e94-1fd8-4ac0-b370-ae1ba13fa836
3: I1207 01:24:44.355304 16047 containerizer.cpp:2930] Transitioning the state
of container 0bd20e94-1fd8-4ac0-b370-ae1ba13fa836 from FETCHING to RUNNING
3: I1207 01:24:44.632124 18032 exec.cpp:162] Version: 1.5.0
3: I1207 01:24:44.646502 16055 slave.cpp:4182] Got registration for executor
'8c9391b0-8dd7-4712-8dd0-568f4cfbae2d' of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000 from executor(1)@172.17.0.4:41330
3: I1207 01:24:44.650283 16043 slave.cpp:2732] Sending queued task
'8c9391b0-8dd7-4712-8dd0-568f4cfbae2d' to executor
'8c9391b0-8dd7-4712-8dd0-568f4cfbae2d' of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000 at executor(1)@172.17.0.4:41330
3: I1207 01:24:44.654424 18039 exec.cpp:237] Executor registered on agent
cd0a9c18-18a5-40d6-a064-1986155053a4-S0
3: I1207 01:24:44.660862 18024 executor.cpp:171] Received SUBSCRIBED event
3: I1207 01:24:44.662505 18024 executor.cpp:175] Subscribed executor on
18571b98d89c
3: I1207 01:24:44.662823 18024 executor.cpp:171] Received LAUNCH event
3: I1207 01:24:44.665657 18024 executor.cpp:637] Starting task
8c9391b0-8dd7-4712-8dd0-568f4cfbae2d
3: I1207 01:24:44.669632 16057 slave.cpp:4636] Handling status update
TASK_STARTING (UUID: 1aa43fd0-d51e-46de-8cc9-e9d07e98a0c8) for task
8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000 from executor(1)@172.17.0.4:41330
3: I1207 01:24:44.672492 16055 task_status_update_manager.cpp:328] Received
task status update TASK_STARTING (UUID: 1aa43fd0-d51e-46de-8cc9-e9d07e98a0c8)
for task 8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000
3: I1207 01:24:44.672590 16055 task_status_update_manager.cpp:507] Creating
StatusUpdate stream for task 8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000
3: I1207 01:24:44.673719 16055 task_status_update_manager.cpp:383] Forwarding
task status update TASK_STARTING (UUID: 1aa43fd0-d51e-46de-8cc9-e9d07e98a0c8)
for task 8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000 to the agent
3: I1207 01:24:44.674124 16062 slave.cpp:5119] Forwarding the update
TASK_STARTING (UUID: 1aa43fd0-d51e-46de-8cc9-e9d07e98a0c8) for task
8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000 to [email protected]:39462
3: I1207 01:24:44.674561 16062 slave.cpp:5012] Task status update manager
successfully handled status update TASK_STARTING (UUID:
1aa43fd0-d51e-46de-8cc9-e9d07e98a0c8) for task
8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000
3: I1207 01:24:44.674646 16062 slave.cpp:5028] Sending acknowledgement for
status update TASK_STARTING (UUID: 1aa43fd0-d51e-46de-8cc9-e9d07e98a0c8) for
task 8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000 to executor(1)@172.17.0.4:41330
3: I1207 01:24:44.674937 16056 master.cpp:7689] Status update TASK_STARTING
(UUID: 1aa43fd0-d51e-46de-8cc9-e9d07e98a0c8) for task
8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000 from agent
cd0a9c18-18a5-40d6-a064-1986155053a4-S0 at slave(110)@172.17.0.4:39462
(18571b98d89c)
3: I1207 01:24:44.675038 16056 master.cpp:7745] Forwarding status update
TASK_STARTING (UUID: 1aa43fd0-d51e-46de-8cc9-e9d07e98a0c8) for task
8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000
3: I1207 01:24:44.675366 16056 master.cpp:9964] Updating the state of task
8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000 (latest state: TASK_STARTING, status
update state: TASK_STARTING)
3: I1207 01:24:44.675771 16044 sched.cpp:1029] Scheduler::statusUpdate took
144683ns
3: I1207 01:24:44.676317 16049 master.cpp:5790] Processing ACKNOWLEDGE call
1aa43fd0-d51e-46de-8cc9-e9d07e98a0c8 for task
8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000 (default) at
[email protected]:39462 on agent
cd0a9c18-18a5-40d6-a064-1986155053a4-S0
3: I1207 01:24:44.676964 16053 task_status_update_manager.cpp:401] Received
task status update acknowledgement (UUID: 1aa43fd0-d51e-46de-8cc9-e9d07e98a0c8)
for task 8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000
3: I1207 01:24:44.677480 16045 slave.cpp:3920] Task status update manager
successfully handled status update acknowledgement (UUID:
1aa43fd0-d51e-46de-8cc9-e9d07e98a0c8) for task
8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000
3: I1207 01:24:44.685876 18024 executor.cpp:477] Running
'/mesos/build/src/mesos-containerizer launch <POSSIBLY-SENSITIVE-DATA>'
3: I1207 01:24:44.690498 18024 executor.cpp:650] Forked command at 18045
3: I1207 01:24:44.694351 16061 slave.cpp:4636] Handling status update
TASK_RUNNING (UUID: b208f2a2-d8b2-4498-9a93-57c6b3319fdd) for task
8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000 from executor(1)@172.17.0.4:41330
3: I1207 01:24:44.696379 16042 task_status_update_manager.cpp:328] Received
task status update TASK_RUNNING (UUID: b208f2a2-d8b2-4498-9a93-57c6b3319fdd)
for task 8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000
3: I1207 01:24:44.696658 16042 task_status_update_manager.cpp:383] Forwarding
task status update TASK_RUNNING (UUID: b208f2a2-d8b2-4498-9a93-57c6b3319fdd)
for task 8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000 to the agent
3: I1207 01:24:44.696998 16054 slave.cpp:5119] Forwarding the update
TASK_RUNNING (UUID: b208f2a2-d8b2-4498-9a93-57c6b3319fdd) for task
8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000 to [email protected]:39462
3: I1207 01:24:44.697356 16054 slave.cpp:5012] Task status update manager
successfully handled status update TASK_RUNNING (UUID:
b208f2a2-d8b2-4498-9a93-57c6b3319fdd) for task
8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000
3: I1207 01:24:44.697434 16054 slave.cpp:5028] Sending acknowledgement for
status update TASK_RUNNING (UUID: b208f2a2-d8b2-4498-9a93-57c6b3319fdd) for
task 8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000 to executor(1)@172.17.0.4:41330
3: I1207 01:24:44.697717 16046 master.cpp:7689] Status update TASK_RUNNING
(UUID: b208f2a2-d8b2-4498-9a93-57c6b3319fdd) for task
8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000 from agent
cd0a9c18-18a5-40d6-a064-1986155053a4-S0 at slave(110)@172.17.0.4:39462
(18571b98d89c)
3: I1207 01:24:44.697808 16046 master.cpp:7745] Forwarding status update
TASK_RUNNING (UUID: b208f2a2-d8b2-4498-9a93-57c6b3319fdd) for task
8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000
3: I1207 01:24:44.698119 16046 master.cpp:9964] Updating the state of task
8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000 (latest state: TASK_RUNNING, status
update state: TASK_RUNNING)
3: I1207 01:24:44.698496 16055 sched.cpp:1029] Scheduler::statusUpdate took
135740ns
3: I1207 01:24:44.698940 16062 master.cpp:5790] Processing ACKNOWLEDGE call
b208f2a2-d8b2-4498-9a93-57c6b3319fdd for task
8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000 (default) at
[email protected]:39462 on agent
cd0a9c18-18a5-40d6-a064-1986155053a4-S0
3: I1207 01:24:44.699450 16044 task_status_update_manager.cpp:401] Received
task status update acknowledgement (UUID: b208f2a2-d8b2-4498-9a93-57c6b3319fdd)
for task 8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000
3: I1207 01:24:44.699868 16049 slave.cpp:3920] Task status update manager
successfully handled status update acknowledgement (UUID:
b208f2a2-d8b2-4498-9a93-57c6b3319fdd) for task
8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000
3: W1207 01:24:44.701014 16039 process.cpp:2756] Attempted to spawn already
running process [email protected]:39462
3: I1207 01:24:44.702425 16039 sched.cpp:232] Version: 1.5.0
3: I1207 01:24:44.703780 16061 sched.cpp:336] New master detected at
[email protected]:39462
3: I1207 01:24:44.703986 16061 sched.cpp:396] Authenticating with master
[email protected]:39462
3: I1207 01:24:44.704015 16061 sched.cpp:403] Using default CRAM-MD5
authenticatee
3: I1207 01:24:44.704527 16060 authenticatee.cpp:121] Creating new client SASL
connection
3: I1207 01:24:44.705021 16059 master.cpp:8738] Authenticating
[email protected]:39462
3: I1207 01:24:44.705287 16052 authenticator.cpp:414] Starting authentication
session for crammd5-authenticatee(237)@172.17.0.4:39462
3: I1207 01:24:44.705742 16041 authenticator.cpp:98] Creating new server SASL
connection
3: I1207 01:24:44.706166 16048 authenticatee.cpp:213] Received SASL
authentication mechanisms: CRAM-MD5
3: I1207 01:24:44.706212 16048 authenticatee.cpp:239] Attempting to
authenticate with mechanism 'CRAM-MD5'
3: I1207 01:24:44.706419 16043 authenticator.cpp:204] Received SASL
authentication start
3: I1207 01:24:44.706499 16043 authenticator.cpp:326] Authentication requires
more steps
3: I1207 01:24:44.706681 16043 authenticatee.cpp:259] Received SASL
authentication step
3: I1207 01:24:44.706919 16051 authenticator.cpp:232] Received SASL
authentication step
3: I1207 01:24:44.706976 16051 auxprop.cpp:109] Request to lookup properties
for user: 'test-principal' realm: '18571b98d89c' server FQDN: '18571b98d89c'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: false
3: I1207 01:24:44.706997 16051 auxprop.cpp:181] Looking up auxiliary property
'*userPassword'
3: I1207 01:24:44.707074 16051 auxprop.cpp:181] Looking up auxiliary property
'*cmusaslsecretCRAM-MD5'
3: I1207 01:24:44.707104 16051 auxprop.cpp:109] Request to lookup properties
for user: 'test-principal' realm: '18571b98d89c' server FQDN: '18571b98d89c'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: true
3: I1207 01:24:44.707120 16051 auxprop.cpp:131] Skipping auxiliary property
'*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1207 01:24:44.707129 16051 auxprop.cpp:131] Skipping auxiliary property
'*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1207 01:24:44.707151 16051 authenticator.cpp:318] Authentication success
3: I1207 01:24:44.707314 16047 authenticatee.cpp:299] Authentication success
3: I1207 01:24:44.707520 16058 master.cpp:8768] Successfully authenticated
principal 'test-principal' at
[email protected]:39462
3: I1207 01:24:44.707531 16047 authenticator.cpp:432] Authentication session
cleanup for crammd5-authenticatee(237)@172.17.0.4:39462
3: I1207 01:24:44.707895 16042 sched.cpp:502] Successfully authenticated with
master [email protected]:39462
3: I1207 01:24:44.707931 16042 sched.cpp:824] Sending SUBSCRIBE call to
[email protected]:39462
3: I1207 01:24:44.708118 16042 sched.cpp:857] Will retry registration in
598.158028ms if necessary
3: I1207 01:24:44.708410 16044 master.cpp:2960] Received SUBSCRIBE call for
framework 'default' at
[email protected]:39462
3: I1207 01:24:44.708504 16044 master.cpp:2277] Authorizing framework principal
'test-principal' to receive offers for roles '{ * }'
3: I1207 01:24:44.709496 16063 master.cpp:3040] Subscribing framework default
with checkpointing disabled and capabilities [ MULTI_ROLE,
RESERVATION_REFINEMENT, PARTITION_AWARE ]
3: I1207 01:24:44.709880 16063 master.cpp:8959] Adding framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001 (default) at
[email protected]:39462 with roles { }
suppressed
3: I1207 01:24:44.710522 16053 hierarchical.cpp:297] Added framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001
3: I1207 01:24:44.710536 16045 sched.cpp:751] Framework registered with
cd0a9c18-18a5-40d6-a064-1986155053a4-0001
3: I1207 01:24:44.710611 16045 sched.cpp:765] Scheduler::registered took 38692ns
3: I1207 01:24:44.713057 16053 hierarchical.cpp:1527] Performed allocation for
1 agents in 2.270073ms
3: I1207 01:24:44.713886 16040 master.cpp:8568] Sending 1 offers to framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001 (default) at
[email protected]:39462
3: I1207 01:24:44.714728 16061 sched.cpp:921] Scheduler::resourceOffers took
153436ns
3: I1207 01:24:44.717455 16060 master.cpp:10488] Removing offer
cd0a9c18-18a5-40d6-a064-1986155053a4-O1
3: I1207 01:24:44.717664 16060 master.cpp:4227] Processing ACCEPT call for
offers: [ cd0a9c18-18a5-40d6-a064-1986155053a4-O1 ] on agent
cd0a9c18-18a5-40d6-a064-1986155053a4-S0 at slave(110)@172.17.0.4:39462
(18571b98d89c) for framework cd0a9c18-18a5-40d6-a064-1986155053a4-0001
(default) at [email protected]:39462
3: I1207 01:24:44.717792 16060 master.cpp:3596] Authorizing framework principal
'test-principal' to launch task 49debeaa-a135-4ecf-93d0-4e5d94efaf50
3: I1207 01:24:44.720377 16048 master.cpp:11240] Adding task
49debeaa-a135-4ecf-93d0-4e5d94efaf50 with resources cpus(allocated: *):1;
mem(allocated: *):512 on agent cd0a9c18-18a5-40d6-a064-1986155053a4-S0 at
slave(110)@172.17.0.4:39462 (18571b98d89c)
3: I1207 01:24:44.720751 16048 master.cpp:4975] Launching task
49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001 (default) at
[email protected]:39462 with resources
[{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}]
on agent cd0a9c18-18a5-40d6-a064-1986155053a4-S0 at
slave(110)@172.17.0.4:39462 (18571b98d89c)
3: I1207 01:24:44.722041 16043 slave.cpp:1866] Got assigned task
'49debeaa-a135-4ecf-93d0-4e5d94efaf50' for framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001
3: I1207 01:24:44.722301 16054 hierarchical.cpp:1202] Recovered
ports(allocated: *):[31000-32000]; disk(allocated: *):367463 (total: cpus:2;
mem:1024; disk:367463; ports:[31000-32000], allocated: cpus(allocated: *):2;
mem(allocated: *):1024) on agent cd0a9c18-18a5-40d6-a064-1986155053a4-S0 from
framework cd0a9c18-18a5-40d6-a064-1986155053a4-0001
3: I1207 01:24:44.722406 16054 hierarchical.cpp:1248] Framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001 filtered agent
cd0a9c18-18a5-40d6-a064-1986155053a4-S0 for 5secs
3: I1207 01:24:44.723183 16043 slave.cpp:2134] Authorizing task
'49debeaa-a135-4ecf-93d0-4e5d94efaf50' for framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001
3: I1207 01:24:44.723276 16043 slave.cpp:7529] Authorizing framework principal
'test-principal' to launch task 49debeaa-a135-4ecf-93d0-4e5d94efaf50
3: I1207 01:24:44.724411 16046 slave.cpp:2302] Launching task
'49debeaa-a135-4ecf-93d0-4e5d94efaf50' for framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001
3: I1207 01:24:44.725203 16046 paths.cpp:702] Trying to chown
'/tmp/PartitionTest_PartitionedSlaveReregistrationMasterFailover_TtBjhU/slaves/cd0a9c18-18a5-40d6-a064-1986155053a4-S0/frameworks/cd0a9c18-18a5-40d6-a064-1986155053a4-0001/executors/49debeaa-a135-4ecf-93d0-4e5d94efaf50/runs/2284b294-9cd3-43da-944e-203509a46f5a'
to user 'mesos'
3: I1207 01:24:44.725548 16046 slave.cpp:8003] Launching executor
'49debeaa-a135-4ecf-93d0-4e5d94efaf50' of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001 with resources
[{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":0.1},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":32.0},"type":"SCALAR"}]
in work directory
'/tmp/PartitionTest_PartitionedSlaveReregistrationMasterFailover_TtBjhU/slaves/cd0a9c18-18a5-40d6-a064-1986155053a4-S0/frameworks/cd0a9c18-18a5-40d6-a064-1986155053a4-0001/executors/49debeaa-a135-4ecf-93d0-4e5d94efaf50/runs/2284b294-9cd3-43da-944e-203509a46f5a'
3: I1207 01:24:44.726498 16046 slave.cpp:2993] Launching container
2284b294-9cd3-43da-944e-203509a46f5a for executor
'49debeaa-a135-4ecf-93d0-4e5d94efaf50' of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001
3: I1207 01:24:44.726862 16047 containerizer.cpp:1201] Starting container
2284b294-9cd3-43da-944e-203509a46f5a
3: I1207 01:24:44.726933 16046 slave.cpp:2530] Queued task
'49debeaa-a135-4ecf-93d0-4e5d94efaf50' for executor
'49debeaa-a135-4ecf-93d0-4e5d94efaf50' of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001
3: I1207 01:24:44.727066 16046 slave.cpp:979] Successfully attached
'/tmp/PartitionTest_PartitionedSlaveReregistrationMasterFailover_TtBjhU/slaves/cd0a9c18-18a5-40d6-a064-1986155053a4-S0/frameworks/cd0a9c18-18a5-40d6-a064-1986155053a4-0001/executors/49debeaa-a135-4ecf-93d0-4e5d94efaf50/runs/2284b294-9cd3-43da-944e-203509a46f5a'
to virtual path
'/tmp/PartitionTest_PartitionedSlaveReregistrationMasterFailover_TtBjhU/slaves/cd0a9c18-18a5-40d6-a064-1986155053a4-S0/frameworks/cd0a9c18-18a5-40d6-a064-1986155053a4-0001/executors/49debeaa-a135-4ecf-93d0-4e5d94efaf50/runs/latest'
3: I1207 01:24:44.727133 16046 slave.cpp:979] Successfully attached
'/tmp/PartitionTest_PartitionedSlaveReregistrationMasterFailover_TtBjhU/slaves/cd0a9c18-18a5-40d6-a064-1986155053a4-S0/frameworks/cd0a9c18-18a5-40d6-a064-1986155053a4-0001/executors/49debeaa-a135-4ecf-93d0-4e5d94efaf50/runs/2284b294-9cd3-43da-944e-203509a46f5a'
to virtual path
'/frameworks/cd0a9c18-18a5-40d6-a064-1986155053a4-0001/executors/49debeaa-a135-4ecf-93d0-4e5d94efaf50/runs/latest'
3: I1207 01:24:44.727187 16046 slave.cpp:979] Successfully attached
'/tmp/PartitionTest_PartitionedSlaveReregistrationMasterFailover_TtBjhU/slaves/cd0a9c18-18a5-40d6-a064-1986155053a4-S0/frameworks/cd0a9c18-18a5-40d6-a064-1986155053a4-0001/executors/49debeaa-a135-4ecf-93d0-4e5d94efaf50/runs/2284b294-9cd3-43da-944e-203509a46f5a'
to virtual path
'/tmp/PartitionTest_PartitionedSlaveReregistrationMasterFailover_TtBjhU/slaves/cd0a9c18-18a5-40d6-a064-1986155053a4-S0/frameworks/cd0a9c18-18a5-40d6-a064-1986155053a4-0001/executors/49debeaa-a135-4ecf-93d0-4e5d94efaf50/runs/2284b294-9cd3-43da-944e-203509a46f5a'
3: I1207 01:24:44.728008 16047 containerizer.cpp:1373] Checkpointed
ContainerConfig at
'/tmp/PartitionTest_PartitionedSlaveReregistrationMasterFailover_e0oxyE/containers/2284b294-9cd3-43da-944e-203509a46f5a/config'
3: I1207 01:24:44.728055 16047 containerizer.cpp:2930] Transitioning the state
of container 2284b294-9cd3-43da-944e-203509a46f5a from PROVISIONING to PREPARING
3: I1207 01:24:44.734264 16057 containerizer.cpp:1842] Launching
'mesos-containerizer' with flags '--help="false"
--launch_info="{"command":{"arguments":["mesos-executor","--launcher_dir=\/mesos\/build\/src"],"shell":false,"value":"\/mesos\/build\/src\/mesos-executor"},"environment":{"variables":[{"name":"LIBPROCESS_PORT","type":"VALUE","value":"0"},{"name":"MESOS_AGENT_ENDPOINT","type":"VALUE","value":"172.17.0.4:39462"},{"name":"MESOS_CHECKPOINT","type":"VALUE","value":"0"},{"name":"MESOS_DIRECTORY","type":"VALUE","value":"\/tmp\/PartitionTest_PartitionedSlaveReregistrationMasterFailover_TtBjhU\/slaves\/cd0a9c18-18a5-40d6-a064-1986155053a4-S0\/frameworks\/cd0a9c18-18a5-40d6-a064-1986155053a4-0001\/executors\/49debeaa-a135-4ecf-93d0-4e5d94efaf50\/runs\/2284b294-9cd3-43da-944e-203509a46f5a"},{"name":"MESOS_EXECUTOR_ID","type":"VALUE","value":"49debeaa-a135-4ecf-93d0-4e5d94efaf50"},{"name":"MESOS_EXECUTOR_SHUTDOWN_GRACE_PERIOD","type":"VALUE","value":"5secs"},{"name":"MESOS_FRAMEWORK_ID","type":"VALUE","value":"cd0a9c18-18a5-40d6-a064-1986155053a4-0001"},{"name":"MESOS_HTTP_COMMAND_EXECUTOR","type":"VALUE","value":"0"},{"name":"MESOS_SLAVE_ID","type":"VALUE","value":"cd0a9c18-18a5-40d6-a064-1986155053a4-S0"},{"name":"MESOS_SLAVE_PID","type":"VALUE","value":"slave(110)@172.17.0.4:39462"},{"name":"MESOS_SANDBOX","type":"VALUE","value":"\/tmp\/PartitionTest_PartitionedSlaveReregistrationMasterFailover_TtBjhU\/slaves\/cd0a9c18-18a5-40d6-a064-1986155053a4-S0\/frameworks\/cd0a9c18-18a5-40d6-a064-1986155053a4-0001\/executors\/49debeaa-a135-4ecf-93d0-4e5d94efaf50\/runs\/2284b294-9cd3-43da-944e-203509a46f5a"}]},"task_environment":{},"user":"mesos","working_directory":"\/tmp\/PartitionTest_PartitionedSlaveReregistrationMasterFailover_TtBjhU\/slaves\/cd0a9c18-18a5-40d6-a064-1986155053a4-S0\/frameworks\/cd0a9c18-18a5-40d6-a064-1986155053a4-0001\/executors\/49debeaa-a135-4ecf-93d0-4e5d94efaf50\/runs\/2284b294-9cd3-43da-944e-203509a46f5a"}"
--pipe_read="9" --pipe_write="10"
--runtime_directory="/tmp/PartitionTest_PartitionedSlaveReregistrationMasterFailover_e0oxyE/containers/2284b294-9cd3-43da-944e-203509a46f5a"
--unshare_namespace_mnt="false"'
3: I1207 01:24:44.737740 16057 launcher.cpp:140] Forked child with pid '18046'
for container '2284b294-9cd3-43da-944e-203509a46f5a'
3: I1207 01:24:44.738428 16057 containerizer.cpp:2930] Transitioning the state
of container 2284b294-9cd3-43da-944e-203509a46f5a from PREPARING to ISOLATING
3: I1207 01:24:44.740550 16057 containerizer.cpp:2930] Transitioning the state
of container 2284b294-9cd3-43da-944e-203509a46f5a from ISOLATING to FETCHING
3: I1207 01:24:44.740886 16047 fetcher.cpp:380] Starting to fetch URIs for
container: 2284b294-9cd3-43da-944e-203509a46f5a, directory:
/tmp/PartitionTest_PartitionedSlaveReregistrationMasterFailover_TtBjhU/slaves/cd0a9c18-18a5-40d6-a064-1986155053a4-S0/frameworks/cd0a9c18-18a5-40d6-a064-1986155053a4-0001/executors/49debeaa-a135-4ecf-93d0-4e5d94efaf50/runs/2284b294-9cd3-43da-944e-203509a46f5a
3: I1207 01:24:44.742189 16049 containerizer.cpp:2930] Transitioning the state
of container 2284b294-9cd3-43da-944e-203509a46f5a from FETCHING to RUNNING
3: I1207 01:24:45.065726 18061 exec.cpp:162] Version: 1.5.0
3: I1207 01:24:45.081804 16053 slave.cpp:4182] Got registration for executor
'49debeaa-a135-4ecf-93d0-4e5d94efaf50' of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001 from executor(1)@172.17.0.4:32880
3: I1207 01:24:45.085716 16043 slave.cpp:2732] Sending queued task
'49debeaa-a135-4ecf-93d0-4e5d94efaf50' to executor
'49debeaa-a135-4ecf-93d0-4e5d94efaf50' of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001 at executor(1)@172.17.0.4:32880
3: I1207 01:24:45.090911 18068 exec.cpp:237] Executor registered on agent
cd0a9c18-18a5-40d6-a064-1986155053a4-S0
3: I1207 01:24:45.096355 18072 executor.cpp:171] Received SUBSCRIBED event
3: I1207 01:24:45.097993 18072 executor.cpp:175] Subscribed executor on
18571b98d89c
3: I1207 01:24:45.098274 18072 executor.cpp:171] Received LAUNCH event
3: I1207 01:24:45.100904 18072 executor.cpp:637] Starting task
49debeaa-a135-4ecf-93d0-4e5d94efaf50
3: I1207 01:24:45.104774 16042 slave.cpp:4636] Handling status update
TASK_STARTING (UUID: f9c82e92-17f8-42fb-90b2-98cb84015b8a) for task
49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001 from executor(1)@172.17.0.4:32880
3: I1207 01:24:45.107380 16053 task_status_update_manager.cpp:328] Received
task status update TASK_STARTING (UUID: f9c82e92-17f8-42fb-90b2-98cb84015b8a)
for task 49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001
3: I1207 01:24:45.107450 16053 task_status_update_manager.cpp:507] Creating
StatusUpdate stream for task 49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001
3: I1207 01:24:45.108530 16053 task_status_update_manager.cpp:383] Forwarding
task status update TASK_STARTING (UUID: f9c82e92-17f8-42fb-90b2-98cb84015b8a)
for task 49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001 to the agent
3: I1207 01:24:45.108815 16054 slave.cpp:5119] Forwarding the update
TASK_STARTING (UUID: f9c82e92-17f8-42fb-90b2-98cb84015b8a) for task
49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001 to [email protected]:39462
3: I1207 01:24:45.109156 16054 slave.cpp:5012] Task status update manager
successfully handled status update TASK_STARTING (UUID:
f9c82e92-17f8-42fb-90b2-98cb84015b8a) for task
49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001
3: I1207 01:24:45.109225 16054 slave.cpp:5028] Sending acknowledgement for
status update TASK_STARTING (UUID: f9c82e92-17f8-42fb-90b2-98cb84015b8a) for
task 49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001 to executor(1)@172.17.0.4:32880
3: I1207 01:24:45.109413 16059 master.cpp:7689] Status update TASK_STARTING
(UUID: f9c82e92-17f8-42fb-90b2-98cb84015b8a) for task
49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001 from agent
cd0a9c18-18a5-40d6-a064-1986155053a4-S0 at slave(110)@172.17.0.4:39462
(18571b98d89c)
3: I1207 01:24:45.109498 16059 master.cpp:7745] Forwarding status update
TASK_STARTING (UUID: f9c82e92-17f8-42fb-90b2-98cb84015b8a) for task
49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001
3: I1207 01:24:45.109776 16059 master.cpp:9964] Updating the state of task
49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001 (latest state: TASK_STARTING, status
update state: TASK_STARTING)
3: I1207 01:24:45.110435 16058 sched.cpp:1029] Scheduler::statusUpdate took
169759ns
3: I1207 01:24:45.111052 16055 master.cpp:5790] Processing ACKNOWLEDGE call
f9c82e92-17f8-42fb-90b2-98cb84015b8a for task
49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001 (default) at
[email protected]:39462 on agent
cd0a9c18-18a5-40d6-a064-1986155053a4-S0
3: I1207 01:24:45.111673 16060 task_status_update_manager.cpp:401] Received
task status update acknowledgement (UUID: f9c82e92-17f8-42fb-90b2-98cb84015b8a)
for task 49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001
3: I1207 01:24:45.112160 16052 slave.cpp:3920] Task status update manager
successfully handled status update acknowledgement (UUID:
f9c82e92-17f8-42fb-90b2-98cb84015b8a) for task
49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001
3: I1207 01:24:45.121299 18072 executor.cpp:477] Running
'/mesos/build/src/mesos-containerizer launch <POSSIBLY-SENSITIVE-DATA>'
3: I1207 01:24:45.125396 18072 executor.cpp:650] Forked command at 18074
3: I1207 01:24:45.129005 16050 slave.cpp:4636] Handling status update
TASK_RUNNING (UUID: a14daaae-08bb-4c91-be33-591fa6ddbc0c) for task
49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001 from executor(1)@172.17.0.4:32880
3: I1207 01:24:45.131047 16045 task_status_update_manager.cpp:328] Received
task status update TASK_RUNNING (UUID: a14daaae-08bb-4c91-be33-591fa6ddbc0c)
for task 49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001
3: I1207 01:24:45.131228 16045 task_status_update_manager.cpp:383] Forwarding
task status update TASK_RUNNING (UUID: a14daaae-08bb-4c91-be33-591fa6ddbc0c)
for task 49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001 to the agent
3: I1207 01:24:45.131489 16040 slave.cpp:5119] Forwarding the update
TASK_RUNNING (UUID: a14daaae-08bb-4c91-be33-591fa6ddbc0c) for task
49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001 to [email protected]:39462
3: I1207 01:24:45.131743 16040 slave.cpp:5012] Task status update manager
successfully handled status update TASK_RUNNING (UUID:
a14daaae-08bb-4c91-be33-591fa6ddbc0c) for task
49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001
3: I1207 01:24:45.131800 16040 slave.cpp:5028] Sending acknowledgement for
status update TASK_RUNNING (UUID: a14daaae-08bb-4c91-be33-591fa6ddbc0c) for
task 49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001 to executor(1)@172.17.0.4:32880
3: I1207 01:24:45.131997 16061 master.cpp:7689] Status update TASK_RUNNING
(UUID: a14daaae-08bb-4c91-be33-591fa6ddbc0c) for task
49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001 from agent
cd0a9c18-18a5-40d6-a064-1986155053a4-S0 at slave(110)@172.17.0.4:39462
(18571b98d89c)
3: I1207 01:24:45.132068 16061 master.cpp:7745] Forwarding status update
TASK_RUNNING (UUID: a14daaae-08bb-4c91-be33-591fa6ddbc0c) for task
49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001
3: I1207 01:24:45.132304 16061 master.cpp:9964] Updating the state of task
49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001 (latest state: TASK_RUNNING, status
update state: TASK_RUNNING)
3: I1207 01:24:45.132663 16053 sched.cpp:1029] Scheduler::statusUpdate took
106232ns
3: I1207 01:24:45.133077 16054 master.cpp:5790] Processing ACKNOWLEDGE call
a14daaae-08bb-4c91-be33-591fa6ddbc0c for task
49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001 (default) at
[email protected]:39462 on agent
cd0a9c18-18a5-40d6-a064-1986155053a4-S0
3: I1207 01:24:45.133541 16058 task_status_update_manager.cpp:401] Received
task status update acknowledgement (UUID: a14daaae-08bb-4c91-be33-591fa6ddbc0c)
for task 49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001
3: I1207 01:24:45.134032 16055 slave.cpp:3920] Task status update manager
successfully handled status update acknowledgement (UUID:
a14daaae-08bb-4c91-be33-591fa6ddbc0c) for task
49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001
3: I1207 01:24:45.138372 16051 hierarchical.cpp:1527] Performed allocation for
1 agents in 398700ns
3: I1207 01:24:45.141093 16045 hierarchical.cpp:1527] Performed allocation for
1 agents in 253100ns
3: I1207 01:24:45.143366 16058 hierarchical.cpp:1527] Performed allocation for
1 agents in 264368ns
3: I1207 01:24:45.145617 16050 hierarchical.cpp:1527] Performed allocation for
1 agents in 173226ns
3: I1207 01:24:45.145946 16049 slave.cpp:6179] Current disk usage 39.62%. Max
allowed age: 3.526401190463889days
3: I1207 01:24:45.148180 16047 master.cpp:8007] Marking agent
cd0a9c18-18a5-40d6-a064-1986155053a4-S0 at slave(110)@172.17.0.4:39462
(18571b98d89c) unreachable: health check timed out
3: I1207 01:24:45.148188 16048 hierarchical.cpp:1527] Performed allocation for
1 agents in 271260ns
3: I1207 01:24:45.148938 16054 registrar.cpp:495] Applied 1 operations in
171548ns; attempting to update the registry
3: I1207 01:24:45.149746 16054 registrar.cpp:552] Successfully updated the
registry in 0ns
3: I1207 01:24:45.150043 16060 master.cpp:8055] Marked agent
cd0a9c18-18a5-40d6-a064-1986155053a4-S0 at slave(110)@172.17.0.4:39462
(18571b98d89c) unreachable: health check timed out
3: I1207 01:24:45.150373 16060 master.cpp:9964] Updating the state of task
49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001 (latest state: TASK_UNREACHABLE,
status update state: TASK_UNREACHABLE)
3: I1207 01:24:45.151113 16041 hierarchical.cpp:610] Removed agent
cd0a9c18-18a5-40d6-a064-1986155053a4-S0
3: I1207 01:24:45.151132 16060 master.cpp:10070] Removing task
49debeaa-a135-4ecf-93d0-4e5d94efaf50 with resources cpus(allocated: *):1;
mem(allocated: *):512 of framework cd0a9c18-18a5-40d6-a064-1986155053a4-0001 on
agent cd0a9c18-18a5-40d6-a064-1986155053a4-S0 at slave(110)@172.17.0.4:39462
(18571b98d89c)
3: I1207 01:24:45.151468 16060 master.cpp:7740] Sending status update
TASK_UNREACHABLE for task 49debeaa-a135-4ecf-93d0-4e5d94efaf50 of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001 'health check timed out'
3: I1207 01:24:45.151760 16060 master.cpp:9964] Updating the state of task
8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000 (latest state: TASK_LOST, status
update state: TASK_LOST)
3: I1207 01:24:45.152041 16052 sched.cpp:1029] Scheduler::statusUpdate took
91078ns
3: I1207 01:24:45.152400 16060 master.cpp:10070] Removing task
8c9391b0-8dd7-4712-8dd0-568f4cfbae2d with resources cpus(allocated: *):1;
mem(allocated: *):512 of framework cd0a9c18-18a5-40d6-a064-1986155053a4-0000 on
agent cd0a9c18-18a5-40d6-a064-1986155053a4-S0 at slave(110)@172.17.0.4:39462
(18571b98d89c)
3: I1207 01:24:45.152739 16060 master.cpp:7740] Sending status update TASK_LOST
for task 8c9391b0-8dd7-4712-8dd0-568f4cfbae2d of framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000 'health check timed out'
3: I1207 01:24:45.153237 16050 sched.cpp:1029] Scheduler::statusUpdate took
82555ns
3: I1207 01:24:45.153435 16060 master.cpp:2129] Notifying framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001 (default) at
[email protected]:39462 of lost agent
cd0a9c18-18a5-40d6-a064-1986155053a4-S0 (18571b98d89c)
3: I1207 01:24:45.153561 16060 master.cpp:2129] Notifying framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000 (default) at
[email protected]:39462 of lost agent
cd0a9c18-18a5-40d6-a064-1986155053a4-S0 (18571b98d89c)
3: I1207 01:24:45.153754 16043 sched.cpp:1091] Lost agent
cd0a9c18-18a5-40d6-a064-1986155053a4-S0
3: I1207 01:24:45.153820 16049 sched.cpp:1091] Lost agent
cd0a9c18-18a5-40d6-a064-1986155053a4-S0
3: I1207 01:24:45.153872 16043 sched.cpp:1102] Scheduler::slaveLost took 70275ns
3: I1207 01:24:45.153898 16049 sched.cpp:1102] Scheduler::slaveLost took 37500ns
3: I1207 01:24:45.155570 16039 master.cpp:1150] Master terminating
3: I1207 01:24:45.155843 16061 hierarchical.cpp:349] Removed framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0001
3: I1207 01:24:45.156158 16061 hierarchical.cpp:349] Removed framework
cd0a9c18-18a5-40d6-a064-1986155053a4-0000
3: I1207 01:24:45.156507 16052 slave.cpp:5251] Got exited event for
[email protected]:39462
3: W1207 01:24:45.156544 16052 slave.cpp:5256] Master disconnected! Waiting for
a new master to be elected
3: I1207 01:24:45.163777 16039 cluster.cpp:172] Creating default 'local'
authorizer
3: I1207 01:24:45.167943 16041 master.cpp:454] Master
7dca68c8-0c55-4a86-aeef-af43cededda5 (18571b98d89c) started on 172.17.0.4:39462
3: I1207 01:24:45.167992 16041 master.cpp:456] Flags at startup: --acls=""
--agent_ping_timeout="15secs" --agent_reregister_timeout="10mins"
--allocation_interval="1secs" --allocator="HierarchicalDRF"
--authenticate_agents="true" --authenticate_frameworks="true"
--authenticate_http_frameworks="true" --authenticate_http_readonly="true"
--authenticate_http_readwrite="true" --authenticators="crammd5"
--authorizers="local" --credentials="/tmp/82a7Z9/credentials"
--filter_gpu_resources="true" --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_agent_ping_timeouts="5" --max_completed_frameworks="50"
--max_completed_tasks_per_framework="1000"
--max_unreachable_tasks_per_framework="1000" --port="5050" --quiet="false"
--recovery_agent_removal_limit="100%" --registry="in_memory"
--registry_fetch_timeout="1mins" --registry_gc_interval="15mins"
--registry_max_agent_age="2weeks" --registry_max_agent_count="102400"
--registry_store_timeout="100secs" --registry_strict="false"
--root_submissions="true" --user_sorter="drf" --version="false"
--webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/82a7Z9/master"
--zk_session_timeout="10secs"
3: I1207 01:24:45.168509 16041 master.cpp:505] Master only allowing
authenticated frameworks to register
3: I1207 01:24:45.168526 16041 master.cpp:511] Master only allowing
authenticated agents to register
3: I1207 01:24:45.168536 16041 master.cpp:517] Master only allowing
authenticated HTTP frameworks to register
3: I1207 01:24:45.168550 16041 credentials.hpp:37] Loading credentials for
authentication from '/tmp/82a7Z9/credentials'
3: I1207 01:24:45.169050 16041 master.cpp:561] Using default 'crammd5'
authenticator
3: I1207 01:24:45.169370 16041 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readonly'
3: I1207 01:24:45.169675 16041 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readwrite'
3: I1207 01:24:45.169926 16041 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-scheduler'
3: I1207 01:24:45.170166 16041 master.cpp:640] Authorization enabled
3: I1207 01:24:45.170418 16042 hierarchical.cpp:175] Initialized hierarchical
allocator process
3: I1207 01:24:45.170522 16051 whitelist_watcher.cpp:77] No whitelist given
3: I1207 01:24:45.175169 16063 master.cpp:2212] Elected as the leading master!
3: I1207 01:24:45.175206 16063 master.cpp:1692] Recovering from registrar
3: I1207 01:24:45.175441 16040 registrar.cpp:347] Recovering registrar
3: I1207 01:24:45.176407 16040 registrar.cpp:391] Successfully fetched the
registry (0B) in 0ns
3: I1207 01:24:45.176632 16040 registrar.cpp:495] Applied 1 operations in
77770ns; attempting to update the registry
3: I1207 01:24:45.177484 16040 registrar.cpp:552] Successfully updated the
registry in 0ns
3: I1207 01:24:45.177680 16040 registrar.cpp:424] Successfully recovered
registrar
3: I1207 01:24:45.178222 16050 master.cpp:1805] Recovered 0 agents from the
registry (135B); allowing 10mins for agents to re-register
3: I1207 01:24:45.178263 16057 hierarchical.cpp:213] Skipping recovery of
hierarchical allocator: nothing to recover
3: I1207 01:24:45.179334 16043 slave.cpp:1028] New master detected at
[email protected]:39462
3: I1207 01:24:45.179370 16060 task_status_update_manager.cpp:181] Pausing
sending task status updates
3: I1207 01:24:45.179469 16049 sched.cpp:330] Scheduler::disconnected took
39439ns
3: I1207 01:24:45.179500 16049 sched.cpp:336] New master detected at
[email protected]:39462
3: I1207 01:24:45.179505 16060 sched.cpp:330] Scheduler::disconnected took
36581ns
3: I1207 01:24:45.179530 16060 sched.cpp:336] New master detected at
[email protected]:39462
3: I1207 01:24:45.179534 16043 slave.cpp:1083] Detecting new master
3: I1207 01:24:45.179677 16049 sched.cpp:396] Authenticating with master
[email protected]:39462
3: I1207 01:24:45.179703 16049 sched.cpp:403] Using default CRAM-MD5
authenticatee
3: I1207 01:24:45.179762 16060 sched.cpp:396] Authenticating with master
[email protected]:39462
3: I1207 01:24:45.179795 16060 sched.cpp:403] Using default CRAM-MD5
authenticatee
3: I1207 01:24:45.180135 16042 authenticatee.cpp:121] Creating new client SASL
connection
3: I1207 01:24:45.180172 16041 authenticatee.cpp:121] Creating new client SASL
connection
3: I1207 01:24:45.180586 16063 master.cpp:8738] Authenticating
[email protected]:39462
3: I1207 01:24:45.180804 16054 authenticator.cpp:414] Starting authentication
session for crammd5-authenticatee(238)@172.17.0.4:39462
3: I1207 01:24:45.180960 16046 slave.cpp:1110] Authenticating with master
[email protected]:39462
3: I1207 01:24:45.180981 16063 master.cpp:8738] Authenticating
[email protected]:39462
3: I1207 01:24:45.181144 16046 slave.cpp:1119] Using default CRAM-MD5
authenticatee
3: I1207 01:24:45.181244 16055 authenticator.cpp:98] Creating new server SASL
connection
3: I1207 01:24:45.181288 16054 authenticator.cpp:414] Starting authentication
session for crammd5-authenticatee(239)@172.17.0.4:39462
3: I1207 01:24:45.181463 16059 authenticatee.cpp:121] Creating new client SASL
connection
3: I1207 01:24:45.181608 16048 authenticatee.cpp:213] Received SASL
authentication mechanisms: CRAM-MD5
3: I1207 01:24:45.181650 16048 authenticatee.cpp:239] Attempting to
authenticate with mechanism 'CRAM-MD5'
3: I1207 01:24:45.181680 16047 authenticator.cpp:98] Creating new server SASL
connection
3: I1207 01:24:45.181799 16059 authenticator.cpp:204] Received SASL
authentication start
3: I1207 01:24:45.181888 16059 authenticator.cpp:326] Authentication requires
more steps
3: I1207 01:24:45.181907 16045 master.cpp:8738] Authenticating
slave(110)@172.17.0.4:39462
3: I1207 01:24:45.182049 16061 authenticatee.cpp:213] Received SASL
authentication mechanisms: CRAM-MD5
3: I1207 01:24:45.182092 16061 authenticatee.cpp:239] Attempting to
authenticate with mechanism 'CRAM-MD5'
3: I1207 01:24:45.182087 16059 authenticator.cpp:414] Starting authentication
session for crammd5-authenticatee(240)@172.17.0.4:39462
3: I1207 01:24:45.182101 16062 authenticatee.cpp:259] Received SASL
authentication step
3: I1207 01:24:45.182265 16061 authenticator.cpp:204] Received SASL
authentication start
3: I1207 01:24:45.182346 16061 authenticator.cpp:326] Authentication requires
more steps
3: I1207 01:24:45.182363 16057 authenticator.cpp:232] Received SASL
authentication step
3: I1207 01:24:45.182409 16057 auxprop.cpp:109] Request to lookup properties
for user: 'test-principal' realm: '18571b98d89c' server FQDN: '18571b98d89c'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: false
3: I1207 01:24:45.182432 16057 auxprop.cpp:181] Looking up auxiliary property
'*userPassword'
3: I1207 01:24:45.182442 16062 authenticator.cpp:98] Creating new server SASL
connection
3: I1207 01:24:45.182495 16057 auxprop.cpp:181] Looking up auxiliary property
'*cmusaslsecretCRAM-MD5'
3: I1207 01:24:45.182535 16057 auxprop.cpp:109] Request to lookup properties
for user: 'test-principal' realm: '18571b98d89c' server FQDN: '18571b98d89c'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: true
3: I1207 01:24:45.182546 16053 authenticatee.cpp:259] Received SASL
authentication step
3: I1207 01:24:45.182559 16057 auxprop.cpp:131] Skipping auxiliary property
'*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1207 01:24:45.182572 16057 auxprop.cpp:131] Skipping auxiliary property
'*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1207 01:24:45.182600 16057 authenticator.cpp:318] Authentication success
write /dev/stdout: resource temporarily unavailable
+ docker rmi mesos-1512607602-15860
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user [email protected]
Not sending mail to unregistered user [email protected]
