mesos-builds mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Jenkins Server <jenk...@builds.apache.org>
Subject Build failed in Jenkins: Mesos-Buildbot » cmake,gcc,--verbose --disable-libtool-wrappers,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4582
Date Tue, 12 Dec 2017 05:31:05 GMT
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,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)/4582/display/redirect?page=changes>

Changes:

[yujie.jay] Fixed the agent state endpoint to show proper agent capabilities.

[bmahler] Enforced quota limit in the presence of unallocated reservations.

------------------------------------------
[...truncated 2.51 MB...]
3: I1212 04:46:12.803277 17378 authenticator.cpp:204] Received SASL authentication start
3: I1212 04:46:12.803340 17378 authenticator.cpp:326] Authentication requires more steps
3: I1212 04:46:12.803465 17380 authenticatee.cpp:259] Received SASL authentication step
3: I1212 04:46:12.803603 17375 authenticator.cpp:232] Received SASL authentication step
3: I1212 04:46:12.803638 17375 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '556fb3122370' server FQDN: '556fb3122370' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
3: I1212 04:46:12.803652 17375 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1212 04:46:12.803694 17375 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1212 04:46:12.803712 17375 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '556fb3122370' server FQDN: '556fb3122370' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
3: I1212 04:46:12.803721 17375 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1212 04:46:12.803730 17375 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1212 04:46:12.803746 17375 authenticator.cpp:318] Authentication success
3: I1212 04:46:12.803818 17382 authenticatee.cpp:299] Authentication success
3: I1212 04:46:12.803944 17382 master.cpp:8918] Successfully authenticated principal 'test-principal' at slave(26)@172.17.0.2:34899
3: I1212 04:46:12.804131 17386 slave.cpp:1207] Successfully authenticated with master master@172.17.0.2:34899
3: I1212 04:46:12.804363 17386 slave.cpp:1684] Will retry registration in 3.127902ms if necessary
3: I1212 04:46:12.804512 17379 master.cpp:6077] Received register agent message from slave(26)@172.17.0.2:34899 (556fb3122370)
3: I1212 04:46:12.804586 17379 master.cpp:3866] Authorizing agent with principal 'test-principal'
3: I1212 04:46:12.804992 17374 master.cpp:6147] Authorized registration of agent at slave(26)@172.17.0.2:34899 (556fb3122370)
3: I1212 04:46:12.805083 17374 master.cpp:6240] Registering agent at slave(26)@172.17.0.2:34899 (556fb3122370) with id 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0
3: I1212 04:46:12.805518 17377 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(48)@172.17.0.2:34899
3: I1212 04:46:12.805716 17381 registrar.cpp:495] Applied 1 operations in 107479ns; attempting to update the registry
3: I1212 04:46:12.806390 17381 registrar.cpp:552] Successfully updated the registry in 612864ns
3: I1212 04:46:12.806594 17382 master.cpp:6288] Admitted agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 at slave(26)@172.17.0.2:34899 (556fb3122370)
3: I1212 04:46:12.807328 17382 master.cpp:6337] Registered agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 at slave(26)@172.17.0.2:34899 (556fb3122370) with cpus:2; mem:1024; disk:1024; ports:[31000-32000]
3: I1212 04:46:12.807436 17384 slave.cpp:1253] Registered with master master@172.17.0.2:34899; given agent ID 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0
3: I1212 04:46:12.807580 17379 task_status_update_manager.cpp:188] Resuming sending task status updates
3: I1212 04:46:12.807826 17386 hierarchical.cpp:574] Added agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 (556fb3122370) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
3: I1212 04:46:12.807965 17384 slave.cpp:1273] Checkpointing SlaveInfo to '/tmp/DefaultExecutorCheckTest_MultipleTasksWithChecks_duTTYN/meta/slaves/6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0/slave.info'
3: I1212 04:46:12.808648 17384 slave.cpp:1330] Forwarding agent update {"offer_operations":{},"resource_categories":{"oversubscribed":true},"resource_version_uuid":"Sr6w8WI\/QjGzU7XeSIoqkA==","slave_id":{"value":"6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0"}}
3: I1212 04:46:12.808869 17384 master.cpp:7238] Received update of agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 at slave(26)@172.17.0.2:34899 (556fb3122370) with total oversubscribed resources {}
3: I1212 04:46:12.809156 17384 master.cpp:7336] Ignoring update on agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 at slave(26)@172.17.0.2:34899 (556fb3122370) as it reports no changes
3: I1212 04:46:12.809537 17386 hierarchical.cpp:1517] Performed allocation for 1 agents in 1.536758ms
3: I1212 04:46:12.810210 17385 master.cpp:8718] Sending 1 offers to framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 (default)
3: I1212 04:46:12.812659 17378 scheduler.cpp:739] Enqueuing event OFFERS received from http://172.17.0.2:34899/master/api/v1/scheduler
3: I1212 04:46:12.815162 17371 scheduler.cpp:247] Sending ACCEPT call to http://172.17.0.2:34899/master/api/v1/scheduler
3: I1212 04:46:12.817167 17375 process.cpp:3503] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
3: I1212 04:46:12.818892 17383 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:42141
3: I1212 04:46:12.819913 17383 master.cpp:10638] Removing offer 6fc54efb-67ac-40fd-a741-346dfd16f1b4-O0
3: I1212 04:46:12.820137 17383 master.cpp:4273] Processing ACCEPT call for offers: [ 6fc54efb-67ac-40fd-a741-346dfd16f1b4-O0 ] on agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 at slave(26)@172.17.0.2:34899 (556fb3122370) for framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 (default)
3: I1212 04:46:12.820284 17383 master.cpp:3593] Authorizing framework principal 'test-principal' to launch task cf181ad6-98cf-430b-85f2-b4041117ef7d
3: I1212 04:46:12.820582 17383 master.cpp:3593] Authorizing framework principal 'test-principal' to launch task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c
3: I1212 04:46:12.824473 17383 master.cpp:11393] Adding task cf181ad6-98cf-430b-85f2-b4041117ef7d with resources cpus(allocated: *):0.1; mem(allocated: *):32; disk(allocated: *):32 on agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 at slave(26)@172.17.0.2:34899 (556fb3122370)
3: I1212 04:46:12.824780 17383 master.cpp:11393] Adding task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c with resources cpus(allocated: *):0.1; mem(allocated: *):32; disk(allocated: *):32 on agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 at slave(26)@172.17.0.2:34899 (556fb3122370)
3: I1212 04:46:12.824899 17383 master.cpp:5227] Launching task group { 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c, cf181ad6-98cf-430b-85f2-b4041117ef7d } of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 (default) with resources cpus(allocated: *):0.2; mem(allocated: *):64; disk(allocated: *):64 on agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 at slave(26)@172.17.0.2:34899 (556fb3122370)
3: I1212 04:46:12.825934 17385 slave.cpp:1807] Got assigned task group containing tasks [ cf181ad6-98cf-430b-85f2-b4041117ef7d, 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c ] for framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:12.826045 17383 hierarchical.cpp:1192] Recovered cpus(allocated: *):1.7; mem(allocated: *):928; disk(allocated: *):928; ports(allocated: *):[31000-32000] (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: cpus(allocated: *):0.3; mem(allocated: *):96; disk(allocated: *):96) on agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 from framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:12.826103 17383 hierarchical.cpp:1238] Framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 filtered agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 for 5secs
3: I1212 04:46:12.827085 17385 slave.cpp:2077] Authorizing task group containing tasks [ cf181ad6-98cf-430b-85f2-b4041117ef7d, 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c ] for framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:12.827155 17385 slave.cpp:7731] Authorizing framework principal 'test-principal' to launch task cf181ad6-98cf-430b-85f2-b4041117ef7d
3: I1212 04:46:12.827343 17385 slave.cpp:7731] Authorizing framework principal 'test-principal' to launch task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c
3: I1212 04:46:12.828831 17380 slave.cpp:2471] Launching task group containing tasks [ cf181ad6-98cf-430b-85f2-b4041117ef7d, 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c ] for framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:12.829427 17380 paths.cpp:702] Trying to chown '/tmp/DefaultExecutorCheckTest_MultipleTasksWithChecks_duTTYN/slaves/6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0/frameworks/6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000/executors/default/runs/2e54567a-4a70-40cd-b893-597034c39dc2' to user 'mesos'
3: I1212 04:46:12.829706 17380 slave.cpp:8205] Launching executor 'default' of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":0.1},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":32.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":32.0},"type":"SCALAR"}] in work directory '/tmp/DefaultExecutorCheckTest_MultipleTasksWithChecks_duTTYN/slaves/6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0/frameworks/6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000/executors/default/runs/2e54567a-4a70-40cd-b893-597034c39dc2'
3: I1212 04:46:12.830512 17380 slave.cpp:3023] Launching container 2e54567a-4a70-40cd-b893-597034c39dc2 for executor 'default' of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:12.831156 17380 slave.cpp:2557] Queued task group containing tasks [ cf181ad6-98cf-430b-85f2-b4041117ef7d, 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c ] for executor 'default' of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:12.831277 17380 slave.cpp:984] Successfully attached '/tmp/DefaultExecutorCheckTest_MultipleTasksWithChecks_duTTYN/slaves/6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0/frameworks/6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000/executors/default/runs/2e54567a-4a70-40cd-b893-597034c39dc2' to virtual path '/tmp/DefaultExecutorCheckTest_MultipleTasksWithChecks_duTTYN/slaves/6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0/frameworks/6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000/executors/default/runs/latest'
3: I1212 04:46:12.831324 17380 slave.cpp:984] Successfully attached '/tmp/DefaultExecutorCheckTest_MultipleTasksWithChecks_duTTYN/slaves/6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0/frameworks/6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000/executors/default/runs/2e54567a-4a70-40cd-b893-597034c39dc2' to virtual path '/frameworks/6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000/executors/default/runs/latest'
3: I1212 04:46:12.831357 17380 slave.cpp:984] Successfully attached '/tmp/DefaultExecutorCheckTest_MultipleTasksWithChecks_duTTYN/slaves/6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0/frameworks/6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000/executors/default/runs/2e54567a-4a70-40cd-b893-597034c39dc2' to virtual path '/tmp/DefaultExecutorCheckTest_MultipleTasksWithChecks_duTTYN/slaves/6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0/frameworks/6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000/executors/default/runs/2e54567a-4a70-40cd-b893-597034c39dc2'
3: I1212 04:46:12.831565 17382 containerizer.cpp:1201] Starting container 2e54567a-4a70-40cd-b893-597034c39dc2
3: I1212 04:46:12.832288 17382 containerizer.cpp:1373] Checkpointed ContainerConfig at '/tmp/DefaultExecutorCheckTest_MultipleTasksWithChecks_Glqc78/containers/2e54567a-4a70-40cd-b893-597034c39dc2/config'
3: I1212 04:46:12.832309 17382 containerizer.cpp:2930] Transitioning the state of container 2e54567a-4a70-40cd-b893-597034c39dc2 from PROVISIONING to PREPARING
3: I1212 04:46:12.836858 17385 containerizer.cpp:1842] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"arguments":["mesos-default-executor","--launcher_dir=\/mesos\/build\/src"],"shell":false,"value":"\/mesos\/build\/src\/mesos-default-executor"},"environment":{"variables":[{"name":"LIBPROCESS_PORT","type":"VALUE","value":"0"},{"name":"MESOS_AGENT_ENDPOINT","type":"VALUE","value":"172.17.0.2:34899"},{"name":"MESOS_CHECKPOINT","type":"VALUE","value":"0"},{"name":"MESOS_DIRECTORY","type":"VALUE","value":"\/tmp\/DefaultExecutorCheckTest_MultipleTasksWithChecks_duTTYN\/slaves\/6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0\/frameworks\/6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000\/executors\/default\/runs\/2e54567a-4a70-40cd-b893-597034c39dc2"},{"name":"MESOS_EXECUTOR_ID","type":"VALUE","value":"default"},{"name":"MESOS_EXECUTOR_SHUTDOWN_GRACE_PERIOD","type":"VALUE","value":"5secs"},{"name":"MESOS_FRAMEWORK_ID","type":"VALUE","value":"6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000"},{"name":"MESOS_HTTP_COMMAND_EXECUTOR","type":"VALUE","value":"0"},{"name":"MESOS_SLAVE_ID","type":"VALUE","value":"6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0"},{"name":"MESOS_SLAVE_PID","type":"VALUE","value":"slave(26)@172.17.0.2:34899"},{"name":"MESOS_SANDBOX","type":"VALUE","value":"\/tmp\/DefaultExecutorCheckTest_MultipleTasksWithChecks_duTTYN\/slaves\/6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0\/frameworks\/6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000\/executors\/default\/runs\/2e54567a-4a70-40cd-b893-597034c39dc2"}]},"task_environment":{},"user":"mesos","working_directory":"\/tmp\/DefaultExecutorCheckTest_MultipleTasksWithChecks_duTTYN\/slaves\/6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0\/frameworks\/6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000\/executors\/default\/runs\/2e54567a-4a70-40cd-b893-597034c39dc2"}" --pipe_read="13" --pipe_write="14" --runtime_directory="/tmp/DefaultExecutorCheckTest_MultipleTasksWithChecks_Glqc78/containers/2e54567a-4a70-40cd-b893-597034c39dc2" --unshare_namespace_mnt="false"'
3: I1212 04:46:12.839772 17385 launcher.cpp:140] Forked child with pid '17962' for container '2e54567a-4a70-40cd-b893-597034c39dc2'
3: I1212 04:46:12.840384 17385 containerizer.cpp:2930] Transitioning the state of container 2e54567a-4a70-40cd-b893-597034c39dc2 from PREPARING to ISOLATING
3: I1212 04:46:12.841852 17385 containerizer.cpp:2930] Transitioning the state of container 2e54567a-4a70-40cd-b893-597034c39dc2 from ISOLATING to FETCHING
3: I1212 04:46:12.842075 17373 fetcher.cpp:369] Starting to fetch URIs for container: 2e54567a-4a70-40cd-b893-597034c39dc2, directory: /tmp/DefaultExecutorCheckTest_MultipleTasksWithChecks_duTTYN/slaves/6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0/frameworks/6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000/executors/default/runs/2e54567a-4a70-40cd-b893-597034c39dc2
3: I1212 04:46:12.842985 17372 containerizer.cpp:2930] Transitioning the state of container 2e54567a-4a70-40cd-b893-597034c39dc2 from FETCHING to RUNNING
3: I1212 04:46:13.095166 17972 executor.cpp:192] Version: 1.5.0
3: I1212 04:46:13.105998 17376 process.cpp:3503] Handling HTTP event for process 'slave(26)' with path: '/slave(26)/api/v1/executor'
3: I1212 04:46:13.108214 17377 http.cpp:1185] HTTP POST for /slave(26)/api/v1/executor from 172.17.0.2:42143
3: I1212 04:46:13.108465 17377 slave.cpp:4074] Received Subscribe request for HTTP executor 'default' of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.111889 17381 slave.cpp:2803] Sending queued task group task group containing tasks [ cf181ad6-98cf-430b-85f2-b4041117ef7d, 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c ] to executor 'default' of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 (via HTTP)
3: I1212 04:46:13.119052 17978 default_executor.cpp:191] Received SUBSCRIBED event
3: I1212 04:46:13.122263 17978 default_executor.cpp:195] Subscribed executor on 556fb3122370
3: I1212 04:46:13.123183 17978 default_executor.cpp:191] Received LAUNCH_GROUP event
3: I1212 04:46:13.124804 17977 default_executor.cpp:402] Setting 'MESOS_CONTAINER_IP' to: 172.17.0.2
3: I1212 04:46:13.127849 17372 process.cpp:3503] Handling HTTP event for process 'slave(26)' with path: '/slave(26)/api/v1'
3: I1212 04:46:13.128340 17372 process.cpp:3503] Handling HTTP event for process 'slave(26)' with path: '/slave(26)/api/v1/executor'
3: I1212 04:46:13.129523 17372 http.cpp:1185] HTTP POST for /slave(26)/api/v1 from 172.17.0.2:42145
3: I1212 04:46:13.130357 17372 http.cpp:2405] Processing LAUNCH_NESTED_CONTAINER call for container '2e54567a-4a70-40cd-b893-597034c39dc2.3325be98-bc04-4313-9e45-bfbf5007d67d'
3: I1212 04:46:13.130744 17372 process.cpp:3503] Handling HTTP event for process 'slave(26)' with path: '/slave(26)/api/v1'
3: I1212 04:46:13.131062 17372 http.cpp:1185] HTTP POST for /slave(26)/api/v1/executor from 172.17.0.2:42144
3: I1212 04:46:13.131338 17372 slave.cpp:4732] Handling status update TASK_STARTING (Status UUID: cc951216-bff6-49bf-b4a9-fc8c597fbef1) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.131863 17372 process.cpp:3503] Handling HTTP event for process 'slave(26)' with path: '/slave(26)/api/v1/executor'
3: I1212 04:46:13.132913 17385 containerizer.cpp:1167] Trying to chown '/tmp/DefaultExecutorCheckTest_MultipleTasksWithChecks_duTTYN/slaves/6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0/frameworks/6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000/executors/default/runs/2e54567a-4a70-40cd-b893-597034c39dc2/containers/3325be98-bc04-4313-9e45-bfbf5007d67d' to user 'mesos'
3: I1212 04:46:13.133266 17385 containerizer.cpp:1201] Starting container 2e54567a-4a70-40cd-b893-597034c39dc2.3325be98-bc04-4313-9e45-bfbf5007d67d
3: I1212 04:46:13.133417 17372 http.cpp:1185] HTTP POST for /slave(26)/api/v1 from 172.17.0.2:42145
3: I1212 04:46:13.133481 17377 task_status_update_manager.cpp:328] Received task status update TASK_STARTING (Status UUID: cc951216-bff6-49bf-b4a9-fc8c597fbef1) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.133893 17377 task_status_update_manager.cpp:507] Creating StatusUpdate stream for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.133985 17372 http.cpp:2405] Processing LAUNCH_NESTED_CONTAINER call for container '2e54567a-4a70-40cd-b893-597034c39dc2.53abe0ca-8fa0-4fb0-b98b-929ad413369d'
3: I1212 04:46:13.134201 17385 containerizer.cpp:1373] Checkpointed ContainerConfig at '/tmp/DefaultExecutorCheckTest_MultipleTasksWithChecks_Glqc78/containers/2e54567a-4a70-40cd-b893-597034c39dc2/containers/3325be98-bc04-4313-9e45-bfbf5007d67d/config'
3: I1212 04:46:13.134233 17385 containerizer.cpp:2930] Transitioning the state of container 2e54567a-4a70-40cd-b893-597034c39dc2.3325be98-bc04-4313-9e45-bfbf5007d67d from PROVISIONING to PREPARING
3: I1212 04:46:13.135052 17377 task_status_update_manager.cpp:383] Forwarding task status update TASK_STARTING (Status UUID: cc951216-bff6-49bf-b4a9-fc8c597fbef1) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 to the agent
3: I1212 04:46:13.135277 17372 http.cpp:1185] HTTP POST for /slave(26)/api/v1/executor from 172.17.0.2:42144
3: I1212 04:46:13.135514 17385 containerizer.cpp:1167] Trying to chown '/tmp/DefaultExecutorCheckTest_MultipleTasksWithChecks_duTTYN/slaves/6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0/frameworks/6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000/executors/default/runs/2e54567a-4a70-40cd-b893-597034c39dc2/containers/53abe0ca-8fa0-4fb0-b98b-929ad413369d' to user 'mesos'
3: I1212 04:46:13.135501 17372 slave.cpp:4732] Handling status update TASK_STARTING (Status UUID: 4fde0b68-edd4-4f38-8575-fa370a0bb722) for task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.135722 17385 containerizer.cpp:1201] Starting container 2e54567a-4a70-40cd-b893-597034c39dc2.53abe0ca-8fa0-4fb0-b98b-929ad413369d
3: I1212 04:46:13.136062 17372 slave.cpp:5215] Forwarding the update TASK_STARTING (Status UUID: cc951216-bff6-49bf-b4a9-fc8c597fbef1) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 to master@172.17.0.2:34899
3: I1212 04:46:13.136325 17372 slave.cpp:5108] Task status update manager successfully handled status update TASK_STARTING (Status UUID: cc951216-bff6-49bf-b4a9-fc8c597fbef1) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.136579 17376 master.cpp:7811] Status update TASK_STARTING (Status UUID: cc951216-bff6-49bf-b4a9-fc8c597fbef1) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 from agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 at slave(26)@172.17.0.2:34899 (556fb3122370)
3: I1212 04:46:13.136647 17376 master.cpp:7867] Forwarding status update TASK_STARTING (Status UUID: cc951216-bff6-49bf-b4a9-fc8c597fbef1) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.137135 17376 master.cpp:10114] Updating the state of task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 (latest state: TASK_STARTING, status update state: TASK_STARTING)
3: I1212 04:46:13.137639 17385 containerizer.cpp:1373] Checkpointed ContainerConfig at '/tmp/DefaultExecutorCheckTest_MultipleTasksWithChecks_Glqc78/containers/2e54567a-4a70-40cd-b893-597034c39dc2/containers/53abe0ca-8fa0-4fb0-b98b-929ad413369d/config'
3: I1212 04:46:13.137760 17385 containerizer.cpp:2930] Transitioning the state of container 2e54567a-4a70-40cd-b893-597034c39dc2.53abe0ca-8fa0-4fb0-b98b-929ad413369d from PROVISIONING to PREPARING
3: I1212 04:46:13.138032 17380 scheduler.cpp:739] Enqueuing event UPDATE received from http://172.17.0.2:34899/master/api/v1/scheduler
3: I1212 04:46:13.139808 17972 default_executor.cpp:191] Received ACKNOWLEDGED event
3: I1212 04:46:13.140035 17379 containerizer.cpp:1842] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"shell":true,"value":"sleep 10000"},"environment":{"variables":[{"name":"MESOS_SANDBOX","type":"VALUE","value":"\/tmp\/DefaultExecutorCheckTest_MultipleTasksWithChecks_duTTYN\/slaves\/6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0\/frameworks\/6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000\/executors\/default\/runs\/2e54567a-4a70-40cd-b893-597034c39dc2\/containers\/3325be98-bc04-4313-9e45-bfbf5007d67d"},{"name":"MESOS_CONTAINER_IP","type":"VALUE","value":"172.17.0.2"}]},"task_environment":{},"user":"mesos","working_directory":"\/tmp\/DefaultExecutorCheckTest_MultipleTasksWithChecks_duTTYN\/slaves\/6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0\/frameworks\/6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000\/executors\/default\/runs\/2e54567a-4a70-40cd-b893-597034c39dc2\/containers\/3325be98-bc04-4313-9e45-bfbf5007d67d"}" --pipe_read="16" --pipe_write="17" --runtime_directory="/tmp/DefaultExecutorCheckTest_MultipleTasksWithChecks_Glqc78/containers/2e54567a-4a70-40cd-b893-597034c39dc2/containers/3325be98-bc04-4313-9e45-bfbf5007d67d" --unshare_namespace_mnt="false"'
3: I1212 04:46:13.142509 17379 launcher.cpp:140] Forked child with pid '17981' for container '2e54567a-4a70-40cd-b893-597034c39dc2.3325be98-bc04-4313-9e45-bfbf5007d67d'
3: I1212 04:46:13.143080 17380 scheduler.cpp:247] Sending ACKNOWLEDGE call to http://172.17.0.2:34899/master/api/v1/scheduler
3: I1212 04:46:13.143317 17379 containerizer.cpp:2930] Transitioning the state of container 2e54567a-4a70-40cd-b893-597034c39dc2.3325be98-bc04-4313-9e45-bfbf5007d67d from PREPARING to ISOLATING
3: W1212 04:46:13.144351 17375 containerizer.cpp:2275] Skipping status for container 2e54567a-4a70-40cd-b893-597034c39dc2.53abe0ca-8fa0-4fb0-b98b-929ad413369d because: Container does not exist!
3: I1212 04:46:13.145341 17379 containerizer.cpp:2930] Transitioning the state of container 2e54567a-4a70-40cd-b893-597034c39dc2.3325be98-bc04-4313-9e45-bfbf5007d67d from ISOLATING to FETCHING
3: I1212 04:46:13.145797 17384 fetcher.cpp:369] Starting to fetch URIs for container: 2e54567a-4a70-40cd-b893-597034c39dc2.3325be98-bc04-4313-9e45-bfbf5007d67d, directory: /tmp/DefaultExecutorCheckTest_MultipleTasksWithChecks_duTTYN/slaves/6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0/frameworks/6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000/executors/default/runs/2e54567a-4a70-40cd-b893-597034c39dc2/containers/3325be98-bc04-4313-9e45-bfbf5007d67d
3: I1212 04:46:13.146111 17374 process.cpp:3503] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
3: I1212 04:46:13.146389 17373 task_status_update_manager.cpp:328] Received task status update TASK_STARTING (Status UUID: 4fde0b68-edd4-4f38-8575-fa370a0bb722) for task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.146456 17373 task_status_update_manager.cpp:507] Creating StatusUpdate stream for task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.146953 17379 containerizer.cpp:1842] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"shell":true,"value":"sleep 10000"},"environment":{"variables":[{"name":"MESOS_SANDBOX","type":"VALUE","value":"\/tmp\/DefaultExecutorCheckTest_MultipleTasksWithChecks_duTTYN\/slaves\/6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0\/frameworks\/6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000\/executors\/default\/runs\/2e54567a-4a70-40cd-b893-597034c39dc2\/containers\/53abe0ca-8fa0-4fb0-b98b-929ad413369d"},{"name":"MESOS_CONTAINER_IP","type":"VALUE","value":"172.17.0.2"}]},"task_environment":{},"user":"mesos","working_directory":"\/tmp\/DefaultExecutorCheckTest_MultipleTasksWithChecks_duTTYN\/slaves\/6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0\/frameworks\/6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000\/executors\/default\/runs\/2e54567a-4a70-40cd-b893-597034c39dc2\/containers\/53abe0ca-8fa0-4fb0-b98b-929ad413369d"}" --pipe_read="19" --pipe_write="20" --runtime_directory="/tmp/DefaultExecutorCheckTest_MultipleTasksWithChecks_Glqc78/containers/2e54567a-4a70-40cd-b893-597034c39dc2/containers/53abe0ca-8fa0-4fb0-b98b-929ad413369d" --unshare_namespace_mnt="false"'
3: I1212 04:46:13.147161 17373 task_status_update_manager.cpp:383] Forwarding task status update TASK_STARTING (Status UUID: 4fde0b68-edd4-4f38-8575-fa370a0bb722) for task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 to the agent
3: I1212 04:46:13.147367 17372 slave.cpp:5215] Forwarding the update TASK_STARTING (Status UUID: 4fde0b68-edd4-4f38-8575-fa370a0bb722) for task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 to master@172.17.0.2:34899
3: I1212 04:46:13.149519 17379 launcher.cpp:140] Forked child with pid '17982' for container '2e54567a-4a70-40cd-b893-597034c39dc2.53abe0ca-8fa0-4fb0-b98b-929ad413369d'
3: I1212 04:46:13.149996 17372 slave.cpp:5108] Task status update manager successfully handled status update TASK_STARTING (Status UUID: 4fde0b68-edd4-4f38-8575-fa370a0bb722) for task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.150388 17379 containerizer.cpp:2930] Transitioning the state of container 2e54567a-4a70-40cd-b893-597034c39dc2.53abe0ca-8fa0-4fb0-b98b-929ad413369d from PREPARING to ISOLATING
3: I1212 04:46:13.150436 17383 master.cpp:7811] Status update TASK_STARTING (Status UUID: 4fde0b68-edd4-4f38-8575-fa370a0bb722) for task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 from agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 at slave(26)@172.17.0.2:34899 (556fb3122370)
3: I1212 04:46:13.150508 17383 master.cpp:7867] Forwarding status update TASK_STARTING (Status UUID: 4fde0b68-edd4-4f38-8575-fa370a0bb722) for task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.151067 17383 master.cpp:10114] Updating the state of task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 (latest state: TASK_STARTING, status update state: TASK_STARTING)
3: I1212 04:46:13.152097 17379 containerizer.cpp:2930] Transitioning the state of container 2e54567a-4a70-40cd-b893-597034c39dc2.3325be98-bc04-4313-9e45-bfbf5007d67d from FETCHING to RUNNING
3: I1212 04:46:13.152560 17375 scheduler.cpp:739] Enqueuing event UPDATE received from http://172.17.0.2:34899/master/api/v1/scheduler
3: I1212 04:46:13.153373 17977 default_executor.cpp:191] Received ACKNOWLEDGED event
3: I1212 04:46:13.153972 17379 containerizer.cpp:2930] Transitioning the state of container 2e54567a-4a70-40cd-b893-597034c39dc2.53abe0ca-8fa0-4fb0-b98b-929ad413369d from ISOLATING to FETCHING
3: I1212 04:46:13.154184 17386 fetcher.cpp:369] Starting to fetch URIs for container: 2e54567a-4a70-40cd-b893-597034c39dc2.53abe0ca-8fa0-4fb0-b98b-929ad413369d, directory: /tmp/DefaultExecutorCheckTest_MultipleTasksWithChecks_duTTYN/slaves/6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0/frameworks/6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000/executors/default/runs/2e54567a-4a70-40cd-b893-597034c39dc2/containers/53abe0ca-8fa0-4fb0-b98b-929ad413369d
3: I1212 04:46:13.155356 17386 containerizer.cpp:2930] Transitioning the state of container 2e54567a-4a70-40cd-b893-597034c39dc2.53abe0ca-8fa0-4fb0-b98b-929ad413369d from FETCHING to RUNNING
3: I1212 04:46:13.160187 17373 scheduler.cpp:247] Sending ACKNOWLEDGE call to http://172.17.0.2:34899/master/api/v1/scheduler
3: I1212 04:46:13.183818 17976 default_executor.cpp:640] Successfully launched tasks [ cf181ad6-98cf-430b-85f2-b4041117ef7d, 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c ] in child containers [ 2e54567a-4a70-40cd-b893-597034c39dc2.3325be98-bc04-4313-9e45-bfbf5007d67d, 2e54567a-4a70-40cd-b893-597034c39dc2.53abe0ca-8fa0-4fb0-b98b-929ad413369d ]
3: I1212 04:46:13.186535 17371 process.cpp:3503] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
3: I1212 04:46:13.188908 17382 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:42141
3: I1212 04:46:13.189239 17382 master.cpp:5842] Processing ACKNOWLEDGE call cc951216-bff6-49bf-b4a9-fc8c597fbef1 for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 (default) on agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0
3: I1212 04:46:13.189721 17372 task_status_update_manager.cpp:401] Received task status update acknowledgement (UUID: cc951216-bff6-49bf-b4a9-fc8c597fbef1) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.190074 17375 slave.cpp:4010] Task status update manager successfully handled status update acknowledgement (UUID: cc951216-bff6-49bf-b4a9-fc8c597fbef1) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.191138 17382 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:42141
3: I1212 04:46:13.191295 17382 master.cpp:5842] Processing ACKNOWLEDGE call 4fde0b68-edd4-4f38-8575-fa370a0bb722 for task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 (default) on agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0
3: I1212 04:46:13.191606 17383 task_status_update_manager.cpp:401] Received task status update acknowledgement (UUID: 4fde0b68-edd4-4f38-8575-fa370a0bb722) for task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.191897 17378 slave.cpp:4010] Task status update manager successfully handled status update acknowledgement (UUID: 4fde0b68-edd4-4f38-8575-fa370a0bb722) for task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.196965 17386 process.cpp:3503] Handling HTTP event for process 'slave(26)' with path: '/slave(26)/api/v1/executor'
3: I1212 04:46:13.197434 17976 default_executor.cpp:713] Waiting for child container 2e54567a-4a70-40cd-b893-597034c39dc2.3325be98-bc04-4313-9e45-bfbf5007d67d of task 'cf181ad6-98cf-430b-85f2-b4041117ef7d'
3: I1212 04:46:13.200577 17977 checker_process.cpp:1113] TCP check for task 'cf181ad6-98cf-430b-85f2-b4041117ef7d' returned: 0
3: I1212 04:46:13.202441 17976 default_executor.cpp:713] Waiting for child container 2e54567a-4a70-40cd-b893-597034c39dc2.53abe0ca-8fa0-4fb0-b98b-929ad413369d of task '6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c'
3: I1212 04:46:13.202687 17976 default_executor.cpp:1214] Received check update 'TCP connection failure' for task 'cf181ad6-98cf-430b-85f2-b4041117ef7d'
3: I1212 04:46:13.204223 17375 process.cpp:3503] Handling HTTP event for process 'slave(26)' with path: '/slave(26)/api/v1'
3: I1212 04:46:13.205663 17379 http.cpp:1185] HTTP POST for /slave(26)/api/v1 from 172.17.0.2:42147
3: I1212 04:46:13.206125 17379 process.cpp:3503] Handling HTTP event for process 'slave(26)' with path: '/slave(26)/api/v1'
3: I1212 04:46:13.206638 17379 http.cpp:2632] Processing WAIT_NESTED_CONTAINER call for container '2e54567a-4a70-40cd-b893-597034c39dc2.53abe0ca-8fa0-4fb0-b98b-929ad413369d'
3: I1212 04:46:13.207525 17379 http.cpp:1185] HTTP POST for /slave(26)/api/v1 from 172.17.0.2:42146
3: I1212 04:46:13.207972 17379 http.cpp:2632] Processing WAIT_NESTED_CONTAINER call for container '2e54567a-4a70-40cd-b893-597034c39dc2.3325be98-bc04-4313-9e45-bfbf5007d67d'
3: I1212 04:46:13.235064 17375 process.cpp:3503] Handling HTTP event for process 'slave(26)' with path: '/slave(26)/api/v1/executor'
3: I1212 04:46:13.235703 17375 process.cpp:3503] Handling HTTP event for process 'slave(26)' with path: '/slave(26)/api/v1/executor'
3: I1212 04:46:13.237305 17382 http.cpp:1185] HTTP POST for /slave(26)/api/v1/executor from 172.17.0.2:42144
3: I1212 04:46:13.237696 17382 slave.cpp:4732] Handling status update TASK_RUNNING (Status UUID: afea4b0a-f76b-46a1-86d8-be24e51ed081) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.238921 17382 http.cpp:1185] HTTP POST for /slave(26)/api/v1/executor from 172.17.0.2:42144
3: I1212 04:46:13.239112 17382 slave.cpp:4732] Handling status update TASK_RUNNING (Status UUID: 1754bef7-432b-4ac6-907e-5d00f7eedb31) for task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.240546 17382 http.cpp:1185] HTTP POST for /slave(26)/api/v1/executor from 172.17.0.2:42144
3: I1212 04:46:13.240769 17382 slave.cpp:4732] Handling status update TASK_RUNNING (Status UUID: c3dd94e4-4cac-4e85-8832-e2c11bd20882) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.243571 17382 task_status_update_manager.cpp:328] Received task status update TASK_RUNNING (Status UUID: afea4b0a-f76b-46a1-86d8-be24e51ed081) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.243770 17382 task_status_update_manager.cpp:383] Forwarding task status update TASK_RUNNING (Status UUID: afea4b0a-f76b-46a1-86d8-be24e51ed081) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 to the agent
3: I1212 04:46:13.243980 17376 slave.cpp:5215] Forwarding the update TASK_RUNNING (Status UUID: afea4b0a-f76b-46a1-86d8-be24e51ed081) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 to master@172.17.0.2:34899
3: I1212 04:46:13.244123 17382 task_status_update_manager.cpp:328] Received task status update TASK_RUNNING (Status UUID: 1754bef7-432b-4ac6-907e-5d00f7eedb31) for task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.244230 17376 slave.cpp:5108] Task status update manager successfully handled status update TASK_RUNNING (Status UUID: afea4b0a-f76b-46a1-86d8-be24e51ed081) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.244257 17382 task_status_update_manager.cpp:383] Forwarding task status update TASK_RUNNING (Status UUID: 1754bef7-432b-4ac6-907e-5d00f7eedb31) for task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 to the agent
3: I1212 04:46:13.244591 17382 task_status_update_manager.cpp:328] Received task status update TASK_RUNNING (Status UUID: c3dd94e4-4cac-4e85-8832-e2c11bd20882) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.244626 17376 slave.cpp:5215] Forwarding the update TASK_RUNNING (Status UUID: 1754bef7-432b-4ac6-907e-5d00f7eedb31) for task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 to master@172.17.0.2:34899
3: I1212 04:46:13.244837 17376 slave.cpp:5108] Task status update manager successfully handled status update TASK_RUNNING (Status UUID: 1754bef7-432b-4ac6-907e-5d00f7eedb31) for task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.245029 17376 slave.cpp:5108] Task status update manager successfully handled status update TASK_RUNNING (Status UUID: c3dd94e4-4cac-4e85-8832-e2c11bd20882) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.245383 17385 master.cpp:7811] Status update TASK_RUNNING (Status UUID: afea4b0a-f76b-46a1-86d8-be24e51ed081) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 from agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 at slave(26)@172.17.0.2:34899 (556fb3122370)
3: I1212 04:46:13.246381 17385 master.cpp:7867] Forwarding status update TASK_RUNNING (Status UUID: afea4b0a-f76b-46a1-86d8-be24e51ed081) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.246909 17385 master.cpp:10114] Updating the state of task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
3: I1212 04:46:13.247239 17385 master.cpp:7811] Status update TASK_RUNNING (Status UUID: 1754bef7-432b-4ac6-907e-5d00f7eedb31) for task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 from agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 at slave(26)@172.17.0.2:34899 (556fb3122370)
3: I1212 04:46:13.247290 17385 master.cpp:7867] Forwarding status update TASK_RUNNING (Status UUID: 1754bef7-432b-4ac6-907e-5d00f7eedb31) for task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.247659 17385 master.cpp:10114] Updating the state of task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
3: I1212 04:46:13.248586 17377 scheduler.cpp:739] Enqueuing event UPDATE received from http://172.17.0.2:34899/master/api/v1/scheduler
3: I1212 04:46:13.249563 17386 scheduler.cpp:739] Enqueuing event UPDATE received from http://172.17.0.2:34899/master/api/v1/scheduler
3: I1212 04:46:13.249934 17978 default_executor.cpp:191] Received ACKNOWLEDGED event
3: I1212 04:46:13.250218 17386 scheduler.cpp:247] Sending ACKNOWLEDGE call to http://172.17.0.2:34899/master/api/v1/scheduler
3: I1212 04:46:13.251022 17382 scheduler.cpp:247] Sending ACKNOWLEDGE call to http://172.17.0.2:34899/master/api/v1/scheduler
3: I1212 04:46:13.251121 17972 default_executor.cpp:191] Received ACKNOWLEDGED event
3: I1212 04:46:13.251734 17976 default_executor.cpp:191] Received ACKNOWLEDGED event
3: I1212 04:46:13.253588 17376 process.cpp:3503] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
3: I1212 04:46:13.292052 17381 process.cpp:3503] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
3: I1212 04:46:13.293072 17381 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:42141
3: I1212 04:46:13.293505 17381 master.cpp:5842] Processing ACKNOWLEDGE call afea4b0a-f76b-46a1-86d8-be24e51ed081 for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 (default) on agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0
3: I1212 04:46:13.294736 17381 task_status_update_manager.cpp:401] Received task status update acknowledgement (UUID: afea4b0a-f76b-46a1-86d8-be24e51ed081) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.294983 17378 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:42141
3: I1212 04:46:13.295069 17381 task_status_update_manager.cpp:383] Forwarding task status update TASK_RUNNING (Status UUID: c3dd94e4-4cac-4e85-8832-e2c11bd20882) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 to the agent
3: I1212 04:46:13.295123 17378 master.cpp:5842] Processing ACKNOWLEDGE call 1754bef7-432b-4ac6-907e-5d00f7eedb31 for task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 (default) on agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0
3: I1212 04:46:13.295567 17372 slave.cpp:5215] Forwarding the update TASK_RUNNING (Status UUID: c3dd94e4-4cac-4e85-8832-e2c11bd20882) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 to master@172.17.0.2:34899
3: I1212 04:46:13.296118 17379 task_status_update_manager.cpp:401] Received task status update acknowledgement (UUID: 1754bef7-432b-4ac6-907e-5d00f7eedb31) for task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.296161 17380 master.cpp:7811] Status update TASK_RUNNING (Status UUID: c3dd94e4-4cac-4e85-8832-e2c11bd20882) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 from agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 at slave(26)@172.17.0.2:34899 (556fb3122370)
3: I1212 04:46:13.296211 17380 master.cpp:7867] Forwarding status update TASK_RUNNING (Status UUID: c3dd94e4-4cac-4e85-8832-e2c11bd20882) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.296432 17372 slave.cpp:4010] Task status update manager successfully handled status update acknowledgement (UUID: afea4b0a-f76b-46a1-86d8-be24e51ed081) for task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.296602 17372 slave.cpp:4010] Task status update manager successfully handled status update acknowledgement (UUID: 1754bef7-432b-4ac6-907e-5d00f7eedb31) for task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.296690 17380 master.cpp:10114] Updating the state of task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
3: I1212 04:46:13.298288 17375 scheduler.cpp:739] Enqueuing event UPDATE received from http://172.17.0.2:34899/master/api/v1/scheduler
3: I1212 04:46:13.298761 17970 checker_process.cpp:1113] TCP check for task '6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c' returned: 0
3: I1212 04:46:13.299129 17970 default_executor.cpp:1214] Received check update 'TCP connection failure' for task '6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c'
3: I1212 04:46:13.299181 17973 checker_process.cpp:1113] TCP check for task 'cf181ad6-98cf-430b-85f2-b4041117ef7d' returned: 0
3: I1212 04:46:13.301522 17379 scheduler.cpp:247] Sending ACKNOWLEDGE call to http://172.17.0.2:34899/master/api/v1/scheduler
3: I1212 04:46:13.305588 17376 master.cpp:1419] Framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 (default) disconnected
3: I1212 04:46:13.305624 17376 master.cpp:3327] Deactivating framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 (default)
3: I1212 04:46:13.305703 17376 master.cpp:3304] Disconnecting framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 (default)
3: I1212 04:46:13.305732 17376 master.cpp:1434] Giving framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 (default) 0ns to failover
3: I1212 04:46:13.305982 17376 hierarchical.cpp:405] Deactivated framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.306406 17370 slave.cpp:909] Agent terminating
3: I1212 04:46:13.306751 17370 slave.cpp:3375] Asked to shut down framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 by @0.0.0.0:0
3: I1212 04:46:13.306799 17370 slave.cpp:3400] Shutting down framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.306871 17370 slave.cpp:6091] Shutting down executor 'default' of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 (via HTTP)
3: I1212 04:46:13.309237 17373 master.cpp:1305] Agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 at slave(26)@172.17.0.2:34899 (556fb3122370) disconnected
3: I1212 04:46:13.309278 17373 master.cpp:3364] Disconnecting agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 at slave(26)@172.17.0.2:34899 (556fb3122370)
3: I1212 04:46:13.309363 17373 master.cpp:3383] Deactivating agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 at slave(26)@172.17.0.2:34899 (556fb3122370)
3: I1212 04:46:13.309559 17383 hierarchical.cpp:766] Agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 deactivated
3: I1212 04:46:13.309551 17373 master.cpp:1329] Removing framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 (default) from disconnected agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 at slave(26)@172.17.0.2:34899 (556fb3122370) because the framework is not checkpointing
3: I1212 04:46:13.310159 17377 containerizer.cpp:2328] Destroying container 2e54567a-4a70-40cd-b893-597034c39dc2 in RUNNING state
3: I1212 04:46:13.310163 17373 master.cpp:9584] Removing framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 (default) from agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 at slave(26)@172.17.0.2:34899 (556fb3122370)
3: I1212 04:46:13.310183 17377 containerizer.cpp:2930] Transitioning the state of container 2e54567a-4a70-40cd-b893-597034c39dc2 from RUNNING to DESTROYING
3: I1212 04:46:13.310220 17377 containerizer.cpp:2328] Destroying container 2e54567a-4a70-40cd-b893-597034c39dc2.53abe0ca-8fa0-4fb0-b98b-929ad413369d in RUNNING state
3: I1212 04:46:13.310240 17377 containerizer.cpp:2930] Transitioning the state of container 2e54567a-4a70-40cd-b893-597034c39dc2.53abe0ca-8fa0-4fb0-b98b-929ad413369d from RUNNING to DESTROYING
3: I1212 04:46:13.310307 17373 master.cpp:10114] Updating the state of task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 (latest state: TASK_LOST, status update state: TASK_LOST)
3: I1212 04:46:13.310649 17377 containerizer.cpp:2328] Destroying container 2e54567a-4a70-40cd-b893-597034c39dc2.3325be98-bc04-4313-9e45-bfbf5007d67d in RUNNING state
3: I1212 04:46:13.310685 17377 containerizer.cpp:2930] Transitioning the state of container 2e54567a-4a70-40cd-b893-597034c39dc2.3325be98-bc04-4313-9e45-bfbf5007d67d from RUNNING to DESTROYING
3: I1212 04:46:13.310848 17975 default_executor.cpp:191] Received SHUTDOWN event
3: I1212 04:46:13.310890 17975 default_executor.cpp:961] Shutting down
3: I1212 04:46:13.310963 17373 master.cpp:10220] Removing task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c with resources cpus(allocated: *):0.1; mem(allocated: *):32; disk(allocated: *):32 of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 on agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 at slave(26)@172.17.0.2:34899 (556fb3122370)
3: I1212 04:46:13.311002 17976 checker_process.cpp:247] Stopped TCP check for task 'cf181ad6-98cf-430b-85f2-b4041117ef7d'
3: I1212 04:46:13.311256 17975 default_executor.cpp:1057] Killing task cf181ad6-98cf-430b-85f2-b4041117ef7d running in child container 2e54567a-4a70-40cd-b893-597034c39dc2.3325be98-bc04-4313-9e45-bfbf5007d67d with SIGTERM signal
3: I1212 04:46:13.311290 17373 master.cpp:10114] Updating the state of task cf181ad6-98cf-430b-85f2-b4041117ef7d of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 (latest state: TASK_LOST, status update state: TASK_LOST)
3: I1212 04:46:13.311272 17975 default_executor.cpp:1079] Scheduling escalation to SIGKILL in 3secs from now
3: I1212 04:46:13.311640 17373 master.cpp:10220] Removing task cf181ad6-98cf-430b-85f2-b4041117ef7d with resources cpus(allocated: *):0.1; mem(allocated: *):32; disk(allocated: *):32 of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 on agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 at slave(26)@172.17.0.2:34899 (556fb3122370)
3: I1212 04:46:13.312011 17380 hierarchical.cpp:1192] Recovered cpus(allocated: *):0.1; mem(allocated: *):32; disk(allocated: *):32 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: cpus(allocated: *):0.2; mem(allocated: *):64; disk(allocated: *):64) on agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 from framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.311967 17373 master.cpp:10249] Removing executor 'default' with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":0.1},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":32.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":32.0},"type":"SCALAR"}] of framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 on agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 at slave(26)@172.17.0.2:34899 (556fb3122370)
3: I1212 04:46:13.312342 17975 checker_process.cpp:247] Stopped TCP check for task '6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c'
3: I1212 04:46:13.312464 17975 default_executor.cpp:1057] Killing task 6ae7df74-66b1-4dfc-b7bc-7c88bc924a7c running in child container 2e54567a-4a70-40cd-b893-597034c39dc2.53abe0ca-8fa0-4fb0-b98b-929ad413369d with SIGTERM signal
3: I1212 04:46:13.312477 17975 default_executor.cpp:1079] Scheduling escalation to SIGKILL in 3secs from now
3: I1212 04:46:13.313246 17377 launcher.cpp:156] Asked to destroy container 2e54567a-4a70-40cd-b893-597034c39dc2.53abe0ca-8fa0-4fb0-b98b-929ad413369d
3: I1212 04:46:13.313181 17380 hierarchical.cpp:1192] Recovered cpus(allocated: *):0.1; mem(allocated: *):32; disk(allocated: *):32 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: cpus(allocated: *):0.1; mem(allocated: *):32; disk(allocated: *):32) on agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 from framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
3: I1212 04:46:13.313565 17379 master.cpp:8533] Framework failover timeout, removing framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 (default)
3: I1212 04:46:13.313585 17379 master.cpp:9410] Removing framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000 (default)
3: I1212 04:46:13.314610 17387 process.cpp:2681] Returning '404 Not Found' for '/slave(26)/api/v1'
3: I1212 04:46:13.315516 17380 hierarchical.cpp:1192] Recovered cpus(allocated: *):0.1; mem(allocated: *):32; disk(allocated: *):32 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: {}) on agent 6fc54efb-67ac-40fd-a741-346dfd16f1b4-S0 from framework 6fc54efb-67ac-40fd-a741-346dfd16f1b4-0000
write /dev/stdout: resource temporarily unavailable

Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user yujie.jay@gmail.com

Mime
View raw message