See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/2100/changes>
Changes: [vinod] Fixed distclean break during maven clean up. [idownes] Fixed some indentation. [benjamin.hindman] Better error message for protobuf::write. [benjamin.hindman] Added 'mesos-usage' for use by external containerizers. [benjamin.hindman] Added test for slave stopping before containerizer launches. [benjamin.hindman] Allowed passing headers to http::get/post. [benjamin.hindman] Updated uses of http::post. [benjamin.hindman] Used memory::shared_ptr instead of boost::shared_ptr. [benjamin.hindman] Added 'cref' and 'ref' to lambda:: namespace. [benjamin.hindman] Added process::async overloads for void functions. [benjamin.hindman] Fix URL decoding of '+' as space. ------------------------------------------ [...truncated 12167 lines...] I0430 07:14:45.095927 20159 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 14.693982ms I0430 07:14:45.095958 20159 replica.cpp:664] Persisted action at 0 I0430 07:14:45.096354 20156 replica.cpp:643] Replica received learned notice for position 0 I0430 07:14:45.112054 20156 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 15.675985ms I0430 07:14:45.112085 20156 replica.cpp:664] Persisted action at 0 I0430 07:14:45.112097 20156 replica.cpp:649] Replica learned NOP action at position 0 I0430 07:14:45.112575 20173 log.cpp:672] Writer started with ending position 0 I0430 07:14:45.114032 20164 leveldb.cpp:436] Reading position from leveldb took 15974ns I0430 07:14:45.117079 20172 registrar.cpp:308] Successfully recovered registrar I0430 07:14:45.117110 20172 registrar.cpp:379] Attempting to update the 'registry' I0430 07:14:45.119696 20170 log.cpp:680] Attempting to append 138 bytes to the log I0430 07:14:45.119909 20165 coordinator.cpp:339] Coordinator attempting to write APPEND action at position 1 I0430 07:14:45.121414 20169 replica.cpp:508] Replica received write request for position 1 I0430 07:14:45.140153 20169 leveldb.cpp:341] Persisting action (157 bytes) to leveldb took 18.711857ms I0430 07:14:45.140185 20169 replica.cpp:664] Persisted action at 1 I0430 07:14:45.140605 20151 replica.cpp:643] Replica received learned notice for position 1 I0430 07:14:45.156277 20151 leveldb.cpp:341] Persisting action (159 bytes) to leveldb took 15.574151ms I0430 07:14:45.156309 20151 replica.cpp:664] Persisted action at 1 I0430 07:14:45.156321 20151 replica.cpp:649] Replica learned APPEND action at position 1 I0430 07:14:45.156697 20151 log.cpp:699] Attempting to truncate the log to 1 I0430 07:14:45.156749 20161 registrar.cpp:427] Successfully updated 'registry' I0430 07:14:45.157124 20161 master.cpp:780] Recovered 0 slaves from the Registry (100B) ; allowing 10mins for slaves to re-register I0430 07:14:45.157249 20168 coordinator.cpp:339] Coordinator attempting to write TRUNCATE action at position 2 I0430 07:14:45.158311 20153 replica.cpp:508] Replica received write request for position 2 I0430 07:14:45.161258 20161 slave.cpp:140] Slave started on 18)@140.211.11.27:34679 I0430 07:14:45.161368 20161 credentials.hpp:35] Loading credentials for authentication W0430 07:14:45.161427 20161 credentials.hpp:48] Failed to stat credentials file 'file:///tmp/ExternalContainerizerTest_Launch_EpuFum/credential': No such file or directory I0430 07:14:45.161450 20161 slave.cpp:231] Slave using credential for: test-principal I0430 07:14:45.161546 20161 slave.cpp:244] Slave resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0430 07:14:45.161610 20161 slave.cpp:272] Slave hostname: hemera.apache.org I0430 07:14:45.161623 20161 slave.cpp:273] Slave checkpoint: false I0430 07:14:45.162005 20161 state.cpp:33] Recovering state from '/tmp/ExternalContainerizerTest_Launch_EpuFum/meta' I0430 07:14:45.162148 20168 status_update_manager.cpp:193] Recovering status update manager I0430 07:14:45.162564 20170 slave.cpp:2943] Finished recovery I0430 07:14:45.164058 20132 sched.cpp:121] Version: 0.19.0 I0430 07:14:45.164284 20174 sched.cpp:217] New master detected at [email protected]:34679 I0430 07:14:45.164312 20174 sched.cpp:268] Authenticating with master [email protected]:34679 I0430 07:14:45.164554 20174 authenticatee.hpp:128] Creating new client SASL connection I0430 07:14:45.164816 20174 master.cpp:2795] Authenticating scheduler(15)@140.211.11.27:34679 I0430 07:14:45.164914 20154 authenticator.hpp:148] Creating new server SASL connection I0430 07:14:45.165529 20157 authenticatee.hpp:219] Received SASL authentication mechanisms: CRAM-MD5 I0430 07:14:45.165555 20157 authenticatee.hpp:245] Attempting to authenticate with mechanism 'CRAM-MD5' I0430 07:14:45.165595 20157 authenticator.hpp:254] Received SASL authentication start I0430 07:14:45.165647 20157 authenticator.hpp:342] Authentication requires more steps I0430 07:14:45.165722 20157 authenticatee.hpp:265] Received SASL authentication step I0430 07:14:45.165889 20174 authenticator.hpp:282] Received SASL authentication step I0430 07:14:45.165920 20174 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'hemera.apache.org' server FQDN: 'hemera.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0430 07:14:45.165930 20174 auxprop.cpp:153] Looking up auxiliary property '*userPassword' I0430 07:14:45.165940 20174 auxprop.cpp:153] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0430 07:14:45.165951 20174 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'hemera.apache.org' server FQDN: 'hemera.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0430 07:14:45.165957 20174 auxprop.cpp:103] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0430 07:14:45.165962 20174 auxprop.cpp:103] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0430 07:14:45.165977 20174 authenticator.hpp:334] Authentication success I0430 07:14:45.166046 20174 authenticatee.hpp:305] Authentication success I0430 07:14:45.166085 20154 master.cpp:2835] Successfully authenticated scheduler(15)@140.211.11.27:34679 I0430 07:14:45.166658 20174 sched.cpp:342] Successfully authenticated with master [email protected]:34679 I0430 07:14:45.166679 20174 sched.cpp:461] Sending registration request to [email protected]:34679 I0430 07:14:45.166820 20158 master.cpp:981] Received registration request from scheduler(15)@140.211.11.27:34679 I0430 07:14:45.166910 20158 master.cpp:999] Registering framework 20140430-071445-453759884-34679-20132-0000 at scheduler(15)@140.211.11.27:34679 I0430 07:14:45.167436 20155 sched.cpp:392] Framework registered with 20140430-071445-453759884-34679-20132-0000 I0430 07:14:45.167618 20155 sched.cpp:406] Scheduler::registered took 142411ns I0430 07:14:45.167680 20163 hierarchical_allocator_process.hpp:332] Added framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:45.167695 20163 hierarchical_allocator_process.hpp:726] No resources available to allocate! I0430 07:14:45.167702 20163 hierarchical_allocator_process.hpp:688] Performed allocation for 0 slaves in 7477ns I0430 07:14:45.168773 20163 slave.cpp:525] New master detected at [email protected]:34679 I0430 07:14:45.168927 20163 slave.cpp:585] Authenticating with master [email protected]:34679 I0430 07:14:45.168952 20168 status_update_manager.cpp:167] New master detected at [email protected]:34679 I0430 07:14:45.169455 20163 slave.cpp:558] Detecting new master I0430 07:14:45.169468 20159 authenticatee.hpp:128] Creating new client SASL connection I0430 07:14:45.170161 20159 master.cpp:2795] Authenticating slave(18)@140.211.11.27:34679 I0430 07:14:45.170263 20154 authenticator.hpp:148] Creating new server SASL connection I0430 07:14:45.170413 20154 authenticatee.hpp:219] Received SASL authentication mechanisms: CRAM-MD5 I0430 07:14:45.170440 20154 authenticatee.hpp:245] Attempting to authenticate with mechanism 'CRAM-MD5' I0430 07:14:45.170763 20174 authenticator.hpp:254] Received SASL authentication start I0430 07:14:45.170874 20174 authenticator.hpp:342] Authentication requires more steps I0430 07:14:45.171197 20155 authenticatee.hpp:265] Received SASL authentication step I0430 07:14:45.171363 20168 authenticator.hpp:282] Received SASL authentication step I0430 07:14:45.171392 20168 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'hemera.apache.org' server FQDN: 'hemera.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0430 07:14:45.171401 20168 auxprop.cpp:153] Looking up auxiliary property '*userPassword' I0430 07:14:45.171412 20168 auxprop.cpp:153] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0430 07:14:45.171422 20168 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'hemera.apache.org' server FQDN: 'hemera.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0430 07:14:45.171429 20168 auxprop.cpp:103] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0430 07:14:45.171434 20168 auxprop.cpp:103] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0430 07:14:45.171447 20168 authenticator.hpp:334] Authentication success I0430 07:14:45.171484 20168 authenticatee.hpp:305] Authentication success I0430 07:14:45.171511 20158 master.cpp:2835] Successfully authenticated slave(18)@140.211.11.27:34679 I0430 07:14:45.172602 20153 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 14.090268ms I0430 07:14:45.172627 20153 replica.cpp:664] Persisted action at 2 I0430 07:14:45.172777 20155 slave.cpp:642] Successfully authenticated with master [email protected]:34679 I0430 07:14:45.173617 20155 slave.cpp:871] Will retry registration in 6.210883842secs if necessary I0430 07:14:45.175292 20172 registrar.cpp:379] Attempting to update the 'registry' I0430 07:14:45.175423 20166 replica.cpp:643] Replica received learned notice for position 2 I0430 07:14:45.188819 20166 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 13.375024ms I0430 07:14:45.188906 20166 leveldb.cpp:399] Deleting ~1 keys from leveldb took 56264ns I0430 07:14:45.188921 20166 replica.cpp:664] Persisted action at 2 I0430 07:14:45.188930 20166 replica.cpp:649] Replica learned TRUNCATE action at position 2 I0430 07:14:45.189460 20155 log.cpp:680] Attempting to append 332 bytes to the log I0430 07:14:45.189753 20171 coordinator.cpp:339] Coordinator attempting to write APPEND action at position 3 I0430 07:14:45.191615 20161 replica.cpp:508] Replica received write request for position 3 I0430 07:14:45.204910 20161 leveldb.cpp:341] Persisting action (351 bytes) to leveldb took 13.269444ms I0430 07:14:45.204939 20161 replica.cpp:664] Persisted action at 3 I0430 07:14:45.205428 20165 replica.cpp:643] Replica received learned notice for position 3 I0430 07:14:45.217073 20165 leveldb.cpp:341] Persisting action (353 bytes) to leveldb took 11.620776ms I0430 07:14:45.217105 20165 replica.cpp:664] Persisted action at 3 I0430 07:14:45.217116 20165 replica.cpp:649] Replica learned APPEND action at position 3 I0430 07:14:45.217731 20157 registrar.cpp:427] Successfully updated 'registry' I0430 07:14:45.217835 20157 master.cpp:2169] Admitted slave on hemera.apache.org at slave(18)@140.211.11.27:34679 I0430 07:14:45.217850 20157 master.cpp:3283] Adding slave 20140430-071445-453759884-34679-20132-0 at hemera.apache.org with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0430 07:14:45.218056 20168 slave.cpp:675] Registered with master [email protected]:34679; given slave ID 20140430-071445-453759884-34679-20132-0 I0430 07:14:45.218135 20162 log.cpp:699] Attempting to truncate the log to 3 I0430 07:14:45.218255 20157 hierarchical_allocator_process.hpp:445] Added slave 20140430-071445-453759884-34679-20132-0 (hemera.apache.org) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (and cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] available) I0430 07:14:45.218659 20159 coordinator.cpp:339] Coordinator attempting to write TRUNCATE action at position 4 I0430 07:14:45.218742 20157 hierarchical_allocator_process.hpp:752] Offering cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140430-071445-453759884-34679-20132-0 to framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:45.219079 20157 hierarchical_allocator_process.hpp:708] Performed allocation for slave 20140430-071445-453759884-34679-20132-0 in 368873ns I0430 07:14:45.219281 20157 master.hpp:586] Adding offer 20140430-071445-453759884-34679-20132-0 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140430-071445-453759884-34679-20132-0 (hemera.apache.org) I0430 07:14:45.219336 20157 master.cpp:2744] Sending 1 offers to framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:45.219938 20158 replica.cpp:508] Replica received write request for position 4 I0430 07:14:45.220268 20167 sched.cpp:529] Scheduler::resourceOffers took 586095ns I0430 07:14:45.221384 20154 master.hpp:596] Removing offer 20140430-071445-453759884-34679-20132-0 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140430-071445-453759884-34679-20132-0 (hemera.apache.org) I0430 07:14:45.221451 20154 master.cpp:1806] Processing reply for offers: [ 20140430-071445-453759884-34679-20132-0 ] on slave 20140430-071445-453759884-34679-20132-0 (hemera.apache.org) for framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:45.221530 20154 master.hpp:558] Adding task 1 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140430-071445-453759884-34679-20132-0 (hemera.apache.org) I0430 07:14:45.221596 20154 master.cpp:2919] Launching task 1 of framework 20140430-071445-453759884-34679-20132-0000 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140430-071445-453759884-34679-20132-0 (hemera.apache.org) I0430 07:14:45.221796 20161 slave.cpp:905] Got assigned task 1 for framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:45.222100 20161 slave.cpp:1015] Launching task 1 for framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:45.224656 20161 slave.cpp:1125] Queuing task '1' for executor 1 of framework '20140430-071445-453759884-34679-20132-0000 I0430 07:14:45.224709 20161 slave.cpp:486] Successfully attached file '/tmp/ExternalContainerizerTest_Launch_EpuFum/slaves/20140430-071445-453759884-34679-20132-0/frameworks/20140430-071445-453759884-34679-20132-0000/executors/1/runs/c4df3cfc-3a53-4283-ae14-596a2b8de9d2' I0430 07:14:45.224736 20167 external_containerizer.cpp:266] Launching container 'c4df3cfc-3a53-4283-ae14-596a2b8de9d2' I0430 07:14:45.224830 20167 external_containerizer.cpp:804] Invoking external containerizer for method 'launch' I0430 07:14:45.224930 20167 external_containerizer.cpp:818] user: jenkins I0430 07:14:45.233916 20158 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 13.87842ms I0430 07:14:45.234233 20158 replica.cpp:664] Persisted action at 4 I0430 07:14:45.239241 20151 replica.cpp:643] Replica received learned notice for position 4 I0430 07:14:45.240955 20167 external_containerizer.cpp:378] Wait triggered on container 'c4df3cfc-3a53-4283-ae14-596a2b8de9d2' I0430 07:14:45.265941 20151 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 26.664443ms I0430 07:14:45.266000 20151 leveldb.cpp:399] Deleting ~2 keys from leveldb took 26931ns I0430 07:14:45.266013 20151 replica.cpp:664] Persisted action at 4 I0430 07:14:45.266022 20151 replica.cpp:649] Replica learned TRUNCATE action at position 4 I0430 07:14:46.005877 20173 hierarchical_allocator_process.hpp:688] Performed allocation for 1 slaves in 85221ns 2014-04-30 07:14:46,684:20132(0x2b0618d35700):ZOO_ERROR@handle_socket_error_msg@1697: Socket [127.0.0.1:41518] zk retcode=-4, errno=111(Connection refused): server refused to accept the client I0430 07:14:47.006727 20174 hierarchical_allocator_process.hpp:688] Performed allocation for 1 slaves in 37120ns I0430 07:14:47.494434 20154 slave.cpp:1598] Got registration for executor '1' of framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:47.495302 20154 slave.cpp:1717] Flushing queued task 1 for executor '1' of framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:47.495360 20170 external_containerizer.cpp:476] Update triggered on container 'c4df3cfc-3a53-4283-ae14-596a2b8de9d2' I0430 07:14:47.499454 20156 slave.cpp:1953] Handling status update TASK_RUNNING (UUID: e194d707-5e52-469f-9b1d-8f63d4cca17b) for task 1 of framework 20140430-071445-453759884-34679-20132-0000 from executor(1)@140.211.11.27:34700 I0430 07:14:47.499652 20156 status_update_manager.cpp:320] Received status update TASK_RUNNING (UUID: e194d707-5e52-469f-9b1d-8f63d4cca17b) for task 1 of framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:47.499673 20156 status_update_manager.cpp:499] Creating StatusUpdate stream for task 1 of framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:47.500179 20156 status_update_manager.cpp:373] Forwarding status update TASK_RUNNING (UUID: e194d707-5e52-469f-9b1d-8f63d4cca17b) for task 1 of framework 20140430-071445-453759884-34679-20132-0000 to [email protected]:34679 I0430 07:14:47.500692 20174 slave.cpp:2070] Status update manager successfully handled status update TASK_RUNNING (UUID: e194d707-5e52-469f-9b1d-8f63d4cca17b) for task 1 of framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:47.500716 20174 slave.cpp:2076] Sending acknowledgement for status update TASK_RUNNING (UUID: e194d707-5e52-469f-9b1d-8f63d4cca17b) for task 1 of framework 20140430-071445-453759884-34679-20132-0000 to executor(1)@140.211.11.27:34700 I0430 07:14:47.500833 20164 master.cpp:2444] Status update TASK_RUNNING (UUID: e194d707-5e52-469f-9b1d-8f63d4cca17b) for task 1 of framework 20140430-071445-453759884-34679-20132-0000 from slave(18)@140.211.11.27:34679 I0430 07:14:47.501085 20170 sched.cpp:620] Scheduler::statusUpdate took 333869ns I0430 07:14:47.502003 20168 status_update_manager.cpp:398] Received status update acknowledgement (UUID: e194d707-5e52-469f-9b1d-8f63d4cca17b) for task 1 of framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:47.502421 20167 slave.cpp:1538] Status update manager successfully handled status update acknowledgement (UUID: e194d707-5e52-469f-9b1d-8f63d4cca17b) for task 1 of framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:47.514267 20159 external_containerizer.cpp:550] Usage triggered on container 'c4df3cfc-3a53-4283-ae14-596a2b8de9d2' I0430 07:14:48.007387 20169 hierarchical_allocator_process.hpp:688] Performed allocation for 1 slaves in 66424ns I0430 07:14:48.188813 20169 external_containerizer.cpp:341] Launch validation callback triggered on container 'c4df3cfc-3a53-4283-ae14-596a2b8de9d2' I0430 07:14:48.188833 20169 external_containerizer.cpp:350] Launch finishing up for container 'c4df3cfc-3a53-4283-ae14-596a2b8de9d2' I0430 07:14:48.189400 20169 external_containerizer.cpp:396] Wait continuation triggered on container 'c4df3cfc-3a53-4283-ae14-596a2b8de9d2' I0430 07:14:48.189424 20169 external_containerizer.cpp:804] Invoking external containerizer for method 'wait' I0430 07:14:48.189438 20169 external_containerizer.cpp:818] user: jenkins I0430 07:14:48.189805 20157 slave.cpp:2282] Monitoring executor '1' of framework '20140430-071445-453759884-34679-20132-0000' in container 'c4df3cfc-3a53-4283-ae14-596a2b8de9d2' I0430 07:14:48.206432 20169 external_containerizer.cpp:496] Update continuation triggered on container 'c4df3cfc-3a53-4283-ae14-596a2b8de9d2' I0430 07:14:48.206492 20169 external_containerizer.cpp:804] Invoking external containerizer for method 'update' I0430 07:14:48.206508 20169 external_containerizer.cpp:818] user: jenkins I0430 07:14:48.221786 20169 external_containerizer.cpp:568] Usage continuation on container 'c4df3cfc-3a53-4283-ae14-596a2b8de9d2' I0430 07:14:48.221815 20169 external_containerizer.cpp:804] Invoking external containerizer for method 'usage' I0430 07:14:48.221828 20169 external_containerizer.cpp:818] user: jenkins I0430 07:14:48.236387 20169 external_containerizer.cpp:364] Launch confirmation callback triggered on container 'c4df3cfc-3a53-4283-ae14-596a2b8de9d2' I0430 07:14:49.007865 20165 hierarchical_allocator_process.hpp:688] Performed allocation for 1 slaves in 81290ns I0430 07:14:49.189896 20168 external_containerizer.cpp:532] Update callback triggered on container 'c4df3cfc-3a53-4283-ae14-596a2b8de9d2' I0430 07:14:49.190199 20151 external_containerizer.cpp:611] Usage callback triggered on container 'c4df3cfc-3a53-4283-ae14-596a2b8de9d2' I0430 07:14:49.192558 20161 master.cpp:1912] Asked to kill task 1 of framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:49.192589 20161 master.cpp:1995] Telling slave 20140430-071445-453759884-34679-20132-0 (hemera.apache.org) to kill task 1 of framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:49.192630 20161 slave.cpp:1181] Asked to kill task 1 of framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:49.193553 20167 external_containerizer.cpp:550] Usage triggered on container 'c4df3cfc-3a53-4283-ae14-596a2b8de9d2' I0430 07:14:49.193631 20167 external_containerizer.cpp:568] Usage continuation on container 'c4df3cfc-3a53-4283-ae14-596a2b8de9d2' I0430 07:14:49.193645 20167 external_containerizer.cpp:804] Invoking external containerizer for method 'usage' I0430 07:14:49.193655 20167 external_containerizer.cpp:818] user: jenkins I0430 07:14:49.501615 20163 slave.cpp:1953] Handling status update TASK_KILLED (UUID: 7567ece3-1cc5-4433-b397-78dea46a2d9a) for task 1 of framework 20140430-071445-453759884-34679-20132-0000 from executor(1)@140.211.11.27:34700 I0430 07:14:49.501816 20163 slave.cpp:3444] Terminating task 1 I0430 07:14:49.502852 20153 status_update_manager.cpp:320] Received status update TASK_KILLED (UUID: 7567ece3-1cc5-4433-b397-78dea46a2d9a) for task 1 of framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:49.502864 20173 external_containerizer.cpp:476] Update triggered on container 'c4df3cfc-3a53-4283-ae14-596a2b8de9d2' I0430 07:14:49.502949 20153 status_update_manager.cpp:373] Forwarding status update TASK_KILLED (UUID: 7567ece3-1cc5-4433-b397-78dea46a2d9a) for task 1 of framework 20140430-071445-453759884-34679-20132-0000 to [email protected]:34679 I0430 07:14:49.503053 20173 external_containerizer.cpp:496] Update continuation triggered on container 'c4df3cfc-3a53-4283-ae14-596a2b8de9d2' I0430 07:14:49.503460 20163 master.cpp:2444] Status update TASK_KILLED (UUID: 7567ece3-1cc5-4433-b397-78dea46a2d9a) for task 1 of framework 20140430-071445-453759884-34679-20132-0000 from slave(18)@140.211.11.27:34679 I0430 07:14:49.503559 20173 external_containerizer.cpp:804] Invoking external containerizer for method 'update' I0430 07:14:49.503922 20173 external_containerizer.cpp:818] user: jenkins I0430 07:14:49.504276 20174 slave.cpp:2070] Status update manager successfully handled status update TASK_KILLED (UUID: 7567ece3-1cc5-4433-b397-78dea46a2d9a) for task 1 of framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:49.504305 20174 slave.cpp:2076] Sending acknowledgement for status update TASK_KILLED (UUID: 7567ece3-1cc5-4433-b397-78dea46a2d9a) for task 1 of framework 20140430-071445-453759884-34679-20132-0000 to executor(1)@140.211.11.27:34700 I0430 07:14:49.506994 20163 master.hpp:576] Removing task 1 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140430-071445-453759884-34679-20132-0 (hemera.apache.org) I0430 07:14:49.507316 20161 sched.cpp:620] Scheduler::statusUpdate took 525600ns I0430 07:14:49.508543 20161 sched.cpp:731] Stopping framework '20140430-071445-453759884-34679-20132-0000' I0430 07:14:49.508687 20171 hierarchical_allocator_process.hpp:637] Recovered cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (total allocatable: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]) on slave 20140430-071445-453759884-34679-20132-0 from framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:49.508822 20160 master.cpp:551] Master terminating I0430 07:14:49.509269 20166 status_update_manager.cpp:398] Received status update acknowledgement (UUID: 7567ece3-1cc5-4433-b397-78dea46a2d9a) for task 1 of framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:49.509392 20166 status_update_manager.cpp:530] Cleaning up status update stream for task 1 of framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:49.510393 20158 slave.cpp:2151] [email protected]:34679 exited W0430 07:14:49.510465 20158 slave.cpp:2154] Master disconnected! Waiting for a new master to be elected I0430 07:14:49.510941 20157 slave.cpp:1538] Status update manager successfully handled status update acknowledgement (UUID: 7567ece3-1cc5-4433-b397-78dea46a2d9a) for task 1 of framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:49.510969 20157 slave.cpp:3468] Completing task 1 I0430 07:14:49.523191 20152 external_containerizer.cpp:378] Wait triggered on container 'c4df3cfc-3a53-4283-ae14-596a2b8de9d2' I0430 07:14:49.523298 20152 external_containerizer.cpp:637] Destroy triggered on container 'c4df3cfc-3a53-4283-ae14-596a2b8de9d2' I0430 07:14:49.523362 20152 external_containerizer.cpp:396] Wait continuation triggered on container 'c4df3cfc-3a53-4283-ae14-596a2b8de9d2' I0430 07:14:49.523376 20152 external_containerizer.cpp:804] Invoking external containerizer for method 'wait' I0430 07:14:49.523387 20152 external_containerizer.cpp:818] user: jenkins I0430 07:14:49.539129 20152 external_containerizer.cpp:655] Destroy continuation on container 'c4df3cfc-3a53-4283-ae14-596a2b8de9d2' I0430 07:14:49.539161 20152 external_containerizer.cpp:804] Invoking external containerizer for method 'destroy' I0430 07:14:49.539190 20152 external_containerizer.cpp:818] user: jenkins 2014-04-30 07:14:50,020:20132(0x2b0618d35700):ZOO_ERROR@handle_socket_error_msg@1697: Socket [127.0.0.1:41518] zk retcode=-4, errno=111(Connection refused): server refused to accept the client I0430 07:14:50.191496 20172 external_containerizer.cpp:448] Wait callback triggered on container 'c4df3cfc-3a53-4283-ae14-596a2b8de9d2' E0430 07:14:50.193096 20165 slave.cpp:2324] Termination of executor '1' of framework '20140430-071445-453759884-34679-20132-0000' failed: External containerizer failed (status: 1) I0430 07:14:50.194201 20165 slave.cpp:2479] Cleaning up executor '1' of framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:50.195521 20165 slave.cpp:2554] Cleaning up framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:50.195538 20160 gc.cpp:56] Scheduling '/tmp/ExternalContainerizerTest_Launch_EpuFum/slaves/20140430-071445-453759884-34679-20132-0/frameworks/20140430-071445-453759884-34679-20132-0000/executors/1/runs/c4df3cfc-3a53-4283-ae14-596a2b8de9d2' for gc 6.99999774381926days in the future I0430 07:14:50.195688 20160 gc.cpp:56] Scheduling '/tmp/ExternalContainerizerTest_Launch_EpuFum/slaves/20140430-071445-453759884-34679-20132-0/frameworks/20140430-071445-453759884-34679-20132-0000/executors/1' for gc 6.99999774260444days in the future I0430 07:14:50.195731 20173 status_update_manager.cpp:282] Closing status update streams for framework 20140430-071445-453759884-34679-20132-0000 I0430 07:14:50.195739 20160 gc.cpp:56] Scheduling '/tmp/ExternalContainerizerTest_Launch_EpuFum/slaves/20140430-071445-453759884-34679-20132-0/frameworks/20140430-071445-453759884-34679-20132-0000' for gc 6.99999773615704days in the future ../../src/tests/cluster.hpp:462: Failure (wait).failure(): External containerizer failed (status: 1) I0430 07:14:50.211710 20172 external_containerizer.cpp:762] Killed the following process tree/s: [ ] I0430 07:14:50.211751 20172 external_containerizer.cpp:717] Callback performing final cleanup of running state F0430 07:14:50.211751 20132 logging.cpp:55] RAW: Pure virtual method called @ 0x2b03838419ad google::LogMessage::Fail() @ 0x2b038384951a google::RawLog__() @ 0x51dd69 mesos::internal::tests::Cluster::Slaves::shutdown() @ 0x740309 mesos::internal::tests::MesosTest::ShutdownSlaves() @ 0x8bf4cd testing::internal::HandleExceptionsInMethodIfSupported<>() @ 0x8b7ab3 testing::Test::Run() @ 0x8b7be6 testing::TestInfo::Run() @ 0x8b7d27 testing::TestCase::Run() @ 0x8b808e testing::internal::UnitTestImpl::RunAllTests() @ 0x8bf04d testing::internal::HandleExceptionsInMethodIfSupported<>() @ 0x8b715e testing::UnitTest::Run() @ 0x4a54a0 main @ 0x2b0384c8d76d (unknown) @ 0x4b08a1 (unknown) make[4]: *** [check-local] Aborted (core dumped) make[4]: Leaving directory `/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/mesos-0.19.0/_build/src' make[3]: *** [check-am] Error 2 make[3]: Leaving directory `/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/mesos-0.19.0/_build/src' make[2]: *** [check] Error 2 make[2]: Leaving directory `/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/mesos-0.19.0/_build/src' make[1]: *** [check-recursive] Error 1 make[1]: Leaving directory `/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/mesos-0.19.0/_build' make: *** [distcheck] Error 1 Build step 'Execute shell' marked build as failure
