You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2014/08/04 20:45:29 UTC
Build failed in Jenkins:
Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME #2025
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/2025/changes>
Changes:
[benjamin.hindman] Serialize Containerizer::launch,wait invocations.
[benjamin.hindman] Added 'bool' return value to Containerizer::launch.
[benjamin.hindman] Added composing containerizer and --containerizers flag.
[benjamin.hindman] Added a helper for determining the cgroup of particular pid.
------------------------------------------
[...truncated 61378 lines...]
I0804 18:45:27.133662 27257 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 23.432629ms
I0804 18:45:27.133748 27257 replica.cpp:676] Persisted action at 0
I0804 18:45:27.133955 27257 replica.cpp:655] Replica received learned notice for position 0
I0804 18:45:27.153662 27257 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 19.635239ms
I0804 18:45:27.153749 27257 replica.cpp:676] Persisted action at 0
I0804 18:45:27.153806 27257 replica.cpp:661] Replica learned NOP action at position 0
I0804 18:45:27.154067 27257 log.cpp:672] Writer started with ending position 0
I0804 18:45:27.154383 27257 leveldb.cpp:438] Reading position from leveldb took 10735ns
I0804 18:45:27.156523 27257 registrar.cpp:346] Successfully fetched the registry (0B)
I0804 18:45:27.156610 27257 registrar.cpp:422] Attempting to update the 'registry'
I0804 18:45:27.158849 27237 log.cpp:680] Attempting to append 138 bytes to the log
I0804 18:45:27.158926 27237 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 1
I0804 18:45:27.159185 27237 replica.cpp:508] Replica received write request for position 1
I0804 18:45:27.181671 27237 leveldb.cpp:343] Persisting action (157 bytes) to leveldb took 22.464014ms
I0804 18:45:27.181710 27237 replica.cpp:676] Persisted action at 1
I0804 18:45:27.181967 27237 replica.cpp:655] Replica received learned notice for position 1
I0804 18:45:27.201668 27237 leveldb.cpp:343] Persisting action (159 bytes) to leveldb took 19.681537ms
I0804 18:45:27.201704 27237 replica.cpp:676] Persisted action at 1
I0804 18:45:27.201714 27237 replica.cpp:661] Replica learned APPEND action at position 1
I0804 18:45:27.202075 27237 registrar.cpp:479] Successfully updated 'registry'
I0804 18:45:27.202113 27237 registrar.cpp:372] Successfully recovered registrar
I0804 18:45:27.202155 27237 log.cpp:699] Attempting to truncate the log to 1
I0804 18:45:27.202231 27237 master.cpp:987] Recovered 0 slaves from the Registry (100B) ; allowing 10mins for slaves to re-register
I0804 18:45:27.202268 27237 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 2
I0804 18:45:27.202550 27237 replica.cpp:508] Replica received write request for position 2
I0804 18:45:27.221668 27237 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 19.097017ms
I0804 18:45:27.221704 27237 replica.cpp:676] Persisted action at 2
I0804 18:45:27.221956 27237 replica.cpp:655] Replica received learned notice for position 2
I0804 18:45:27.241664 27237 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 19.688201ms
I0804 18:45:27.241729 27237 leveldb.cpp:401] Deleting ~1 keys from leveldb took 32578ns
I0804 18:45:27.241742 27237 replica.cpp:676] Persisted action at 2
I0804 18:45:27.241752 27237 replica.cpp:661] Replica learned TRUNCATE action at position 2
I0804 18:45:27.250262 25520 containerizer.cpp:124] Using isolation: posix/cpu,posix/mem
I0804 18:45:27.253754 27237 slave.cpp:169] Slave started on 197)@140.211.11.27:41719
I0804 18:45:27.253772 27237 credentials.hpp:84] Loading credential for authentication from '/tmp/MesosContainerizerSlaveRecoveryTest_ResourceStatistics_tblm1v/credential'
I0804 18:45:27.253875 27237 slave.cpp:267] Slave using credential for: test-principal
I0804 18:45:27.253981 27237 slave.cpp:280] Slave resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0804 18:45:27.254070 27237 slave.cpp:325] Slave hostname: hemera.apache.org
I0804 18:45:27.254079 27237 slave.cpp:326] Slave checkpoint: true
I0804 18:45:27.254830 27253 state.cpp:33] Recovering state from '/tmp/MesosContainerizerSlaveRecoveryTest_ResourceStatistics_tblm1v/meta'
I0804 18:45:27.257428 25520 sched.cpp:139] Version: 0.20.0
I0804 18:45:27.257617 27237 status_update_manager.cpp:193] Recovering status update manager
I0804 18:45:27.257690 27246 sched.cpp:235] New master detected at master@140.211.11.27:41719
I0804 18:45:27.257726 27246 sched.cpp:285] Authenticating with master master@140.211.11.27:41719
I0804 18:45:27.257846 27246 containerizer.cpp:287] Recovering containerizer
I0804 18:45:27.257917 27244 authenticatee.hpp:128] Creating new client SASL connection
I0804 18:45:27.258075 27244 master.cpp:3505] Authenticating scheduler-3ed84ba6-bf15-4ed7-8a81-8e7ec6096dff@140.211.11.27:41719
I0804 18:45:27.258167 27244 authenticator.hpp:156] Creating new server SASL connection
I0804 18:45:27.258258 27244 authenticatee.hpp:219] Received SASL authentication mechanisms: CRAM-MD5
I0804 18:45:27.258275 27244 authenticatee.hpp:245] Attempting to authenticate with mechanism 'CRAM-MD5'
I0804 18:45:27.258302 27244 authenticator.hpp:262] Received SASL authentication start
I0804 18:45:27.258349 27244 authenticator.hpp:384] Authentication requires more steps
I0804 18:45:27.258379 27244 authenticatee.hpp:265] Received SASL authentication step
I0804 18:45:27.258415 27244 authenticator.hpp:290] Received SASL authentication step
I0804 18:45:27.258430 27244 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
I0804 18:45:27.258437 27244 auxprop.cpp:153] Looking up auxiliary property '*userPassword'
I0804 18:45:27.258447 27244 auxprop.cpp:153] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0804 18:45:27.258456 27244 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
I0804 18:45:27.258462 27244 auxprop.cpp:103] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0804 18:45:27.258468 27244 auxprop.cpp:103] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0804 18:45:27.258479 27244 authenticator.hpp:376] Authentication success
I0804 18:45:27.258507 27244 authenticatee.hpp:305] Authentication success
I0804 18:45:27.258533 27244 master.cpp:3545] Successfully authenticated principal 'test-principal' at scheduler-3ed84ba6-bf15-4ed7-8a81-8e7ec6096dff@140.211.11.27:41719
I0804 18:45:27.258610 27244 sched.cpp:359] Successfully authenticated with master master@140.211.11.27:41719
I0804 18:45:27.258625 27244 sched.cpp:478] Sending registration request to master@140.211.11.27:41719
I0804 18:45:27.258668 27244 master.cpp:1248] Received registration request from scheduler-3ed84ba6-bf15-4ed7-8a81-8e7ec6096dff@140.211.11.27:41719
I0804 18:45:27.258687 27244 master.cpp:1208] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0804 18:45:27.258798 27244 master.cpp:1307] Registering framework 20140804-184527-453759884-41719-25520-0000 at scheduler-3ed84ba6-bf15-4ed7-8a81-8e7ec6096dff@140.211.11.27:41719
I0804 18:45:27.258890 27244 sched.cpp:409] Framework registered with 20140804-184527-453759884-41719-25520-0000
I0804 18:45:27.258913 27244 sched.cpp:423] Scheduler::registered took 9406ns
I0804 18:45:27.258949 27244 hierarchical_allocator_process.hpp:331] Added framework 20140804-184527-453759884-41719-25520-0000
I0804 18:45:27.258960 27244 hierarchical_allocator_process.hpp:724] No resources available to allocate!
I0804 18:45:27.258966 27244 hierarchical_allocator_process.hpp:686] Performed allocation for 0 slaves in 6923ns
I0804 18:45:27.259197 27231 slave.cpp:3150] Finished recovery
I0804 18:45:27.259404 27231 slave.cpp:601] New master detected at master@140.211.11.27:41719
I0804 18:45:27.259425 27231 slave.cpp:677] Authenticating with master master@140.211.11.27:41719
I0804 18:45:27.259462 27231 slave.cpp:650] Detecting new master
I0804 18:45:27.259495 27231 status_update_manager.cpp:167] New master detected at master@140.211.11.27:41719
I0804 18:45:27.259520 27231 authenticatee.hpp:128] Creating new client SASL connection
I0804 18:45:27.259621 27231 master.cpp:3505] Authenticating slave(197)@140.211.11.27:41719
I0804 18:45:27.259693 27231 authenticator.hpp:156] Creating new server SASL connection
I0804 18:45:27.259767 27231 authenticatee.hpp:219] Received SASL authentication mechanisms: CRAM-MD5
I0804 18:45:27.259779 27231 authenticatee.hpp:245] Attempting to authenticate with mechanism 'CRAM-MD5'
I0804 18:45:27.259800 27231 authenticator.hpp:262] Received SASL authentication start
I0804 18:45:27.259834 27231 authenticator.hpp:384] Authentication requires more steps
I0804 18:45:27.259855 27231 authenticatee.hpp:265] Received SASL authentication step
I0804 18:45:27.259881 27231 authenticator.hpp:290] Received SASL authentication step
I0804 18:45:27.259894 27231 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
I0804 18:45:27.259901 27231 auxprop.cpp:153] Looking up auxiliary property '*userPassword'
I0804 18:45:27.259908 27231 auxprop.cpp:153] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0804 18:45:27.259917 27231 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
I0804 18:45:27.259922 27231 auxprop.cpp:103] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0804 18:45:27.259927 27231 auxprop.cpp:103] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0804 18:45:27.259937 27231 authenticator.hpp:376] Authentication success
I0804 18:45:27.259958 27231 authenticatee.hpp:305] Authentication success
I0804 18:45:27.259975 27231 master.cpp:3545] Successfully authenticated principal 'test-principal' at slave(197)@140.211.11.27:41719
I0804 18:45:27.260031 27231 slave.cpp:734] Successfully authenticated with master master@140.211.11.27:41719
I0804 18:45:27.260066 27231 slave.cpp:973] Will retry registration in 14.623202ms if necessary
I0804 18:45:27.260123 27231 master.cpp:2763] Registering slave at slave(197)@140.211.11.27:41719 (hemera.apache.org) with id 20140804-184527-453759884-41719-25520-0
I0804 18:45:27.260215 27231 registrar.cpp:422] Attempting to update the 'registry'
I0804 18:45:27.262416 27231 log.cpp:680] Attempting to append 332 bytes to the log
I0804 18:45:27.262471 27231 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 3
I0804 18:45:27.262682 27231 replica.cpp:508] Replica received write request for position 3
I0804 18:45:27.277719 27246 slave.cpp:973] Will retry registration in 39.076321ms if necessary
I0804 18:45:27.277777 27246 master.cpp:2751] Ignoring register slave message from slave(197)@140.211.11.27:41719 (hemera.apache.org) as admission is already in progress
I0804 18:45:27.281662 27231 leveldb.cpp:343] Persisting action (351 bytes) to leveldb took 18.961471ms
I0804 18:45:27.281684 27231 replica.cpp:676] Persisted action at 3
I0804 18:45:27.281884 27231 replica.cpp:655] Replica received learned notice for position 3
I0804 18:45:27.301658 27231 leveldb.cpp:343] Persisting action (353 bytes) to leveldb took 19.755979ms
I0804 18:45:27.301683 27231 replica.cpp:676] Persisted action at 3
I0804 18:45:27.301692 27231 replica.cpp:661] Replica learned APPEND action at position 3
I0804 18:45:27.302008 27231 registrar.cpp:479] Successfully updated 'registry'
I0804 18:45:27.302083 27231 log.cpp:699] Attempting to truncate the log to 3
I0804 18:45:27.302134 27231 master.cpp:2803] Registered slave 20140804-184527-453759884-41719-25520-0 at slave(197)@140.211.11.27:41719 (hemera.apache.org)
I0804 18:45:27.302146 27231 master.cpp:3973] Adding slave 20140804-184527-453759884-41719-25520-0 at slave(197)@140.211.11.27:41719 (hemera.apache.org) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0804 18:45:27.302242 27231 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 4
I0804 18:45:27.302302 27231 slave.cpp:768] Registered with master master@140.211.11.27:41719; given slave ID 20140804-184527-453759884-41719-25520-0
I0804 18:45:27.302435 27231 slave.cpp:781] Checkpointing SlaveInfo to '/tmp/MesosContainerizerSlaveRecoveryTest_ResourceStatistics_tblm1v/meta/slaves/20140804-184527-453759884-41719-25520-0/slave.info'
I0804 18:45:27.302570 27231 hierarchical_allocator_process.hpp:444] Added slave 20140804-184527-453759884-41719-25520-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)
I0804 18:45:27.302628 27231 hierarchical_allocator_process.hpp:750] Offering cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140804-184527-453759884-41719-25520-0 to framework 20140804-184527-453759884-41719-25520-0000
I0804 18:45:27.302736 27231 hierarchical_allocator_process.hpp:706] Performed allocation for slave 20140804-184527-453759884-41719-25520-0 in 133745ns
I0804 18:45:27.302786 27231 slave.cpp:2326] Received ping from slave-observer(167)@140.211.11.27:41719
I0804 18:45:27.302841 27231 master.hpp:816] Adding offer 20140804-184527-453759884-41719-25520-0 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140804-184527-453759884-41719-25520-0 (hemera.apache.org)
I0804 18:45:27.302882 27231 master.cpp:3452] Sending 1 offers to framework 20140804-184527-453759884-41719-25520-0000
I0804 18:45:27.303009 27231 sched.cpp:546] Scheduler::resourceOffers took 19839ns
I0804 18:45:27.303175 27231 replica.cpp:508] Replica received write request for position 4
I0804 18:45:27.305492 27267 master.hpp:826] Removing offer 20140804-184527-453759884-41719-25520-0 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140804-184527-453759884-41719-25520-0 (hemera.apache.org)
I0804 18:45:27.305569 27267 master.cpp:2126] Processing reply for offers: [ 20140804-184527-453759884-41719-25520-0 ] on slave 20140804-184527-453759884-41719-25520-0 at slave(197)@140.211.11.27:41719 (hemera.apache.org) for framework 20140804-184527-453759884-41719-25520-0000
I0804 18:45:27.305603 27267 master.cpp:2212] Authorizing framework principal 'test-principal' to launch task e7b05c72-c72b-4201-8d9f-742348d16213 as user 'jenkins'
I0804 18:45:27.305969 27267 master.hpp:788] Adding task e7b05c72-c72b-4201-8d9f-742348d16213 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140804-184527-453759884-41719-25520-0 (hemera.apache.org)
I0804 18:45:27.306010 27267 master.cpp:2278] Launching task e7b05c72-c72b-4201-8d9f-742348d16213 of framework 20140804-184527-453759884-41719-25520-0000 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140804-184527-453759884-41719-25520-0 at slave(197)@140.211.11.27:41719 (hemera.apache.org)
I0804 18:45:27.306154 27267 slave.cpp:1004] Got assigned task e7b05c72-c72b-4201-8d9f-742348d16213 for framework 20140804-184527-453759884-41719-25520-0000
I0804 18:45:27.306239 27267 slave.cpp:3425] Checkpointing FrameworkInfo to '/tmp/MesosContainerizerSlaveRecoveryTest_ResourceStatistics_tblm1v/meta/slaves/20140804-184527-453759884-41719-25520-0/frameworks/20140804-184527-453759884-41719-25520-0000/framework.info'
I0804 18:45:27.306401 27267 slave.cpp:3432] Checkpointing framework pid 'scheduler-3ed84ba6-bf15-4ed7-8a81-8e7ec6096dff@140.211.11.27:41719' to '/tmp/MesosContainerizerSlaveRecoveryTest_ResourceStatistics_tblm1v/meta/slaves/20140804-184527-453759884-41719-25520-0/frameworks/20140804-184527-453759884-41719-25520-0000/framework.pid'
I0804 18:45:27.306663 27267 slave.cpp:1114] Launching task e7b05c72-c72b-4201-8d9f-742348d16213 for framework 20140804-184527-453759884-41719-25520-0000
I0804 18:45:27.308933 27267 slave.cpp:3739] Checkpointing ExecutorInfo to '/tmp/MesosContainerizerSlaveRecoveryTest_ResourceStatistics_tblm1v/meta/slaves/20140804-184527-453759884-41719-25520-0/frameworks/20140804-184527-453759884-41719-25520-0000/executors/e7b05c72-c72b-4201-8d9f-742348d16213/executor.info'
I0804 18:45:27.309355 27267 slave.cpp:3854] Checkpointing TaskInfo to '/tmp/MesosContainerizerSlaveRecoveryTest_ResourceStatistics_tblm1v/meta/slaves/20140804-184527-453759884-41719-25520-0/frameworks/20140804-184527-453759884-41719-25520-0000/executors/e7b05c72-c72b-4201-8d9f-742348d16213/runs/9da0de07-4776-4c37-b961-73ca56c897ba/tasks/e7b05c72-c72b-4201-8d9f-742348d16213/task.info'
I0804 18:45:27.309500 27267 slave.cpp:1224] Queuing task 'e7b05c72-c72b-4201-8d9f-742348d16213' for executor e7b05c72-c72b-4201-8d9f-742348d16213 of framework '20140804-184527-453759884-41719-25520-0000
I0804 18:45:27.309628 27267 containerizer.cpp:427] Starting container '9da0de07-4776-4c37-b961-73ca56c897ba' for executor 'e7b05c72-c72b-4201-8d9f-742348d16213' of framework '20140804-184527-453759884-41719-25520-0000'
I0804 18:45:27.309820 27266 slave.cpp:562] Successfully attached file '/tmp/MesosContainerizerSlaveRecoveryTest_ResourceStatistics_tblm1v/slaves/20140804-184527-453759884-41719-25520-0/frameworks/20140804-184527-453759884-41719-25520-0000/executors/e7b05c72-c72b-4201-8d9f-742348d16213/runs/9da0de07-4776-4c37-b961-73ca56c897ba'
I0804 18:45:27.313256 27267 launcher.cpp:137] Forked child with pid '22637' for container '9da0de07-4776-4c37-b961-73ca56c897ba'
I0804 18:45:27.313335 27267 containerizer.cpp:705] Checkpointing executor's forked pid 22637 to '/tmp/MesosContainerizerSlaveRecoveryTest_ResourceStatistics_tblm1v/meta/slaves/20140804-184527-453759884-41719-25520-0/frameworks/20140804-184527-453759884-41719-25520-0000/executors/e7b05c72-c72b-4201-8d9f-742348d16213/runs/9da0de07-4776-4c37-b961-73ca56c897ba/pids/forked.pid'
I0804 18:45:27.322113 27267 containerizer.cpp:537] Fetching URIs for container '9da0de07-4776-4c37-b961-73ca56c897ba' using command '/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/mesos-0.20.0/_build/src/mesos-fetcher'
I0804 18:45:27.357795 27231 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 54.49306ms
I0804 18:45:27.357848 27231 replica.cpp:676] Persisted action at 4
I0804 18:45:27.358297 27231 replica.cpp:655] Replica received learned notice for position 4
I0804 18:45:27.372563 27231 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 14.196674ms
I0804 18:45:27.372737 27231 leveldb.cpp:401] Deleting ~2 keys from leveldb took 40349ns
I0804 18:45:27.372813 27231 replica.cpp:676] Persisted action at 4
I0804 18:45:27.372875 27231 replica.cpp:661] Replica learned TRUNCATE action at position 4
E0804 18:45:27.911058 27249 slave.cpp:2448] Container '9da0de07-4776-4c37-b961-73ca56c897ba' for executor 'e7b05c72-c72b-4201-8d9f-742348d16213' of framework '20140804-184527-453759884-41719-25520-0000' failed to start: TaskInfo/ExecutorInfo not supported
WARNING: Logging before InitGoogleLogging() is written to STDERR
I0804 18:45:28.000869 22699 process.cpp:1671] libprocess is initialized on 140.211.11.27:33727 for 24 cpus
I0804 18:45:28.002581 22699 exec.cpp:131] Version: 0.20.0
I0804 18:45:28.003415 22726 exec.cpp:181] Executor started at: executor(1)@140.211.11.27:33727 with pid 22699
I0804 18:45:28.009750 27249 slave.cpp:1735] Got registration for executor 'e7b05c72-c72b-4201-8d9f-742348d16213' of framework 20140804-184527-453759884-41719-25520-0000
I0804 18:45:28.009809 27249 slave.cpp:1820] Checkpointing executor pid 'executor(1)@140.211.11.27:33727' to '/tmp/MesosContainerizerSlaveRecoveryTest_ResourceStatistics_tblm1v/meta/slaves/20140804-184527-453759884-41719-25520-0/frameworks/20140804-184527-453759884-41719-25520-0000/executors/e7b05c72-c72b-4201-8d9f-742348d16213/runs/9da0de07-4776-4c37-b961-73ca56c897ba/pids/libprocess.pid'
I0804 18:45:28.010179 27249 slave.cpp:1854] Flushing queued task e7b05c72-c72b-4201-8d9f-742348d16213 for executor 'e7b05c72-c72b-4201-8d9f-742348d16213' of framework 20140804-184527-453759884-41719-25520-0000
I0804 18:45:28.010658 27269 process.cpp:1098] Socket closed while receiving
I0804 18:45:28.013875 22761 process.cpp:1037] Socket closed while receiving
I0804 18:45:28.014106 25520 slave.cpp:485] Slave terminating
I0804 18:45:28.014780 25520 containerizer.cpp:124] Using isolation: posix/cpu,posix/mem
I0804 18:45:28.017727 22750 exec.cpp:205] Executor registered on slave 20140804-184527-453759884-41719-25520-0
I0804 18:45:28.017844 27261 slave.cpp:169] Slave started on 198)@140.211.11.27:41719
I0804 18:45:28.017871 27261 credentials.hpp:84] Loading credential for authentication from '/tmp/MesosContainerizerSlaveRecoveryTest_ResourceStatistics_tblm1v/credential'
I0804 18:45:28.017861 27255 master.cpp:767] Slave 20140804-184527-453759884-41719-25520-0 at slave(197)@140.211.11.27:41719 (hemera.apache.org) disconnected
I0804 18:45:28.017904 27255 master.cpp:1610] Disconnecting slave 20140804-184527-453759884-41719-25520-0
I0804 18:45:28.019037 22750 exec.cpp:217] Executor::registered took 103486ns
I0804 18:45:28.019114 22750 exec.cpp:292] Executor asked to run task 'e7b05c72-c72b-4201-8d9f-742348d16213'
I0804 18:45:28.019160 22750 exec.cpp:301] Executor::launchTask took 32311ns
Registered executor on hemera.apache.org
Starting task e7b05c72-c72b-4201-8d9f-742348d16213
sh -c 'sleep 1000'
I0804 18:45:28.021733 27261 slave.cpp:267] Slave using credential for: test-principal
I0804 18:45:28.021845 27261 slave.cpp:280] Slave resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0804 18:45:28.021955 27261 slave.cpp:325] Slave hostname: hemera.apache.org
I0804 18:45:28.021967 27261 slave.cpp:326] Slave checkpoint: true
I0804 18:45:28.022542 27261 state.cpp:33] Recovering state from '/tmp/MesosContainerizerSlaveRecoveryTest_ResourceStatistics_tblm1v/meta'
W0804 18:45:28.023190 27261 state.cpp:558] Failed to find status updates file '/tmp/MesosContainerizerSlaveRecoveryTest_ResourceStatistics_tblm1v/meta/slaves/20140804-184527-453759884-41719-25520-0/frameworks/20140804-184527-453759884-41719-25520-0000/executors/e7b05c72-c72b-4201-8d9f-742348d16213/runs/9da0de07-4776-4c37-b961-73ca56c897ba/tasks/e7b05c72-c72b-4201-8d9f-742348d16213/task.updates'
I0804 18:45:28.023794 27261 slave.cpp:3221] Recovering framework 20140804-184527-453759884-41719-25520-0000
I0804 18:45:28.023814 27261 slave.cpp:3589] Recovering executor 'e7b05c72-c72b-4201-8d9f-742348d16213' of framework 20140804-184527-453759884-41719-25520-0000
I0804 18:45:28.024324 27261 status_update_manager.cpp:193] Recovering status update manager
I0804 18:45:28.024334 27261 status_update_manager.cpp:201] Recovering executor 'e7b05c72-c72b-4201-8d9f-742348d16213' of framework 20140804-184527-453759884-41719-25520-0000
W0804 18:45:28.024348 27261 status_update_manager.cpp:240] No updates found for task e7b05c72-c72b-4201-8d9f-742348d16213 of framework 20140804-184527-453759884-41719-25520-0000
I0804 18:45:28.024477 27261 slave.cpp:562] Successfully attached file '/tmp/MesosContainerizerSlaveRecoveryTest_ResourceStatistics_tblm1v/slaves/20140804-184527-453759884-41719-25520-0/frameworks/20140804-184527-453759884-41719-25520-0000/executors/e7b05c72-c72b-4201-8d9f-742348d16213/runs/9da0de07-4776-4c37-b961-73ca56c897ba'
I0804 18:45:28.024637 27261 containerizer.cpp:287] Recovering containerizer
I0804 18:45:28.024653 27261 containerizer.cpp:329] Recovering container '9da0de07-4776-4c37-b961-73ca56c897ba' for executor 'e7b05c72-c72b-4201-8d9f-742348d16213' of framework 20140804-184527-453759884-41719-25520-0000
I0804 18:45:28.025266 27261 slave.cpp:3091] Sending reconnect request to executor e7b05c72-c72b-4201-8d9f-742348d16213 of framework 20140804-184527-453759884-41719-25520-0000 at executor(1)@140.211.11.27:33727
I0804 18:45:28.025404 27255 hierarchical_allocator_process.hpp:483] Slave 20140804-184527-453759884-41719-25520-0 deactivated
Forked command at 22764
I0804 18:45:28.025706 27269 process.cpp:1098] Socket closed while receiving
I0804 18:45:28.025939 22730 exec.cpp:251] Received reconnect request from slave 20140804-184527-453759884-41719-25520-0
I0804 18:45:28.025974 22761 process.cpp:1037] Socket closed while receiving
I0804 18:45:28.031144 22750 exec.cpp:524] Executor sending status update TASK_RUNNING (UUID: 0e527946-b427-47d9-83a5-d9269f9a588b) for task e7b05c72-c72b-4201-8d9f-742348d16213 of framework 20140804-184527-453759884-41719-25520-0000
I0804 18:45:28.037708 27261 hierarchical_allocator_process.hpp:686] Performed allocation for 1 slaves in 32273ns
I0804 18:45:28.037775 27261 slave.cpp:1914] Re-registering executor e7b05c72-c72b-4201-8d9f-742348d16213 of framework 20140804-184527-453759884-41719-25520-0000
I0804 18:45:28.038620 27269 process.cpp:1098] Socket closed while receiving
I0804 18:45:28.038673 27261 slave.cpp:2089] Handling status update TASK_RUNNING (UUID: 0e527946-b427-47d9-83a5-d9269f9a588b) for task e7b05c72-c72b-4201-8d9f-742348d16213 of framework 20140804-184527-453759884-41719-25520-0000 from executor(1)@140.211.11.27:33727
I0804 18:45:28.038727 22761 process.cpp:1037] Socket closed while receiving
I0804 18:45:28.038748 22750 exec.cpp:228] Executor re-registered on slave 20140804-184527-453759884-41719-25520-0
I0804 18:45:28.038769 27261 status_update_manager.cpp:320] Received status update TASK_RUNNING (UUID: 0e527946-b427-47d9-83a5-d9269f9a588b) for task e7b05c72-c72b-4201-8d9f-742348d16213 of framework 20140804-184527-453759884-41719-25520-0000
I0804 18:45:28.038781 27261 status_update_manager.cpp:499] Creating StatusUpdate stream for task e7b05c72-c72b-4201-8d9f-742348d16213 of framework 20140804-184527-453759884-41719-25520-0000
I0804 18:45:28.038929 27261 status_update_manager.hpp:342] Checkpointing UPDATE for status update TASK_RUNNING (UUID: 0e527946-b427-47d9-83a5-d9269f9a588b) for task e7b05c72-c72b-4201-8d9f-742348d16213 of framework 20140804-184527-453759884-41719-25520-0000
Re-registered executor on hemera.apache.org
I0804 18:45:28.040091 22750 exec.cpp:240] Executor::reregistered took 51962ns
W0804 18:45:28.065003 27261 status_update_manager.cpp:381] Not forwarding status update TASK_RUNNING (UUID: 0e527946-b427-47d9-83a5-d9269f9a588b) for task e7b05c72-c72b-4201-8d9f-742348d16213 of framework 20140804-184527-453759884-41719-25520-0000 because no master is elected yet
I0804 18:45:28.065130 27261 slave.cpp:2247] Status update manager successfully handled status update TASK_RUNNING (UUID: 0e527946-b427-47d9-83a5-d9269f9a588b) for task e7b05c72-c72b-4201-8d9f-742348d16213 of framework 20140804-184527-453759884-41719-25520-0000
I0804 18:45:28.065142 27261 slave.cpp:2253] Sending acknowledgement for status update TASK_RUNNING (UUID: 0e527946-b427-47d9-83a5-d9269f9a588b) for task e7b05c72-c72b-4201-8d9f-742348d16213 of framework 20140804-184527-453759884-41719-25520-0000 to executor(1)@140.211.11.27:33727
I0804 18:45:28.069711 27269 process.cpp:1098] Socket closed while receiving
I0804 18:45:28.069857 22750 exec.cpp:338] Executor received status update acknowledgement 0e527946-b427-47d9-83a5-d9269f9a588b for task e7b05c72-c72b-4201-8d9f-742348d16213 of framework 20140804-184527-453759884-41719-25520-0000
I0804 18:45:28.069790 22761 process.cpp:1037] Socket closed while receiving
I0804 18:45:28.365787 27246 containerizer.cpp:909] Destroying container '9da0de07-4776-4c37-b961-73ca56c897ba'
I0804 18:45:28.511019 27269 process.cpp:1037] Socket closed while receiving
I0804 18:45:28.917812 27246 containerizer.cpp:1025] Executor for container '9da0de07-4776-4c37-b961-73ca56c897ba' has exited
I0804 18:45:28.918125 27246 slave.cpp:2550] Executor 'e7b05c72-c72b-4201-8d9f-742348d16213' of framework 20140804-184527-453759884-41719-25520-0000 terminated with signal Killed
I0804 18:45:28.920038 27246 slave.cpp:2089] Handling status update TASK_FAILED (UUID: 31ac24ea-d3f6-4a1f-b79d-852ee5c35e00) for task e7b05c72-c72b-4201-8d9f-742348d16213 of framework 20140804-184527-453759884-41719-25520-0000 from @0.0.0.0:0
I0804 18:45:28.920066 27246 slave.cpp:3787] Terminating task e7b05c72-c72b-4201-8d9f-742348d16213
W0804 18:45:28.920225 27246 containerizer.cpp:815] Ignoring update for unknown container: 9da0de07-4776-4c37-b961-73ca56c897ba
I0804 18:45:28.920354 27246 status_update_manager.cpp:320] Received status update TASK_FAILED (UUID: 31ac24ea-d3f6-4a1f-b79d-852ee5c35e00) for task e7b05c72-c72b-4201-8d9f-742348d16213 of framework 20140804-184527-453759884-41719-25520-0000
I0804 18:45:28.920372 27246 status_update_manager.hpp:342] Checkpointing UPDATE for status update TASK_FAILED (UUID: 31ac24ea-d3f6-4a1f-b79d-852ee5c35e00) for task e7b05c72-c72b-4201-8d9f-742348d16213 of framework 20140804-184527-453759884-41719-25520-0000
I0804 18:45:28.921777 27237 sched.cpp:747] Stopping framework '20140804-184527-453759884-41719-25520-0000'
I0804 18:45:28.921876 27231 master.cpp:626] Master terminating
I0804 18:45:28.921939 27231 master.hpp:806] Removing task e7b05c72-c72b-4201-8d9f-742348d16213 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140804-184527-453759884-41719-25520-0 (hemera.apache.org)
W0804 18:45:28.922025 27231 master.cpp:4262] Removing task e7b05c72-c72b-4201-8d9f-742348d16213 of framework 20140804-184527-453759884-41719-25520-0000 and slave 20140804-184527-453759884-41719-25520-0 in non-terminal state TASK_STAGING
I0804 18:45:28.922214 27231 hierarchical_allocator_process.hpp:635] Recovered cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (total allocatable: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]) on slave 20140804-184527-453759884-41719-25520-0 from framework 20140804-184527-453759884-41719-25520-0000
I0804 18:45:28.933886 25520 slave.cpp:485] Slave terminating
[ OK ] MesosContainerizerSlaveRecoveryTest.ResourceStatistics (2020 ms)
[----------] 1 test from MesosContainerizerSlaveRecoveryTest (2020 ms total)
[----------] Global test environment tear-down
[==========] 392 tests from 64 test cases ran. (425574 ms total)
[ PASSED ] 390 tests.
[ FAILED ] 2 tests, listed below:
[ FAILED ] SlaveRecoveryTest/0.RestartBeforeContainerizerLaunch, where TypeParam = mesos::internal::slave::MesosContainerizer
[ FAILED ] SlaveTest.MesosExecutorWithOverride
2 FAILED TESTS
YOU HAVE 4 DISABLED TESTS
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/mesos-0.20.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/mesos-0.20.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/mesos-0.20.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/mesos-0.20.0/_build'
make: *** [distcheck] Error 1
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal :
Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME #2028
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/2028/changes>
Build failed in Jenkins:
Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME #2027
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/2027/changes>
Changes:
[bmahler] Removed unused code from future.hpp.
[bmahler] Made WeakFuture<T>::get a const operation.
[bmahler] Master detector cleanups.
[bmahler] Handle discards on the master detection futures.
[bmahler] Added a ping timeout in the slave to trigger a re-detection.
[vinodkone] Fixed header paths for proto files during installation.
[benjamin.hindman] Added a 'Docker' abstraction.
[benjamin.hindman] Added a Docker containerizer.
[benjamin.hindman] Bug fixes and cleanups in Docker abstraction.
[benjamin.hindman] Integrated DockerContainerizer.
[benjamin.hindman] Add environment test for Docker.
[benjamin.hindman] Added pid() in docker/docker.cpp to get the pid of the container.
[benjamin.hindman] Added Docker::ps() "all" option.
[benjamin.hindman] Added rm() in docker.hpp/cpp to enable users remove containers.
[benjamin.hindman] Modify validate Docker to call 'info' instead.
[benjamin.hindman] Added Docker unit test, Docker flag and fix issues found.
[benjamin.hindman] Changed docker.kill() to docker.rm().
[benjamin.hindman] Added usage() for the docker containerizer.
[benjamin.hindman] Used 'flags.docker' in tests.
[benjamin.hindman] Exposed and used the Docker container name prefix.
[benjamin.hindman] Renamed variable to be more accurate.
[benjamin.hindman] Refactored Docker::Container::pid() to return an Option.
[benjamin.hindman] Made Docker::ps/rm default arguments match CLI defaults.
[benjamin.hindman] Be more mock friendly in MockDockerContainerizer.
[benjamin.hindman] Added license in docker/docker.cpp.
[benjamin.hindman] Added docker_tests to test the docker abstraction.
[benjamin.hindman] Added docker::killAndRm() to performs 'docker kill && docker rm (-f)'
[benjamin.hindman] Refactored docker::ps(), added 'prefix' option to inspect only interested containers.
[benjamin.hindman] Moved cpu/mem constants from cpushare.cpp/mem.cpp to cpushare.hpp/mem.hpp
[benjamin.hindman] Refactored docker::usage() and docker::run().
[benjamin.hindman] Added a DockerContainerizer::recover test.
[benjamin.hindman] Implemented DockerContainerizer::update.
[benjamin.hindman] Added an example Docker framework for testing.
[benjamin.hindman] Used unsigned constants for older compilers.
[benjamin.hindman] Used the new cgroups helpers when updating Docker container resources.
[benjamin.hindman] Moved WSTRINGIFY out of a namespace.
[benjamin.hindman] Modified Docker example framework to use busybox.
[benjamin.hindman] Improved failure handling of DockerContainerizer.
[benjamin.hindman] Refactored some Docker tests to be more generic.
[benjamin.hindman] Fix docker usage test
[benjamin.hindman] Added DockerContainerizer kill task test.
[benjamin.hindman] Checked for mounted 'cpu' cgroups subsystem in Docker::validate.
[benjamin.hindman] Await container termination in docker kill test
[benjamin.hindman] Update docker uri to expect 3 slashes in prefix
[benjamin.hindman] Implemented launching executors in DockerContainerizer.
[benjamin.hindman] Revised comments to reflect DockerContainerizer implementation.
[benjamin.hindman] Replaced the docker test executor with a smaller one.
[benjamin.hindman] Addressing Docker review comments
[benjamin.hindman] Fixed tests for new launch/wait containerizer semantics.
------------------------------------------
[...truncated 26 lines...]
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Started by an SCM change
Building remotely on ubuntu3 (Ubuntu ubuntu) in workspace <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/>
> git rev-parse --is-inside-work-tree
Fetching changes from the remote Git repository
> git config remote.origin.url https://git-wip-us.apache.org/repos/asf/mesos.git
Fetching upstream changes from https://git-wip-us.apache.org/repos/asf/mesos.git
> git --version
> git fetch --tags --progress https://git-wip-us.apache.org/repos/asf/mesos.git +refs/heads/*:refs/remotes/origin/*
> git rev-parse origin/master^{commit}
Checking out Revision 0ba6b89b7421d426709af5bf89fac138cf0ca63e (origin/master)
> git config core.sparsecheckout
> git checkout -f 0ba6b89b7421d426709af5bf89fac138cf0ca63e
> git rev-list 81d830f502f99290e4c9fd00f231f0b9fff6b591
> git tag -a -f -m Jenkins Build #2027 jenkins-Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME-2027
[Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME] $ /bin/bash -xe /tmp/hudson4439222010273665037.sh
+ export JAVA_HOME=/home/jenkins/tools/java/jdk1.6.0_20-64
+ JAVA_HOME=/home/jenkins/tools/java/jdk1.6.0_20-64
+ export PATH=/home/jenkins/tools/java/jdk1.6.0_20-64/bin:/home/hudson/tools/java/latest1.6/bin:/home/hudson/tools/java/latest1.6/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11:/usr/games
+ PATH=/home/jenkins/tools/java/jdk1.6.0_20-64/bin:/home/hudson/tools/java/latest1.6/bin:/home/hudson/tools/java/latest1.6/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11:/usr/games
+ export M2_HOME=/home/jenkins/tools/maven/latest
+ M2_HOME=/home/jenkins/tools/maven/latest
+ export PATH=/home/jenkins/tools/maven/latest/bin:/home/jenkins/tools/java/jdk1.6.0_20-64/bin:/home/hudson/tools/java/latest1.6/bin:/home/hudson/tools/java/latest1.6/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11:/usr/games
+ PATH=/home/jenkins/tools/maven/latest/bin:/home/jenkins/tools/java/jdk1.6.0_20-64/bin:/home/hudson/tools/java/latest1.6/bin:/home/hudson/tools/java/latest1.6/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11:/usr/games
+ date
Tue Aug 5 02:41:46 UTC 2014
+ chmod -R +w 3rdparty CHANGELOG Doxyfile LICENSE Makefile Makefile.am Makefile.in NOTICE README.md aclocal.m4 ar-lib autom4te.cache bin bootstrap config.guess config.log config.lt config.status config.sub configure configure.ac depcomp docs ec2 frameworks include install-sh libtool ltmain.sh m4 mesos-0.20.0 mesos-0.20.0.tar.gz mesos.pc mesos.pc.in missing mpi src support
+ git clean -fdx
Removing .libs/
Removing 3rdparty/Makefile
Removing 3rdparty/Makefile.in
Removing 3rdparty/leveldb/
Removing 3rdparty/libprocess/.deps/
Removing 3rdparty/libprocess/3rdparty/.deps/
Removing 3rdparty/libprocess/3rdparty/Makefile
Removing 3rdparty/libprocess/3rdparty/Makefile.in
Removing 3rdparty/libprocess/3rdparty/stout/Makefile
Removing 3rdparty/libprocess/3rdparty/stout/Makefile.in
Removing 3rdparty/libprocess/3rdparty/stout/aclocal.m4
Removing 3rdparty/libprocess/3rdparty/stout/autom4te.cache/
Removing 3rdparty/libprocess/3rdparty/stout/config.log
Removing 3rdparty/libprocess/3rdparty/stout/config.status
Removing 3rdparty/libprocess/3rdparty/stout/configure
Removing 3rdparty/libprocess/3rdparty/stout/include/Makefile
Removing 3rdparty/libprocess/3rdparty/stout/include/Makefile.in
Removing 3rdparty/libprocess/3rdparty/stout/missing
Removing 3rdparty/libprocess/Makefile
Removing 3rdparty/libprocess/Makefile.in
Removing 3rdparty/libprocess/aclocal.m4
Removing 3rdparty/libprocess/ar-lib
Removing 3rdparty/libprocess/autom4te.cache/
Removing 3rdparty/libprocess/config.guess
Removing 3rdparty/libprocess/config.log
Removing 3rdparty/libprocess/config.lt
Removing 3rdparty/libprocess/config.status
Removing 3rdparty/libprocess/config.sub
Removing 3rdparty/libprocess/configure
Removing 3rdparty/libprocess/depcomp
Removing 3rdparty/libprocess/include/Makefile
Removing 3rdparty/libprocess/include/Makefile.in
Removing 3rdparty/libprocess/libtool
Removing 3rdparty/libprocess/ltmain.sh
Removing 3rdparty/libprocess/m4/libtool.m4
Removing 3rdparty/libprocess/m4/ltoptions.m4
Removing 3rdparty/libprocess/m4/ltsugar.m4
Removing 3rdparty/libprocess/m4/ltversion.m4
Removing 3rdparty/libprocess/m4/lt~obsolete.m4
Removing 3rdparty/libprocess/missing
Removing Makefile
Removing Makefile.in
Removing aclocal.m4
Removing ar-lib
Removing autom4te.cache/
Removing bin/gdb-mesos-local.sh
Removing bin/gdb-mesos-master.sh
Removing bin/gdb-mesos-slave.sh
Removing bin/gdb-mesos-tests.sh
Removing bin/lldb-mesos-local.sh
Removing bin/lldb-mesos-master.sh
Removing bin/lldb-mesos-slave.sh
Removing bin/lldb-mesos-tests.sh
Removing bin/mesos-local-flags.sh
Removing bin/mesos-local.sh
Removing bin/mesos-master-flags.sh
Removing bin/mesos-master.sh
Removing bin/mesos-slave-flags.sh
Removing bin/mesos-slave.sh
Removing bin/mesos-tests-flags.sh
Removing bin/mesos-tests.sh
Removing bin/mesos.sh
Removing bin/valgrind-mesos-local.sh
Removing bin/valgrind-mesos-master.sh
Removing bin/valgrind-mesos-slave.sh
Removing bin/valgrind-mesos-tests.sh
Removing config.guess
Removing config.log
Removing config.lt
Removing config.status
Removing config.sub
Removing configure
Removing depcomp
Removing ec2/Makefile
Removing ec2/Makefile.in
Removing include/mesos/mesos.hpp
Removing install-sh
Removing libtool
Removing ltmain.sh
Removing m4/libtool.m4
Removing m4/ltoptions.m4
Removing m4/ltsugar.m4
Removing m4/ltversion.m4
Removing m4/lt~obsolete.m4
Removing mesos-0.20.0.tar.gz
Removing mesos-0.20.0/
Removing mesos.pc
Removing missing
Removing mpi/mpiexec-mesos
Removing src/.deps/
Removing src/Makefile
Removing src/Makefile.in
Removing src/authorizer/.deps/
Removing src/cli/.deps/
Removing src/common/.deps/
Removing src/containerizer/
Removing src/deploy/mesos-daemon.sh
Removing src/deploy/mesos-start-cluster.sh
Removing src/deploy/mesos-start-masters.sh
Removing src/deploy/mesos-start-slaves.sh
Removing src/deploy/mesos-stop-cluster.sh
Removing src/deploy/mesos-stop-masters.sh
Removing src/deploy/mesos-stop-slaves.sh
Removing src/examples/.deps/
Removing src/examples/java/test-exception-framework
Removing src/examples/java/test-executor
Removing src/examples/java/test-framework
Removing src/examples/java/test-log
Removing src/examples/java/test-multiple-executors-framework
Removing src/examples/python/test-containerizer
Removing src/examples/python/test-executor
Removing src/examples/python/test-framework
Removing src/exec/.deps/
Removing src/files/.deps/
Removing src/health-check/.deps/
Removing src/java/generated/org/apache/mesos/MesosNativeLibrary.java
Removing src/java/jni/.deps/
Removing src/java/mesos.pom
Removing src/jvm/.deps/
Removing src/jvm/org/apache/.deps/
Removing src/launcher/.deps/
Removing src/linux/.deps/
Removing src/linux/routing/.deps/
Removing src/linux/routing/filter/.deps/
Removing src/linux/routing/link/.deps/
Removing src/linux/routing/queueing/.deps/
Removing src/local/.deps/
Removing src/log/.deps/
Removing src/log/tool/.deps/
Removing src/logging/.deps/
Removing src/master/.deps/
Removing src/messages/.deps/
Removing src/python/interface/setup.py
Removing src/python/native/ext_modules.py
Removing src/python/native/setup.py
Removing src/python/setup.py
Removing src/sasl/.deps/
Removing src/sched/.deps/
Removing src/scheduler/.deps/
Removing src/slave/.deps/
Removing src/slave/containerizer/.deps/
Removing src/slave/containerizer/isolators/cgroups/.deps/
Removing src/slave/containerizer/isolators/network/.deps/
Removing src/slave/containerizer/mesos/.deps/
Removing src/state/.deps/
Removing src/tests/.deps/
Removing src/usage/.deps/
Removing src/zookeeper/.deps/
+ ./bootstrap
autoreconf: Entering directory `.'
autoreconf: configure.ac: not using Gettext
autoreconf: running: aclocal --warnings=all -I m4
autoreconf: configure.ac: tracing
configure.ac:45: warning: back quotes and double quotes must not be escaped in: unrecognized option: $[1]
configure.ac:45: Try \`$[0] --help' for more information.
aclocal.m4:625: LT_OUTPUT is expanded from...
configure.ac:45: the top level
configure.ac:45: warning: back quotes and double quotes must not be escaped in: unrecognized argument: $[1]
configure.ac:45: Try \`$[0] --help' for more information.
aclocal.m4:625: LT_OUTPUT is expanded from...
configure.ac:45: the top level
configure.ac:395: warning: The macro `AC_LANG_SAVE' is obsolete.
configure.ac:395: You should run autoupdate.
../../lib/autoconf/lang.m4:126: AC_LANG_SAVE is expanded from...
m4/acx_pthread.m4:63: ACX_PTHREAD is expanded from...
configure.ac:395: the top level
configure.ac:395: warning: The macro `AC_LANG_C' is obsolete.
configure.ac:395: You should run autoupdate.
../../lib/autoconf/c.m4:73: AC_LANG_C is expanded from...
m4/acx_pthread.m4:63: ACX_PTHREAD is expanded from...
configure.ac:395: the top level
configure.ac:395: warning: The macro `AC_TRY_LINK' is obsolete.
configure.ac:395: You should run autoupdate.
../../lib/autoconf/general.m4:2688: AC_TRY_LINK is expanded from...
m4/acx_pthread.m4:63: ACX_PTHREAD is expanded from...
configure.ac:395: the top level
configure.ac:395: warning: The macro `AC_LANG_RESTORE' is obsolete.
configure.ac:395: You should run autoupdate.
../../lib/autoconf/lang.m4:135: AC_LANG_RESTORE is expanded from...
m4/acx_pthread.m4:63: ACX_PTHREAD is expanded from...
configure.ac:395: the top level
configure.ac:722: warning: The macro `AC_PYTHON_DEVEL' is obsolete.
configure.ac:722: You should run autoupdate.
m4/ax_python_devel.m4:72: AC_PYTHON_DEVEL is expanded from...
configure.ac:722: the top level
autoreconf: configure.ac: adding subdirectory 3rdparty/libprocess to autoreconf
autoreconf: Entering directory `3rdparty/libprocess'
autom4te: cannot create /tmp/arHudeuJ/am4t3996.27686: No such file or directory
at /usr/bin/autom4te line 970
aclocal: /usr/bin/autom4te failed with exit status: 2
autoreconf: aclocal failed with exit status: 2
Build step 'Execute shell' marked build as failure
Build failed in Jenkins:
Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME #2026
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/2026/changes>
Changes:
[idownes] Fix stout/os to properly check errno from getpwnam_r.
------------------------------------------
[...truncated 61346 lines...]
2014-08-04 23:38:39,278:8619(0x2b6983f32700):ZOO_INFO@log_env@733: Client environment:user.name=(null)
2014-08-04 23:38:39,278:8619(0x2b6983f32700):ZOO_INFO@log_env@741: Client environment:user.home=/home/jenkins
2014-08-04 23:38:39,278:8619(0x2b6983f32700):ZOO_INFO@log_env@753: Client environment:user.dir=/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/mesos-0.20.0/_build/src
2014-08-04 23:38:39,278:8619(0x2b6983f32700):ZOO_INFO@zookeeper_init@786: Initiating client connection, host=127.0.0.1:45231 sessionTimeout=10000 watcher=0x2b69809474c0 sessionId=0 sessionPasswd=<null> context=0x2b699c049cb0 flags=0
I0804 23:38:39.278656 9039 contender.cpp:131] Joining the ZK group
I0804 23:38:39.278719 9039 contender.cpp:161] Withdraw requested before the candidacy is obtained; will withdraw after it happens
2014-08-04 23:38:39,285:8619(0x2b6c06992700):ZOO_INFO@check_events@1703: initiated connection to server [127.0.0.1:45231]
2014-08-04 23:38:39,525:8619(0x2b6c06992700):ZOO_INFO@check_events@1750: session establishment complete on server [127.0.0.1:45231], sessionId=0x147a36399010000, negotiated timeout=10000
I0804 23:38:39.533838 9039 group.cpp:313] Group process (group(56)@140.211.11.27:35410) connected to ZooKeeper
I0804 23:38:39.533864 9039 group.cpp:787] Syncing group operations: queue size (joins, cancels, datas) = (1, 0, 0)
I0804 23:38:39.533871 9039 group.cpp:385] Trying to create path '/test' in ZooKeeper
I0804 23:38:39.621798 9034 contender.cpp:240] Joined group after the contender started withdrawing
I0804 23:38:39.621820 9034 contender.cpp:186] Now cancelling the membership: 0
I0804 23:38:39.637754 9039 group.cpp:619] Trying to remove '/test/info_0000000000' in ZooKeeper
I0804 23:38:39.657939 9004 contender.cpp:196] Membership cancelled: 0
I0804 23:38:39.658159 8619 contender.cpp:186] Now cancelling the membership: 0
I0804 23:38:39.658264 9004 contender.cpp:131] Joining the ZK group
I0804 23:38:39.689465 9012 contender.cpp:247] New candidate (id='1') has entered the contest for leadership
2014-08-04 23:38:39,745:8619(0x2b6c06992700):ZOO_ERROR@handle_socket_error_msg@1721: Socket [127.0.0.1:45231] zk retcode=-4, errno=112(Host is down): failed while receiving a server response
I0804 23:38:39.769731 9039 group.cpp:418] Lost connection to ZooKeeper, attempting to reconnect ...
2014-08-04 23:38:40,637:8619(0x2b6c0574c700):ZOO_ERROR@handle_socket_error_msg@1697: Socket [127.0.0.1:33623] zk retcode=-4, errno=111(Connection refused): server refused to accept the client
2014-08-04 23:38:43,081:8619(0x2b6c06992700):ZOO_INFO@check_events@1703: initiated connection to server [127.0.0.1:45231]
2014-08-04 23:38:43,086:8619(0x2b6c06992700):ZOO_ERROR@handle_socket_error_msg@1739: Socket [127.0.0.1:45231] zk retcode=-112, errno=116(Stale NFS file handle): sessionId=0x147a36399010000 has expired.
I0804 23:38:43.089920 9008 group.cpp:472] ZooKeeper session expired
I0804 23:38:43.090006 9032 contender.cpp:196] Membership cancelled: 1
2014-08-04 23:38:43,093:8619(0x2b6983b30700):ZOO_INFO@zookeeper_close@2522: Freeing zookeeper resources for sessionId=0x147a36399010000
I0804 23:38:43.093721 9036 contender.cpp:186] Now cancelling the membership: 1
2014-08-04 23:38:43,093:8619(0x2b698392f700):ZOO_INFO@log_env@712: Client environment:zookeeper.version=zookeeper C client 3.4.5
2014-08-04 23:38:43,093:8619(0x2b698392f700):ZOO_INFO@log_env@716: Client environment:host.name=hemera
I0804 23:38:43.093827 9008 contender.cpp:196] Membership cancelled: 1
2014-08-04 23:38:43,093:8619(0x2b698392f700):ZOO_INFO@log_env@723: Client environment:os.name=Linux
2014-08-04 23:38:43,093:8619(0x2b698392f700):ZOO_INFO@log_env@724: Client environment:os.arch=3.2.0-61-generic
2014-08-04 23:38:43,093:8619(0x2b698392f700):ZOO_INFO@log_env@725: Client environment:os.version=#93-Ubuntu SMP Fri May 2 21:31:50 UTC 2014
2014-08-04 23:38:43,093:8619(0x2b698392f700):ZOO_INFO@log_env@733: Client environment:user.name=(null)
2014-08-04 23:38:43,093:8619(0x2b698392f700):ZOO_INFO@log_env@741: Client environment:user.home=/home/jenkins
2014-08-04 23:38:43,093:8619(0x2b698392f700):ZOO_INFO@log_env@753: Client environment:user.dir=/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/mesos-0.20.0/_build/src
2014-08-04 23:38:43,093:8619(0x2b698392f700):ZOO_INFO@zookeeper_init@786: Initiating client connection, host=127.0.0.1:45231 sessionTimeout=10000 watcher=0x2b69809474c0 sessionId=0 sessionPasswd=<null> context=0x2b69e40014e0 flags=0
I0804 23:38:43.094306 8619 contender.cpp:186] Now cancelling the membership: 1
I0804 23:38:43.094411 9011 contender.cpp:131] Joining the ZK group
2014-08-04 23:38:43,100:8619(0x2b6c06b93700):ZOO_INFO@check_events@1703: initiated connection to server [127.0.0.1:45231]
2014-08-04 23:38:43,109:8619(0x2b6c06b93700):ZOO_INFO@check_events@1750: session establishment complete on server [127.0.0.1:45231], sessionId=0x147a36399010001, negotiated timeout=10000
I0804 23:38:43.115375 9005 group.cpp:313] Group process (group(56)@140.211.11.27:35410) connected to ZooKeeper
I0804 23:38:43.115396 9005 group.cpp:787] Syncing group operations: queue size (joins, cancels, datas) = (1, 0, 0)
I0804 23:38:43.115403 9005 group.cpp:385] Trying to create path '/test' in ZooKeeper
I0804 23:38:43.169690 9012 contender.cpp:247] New candidate (id='2') has entered the contest for leadership
2014-08-04 23:38:43,213:8619(0x2b6c06b93700):ZOO_ERROR@handle_socket_error_msg@1721: Socket [127.0.0.1:45231] zk retcode=-4, errno=112(Host is down): failed while receiving a server response
2014-08-04 23:38:43,225:8619(0x2b6c06b93700):ZOO_INFO@check_events@1703: initiated connection to server [127.0.0.1:45231]
2014-08-04 23:38:43,226:8619(0x2b6c06b93700):ZOO_ERROR@handle_socket_error_msg@1739: Socket [127.0.0.1:45231] zk retcode=-112, errno=116(Stale NFS file handle): sessionId=0x147a36399010001 has expired.
I0804 23:38:43.241724 9005 group.cpp:418] Lost connection to ZooKeeper, attempting to reconnect ...
I0804 23:38:43.269688 9005 group.cpp:472] ZooKeeper session expired
I0804 23:38:43.273696 9026 contender.cpp:196] Membership cancelled: 2
2014-08-04 23:38:43,277:8619(0x2b698372e700):ZOO_INFO@zookeeper_close@2522: Freeing zookeeper resources for sessionId=0x147a36399010001
2014-08-04 23:38:43,277:8619(0x2b698533c700):ZOO_INFO@log_env@712: Client environment:zookeeper.version=zookeeper C client 3.4.5
2014-08-04 23:38:43,277:8619(0x2b698533c700):ZOO_INFO@log_env@716: Client environment:host.name=hemera
2014-08-04 23:38:43,277:8619(0x2b698533c700):ZOO_INFO@log_env@723: Client environment:os.name=Linux
2014-08-04 23:38:43,277:8619(0x2b698533c700):ZOO_INFO@log_env@724: Client environment:os.arch=3.2.0-61-generic
2014-08-04 23:38:43,277:8619(0x2b698533c700):ZOO_INFO@log_env@725: Client environment:os.version=#93-Ubuntu SMP Fri May 2 21:31:50 UTC 2014
2014-08-04 23:38:43,277:8619(0x2b698533c700):ZOO_INFO@log_env@733: Client environment:user.name=(null)
2014-08-04 23:38:43,277:8619(0x2b698533c700):ZOO_INFO@log_env@741: Client environment:user.home=/home/jenkins
2014-08-04 23:38:43,277:8619(0x2b698533c700):ZOO_INFO@log_env@753: Client environment:user.dir=/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/mesos-0.20.0/_build/src
2014-08-04 23:38:43,277:8619(0x2b698533c700):ZOO_INFO@zookeeper_init@786: Initiating client connection, host=127.0.0.1:45231 sessionTimeout=10000 watcher=0x2b69809474c0 sessionId=0 sessionPasswd=<null> context=0x2b699404c750 flags=0
2014-08-04 23:38:43,281:8619(0x2b6c06992700):ZOO_INFO@check_events@1703: initiated connection to server [127.0.0.1:45231]
2014-08-04 23:38:43,293:8619(0x2b6c06992700):ZOO_INFO@check_events@1750: session establishment complete on server [127.0.0.1:45231], sessionId=0x147a36399010002, negotiated timeout=10000
I0804 23:38:43.297833 9037 group.cpp:313] Group process (group(56)@140.211.11.27:35410) connected to ZooKeeper
I0804 23:38:43.297857 9037 group.cpp:787] Syncing group operations: queue size (joins, cancels, datas) = (0, 0, 0)
I0804 23:38:43.297865 9037 group.cpp:385] Trying to create path '/test' in ZooKeeper
I0804 23:38:43.365690 9032 contender.cpp:186] Now cancelling the membership: 2
I0804 23:38:43.365905 9032 contender.cpp:196] Membership cancelled: 2
I0804 23:38:43.366137 8619 contender.cpp:186] Now cancelling the membership: 2
I0804 23:38:43.367751 9007 contender.cpp:131] Joining the ZK group
I0804 23:38:43.393692 9004 contender.cpp:247] New candidate (id='3') has entered the contest for leadership
2014-08-04 23:38:43,401:8619(0x2b6c06992700):ZOO_ERROR@handle_socket_error_msg@1721: Socket [127.0.0.1:45231] zk retcode=-4, errno=112(Host is down): failed while receiving a server response
I0804 23:38:43.430140 8619 zookeeper_test_server.cpp:122] Shutdown ZooKeeperTestServer on port 45231
I0804 23:38:43.433666 9007 group.cpp:418] Lost connection to ZooKeeper, attempting to reconnect ...
W0804 23:38:43.457675 9003 group.cpp:456] Timed out waiting to reconnect to ZooKeeper. Forcing ZooKeeper session (sessionId=147a36399010002) expiration
I0804 23:38:43.459925 9003 group.cpp:472] ZooKeeper session expired
I0804 23:38:43.459997 9010 contender.cpp:196] Membership cancelled: 3
2014-08-04 23:38:43,465:8619(0x2b698332c700):ZOO_INFO@zookeeper_close@2522: Freeing zookeeper resources for sessionId=0x147a36399010002
2014-08-04 23:38:43,465:8619(0x2b698332c700):ZOO_INFO@log_env@712: Client environment:zookeeper.version=zookeeper C client 3.4.5
2014-08-04 23:38:43,465:8619(0x2b698332c700):ZOO_INFO@log_env@716: Client environment:host.name=hemera
2014-08-04 23:38:43,465:8619(0x2b698332c700):ZOO_INFO@log_env@723: Client environment:os.name=Linux
2014-08-04 23:38:43,465:8619(0x2b698332c700):ZOO_INFO@log_env@724: Client environment:os.arch=3.2.0-61-generic
2014-08-04 23:38:43,465:8619(0x2b698332c700):ZOO_INFO@log_env@725: Client environment:os.version=#93-Ubuntu SMP Fri May 2 21:31:50 UTC 2014
2014-08-04 23:38:43,465:8619(0x2b698332c700):ZOO_INFO@log_env@733: Client environment:user.name=(null)
2014-08-04 23:38:43,465:8619(0x2b698332c700):ZOO_INFO@log_env@741: Client environment:user.home=/home/jenkins
2014-08-04 23:38:43,465:8619(0x2b698332c700):ZOO_INFO@log_env@753: Client environment:user.dir=/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/mesos-0.20.0/_build/src
2014-08-04 23:38:43,465:8619(0x2b698332c700):ZOO_INFO@zookeeper_init@786: Initiating client connection, host=127.0.0.1:45231 sessionTimeout=10000 watcher=0x2b69809474c0 sessionId=0 sessionPasswd=<null> context=0x2b69a40019a0 flags=0
2014-08-04 23:38:43,481:8619(0x2b6c06b93700):ZOO_ERROR@handle_socket_error_msg@1697: Socket [127.0.0.1:45231] zk retcode=-4, errno=111(Connection refused): server refused to accept the client
I0804 23:38:43.514201 8619 zookeeper_test_server.cpp:158] Started ZooKeeperTestServer on port 45231
I0804 23:38:43.514430 8619 contender.cpp:186] Now cancelling the membership: 3
I0804 23:38:43.517717 9004 contender.cpp:131] Joining the ZK group
2014-08-04 23:38:43,973:8619(0x2b6c0574c700):ZOO_ERROR@handle_socket_error_msg@1697: Socket [127.0.0.1:33623] zk retcode=-4, errno=111(Connection refused): server refused to accept the client
2014-08-04 23:38:46,821:8619(0x2b6c06b93700):ZOO_INFO@check_events@1703: initiated connection to server [127.0.0.1:45231]
2014-08-04 23:38:46,870:8619(0x2b6c06b93700):ZOO_INFO@check_events@1750: session establishment complete on server [127.0.0.1:45231], sessionId=0x147a363a9a80000, negotiated timeout=10000
I0804 23:38:46.873883 9032 group.cpp:313] Group process (group(56)@140.211.11.27:35410) connected to ZooKeeper
I0804 23:38:46.873909 9032 group.cpp:787] Syncing group operations: queue size (joins, cancels, datas) = (1, 0, 0)
I0804 23:38:46.873919 9032 group.cpp:385] Trying to create path '/test' in ZooKeeper
I0804 23:38:46.957684 9034 contender.cpp:247] New candidate (id='4') has entered the contest for leadership
I0804 23:38:46.958554 8619 contender.cpp:186] Now cancelling the membership: 4
2014-08-04 23:38:46,997:8619(0x2b6983126f80):ZOO_INFO@zookeeper_close@2505: Closing zookeeper sessionId=0x147a363a9a80000 to [127.0.0.1:45231]
I0804 23:38:47.005988 8619 zookeeper_test_server.cpp:122] Shutdown ZooKeeperTestServer on port 45231
[ OK ] ZooKeeperTest.LeaderContender (7778 ms)
[ RUN ] ZooKeeperTest.LeaderDetectorTimeoutHandling
I0804 23:38:47.046175 8619 zookeeper_test_server.cpp:158] Started ZooKeeperTestServer on port 42643
2014-08-04 23:38:47,046:8619(0x2b698553d700):ZOO_INFO@log_env@712: Client environment:zookeeper.version=zookeeper C client 3.4.5
2014-08-04 23:38:47,046:8619(0x2b698553d700):ZOO_INFO@log_env@716: Client environment:host.name=hemera
2014-08-04 23:38:47,046:8619(0x2b698553d700):ZOO_INFO@log_env@723: Client environment:os.name=Linux
2014-08-04 23:38:47,046:8619(0x2b698553d700):ZOO_INFO@log_env@724: Client environment:os.arch=3.2.0-61-generic
2014-08-04 23:38:47,046:8619(0x2b698553d700):ZOO_INFO@log_env@725: Client environment:os.version=#93-Ubuntu SMP Fri May 2 21:31:50 UTC 2014
2014-08-04 23:38:47,046:8619(0x2b698553d700):ZOO_INFO@log_env@733: Client environment:user.name=(null)
2014-08-04 23:38:47,046:8619(0x2b698553d700):ZOO_INFO@log_env@741: Client environment:user.home=/home/jenkins
2014-08-04 23:38:47,046:8619(0x2b698553d700):ZOO_INFO@log_env@753: Client environment:user.dir=/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/mesos-0.20.0/_build/src
2014-08-04 23:38:47,046:8619(0x2b698553d700):ZOO_INFO@zookeeper_init@786: Initiating client connection, host=127.0.0.1:42643 sessionTimeout=10000 watcher=0x2b69809474c0 sessionId=0 sessionPasswd=<null> context=0x2b69c802fae0 flags=0
2014-08-04 23:38:47,053:8619(0x2b6c06992700):ZOO_INFO@check_events@1703: initiated connection to server [127.0.0.1:42643]
2014-08-04 23:38:47,090:8619(0x2b6c06992700):ZOO_INFO@check_events@1750: session establishment complete on server [127.0.0.1:42643], sessionId=0x147a363b7660000, negotiated timeout=10000
I0804 23:38:47.100445 9042 group.cpp:313] Group process (group(57)@140.211.11.27:35410) connected to ZooKeeper
I0804 23:38:47.100468 9042 group.cpp:787] Syncing group operations: queue size (joins, cancels, datas) = (1, 0, 0)
I0804 23:38:47.100476 9042 group.cpp:385] Trying to create path '/test' in ZooKeeper
I0804 23:38:47.201788 9042 detector.cpp:138] Detected a new leader: (id='0')
2014-08-04 23:38:47,209:8619(0x2b6c06992700):ZOO_ERROR@handle_socket_error_msg@1721: Socket [127.0.0.1:42643] zk retcode=-4, errno=112(Host is down): failed while receiving a server response
I0804 23:38:47.217815 9015 group.cpp:418] Lost connection to ZooKeeper, attempting to reconnect ...
I0804 23:38:47.219444 8619 zookeeper_test_server.cpp:122] Shutdown ZooKeeperTestServer on port 42643
W0804 23:38:47.229809 9036 group.cpp:456] Timed out waiting to reconnect to ZooKeeper. Forcing ZooKeeper session (sessionId=147a363b7660000) expiration
I0804 23:38:47.230026 9036 group.cpp:472] ZooKeeper session expired
I0804 23:38:47.230103 9015 detector.cpp:126] The current leader (id=0) is lost
I0804 23:38:47.230115 9015 detector.cpp:138] Detected a new leader: None
2014-08-04 23:38:47,233:8619(0x2b698573e700):ZOO_INFO@zookeeper_close@2522: Freeing zookeeper resources for sessionId=0x147a363b7660000
2014-08-04 23:38:47,233:8619(0x2b698573e700):ZOO_INFO@log_env@712: Client environment:zookeeper.version=zookeeper C client 3.4.5
2014-08-04 23:38:47,233:8619(0x2b698573e700):ZOO_INFO@log_env@716: Client environment:host.name=hemera
2014-08-04 23:38:47,233:8619(0x2b698573e700):ZOO_INFO@log_env@723: Client environment:os.name=Linux
2014-08-04 23:38:47,233:8619(0x2b698573e700):ZOO_INFO@log_env@724: Client environment:os.arch=3.2.0-61-generic
2014-08-04 23:38:47,233:8619(0x2b698573e700):ZOO_INFO@log_env@725: Client environment:os.version=#93-Ubuntu SMP Fri May 2 21:31:50 UTC 2014
2014-08-04 23:38:47,233:8619(0x2b698573e700):ZOO_INFO@log_env@733: Client environment:user.name=(null)
2014-08-04 23:38:47,233:8619(0x2b698573e700):ZOO_INFO@log_env@741: Client environment:user.home=/home/jenkins
2014-08-04 23:38:47,233:8619(0x2b698573e700):ZOO_INFO@log_env@753: Client environment:user.dir=/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/mesos-0.20.0/_build/src
2014-08-04 23:38:47,233:8619(0x2b698573e700):ZOO_INFO@zookeeper_init@786: Initiating client connection, host=127.0.0.1:42643 sessionTimeout=10000 watcher=0x2b69809474c0 sessionId=0 sessionPasswd=<null> context=0x2b69ec03c9b0 flags=0
2014-08-04 23:38:47,249:8619(0x2b6983126f80):ZOO_INFO@zookeeper_close@2522: Freeing zookeeper resources for sessionId=0
[ OK ] ZooKeeperTest.LeaderDetectorTimeoutHandling (243 ms)
[----------] 7 tests from ZooKeeperTest (18262 ms total)
[----------] 3 tests from LogStorageTest/0, where TypeParam = mesos::internal::log::LevelDBStorage
[ RUN ] LogStorageTest/0.Truncate
Using temporary directory '/tmp/LogStorageTest_0_Truncate_wt2jhN'
I0804 23:38:47.293789 8619 leveldb.cpp:176] Opened db in 43.880017ms
2014-08-04 23:38:47,310:8619(0x2b6c0574c700):ZOO_ERROR@handle_socket_error_msg@1697: Socket [127.0.0.1:33623] zk retcode=-4, errno=111(Connection refused): server refused to accept the client
I0804 23:38:47.321655 8619 leveldb.cpp:183] Compacted db in 27.825535ms
I0804 23:38:47.321687 8619 leveldb.cpp:198] Created db iterator in 5222ns
I0804 23:38:47.321696 8619 leveldb.cpp:204] Seeked to beginning of db in 812ns
I0804 23:38:47.321703 8619 leveldb.cpp:273] Iterated through 0 keys in the db in 247ns
I0804 23:38:47.335304 8619 leveldb.cpp:343] Persisting action (19 bytes) to leveldb took 13.562407ms
I0804 23:38:47.353435 8619 leveldb.cpp:343] Persisting action (19 bytes) to leveldb took 18.100406ms
I0804 23:38:47.369654 8619 leveldb.cpp:343] Persisting action (19 bytes) to leveldb took 16.114607ms
I0804 23:38:47.385654 8619 leveldb.cpp:343] Persisting action (19 bytes) to leveldb took 15.90829ms
I0804 23:38:47.399621 8619 leveldb.cpp:343] Persisting action (19 bytes) to leveldb took 13.872122ms
I0804 23:38:47.417675 8619 leveldb.cpp:343] Persisting action (19 bytes) to leveldb took 17.963577ms
I0804 23:38:47.433652 8619 leveldb.cpp:343] Persisting action (19 bytes) to leveldb took 15.830491ms
I0804 23:38:47.447851 8619 leveldb.cpp:343] Persisting action (19 bytes) to leveldb took 14.11905ms
I0804 23:38:47.465654 8619 leveldb.cpp:343] Persisting action (19 bytes) to leveldb took 17.716783ms
I0804 23:38:47.480032 8619 leveldb.cpp:343] Persisting action (19 bytes) to leveldb took 14.286864ms
I0804 23:38:47.480151 8619 leveldb.cpp:438] Reading position from leveldb took 17902ns
I0804 23:38:47.480228 8619 leveldb.cpp:438] Reading position from leveldb took 7144ns
I0804 23:38:47.480299 8619 leveldb.cpp:438] Reading position from leveldb took 6717ns
I0804 23:38:47.480370 8619 leveldb.cpp:438] Reading position from leveldb took 6755ns
I0804 23:38:47.480440 8619 leveldb.cpp:438] Reading position from leveldb took 6872ns
I0804 23:38:47.480510 8619 leveldb.cpp:438] Reading position from leveldb took 6738ns
I0804 23:38:47.480581 8619 leveldb.cpp:438] Reading position from leveldb took 6787ns
I0804 23:38:47.480650 8619 leveldb.cpp:438] Reading position from leveldb took 6793ns
I0804 23:38:47.480720 8619 leveldb.cpp:438] Reading position from leveldb took 6846ns
I0804 23:38:47.480789 8619 leveldb.cpp:438] Reading position from leveldb took 6647ns
I0804 23:38:47.496109 8619 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 15.246757ms
I0804 23:38:47.496204 8619 leveldb.cpp:401] Deleting ~3 keys from leveldb took 22777ns
I0804 23:38:47.496285 8619 leveldb.cpp:438] Reading position from leveldb took 5740ns
I0804 23:38:47.496357 8619 leveldb.cpp:438] Reading position from leveldb took 7205ns
I0804 23:38:47.496428 8619 leveldb.cpp:438] Reading position from leveldb took 6863ns
I0804 23:38:47.496496 8619 leveldb.cpp:438] Reading position from leveldb took 6823ns
I0804 23:38:47.496567 8619 leveldb.cpp:438] Reading position from leveldb took 6936ns
I0804 23:38:47.496635 8619 leveldb.cpp:438] Reading position from leveldb took 7056ns
I0804 23:38:47.496705 8619 leveldb.cpp:438] Reading position from leveldb took 6748ns
I0804 23:38:47.496773 8619 leveldb.cpp:438] Reading position from leveldb took 6823ns
I0804 23:38:47.517657 8619 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 20.817052ms
I0804 23:38:47.517773 8619 leveldb.cpp:401] Deleting ~7 keys from leveldb took 32624ns
I0804 23:38:47.517875 8619 leveldb.cpp:438] Reading position from leveldb took 5915ns
I0804 23:38:47.517947 8619 leveldb.cpp:438] Reading position from leveldb took 7367ns
[ OK ] LogStorageTest/0.Truncate (269 ms)
[ RUN ] LogStorageTest/0.TruncateWithEmptyLog
Using temporary directory '/tmp/LogStorageTest_0_TruncateWithEmptyLog_uPK7LO'
I0804 23:38:47.569813 8619 leveldb.cpp:176] Opened db in 51.277638ms
I0804 23:38:47.593688 8619 leveldb.cpp:183] Compacted db in 23.757896ms
I0804 23:38:47.593787 8619 leveldb.cpp:198] Created db iterator in 5170ns
I0804 23:38:47.593844 8619 leveldb.cpp:204] Seeked to beginning of db in 831ns
I0804 23:38:47.593902 8619 leveldb.cpp:273] Iterated through 0 keys in the db in 274ns
I0804 23:38:47.618412 8619 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 24.43577ms
I0804 23:38:47.618540 8619 leveldb.cpp:438] Reading position from leveldb took 11316ns
[ OK ] LogStorageTest/0.TruncateWithEmptyLog (100 ms)
[ RUN ] LogStorageTest/0.TruncateWithManyHoles
Using temporary directory '/tmp/LogStorageTest_0_TruncateWithManyHoles_zreTAQ'
I0804 23:38:47.665784 8619 leveldb.cpp:176] Opened db in 46.665439ms
I0804 23:38:47.689651 8619 leveldb.cpp:183] Compacted db in 23.766801ms
I0804 23:38:47.689735 8619 leveldb.cpp:198] Created db iterator in 5256ns
I0804 23:38:47.689791 8619 leveldb.cpp:204] Seeked to beginning of db in 834ns
I0804 23:38:47.689848 8619 leveldb.cpp:273] Iterated through 0 keys in the db in 288ns
I0804 23:38:47.709661 8619 leveldb.cpp:343] Persisting action (26 bytes) to leveldb took 19.74562ms
I0804 23:38:47.709771 8619 leveldb.cpp:438] Reading position from leveldb took 16474ns
[ OK ] LogStorageTest/0.TruncateWithManyHoles (92 ms)
[----------] 3 tests from LogStorageTest/0 (461 ms total)
[----------] 2 tests from FetcherTest
[ RUN ] FetcherTest.FileURI
Using temporary directory '/tmp/FetcherTest_FileURI_8jVLHS'
WARNING: Logging before InitGoogleLogging() is written to STDERR
I0804 23:38:47.841572 3328 fetcher.cpp:76] Fetching URI 'file:///tmp/FetcherTest_FileURI_8jVLHS/from/test'
I0804 23:38:47.841706 3328 fetcher.cpp:179] Copying resource from '/tmp/FetcherTest_FileURI_8jVLHS/from/test' to '/tmp/FetcherTest_FileURI_8jVLHS'
I0804 23:38:47.861773 3328 fetcher.cpp:255] Skipped extracting path '/tmp/FetcherTest_FileURI_8jVLHS/test'
[ OK ] FetcherTest.FileURI (513 ms)
[ RUN ] FetcherTest.FileLocalhostURI
Using temporary directory '/tmp/FetcherTest_FileLocalhostURI_P3dssW'
WARNING: Logging before InitGoogleLogging() is written to STDERR
I0804 23:38:48.344256 3373 fetcher.cpp:76] Fetching URI 'file://localhost/tmp/FetcherTest_FileLocalhostURI_P3dssW/from/test'
I0804 23:38:48.344378 3373 fetcher.cpp:179] Copying resource from '/tmp/FetcherTest_FileLocalhostURI_P3dssW/from/test' to '/tmp/FetcherTest_FileLocalhostURI_P3dssW'
I0804 23:38:48.361697 3373 fetcher.cpp:255] Skipped extracting path '/tmp/FetcherTest_FileLocalhostURI_P3dssW/test'
[ OK ] FetcherTest.FileLocalhostURI (1010 ms)
[----------] 2 tests from FetcherTest (1523 ms total)
[----------] Global test environment tear-down
[==========] 392 tests from 64 test cases ran. (422541 ms total)
[ PASSED ] 390 tests.
[ FAILED ] 2 tests, listed below:
[ FAILED ] SlaveRecoveryTest/0.RestartBeforeContainerizerLaunch, where TypeParam = mesos::internal::slave::MesosContainerizer
[ FAILED ] SlaveTest.MesosExecutorWithOverride
2 FAILED TESTS
YOU HAVE 4 DISABLED TESTS
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/mesos-0.20.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/mesos-0.20.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/mesos-0.20.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/mesos-0.20.0/_build'
make: *** [distcheck] Error 1
Build step 'Execute shell' marked build as failure