Qian, can you take a look?

@vinodkone

> On Sep 22, 2016, at 7:02 PM, Apache Jenkins Server 
> <jenk...@builds.apache.org> wrote:
> 
> See 
> <https://builds.apache.org/job/Mesos/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-6)/2671/changes>
> 
> Changes:
> 
> [vinodkone] Terminate when receiving the ACK of terminal status update.
> 
> [vinodkone] Added the test `HTTPCommandExecutorTest.TerminateWithACK`.
> 
> ------------------------------------------
> [...truncated 17386 lines...]
> I0923 02:01:40.432051 30192 hierarchical.cpp:272] Added framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:01:40.432087 30203 slave.cpp:5233] Finished recovery
> I0923 02:01:40.432134 30192 hierarchical.cpp:1691] No allocations performed
> I0923 02:01:40.432173 30192 hierarchical.cpp:1786] No inverse offers to send 
> out!
> I0923 02:01:40.432091 30198 sched.cpp:743] Framework registered with 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:01:40.432267 30192 hierarchical.cpp:1283] Performed allocation for 0 
> agents in 184439ns
> I0923 02:01:40.432286 30198 sched.cpp:757] Scheduler::registered took 37729ns
> I0923 02:01:40.432561 30203 slave.cpp:5405] Querying resource estimator for 
> oversubscribable resources
> I0923 02:01:40.432776 30203 slave.cpp:915] New master detected at 
> master@172.17.0.2:47968
> I0923 02:01:40.432798 30203 slave.cpp:974] Authenticating with master 
> master@172.17.0.2:47968
> I0923 02:01:40.432801 30193 status_update_manager.cpp:177] Pausing sending 
> status updates
> I0923 02:01:40.432847 30203 slave.cpp:985] Using default CRAM-MD5 
> authenticatee
> I0923 02:01:40.432971 30203 slave.cpp:947] Detecting new master
> I0923 02:01:40.433126 30204 authenticatee.cpp:121] Creating new client SASL 
> connection
> I0923 02:01:40.433369 30197 master.cpp:6583] Authenticating 
> (1)@172.17.0.2:47968
> I0923 02:01:40.433460 30201 authenticator.cpp:414] Starting authentication 
> session for crammd5-authenticatee(33)@172.17.0.2:47968
> I0923 02:01:40.433656 30203 authenticator.cpp:98] Creating new server SASL 
> connection
> I0923 02:01:40.433828 30195 authenticatee.cpp:213] Received SASL 
> authentication mechanisms: CRAM-MD5
> I0923 02:01:40.433861 30195 authenticatee.cpp:239] Attempting to authenticate 
> with mechanism 'CRAM-MD5'
> I0923 02:01:40.433987 30198 authenticator.cpp:204] Received SASL 
> authentication start
> I0923 02:01:40.434072 30198 authenticator.cpp:326] Authentication requires 
> more steps
> I0923 02:01:40.434195 30198 authenticatee.cpp:259] Received SASL 
> authentication step
> I0923 02:01:40.434325 30199 authenticator.cpp:232] Received SASL 
> authentication step
> I0923 02:01:40.434357 30199 auxprop.cpp:109] Request to lookup properties for 
> user: 'test-principal' realm: 'ceb803c18b6b' server FQDN: 'ceb803c18b6b' 
> SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false 
> SASL_AUXPROP_AUTHZID: false 
> I0923 02:01:40.434422 30199 auxprop.cpp:181] Looking up auxiliary property 
> '*userPassword'
> I0923 02:01:40.434515 30199 auxprop.cpp:181] Looking up auxiliary property 
> '*cmusaslsecretCRAM-MD5'
> I0923 02:01:40.434545 30199 auxprop.cpp:109] Request to lookup properties for 
> user: 'test-principal' realm: 'ceb803c18b6b' server FQDN: 'ceb803c18b6b' 
> SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false 
> SASL_AUXPROP_AUTHZID: true 
> I0923 02:01:40.434556 30199 auxprop.cpp:131] Skipping auxiliary property 
> '*userPassword' since SASL_AUXPROP_AUTHZID == true
> I0923 02:01:40.434564 30199 auxprop.cpp:131] Skipping auxiliary property 
> '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
> I0923 02:01:40.434581 30199 authenticator.cpp:318] Authentication success
> I0923 02:01:40.434671 30195 authenticatee.cpp:299] Authentication success
> I0923 02:01:40.434720 30204 master.cpp:6613] Successfully authenticated 
> principal 'test-principal' at (1)@172.17.0.2:47968
> I0923 02:01:40.434767 30191 authenticator.cpp:432] Authentication session 
> cleanup for crammd5-authenticatee(33)@172.17.0.2:47968
> I0923 02:01:40.435058 30194 slave.cpp:1069] Successfully authenticated with 
> master master@172.17.0.2:47968
> I0923 02:01:40.435202 30194 slave.cpp:1475] Will retry registration in 
> 11.398618ms if necessary
> I0923 02:01:40.435385 30198 master.cpp:5040] Registering agent at 
> (1)@172.17.0.2:47968 (ceb803c18b6b) with id 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-S0
> I0923 02:01:40.435829 30200 registrar.cpp:461] Applied 1 operations in 
> 53913ns; attempting to update the registry
> I0923 02:01:40.436503 30194 log.cpp:577] Attempting to append 337 bytes to 
> the log
> I0923 02:01:40.436610 30203 coordinator.cpp:348] Coordinator attempting to 
> write APPEND action at position 3
> I0923 02:01:40.437355 30192 replica.cpp:537] Replica received write request 
> for position 3 from __req_res__(175)@172.17.0.2:47968
> I0923 02:01:40.437592 30192 leveldb.cpp:341] Persisting action (356 bytes) to 
> leveldb took 194641ns
> I0923 02:01:40.437618 30192 replica.cpp:708] Persisted action APPEND at 
> position 3
> I0923 02:01:40.438244 30199 replica.cpp:691] Replica received learned notice 
> for position 3 from @0.0.0.0:0
> I0923 02:01:40.438686 30199 leveldb.cpp:341] Persisting action (358 bytes) to 
> leveldb took 414752ns
> I0923 02:01:40.438709 30199 replica.cpp:708] Persisted action APPEND at 
> position 3
> I0923 02:01:40.439976 30198 registrar.cpp:506] Successfully updated the 
> registry in 4.082944ms
> I0923 02:01:40.440181 30204 log.cpp:596] Attempting to truncate the log to 3
> I0923 02:01:40.440351 30200 coordinator.cpp:348] Coordinator attempting to 
> write TRUNCATE action at position 4
> I0923 02:01:40.440735 30203 slave.cpp:4089] Received ping from 
> slave-observer(8)@172.17.0.2:47968
> I0923 02:01:40.440894 30202 master.cpp:5111] Registered agent 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-S0 at (1)@172.17.0.2:47968 
> (ceb803c18b6b) with cpus(*):2; mem(*):1024; disk(*):1024; 
> ports(*):[31000-32000]
> I0923 02:01:40.440997 30203 slave.cpp:1115] Registered with master 
> master@172.17.0.2:47968; given agent ID 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-S0
> I0923 02:01:40.441112 30203 fetcher.cpp:86] Clearing fetcher cache
> I0923 02:01:40.441125 30197 replica.cpp:537] Replica received write request 
> for position 4 from __req_res__(176)@172.17.0.2:47968
> I0923 02:01:40.441251 30200 status_update_manager.cpp:184] Resuming sending 
> status updates
> I0923 02:01:40.441313 30197 leveldb.cpp:341] Persisting action (16 bytes) to 
> leveldb took 155927ns
> I0923 02:01:40.441356 30197 replica.cpp:708] Persisted action TRUNCATE at 
> position 4
> I0923 02:01:40.441467 30203 slave.cpp:1138] Checkpointing SlaveInfo to 
> '/tmp/HTTPCommandExecutorTest_TerminateWithACK_ZGnHvA/meta/slaves/c70d1f79-b5ba-4949-b931-578b1099cfc8-S0/slave.info'
> I0923 02:01:40.442024 30201 replica.cpp:691] Replica received learned notice 
> for position 4 from @0.0.0.0:0
> I0923 02:01:40.442206 30192 hierarchical.cpp:482] Added agent 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-S0 (ceb803c18b6b) with cpus(*):2; 
> mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
> I0923 02:01:40.442227 30201 leveldb.cpp:341] Persisting action (18 bytes) to 
> leveldb took 173078ns
> I0923 02:01:40.442281 30201 leveldb.cpp:399] Deleting ~2 keys from leveldb 
> took 34237ns
> I0923 02:01:40.442303 30201 replica.cpp:708] Persisted action TRUNCATE at 
> position 4
> I0923 02:01:40.443359 30192 hierarchical.cpp:1786] No inverse offers to send 
> out!
> I0923 02:01:40.443475 30192 hierarchical.cpp:1306] Performed allocation for 
> agent c70d1f79-b5ba-4949-b931-578b1099cfc8-S0 in 1.230798ms
> I0923 02:01:40.443985 30194 master.cpp:6412] Sending 1 offers to framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 (default) at 
> scheduler-3a7471c6-7413-43a9-a1f7-3a57c615bb24@172.17.0.2:47968
> I0923 02:01:40.444576 30206 sched.cpp:917] Scheduler::resourceOffers took 
> 101683ns
> I0923 02:01:40.446993 30194 master.cpp:3521] Processing ACCEPT call for 
> offers: [ c70d1f79-b5ba-4949-b931-578b1099cfc8-O0 ] on agent 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-S0 at (1)@172.17.0.2:47968 
> (ceb803c18b6b) for framework c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 
> (default) at scheduler-3a7471c6-7413-43a9-a1f7-3a57c615bb24@172.17.0.2:47968
> I0923 02:01:40.447100 30194 master.cpp:3143] Authorizing framework principal 
> 'test-principal' to launch task 64a804ba-b593-433d-90cc-be342ab8165d
> I0923 02:01:40.449699 30194 master.cpp:8159] Adding task 
> 64a804ba-b593-433d-90cc-be342ab8165d with resources cpus(*):2; mem(*):1024; 
> disk(*):1024; ports(*):[31000-32000] on agent 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-S0 (ceb803c18b6b)
> I0923 02:01:40.449970 30194 master.cpp:4121] Launching task 
> 64a804ba-b593-433d-90cc-be342ab8165d of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 (default) at 
> scheduler-3a7471c6-7413-43a9-a1f7-3a57c615bb24@172.17.0.2:47968 with 
> resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on 
> agent c70d1f79-b5ba-4949-b931-578b1099cfc8-S0 at (1)@172.17.0.2:47968 
> (ceb803c18b6b)
> I0923 02:01:40.450726 30199 slave.cpp:1539] Got assigned task 
> '64a804ba-b593-433d-90cc-be342ab8165d' for framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:01:40.451771 30199 slave.cpp:1696] Launching task 
> '64a804ba-b593-433d-90cc-be342ab8165d' for framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:01:40.452410 30199 paths.cpp:536] Trying to chown 
> '/tmp/HTTPCommandExecutorTest_TerminateWithACK_ZGnHvA/slaves/c70d1f79-b5ba-4949-b931-578b1099cfc8-S0/frameworks/c70d1f79-b5ba-4949-b931-578b1099cfc8-0000/executors/64a804ba-b593-433d-90cc-be342ab8165d/runs/c3a773f0-7be6-497c-be75-eb29e867b8e0'
>  to user 'mesos'
> I0923 02:01:40.488970 30199 slave.cpp:6122] Launching executor 
> '64a804ba-b593-433d-90cc-be342ab8165d' of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 with resources cpus(*):0.1; 
> mem(*):32 in work directory 
> '/tmp/HTTPCommandExecutorTest_TerminateWithACK_ZGnHvA/slaves/c70d1f79-b5ba-4949-b931-578b1099cfc8-S0/frameworks/c70d1f79-b5ba-4949-b931-578b1099cfc8-0000/executors/64a804ba-b593-433d-90cc-be342ab8165d/runs/c3a773f0-7be6-497c-be75-eb29e867b8e0'
> I0923 02:01:40.489878 30206 containerizer.cpp:836] Starting container 
> c3a773f0-7be6-497c-be75-eb29e867b8e0 for executor 
> '64a804ba-b593-433d-90cc-be342ab8165d' of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:01:40.490219 30199 slave.cpp:1982] Queued task 
> '64a804ba-b593-433d-90cc-be342ab8165d' for executor 
> '64a804ba-b593-433d-90cc-be342ab8165d' of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:01:40.490320 30199 slave.cpp:868] Successfully attached file 
> '/tmp/HTTPCommandExecutorTest_TerminateWithACK_ZGnHvA/slaves/c70d1f79-b5ba-4949-b931-578b1099cfc8-S0/frameworks/c70d1f79-b5ba-4949-b931-578b1099cfc8-0000/executors/64a804ba-b593-433d-90cc-be342ab8165d/runs/c3a773f0-7be6-497c-be75-eb29e867b8e0'
> I0923 02:01:40.495131 30192 containerizer.cpp:1247] Launching 
> 'mesos-containerizer' with flags 
> '--command="{"arguments":["mesos-executor","--launcher_dir=\/mesos\/mesos-1.1.0\/_build\/src"],"shell":false,"value":"\/mesos\/mesos-1.1.0\/_build\/src\/mesos-executor"}"
>  --help="false" --pipe_read="9" --pipe_write="12" --pre_exec_commands="[]" 
> --unshare_namespace_mnt="false" --user="mesos" 
> --working_directory="/tmp/HTTPCommandExecutorTest_TerminateWithACK_ZGnHvA/slaves/c70d1f79-b5ba-4949-b931-578b1099cfc8-S0/frameworks/c70d1f79-b5ba-4949-b931-578b1099cfc8-0000/executors/64a804ba-b593-433d-90cc-be342ab8165d/runs/c3a773f0-7be6-497c-be75-eb29e867b8e0"'
> I0923 02:01:40.496817 30192 launcher.cpp:153] Forked child with pid '30228' 
> for container 'c3a773f0-7be6-497c-be75-eb29e867b8e0'
> I0923 02:01:41.395885 30195 hierarchical.cpp:1691] No allocations performed
> I0923 02:01:41.395980 30195 hierarchical.cpp:1786] No inverse offers to send 
> out!
> I0923 02:01:41.396064 30195 hierarchical.cpp:1283] Performed allocation for 1 
> agents in 395694ns
> I0923 02:01:42.397562 30197 hierarchical.cpp:1691] No allocations performed
> I0923 02:01:42.397639 30197 hierarchical.cpp:1786] No inverse offers to send 
> out!
> I0923 02:01:42.397730 30197 hierarchical.cpp:1283] Performed allocation for 1 
> agents in 352776ns
> I0923 02:01:43.399085 30205 hierarchical.cpp:1691] No allocations performed
> I0923 02:01:43.399165 30205 hierarchical.cpp:1786] No inverse offers to send 
> out!
> I0923 02:01:43.399250 30205 hierarchical.cpp:1283] Performed allocation for 1 
> agents in 372860ns
> I0923 02:01:44.400029 30202 hierarchical.cpp:1691] No allocations performed
> I0923 02:01:44.400105 30202 hierarchical.cpp:1786] No inverse offers to send 
> out!
> I0923 02:01:44.400178 30202 hierarchical.cpp:1283] Performed allocation for 1 
> agents in 369084ns
> I0923 02:01:45.401547 30194 hierarchical.cpp:1691] No allocations performed
> I0923 02:01:45.401618 30194 hierarchical.cpp:1786] No inverse offers to send 
> out!
> I0923 02:01:45.401706 30194 hierarchical.cpp:1283] Performed allocation for 1 
> agents in 395014ns
> I0923 02:01:46.402977 30204 hierarchical.cpp:1691] No allocations performed
> I0923 02:01:46.403056 30204 hierarchical.cpp:1786] No inverse offers to send 
> out!
> I0923 02:01:46.403156 30204 hierarchical.cpp:1283] Performed allocation for 1 
> agents in 377773ns
> I0923 02:01:46.562500 30201 process.cpp:3336] Handling HTTP event for process 
> '(1)' with path: '/(1)/api/v1/executor'
> I0923 02:01:46.564327 30193 http.cpp:273] HTTP POST for /(1)/api/v1/executor 
> from 172.17.0.2:35267
> I0923 02:01:46.564826 30193 slave.cpp:3017] Received Subscribe request for 
> HTTP executor '64a804ba-b593-433d-90cc-be342ab8165d' of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:01:46.568183 30199 slave.cpp:2186] Sending queued task 
> '64a804ba-b593-433d-90cc-be342ab8165d' to executor 
> '64a804ba-b593-433d-90cc-be342ab8165d' of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 (via HTTP)
> I0923 02:01:46.583202 30197 process.cpp:3336] Handling HTTP event for process 
> '(1)' with path: '/(1)/api/v1/executor'
> I0923 02:01:46.584014 30204 http.cpp:273] HTTP POST for /(1)/api/v1/executor 
> from 172.17.0.2:35268
> I0923 02:01:46.584375 30204 slave.cpp:3606] Handling status update 
> TASK_RUNNING (UUID: 7c8ecbbb-6705-48fc-82f0-6a0097b8215e) for task 
> 64a804ba-b593-433d-90cc-be342ab8165d of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:01:46.587401 30205 status_update_manager.cpp:323] Received status 
> update TASK_RUNNING (UUID: 7c8ecbbb-6705-48fc-82f0-6a0097b8215e) for task 
> 64a804ba-b593-433d-90cc-be342ab8165d of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:01:46.587502 30205 status_update_manager.cpp:500] Creating 
> StatusUpdate stream for task 64a804ba-b593-433d-90cc-be342ab8165d of 
> framework c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:01:46.588310 30205 status_update_manager.cpp:377] Forwarding update 
> TASK_RUNNING (UUID: 7c8ecbbb-6705-48fc-82f0-6a0097b8215e) for task 
> 64a804ba-b593-433d-90cc-be342ab8165d of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 to the agent
> I0923 02:01:46.588704 30200 slave.cpp:4007] Forwarding the update 
> TASK_RUNNING (UUID: 7c8ecbbb-6705-48fc-82f0-6a0097b8215e) for task 
> 64a804ba-b593-433d-90cc-be342ab8165d of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 to master@172.17.0.2:47968
> I0923 02:01:46.589064 30200 slave.cpp:3901] Status update manager 
> successfully handled status update TASK_RUNNING (UUID: 
> 7c8ecbbb-6705-48fc-82f0-6a0097b8215e) for task 
> 64a804ba-b593-433d-90cc-be342ab8165d of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:01:46.589300 30196 master.cpp:5638] Status update TASK_RUNNING 
> (UUID: 7c8ecbbb-6705-48fc-82f0-6a0097b8215e) for task 
> 64a804ba-b593-433d-90cc-be342ab8165d of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 from agent 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-S0 at (1)@172.17.0.2:47968 (ceb803c18b6b)
> I0923 02:01:46.589401 30196 master.cpp:5700] Forwarding status update 
> TASK_RUNNING (UUID: 7c8ecbbb-6705-48fc-82f0-6a0097b8215e) for task 
> 64a804ba-b593-433d-90cc-be342ab8165d of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:01:46.589704 30196 master.cpp:7537] Updating the state of task 
> 64a804ba-b593-433d-90cc-be342ab8165d of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 (latest state: TASK_RUNNING, status 
> update state: TASK_RUNNING)
> I0923 02:01:46.590028 30195 sched.cpp:1025] Scheduler::statusUpdate took 
> 193790ns
> I0923 02:01:46.590524 30191 master.cpp:4756] Processing ACKNOWLEDGE call 
> 7c8ecbbb-6705-48fc-82f0-6a0097b8215e for task 
> 64a804ba-b593-433d-90cc-be342ab8165d of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 (default) at 
> scheduler-3a7471c6-7413-43a9-a1f7-3a57c615bb24@172.17.0.2:47968 on agent 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-S0
> I0923 02:01:46.591197 30206 status_update_manager.cpp:395] Received status 
> update acknowledgement (UUID: 7c8ecbbb-6705-48fc-82f0-6a0097b8215e) for task 
> 64a804ba-b593-433d-90cc-be342ab8165d of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:01:46.591634 30191 slave.cpp:2953] Status update manager 
> successfully handled status update acknowledgement (UUID: 
> 7c8ecbbb-6705-48fc-82f0-6a0097b8215e) for task 
> 64a804ba-b593-433d-90cc-be342ab8165d of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:01:47.404165 30198 hierarchical.cpp:1691] No allocations performed
> I0923 02:01:47.404239 30198 hierarchical.cpp:1786] No inverse offers to send 
> out!
> I0923 02:01:47.404323 30198 hierarchical.cpp:1283] Performed allocation for 1 
> agents in 372197ns
> I0923 02:01:47.688933 30206 process.cpp:3336] Handling HTTP event for process 
> '(1)' with path: '/(1)/api/v1/executor'
> I0923 02:01:47.689882 30206 http.cpp:273] HTTP POST for /(1)/api/v1/executor 
> from 172.17.0.2:35268
> I0923 02:01:47.690167 30206 slave.cpp:3606] Handling status update 
> TASK_FINISHED (UUID: 2cb6ff03-0867-443b-99ed-a0439b64c30f) for task 
> 64a804ba-b593-433d-90cc-be342ab8165d of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:01:47.693555 30196 status_update_manager.cpp:323] Received status 
> update TASK_FINISHED (UUID: 2cb6ff03-0867-443b-99ed-a0439b64c30f) for task 
> 64a804ba-b593-433d-90cc-be342ab8165d of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:01:47.693809 30196 status_update_manager.cpp:377] Forwarding update 
> TASK_FINISHED (UUID: 2cb6ff03-0867-443b-99ed-a0439b64c30f) for task 
> 64a804ba-b593-433d-90cc-be342ab8165d of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 to the agent
> I0923 02:01:47.694231 30199 slave.cpp:4007] Forwarding the update 
> TASK_FINISHED (UUID: 2cb6ff03-0867-443b-99ed-a0439b64c30f) for task 
> 64a804ba-b593-433d-90cc-be342ab8165d of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 to master@172.17.0.2:47968
> I0923 02:01:47.694506 30199 slave.cpp:3901] Status update manager 
> successfully handled status update TASK_FINISHED (UUID: 
> 2cb6ff03-0867-443b-99ed-a0439b64c30f) for task 
> 64a804ba-b593-433d-90cc-be342ab8165d of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:01:47.694656 30195 master.cpp:5638] Status update TASK_FINISHED 
> (UUID: 2cb6ff03-0867-443b-99ed-a0439b64c30f) for task 
> 64a804ba-b593-433d-90cc-be342ab8165d of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 from agent 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-S0 at (1)@172.17.0.2:47968 (ceb803c18b6b)
> I0923 02:01:47.694737 30195 master.cpp:5700] Forwarding status update 
> TASK_FINISHED (UUID: 2cb6ff03-0867-443b-99ed-a0439b64c30f) for task 
> 64a804ba-b593-433d-90cc-be342ab8165d of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:01:47.695103 30195 master.cpp:7537] Updating the state of task 
> 64a804ba-b593-433d-90cc-be342ab8165d of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 (latest state: TASK_FINISHED, 
> status update state: TASK_FINISHED)
> I0923 02:01:47.695369 30191 sched.cpp:1025] Scheduler::statusUpdate took 
> 156432ns
> I0923 02:01:47.696828 30203 hierarchical.cpp:1015] Recovered cpus(*):2; 
> mem(*):1024; disk(*):1024; ports(*):[31000-32000] (total: cpus(*):2; 
> mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: {}) on agent 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-S0 from framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:01:47.697623 30195 master.cpp:4756] Processing ACKNOWLEDGE call 
> 2cb6ff03-0867-443b-99ed-a0439b64c30f for task 
> 64a804ba-b593-433d-90cc-be342ab8165d of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 (default) at 
> scheduler-3a7471c6-7413-43a9-a1f7-3a57c615bb24@172.17.0.2:47968 on agent 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-S0
> I0923 02:01:47.697705 30195 master.cpp:7633] Removing task 
> 64a804ba-b593-433d-90cc-be342ab8165d with resources cpus(*):2; mem(*):1024; 
> disk(*):1024; ports(*):[31000-32000] of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 on agent 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-S0 at (1)@172.17.0.2:47968 (ceb803c18b6b)
> I0923 02:01:47.698447 30198 status_update_manager.cpp:395] Received status 
> update acknowledgement (UUID: 2cb6ff03-0867-443b-99ed-a0439b64c30f) for task 
> 64a804ba-b593-433d-90cc-be342ab8165d of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:01:47.698683 30198 status_update_manager.cpp:531] Cleaning up status 
> update stream for task 64a804ba-b593-433d-90cc-be342ab8165d of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:01:47.699318 30206 slave.cpp:2953] Status update manager 
> successfully handled status update acknowledgement (UUID: 
> 2cb6ff03-0867-443b-99ed-a0439b64c30f) for task 
> 64a804ba-b593-433d-90cc-be342ab8165d of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:01:47.699398 30206 slave.cpp:6486] Completing task 
> 64a804ba-b593-433d-90cc-be342ab8165d
> I0923 02:01:47.795792 30194 containerizer.cpp:1842] Executor for container 
> c3a773f0-7be6-497c-be75-eb29e867b8e0 has exited
> I0923 02:01:47.795843 30194 containerizer.cpp:1612] Destroying container 
> c3a773f0-7be6-497c-be75-eb29e867b8e0
> I0923 02:01:47.801978 30203 provisioner.cpp:438] Ignoring destroy request for 
> unknown container c3a773f0-7be6-497c-be75-eb29e867b8e0
> I0923 02:01:47.802531 30202 slave.cpp:4498] Executor 
> '64a804ba-b593-433d-90cc-be342ab8165d' of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 exited with status 0
> I0923 02:01:47.802623 30202 slave.cpp:4602] Cleaning up executor 
> '64a804ba-b593-433d-90cc-be342ab8165d' of framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 (via HTTP)
> I0923 02:01:47.803333 30202 slave.cpp:4690] Cleaning up framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:01:47.803475 30191 status_update_manager.cpp:285] Closing status 
> update streams for framework c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:01:48.406038 30202 hierarchical.cpp:1786] No inverse offers to send 
> out!
> I0923 02:01:48.406215 30202 hierarchical.cpp:1283] Performed allocation for 1 
> agents in 1.469451ms
> I0923 02:01:48.406754 30194 master.cpp:6412] Sending 1 offers to framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 (default) at 
> scheduler-3a7471c6-7413-43a9-a1f7-3a57c615bb24@172.17.0.2:47968
> I0923 02:01:48.407296 30205 sched.cpp:917] Scheduler::resourceOffers took 
> 21684ns
> I0923 02:01:49.407096 30206 hierarchical.cpp:1691] No allocations performed
> I0923 02:01:49.407171 30206 hierarchical.cpp:1786] No inverse offers to send 
> out!
> I0923 02:01:49.407258 30206 hierarchical.cpp:1283] Performed allocation for 1 
> agents in 364799ns
> I0923 02:01:50.408556 30192 hierarchical.cpp:1691] No allocations performed
> I0923 02:01:50.408641 30192 hierarchical.cpp:1786] No inverse offers to send 
> out!
> I0923 02:01:50.408745 30192 hierarchical.cpp:1283] Performed allocation for 1 
> agents in 406343ns
> I0923 02:01:51.409394 30199 hierarchical.cpp:1691] No allocations performed
> I0923 02:01:51.409471 30199 hierarchical.cpp:1786] No inverse offers to send 
> out!
> I0923 02:01:51.409554 30199 hierarchical.cpp:1283] Performed allocation for 1 
> agents in 369762ns
> I0923 02:01:52.410338 30202 hierarchical.cpp:1691] No allocations performed
> I0923 02:01:52.410419 30202 hierarchical.cpp:1786] No inverse offers to send 
> out!
> I0923 02:01:52.410536 30202 hierarchical.cpp:1283] Performed allocation for 1 
> agents in 419315ns
> I0923 02:01:53.411484 30198 hierarchical.cpp:1691] No allocations performed
> I0923 02:01:53.411559 30198 hierarchical.cpp:1786] No inverse offers to send 
> out!
> I0923 02:01:53.411644 30198 hierarchical.cpp:1283] Performed allocation for 1 
> agents in 367727ns
> I0923 02:01:54.413033 30199 hierarchical.cpp:1691] No allocations performed
> I0923 02:01:54.413110 30199 hierarchical.cpp:1786] No inverse offers to send 
> out!
> I0923 02:01:54.413200 30199 hierarchical.cpp:1283] Performed allocation for 1 
> agents in 376654ns
> I0923 02:01:55.414566 30198 hierarchical.cpp:1691] No allocations performed
> I0923 02:01:55.414630 30198 hierarchical.cpp:1786] No inverse offers to send 
> out!
> I0923 02:01:55.414721 30198 hierarchical.cpp:1283] Performed allocation for 1 
> agents in 336148ns
> I0923 02:01:55.442041 30205 slave.cpp:4089] Received ping from 
> slave-observer(8)@172.17.0.2:47968
> I0923 02:01:56.415900 30196 hierarchical.cpp:1691] No allocations performed
> I0923 02:01:56.415973 30196 hierarchical.cpp:1786] No inverse offers to send 
> out!
> I0923 02:01:56.416060 30196 hierarchical.cpp:1283] Performed allocation for 1 
> agents in 364213ns
> I0923 02:01:57.416712 30198 hierarchical.cpp:1691] No allocations performed
> I0923 02:01:57.416779 30198 hierarchical.cpp:1786] No inverse offers to send 
> out!
> I0923 02:01:57.416853 30198 hierarchical.cpp:1283] Performed allocation for 1 
> agents in 318248ns
> I0923 02:01:58.417743 30201 hierarchical.cpp:1691] No allocations performed
> I0923 02:01:58.417814 30201 hierarchical.cpp:1786] No inverse offers to send 
> out!
> I0923 02:01:58.417896 30201 hierarchical.cpp:1283] Performed allocation for 1 
> agents in 340275ns
> I0923 02:01:59.419083 30203 hierarchical.cpp:1691] No allocations performed
> I0923 02:01:59.419159 30203 hierarchical.cpp:1786] No inverse offers to send 
> out!
> I0923 02:01:59.419244 30203 hierarchical.cpp:1283] Performed allocation for 1 
> agents in 365489ns
> I0923 02:02:00.420297 30191 hierarchical.cpp:1691] No allocations performed
> I0923 02:02:00.420374 30191 hierarchical.cpp:1786] No inverse offers to send 
> out!
> I0923 02:02:00.420469 30191 hierarchical.cpp:1283] Performed allocation for 1 
> agents in 380802ns
> I0923 02:02:01.421715 30196 hierarchical.cpp:1691] No allocations performed
> I0923 02:02:01.421802 30196 hierarchical.cpp:1786] No inverse offers to send 
> out!
> I0923 02:02:01.421906 30196 hierarchical.cpp:1283] Performed allocation for 1 
> agents in 403188ns
> I0923 02:02:02.422824 30194 hierarchical.cpp:1691] No allocations performed
> I0923 02:02:02.422924 30194 hierarchical.cpp:1786] No inverse offers to send 
> out!
> I0923 02:02:02.423038 30194 hierarchical.cpp:1283] Performed allocation for 1 
> agents in 468849ns
> ../../src/tests/command_executor_tests.cpp:288: Failure
> Failed to wait 15secs for termination
> I0923 02:02:02.697932 30204 master.cpp:1297] Framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 (default) at 
> scheduler-3a7471c6-7413-43a9-a1f7-3a57c615bb24@172.17.0.2:47968 disconnected
> I0923 02:02:02.697996 30204 master.cpp:2888] Disconnecting framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 (default) at 
> scheduler-3a7471c6-7413-43a9-a1f7-3a57c615bb24@172.17.0.2:47968
> I0923 02:02:02.698060 30204 master.cpp:2912] Deactivating framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 (default) at 
> scheduler-3a7471c6-7413-43a9-a1f7-3a57c615bb24@172.17.0.2:47968
> I0923 02:02:02.698297 30195 hierarchical.cpp:383] Deactivated framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> W0923 02:02:02.698882 30204 master.hpp:2265] Master attempted to send message 
> to disconnected framework c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 (default) 
> at scheduler-3a7471c6-7413-43a9-a1f7-3a57c615bb24@172.17.0.2:47968
> I0923 02:02:02.699007 30204 master.cpp:1310] Giving framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 (default) at 
> scheduler-3a7471c6-7413-43a9-a1f7-3a57c615bb24@172.17.0.2:47968 0ns to 
> failover
> ../../src/tests/command_executor_tests.cpp:274: Failure
> Actual function call count doesn't match EXPECT_CALL(slave, 
> executorTerminated(_, _, _))...
>         Expected: to be called once
>           Actual: never called - unsatisfied and active
> I0923 02:02:02.699373 30202 master.cpp:6264] Framework failover timeout, 
> removing framework c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 (default) at 
> scheduler-3a7471c6-7413-43a9-a1f7-3a57c615bb24@172.17.0.2:47968
> I0923 02:02:02.699419 30202 master.cpp:7000] Removing framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 (default) at 
> scheduler-3a7471c6-7413-43a9-a1f7-3a57c615bb24@172.17.0.2:47968
> I0923 02:02:02.699589 30205 hierarchical.cpp:1015] Recovered cpus(*):2; 
> mem(*):1024; disk(*):1024; ports(*):[31000-32000] (total: cpus(*):2; 
> mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: {}) on agent 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-S0 from framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:02:02.699683 30192 slave.cpp:2506] Asked to shut down framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000 by master@172.17.0.2:47968
> W0923 02:02:02.699728 30192 slave.cpp:2521] Cannot shut down unknown 
> framework c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> I0923 02:02:02.700001 30191 hierarchical.cpp:334] Removed framework 
> c70d1f79-b5ba-4949-b931-578b1099cfc8-0000
> *** Aborted at 1474596122 (unix time) try "date -d @1474596122" if you are 
> using GNU date ***
> PC: @                0x0 (unknown)
> *** SIGSEGV (@0x0) received by PID 30172 (TID 0x2b38d310b700) from PID 0; 
> stack trace: ***
>    @     0x2b38c89cb330 (unknown)
> make[4]: *** [check-local] Segmentation fault
> make[4]: Leaving directory `/mesos/mesos-1.1.0/_build/src'
> make[3]: *** [check-am] Error 2
> make[3]: Leaving directory `/mesos/mesos-1.1.0/_build/src'
> make[2]: *** [check] Error 2
> make[2]: Leaving directory `/mesos/mesos-1.1.0/_build/src'
> make[1]: *** [check-recursive] Error 1
> make[1]: Leaving directory `/mesos/mesos-1.1.0/_build'
> make: *** [distcheck] Error 1
> + docker rmi mesos-1474594287-25749
> Untagged: mesos-1474594287-25749:latest
> Deleted: 
> sha256:dac5fa06135b91f89969dd1ab75b52efe2ab6f849313d6e28f32e8fb100212e8
> Deleted: 
> sha256:d2434f0b0751739367858e47d65cc1b84a7a1814cc4e2cc634d1108a79043584
> Deleted: 
> sha256:a0ae0aa667dde45205b2e539818a3805938fc39d13a6c719725eae6b7fde19eb
> Deleted: 
> sha256:e1c38ebd89157981af6ce61937a504654e8b0fef0a0c8b4b1cbffc7bcfb37e5e
> Deleted: 
> sha256:c271150cf7cccbe306a8880a94c810a376cc881a0185ce4463055d840297f0da
> Deleted: 
> sha256:f427dea98dc8181afebe9a5fb5faa994352ed849af881df5a4e9be1f1ea5eab8
> Deleted: 
> sha256:5a92a9d442228e06bc3b174905c03ded5f0bde820762e735fa558e3c9d05e192
> Deleted: 
> sha256:36dbeade7fe6fe6368b3b0e974a501b8a93b414ada2224d35c0984faf53505ab
> Deleted: 
> sha256:9c457c7a95f5255ec2a0897724c6cac78f8d3a6527fe2cd0c427aef2d9c0be03
> Deleted: 
> sha256:f8ff54d12c3b10533c640f804a3bf20839de52f72349a03a47bf5f29ee812447
> Deleted: 
> sha256:ca5e21e6c3a68e7237f0613055eac2691c56aa802f4a27153d268f0cf7090735
> Deleted: 
> sha256:f344968c1f98e5e1f8166f87015d035e028e7edddb4949259bb61a294b400a9c
> Deleted: 
> sha256:9a36b6ce6377f3d6002612fec486ca614570be7bcc3cfd3334539e679b9d6917
> Deleted: 
> sha256:7ed9271bd09a195c61cfbb9f6f39846ade4bac8ee30644b75725ed2a976d2450
> Deleted: 
> sha256:e6449058f85384e0418b0bb197360378cb2b22a9c37463430d359afae187ba59
> Deleted: 
> sha256:43923f240374d78328794e0022551cd8083abb980321805294d5ba275aa76df5
> Deleted: 
> sha256:a4abadfb5b2a9718898059ebd7c9166cc1533bbaa5a9ebc61a9a9dbe2135703a
> Deleted: 
> sha256:c4c2fff2511f4b6614f67d7a30b79e1e8b8e79f65c57d3cd8fb46a4db625a3bf
> Deleted: 
> sha256:ccd6dd92d05485eee7036639d110aa648d982e1b6253531f3a380084487ab591
> Deleted: 
> sha256:f5d5f4deecb28234ac9f54d4b35d4025a000308031dae531daff8280f9a1c2cf
> Deleted: 
> sha256:7dafb4b97264741d9ff138ab586f9ff25463ee761eff7f9c006bce8937b22d90
> Deleted: 
> sha256:a8719430b4ecb659ed7c48c968e163ddfa89240f99f991cf72fb1d1affd465c5
> Deleted: 
> sha256:99531ea918c4b0968f103a0fe5379174a28f5b57f0e8ae72b37503edc960cec4
> Deleted: 
> sha256:95768839c10277ed4772f31cfcad5841e4bc270e18b0ab8e34d6c2505874acee
> Build step 'Execute shell' marked build as failure

Reply via email to