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/04/21 01:22:02 UTC
Build failed in Jenkins:
Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME #2076
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/2076/changes>
Changes:
[yan] Fixed an incorrect CHECK in Group.
------------------------------------------
[...truncated 39913 lines...]
I0420 23:22:01.202941 9371 replica.cpp:508] Replica received write request for position 2
I0420 23:22:01.203482 9329 containerizer.cpp:177] Using isolation: posix/cpu,posix/mem
I0420 23:22:01.207036 9373 slave.cpp:129] Slave started on 143)@140.211.11.27:55410
I0420 23:22:01.207175 9373 slave.cpp:217] Slave resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0420 23:22:01.207341 9373 slave.cpp:245] Slave hostname: hemera.apache.org
I0420 23:22:01.207363 9373 slave.cpp:246] Slave checkpoint: true
I0420 23:22:01.208019 9373 state.cpp:33] Recovering state from '/tmp/SlaveRecoveryTest_0_RemoveNonCheckpointingFramework_lk36kH/meta'
I0420 23:22:01.208195 9373 status_update_manager.cpp:193] Recovering status update manager
I0420 23:22:01.208289 9373 mesos_containerizer.cpp:171] Recovering containerizer
I0420 23:22:01.208663 9373 slave.cpp:2791] Finished recovery
I0420 23:22:01.210376 9355 slave.cpp:496] New master detected at master@140.211.11.27:55410
I0420 23:22:01.210459 9373 status_update_manager.cpp:167] New master detected at master@140.211.11.27:55410
I0420 23:22:01.210486 9355 slave.cpp:521] Detecting new master
I0420 23:22:01.210721 9355 registrar.cpp:314] Attempting to update the 'registry'
I0420 23:22:01.211155 9329 sched.cpp:121] Version: 0.19.0
I0420 23:22:01.211359 9373 sched.cpp:217] New master detected at master@140.211.11.27:55410
I0420 23:22:01.211387 9373 sched.cpp:268] Authenticating with master master@140.211.11.27:55410
I0420 23:22:01.211513 9365 authenticatee.hpp:128] Creating new client SASL connection
I0420 23:22:01.211695 9365 master.cpp:2715] Authenticating framework at scheduler(136)@140.211.11.27:55410
I0420 23:22:01.211843 9373 authenticator.hpp:148] Creating new server SASL connection
I0420 23:22:01.212012 9373 authenticatee.hpp:219] Received SASL authentication mechanisms: CRAM-MD5
I0420 23:22:01.212038 9373 authenticatee.hpp:245] Attempting to authenticate with mechanism 'CRAM-MD5'
I0420 23:22:01.212081 9373 authenticator.hpp:254] Received SASL authentication start
I0420 23:22:01.212173 9373 authenticator.hpp:342] Authentication requires more steps
I0420 23:22:01.214223 9371 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 11.246188ms
I0420 23:22:01.214273 9371 replica.cpp:664] Persisted action at 2
I0420 23:22:01.217913 9359 authenticatee.hpp:265] Received SASL authentication step
I0420 23:22:01.218015 9359 authenticator.hpp:282] Received SASL authentication step
I0420 23:22:01.218045 9359 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
I0420 23:22:01.218060 9359 auxprop.cpp:153] Looking up auxiliary property '*userPassword'
I0420 23:22:01.218077 9359 auxprop.cpp:153] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0420 23:22:01.218092 9359 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
I0420 23:22:01.218104 9359 auxprop.cpp:103] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0420 23:22:01.218113 9359 auxprop.cpp:103] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0420 23:22:01.218133 9359 authenticator.hpp:334] Authentication success
I0420 23:22:01.218183 9359 authenticatee.hpp:305] Authentication success
I0420 23:22:01.218222 9359 master.cpp:2755] Successfully authenticated framework at scheduler(136)@140.211.11.27:55410
I0420 23:22:01.218358 9359 sched.cpp:342] Successfully authenticated with master master@140.211.11.27:55410
I0420 23:22:01.218377 9359 sched.cpp:461] Sending registration request to master@140.211.11.27:55410
I0420 23:22:01.218454 9359 master.cpp:997] Received registration request from scheduler(136)@140.211.11.27:55410
I0420 23:22:01.218502 9359 master.cpp:1015] Registering framework 20140420-232201-453759884-55410-9329-0000 at scheduler(136)@140.211.11.27:55410
I0420 23:22:01.218601 9359 sched.cpp:392] Framework registered with 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.218632 9359 sched.cpp:406] Scheduler::registered took 14553ns
I0420 23:22:01.218684 9359 hierarchical_allocator_process.hpp:332] Added framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.218698 9359 hierarchical_allocator_process.hpp:726] No resources available to allocate!
I0420 23:22:01.218708 9359 hierarchical_allocator_process.hpp:688] Performed allocation for 0 slaves in 10745ns
I0420 23:22:01.219423 9361 replica.cpp:643] Replica received learned notice for position 2
I0420 23:22:01.230386 9361 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 10.920499ms
I0420 23:22:01.230499 9361 leveldb.cpp:399] Deleting ~1 keys from leveldb took 51903ns
I0420 23:22:01.230521 9361 replica.cpp:664] Persisted action at 2
I0420 23:22:01.230538 9361 replica.cpp:649] Replica learned TRUNCATE action at position 2
I0420 23:22:01.231210 9361 log.cpp:663] Attempting to append 330 bytes to the log
I0420 23:22:01.231407 9361 coordinator.cpp:339] Coordinator attempting to write APPEND action at position 3
I0420 23:22:01.231681 9361 replica.cpp:508] Replica received write request for position 3
I0420 23:22:01.242457 9361 leveldb.cpp:341] Persisting action (349 bytes) to leveldb took 10.722373ms
I0420 23:22:01.242516 9361 replica.cpp:664] Persisted action at 3
I0420 23:22:01.242812 9361 replica.cpp:643] Replica received learned notice for position 3
I0420 23:22:01.254533 9361 leveldb.cpp:341] Persisting action (351 bytes) to leveldb took 11.695244ms
I0420 23:22:01.254580 9361 replica.cpp:664] Persisted action at 3
I0420 23:22:01.254590 9361 replica.cpp:649] Replica learned APPEND action at position 3
I0420 23:22:01.254927 9363 registrar.cpp:356] Successfully updated 'registry'
I0420 23:22:01.255056 9368 log.cpp:682] Attempting to truncate the log to 3
I0420 23:22:01.255060 9367 master.cpp:2150] Admitted slave on hemera.apache.org at slave(143)@140.211.11.27:55410
I0420 23:22:01.255079 9367 master.cpp:3204] Adding slave 20140420-232201-453759884-55410-9329-0 at hemera.apache.org with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0420 23:22:01.255175 9369 coordinator.cpp:339] Coordinator attempting to write TRUNCATE action at position 4
I0420 23:22:01.255702 9358 hierarchical_allocator_process.hpp:445] Added slave 20140420-232201-453759884-55410-9329-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)
I0420 23:22:01.255812 9358 hierarchical_allocator_process.hpp:752] Offering cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140420-232201-453759884-55410-9329-0 to framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.255903 9361 replica.cpp:508] Replica received write request for position 4
I0420 23:22:01.255888 9354 slave.cpp:539] Registered with master master@140.211.11.27:55410; given slave ID 20140420-232201-453759884-55410-9329-0
I0420 23:22:01.255929 9358 hierarchical_allocator_process.hpp:708] Performed allocation for slave 20140420-232201-453759884-55410-9329-0 in 187233ns
I0420 23:22:01.255997 9371 master.hpp:524] Adding offer 20140420-232201-453759884-55410-9329-0 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140420-232201-453759884-55410-9329-0 (hemera.apache.org)
I0420 23:22:01.256067 9354 slave.cpp:552] Checkpointing SlaveInfo to '/tmp/SlaveRecoveryTest_0_RemoveNonCheckpointingFramework_lk36kH/meta/slaves/20140420-232201-453759884-55410-9329-0/slave.info'
I0420 23:22:01.256089 9371 master.cpp:2676] Sending 1 offers to framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.256330 9371 sched.cpp:529] Scheduler::resourceOffers took 111222ns
W0420 23:22:01.259619 9363 sched.cpp:902] Attempting to launch task 61c3f349-ba84-4ba3-b270-61d9b4b29c44 with an unknown offer 20140420-232201-453759884-55410-9329-0
I0420 23:22:01.259794 9369 master.hpp:534] Removing offer 20140420-232201-453759884-55410-9329-0 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140420-232201-453759884-55410-9329-0 (hemera.apache.org)
I0420 23:22:01.259838 9369 master.cpp:1815] Processing reply for offers: [ 20140420-232201-453759884-55410-9329-0 ] on slave 20140420-232201-453759884-55410-9329-0 (hemera.apache.org) for framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.259874 9369 master.hpp:496] Adding task 00f7dd55-27d8-484b-8155-dc35dae1bab6 with resources cpus(*):1; mem(*):512 on slave 20140420-232201-453759884-55410-9329-0 (hemera.apache.org)
I0420 23:22:01.259907 9369 master.cpp:2839] Launching task 00f7dd55-27d8-484b-8155-dc35dae1bab6 of framework 20140420-232201-453759884-55410-9329-0000 with resources cpus(*):1; mem(*):512 on slave 20140420-232201-453759884-55410-9329-0 (hemera.apache.org)
I0420 23:22:01.259974 9369 master.hpp:496] Adding task 61c3f349-ba84-4ba3-b270-61d9b4b29c44 with resources cpus(*):1; mem(*):512 on slave 20140420-232201-453759884-55410-9329-0 (hemera.apache.org)
I0420 23:22:01.259984 9364 slave.cpp:754] Got assigned task 00f7dd55-27d8-484b-8155-dc35dae1bab6 for framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.259996 9369 master.cpp:2839] Launching task 61c3f349-ba84-4ba3-b270-61d9b4b29c44 of framework 20140420-232201-453759884-55410-9329-0000 with resources cpus(*):1; mem(*):512 on slave 20140420-232201-453759884-55410-9329-0 (hemera.apache.org)
I0420 23:22:01.260088 9366 hierarchical_allocator_process.hpp:547] Framework 20140420-232201-453759884-55410-9329-0000 left disk(*):1024; ports(*):[31000-32000] unused on slave 20140420-232201-453759884-55410-9329-0
I0420 23:22:01.260159 9366 hierarchical_allocator_process.hpp:590] Framework 20140420-232201-453759884-55410-9329-0000 filtered slave 20140420-232201-453759884-55410-9329-0 for 5secs
I0420 23:22:01.260202 9364 slave.cpp:754] Got assigned task 61c3f349-ba84-4ba3-b270-61d9b4b29c44 for framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.260300 9364 slave.cpp:863] Launching task 00f7dd55-27d8-484b-8155-dc35dae1bab6 for framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.262119 9364 slave.cpp:973] Queuing task '00f7dd55-27d8-484b-8155-dc35dae1bab6' for executor 00f7dd55-27d8-484b-8155-dc35dae1bab6 of framework '20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.262249 9371 mesos_containerizer.cpp:385] Starting container '89a203ed-b577-43d0-894b-908cf7aba57e' for executor '00f7dd55-27d8-484b-8155-dc35dae1bab6' of framework '20140420-232201-453759884-55410-9329-0000'
I0420 23:22:01.262266 9364 slave.cpp:863] Launching task 61c3f349-ba84-4ba3-b270-61d9b4b29c44 for framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.262608 9371 mesos_containerizer.cpp:507] Fetching URIs for container '89a203ed-b577-43d0-894b-908cf7aba57e' using command '/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/mesos-0.19.0/_build/src/mesos-fetcher'
I0420 23:22:01.270736 9364 slave.cpp:973] Queuing task '61c3f349-ba84-4ba3-b270-61d9b4b29c44' for executor 61c3f349-ba84-4ba3-b270-61d9b4b29c44 of framework '20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.270959 9364 slave.cpp:457] Successfully attached file '/tmp/SlaveRecoveryTest_0_RemoveNonCheckpointingFramework_lk36kH/slaves/20140420-232201-453759884-55410-9329-0/frameworks/20140420-232201-453759884-55410-9329-0000/executors/00f7dd55-27d8-484b-8155-dc35dae1bab6/runs/89a203ed-b577-43d0-894b-908cf7aba57e'
I0420 23:22:01.271006 9364 slave.cpp:457] Successfully attached file '/tmp/SlaveRecoveryTest_0_RemoveNonCheckpointingFramework_lk36kH/slaves/20140420-232201-453759884-55410-9329-0/frameworks/20140420-232201-453759884-55410-9329-0000/executors/61c3f349-ba84-4ba3-b270-61d9b4b29c44/runs/226a74b0-dce0-4d2d-a7e9-629253e48e45'
I0420 23:22:01.271997 9361 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 16.063821ms
I0420 23:22:01.272054 9361 replica.cpp:664] Persisted action at 4
I0420 23:22:01.273387 9372 replica.cpp:643] Replica received learned notice for position 4
I0420 23:22:01.278170 9371 mesos_containerizer.cpp:385] Starting container '226a74b0-dce0-4d2d-a7e9-629253e48e45' for executor '61c3f349-ba84-4ba3-b270-61d9b4b29c44' of framework '20140420-232201-453759884-55410-9329-0000'
I0420 23:22:01.279294 9359 mesos_containerizer.cpp:507] Fetching URIs for container '226a74b0-dce0-4d2d-a7e9-629253e48e45' using command '/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/mesos-0.19.0/_build/src/mesos-fetcher'
I0420 23:22:01.288699 9372 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 15.273222ms
I0420 23:22:01.288838 9372 leveldb.cpp:399] Deleting ~2 keys from leveldb took 42933ns
I0420 23:22:01.288856 9372 replica.cpp:664] Persisted action at 4
I0420 23:22:01.288869 9372 replica.cpp:649] Replica learned TRUNCATE action at position 4
I0420 23:22:01.590369 9365 launcher.cpp:117] Forked child with pid '13635' for container '89a203ed-b577-43d0-894b-908cf7aba57e'
I0420 23:22:01.594457 9365 launcher.cpp:117] Forked child with pid '13636' for container '226a74b0-dce0-4d2d-a7e9-629253e48e45'
I0420 23:22:01.596091 9355 slave.cpp:2118] Monitoring executor '61c3f349-ba84-4ba3-b270-61d9b4b29c44' of framework '20140420-232201-453759884-55410-9329-0000' in container '226a74b0-dce0-4d2d-a7e9-629253e48e45'
I0420 23:22:01.599998 9353 slave.cpp:2118] Monitoring executor '00f7dd55-27d8-484b-8155-dc35dae1bab6' of framework '20140420-232201-453759884-55410-9329-0000' in container '89a203ed-b577-43d0-894b-908cf7aba57e'
WARNING: Logging before InitGoogleLogging() is written to STDERR
WARNING: Logging before InitGoogleLogging() is written to STDERR
I0420 23:22:01.644233 13641 process.cpp:1589] libprocess is initialized on 140.211.11.27:51591 for 24 cpus
I0420 23:22:01.644220 13642 process.cpp:1589] libprocess is initialized on 140.211.11.27:43746 for 24 cpus
I0420 23:22:01.645511 13642 exec.cpp:131] Version: 0.19.0
I0420 23:22:01.645648 13641 exec.cpp:131] Version: 0.19.0
I0420 23:22:01.646708 13686 exec.cpp:181] Executor started at: executor(1)@140.211.11.27:43746 with pid 13642
I0420 23:22:01.647003 13692 exec.cpp:181] Executor started at: executor(1)@140.211.11.27:51591 with pid 13641
I0420 23:22:01.647203 9355 slave.cpp:1446] Got registration for executor '00f7dd55-27d8-484b-8155-dc35dae1bab6' of framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.647922 9355 slave.cpp:1565] Flushing queued task 00f7dd55-27d8-484b-8155-dc35dae1bab6 for executor '00f7dd55-27d8-484b-8155-dc35dae1bab6' of framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.648088 9355 slave.cpp:1446] Got registration for executor '61c3f349-ba84-4ba3-b270-61d9b4b29c44' of framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.648169 13719 process.cpp:1008] Socket closed while receiving
I0420 23:22:01.648200 13681 exec.cpp:205] Executor registered on slave 20140420-232201-453759884-55410-9329-0
I0420 23:22:01.648222 9355 slave.cpp:1565] Flushing queued task 61c3f349-ba84-4ba3-b270-61d9b4b29c44 for executor '61c3f349-ba84-4ba3-b270-61d9b4b29c44' of framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.648402 13718 process.cpp:1008] Socket closed while receiving
I0420 23:22:01.648454 13690 exec.cpp:205] Executor registered on slave 20140420-232201-453759884-55410-9329-0
I0420 23:22:01.649363 13681 exec.cpp:217] Executor::registered took 81712ns
Registered executor on hemera.apache.org
I0420 23:22:01.649433 13681 exec.cpp:292] Executor asked to run task '00f7dd55-27d8-484b-8155-dc35dae1bab6'
I0420 23:22:01.649468 13681 exec.cpp:301] Executor::launchTask took 22776ns
Starting task 00f7dd55-27d8-484b-8155-dc35dae1bab6
I0420 23:22:01.649590 13690 exec.cpp:217] Executor::registered took 70056ns
Registered executor on hemera.apache.org
I0420 23:22:01.649662 13690 exec.cpp:292] Executor asked to run task '61c3f349-ba84-4ba3-b270-61d9b4b29c44'
I0420 23:22:01.649696 13690 exec.cpp:301] Executor::launchTask took 22290ns
Starting task 61c3f349-ba84-4ba3-b270-61d9b4b29c44
Forked command at 13720
sh -c 'sleep 1000'
sh -c 'sleep 1000'
Forked command at 13721
I0420 23:22:01.651680 13685 exec.cpp:524] Executor sending status update TASK_RUNNING (UUID: c9179358-7e0f-466f-a964-09d3d4aa55bc) for task 61c3f349-ba84-4ba3-b270-61d9b4b29c44 of framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.651770 13716 exec.cpp:524] Executor sending status update TASK_RUNNING (UUID: 36bb9e17-7812-438d-a699-6c0374ef0f4f) for task 00f7dd55-27d8-484b-8155-dc35dae1bab6 of framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.651947 9357 slave.cpp:1775] Handling status update TASK_RUNNING (UUID: c9179358-7e0f-466f-a964-09d3d4aa55bc) for task 61c3f349-ba84-4ba3-b270-61d9b4b29c44 of framework 20140420-232201-453759884-55410-9329-0000 from executor(1)@140.211.11.27:51591
I0420 23:22:01.652099 9354 status_update_manager.cpp:320] Received status update TASK_RUNNING (UUID: c9179358-7e0f-466f-a964-09d3d4aa55bc) for task 61c3f349-ba84-4ba3-b270-61d9b4b29c44 of framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.652117 9357 slave.cpp:1775] Handling status update TASK_RUNNING (UUID: 36bb9e17-7812-438d-a699-6c0374ef0f4f) for task 00f7dd55-27d8-484b-8155-dc35dae1bab6 of framework 20140420-232201-453759884-55410-9329-0000 from executor(1)@140.211.11.27:43746
I0420 23:22:01.652132 9354 status_update_manager.cpp:499] Creating StatusUpdate stream for task 61c3f349-ba84-4ba3-b270-61d9b4b29c44 of framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.652256 9354 status_update_manager.cpp:373] Forwarding status update TASK_RUNNING (UUID: c9179358-7e0f-466f-a964-09d3d4aa55bc) for task 61c3f349-ba84-4ba3-b270-61d9b4b29c44 of framework 20140420-232201-453759884-55410-9329-0000 to master@140.211.11.27:55410
I0420 23:22:01.652626 9354 status_update_manager.cpp:320] Received status update TASK_RUNNING (UUID: 36bb9e17-7812-438d-a699-6c0374ef0f4f) for task 00f7dd55-27d8-484b-8155-dc35dae1bab6 of framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.652642 9354 status_update_manager.cpp:499] Creating StatusUpdate stream for task 00f7dd55-27d8-484b-8155-dc35dae1bab6 of framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.652683 9359 master.cpp:2382] Status update TASK_RUNNING (UUID: c9179358-7e0f-466f-a964-09d3d4aa55bc) for task 61c3f349-ba84-4ba3-b270-61d9b4b29c44 of framework 20140420-232201-453759884-55410-9329-0000 from slave(143)@140.211.11.27:55410
I0420 23:22:01.652693 9354 status_update_manager.cpp:373] Forwarding status update TASK_RUNNING (UUID: 36bb9e17-7812-438d-a699-6c0374ef0f4f) for task 00f7dd55-27d8-484b-8155-dc35dae1bab6 of framework 20140420-232201-453759884-55410-9329-0000 to master@140.211.11.27:55410
I0420 23:22:01.652735 9358 slave.cpp:1892] Status update manager successfully handled status update TASK_RUNNING (UUID: c9179358-7e0f-466f-a964-09d3d4aa55bc) for task 61c3f349-ba84-4ba3-b270-61d9b4b29c44 of framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.652755 9358 slave.cpp:1898] Sending acknowledgement for status update TASK_RUNNING (UUID: c9179358-7e0f-466f-a964-09d3d4aa55bc) for task 61c3f349-ba84-4ba3-b270-61d9b4b29c44 of framework 20140420-232201-453759884-55410-9329-0000 to executor(1)@140.211.11.27:51591
I0420 23:22:01.652763 9371 sched.cpp:620] Scheduler::statusUpdate took 40138ns
I0420 23:22:01.653095 13718 process.cpp:1008] Socket closed while receiving
I0420 23:22:01.653156 13703 exec.cpp:338] Executor received status update acknowledgement c9179358-7e0f-466f-a964-09d3d4aa55bc for task 61c3f349-ba84-4ba3-b270-61d9b4b29c44 of framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.653197 9366 master.cpp:2382] Status update TASK_RUNNING (UUID: 36bb9e17-7812-438d-a699-6c0374ef0f4f) for task 00f7dd55-27d8-484b-8155-dc35dae1bab6 of framework 20140420-232201-453759884-55410-9329-0000 from slave(143)@140.211.11.27:55410
I0420 23:22:01.653317 9365 status_update_manager.cpp:398] Received status update acknowledgement (UUID: c9179358-7e0f-466f-a964-09d3d4aa55bc) for task 61c3f349-ba84-4ba3-b270-61d9b4b29c44 of framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.653316 9352 slave.cpp:1892] Status update manager successfully handled status update TASK_RUNNING (UUID: 36bb9e17-7812-438d-a699-6c0374ef0f4f) for task 00f7dd55-27d8-484b-8155-dc35dae1bab6 of framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.653338 9352 slave.cpp:1898] Sending acknowledgement for status update TASK_RUNNING (UUID: 36bb9e17-7812-438d-a699-6c0374ef0f4f) for task 00f7dd55-27d8-484b-8155-dc35dae1bab6 of framework 20140420-232201-453759884-55410-9329-0000 to executor(1)@140.211.11.27:43746
I0420 23:22:01.653383 9364 sched.cpp:620] Scheduler::statusUpdate took 76860ns
I0420 23:22:01.653445 9352 slave.cpp:1386] Status update manager successfully handled status update acknowledgement (UUID: c9179358-7e0f-466f-a964-09d3d4aa55bc) for task 61c3f349-ba84-4ba3-b270-61d9b4b29c44 of framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.653516 13719 process.cpp:1008] Socket closed while receiving
I0420 23:22:01.653545 13675 exec.cpp:338] Executor received status update acknowledgement 36bb9e17-7812-438d-a699-6c0374ef0f4f for task 00f7dd55-27d8-484b-8155-dc35dae1bab6 of framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.653635 9360 status_update_manager.cpp:398] Received status update acknowledgement (UUID: 36bb9e17-7812-438d-a699-6c0374ef0f4f) for task 00f7dd55-27d8-484b-8155-dc35dae1bab6 of framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.653687 9356 slave.cpp:386] Slave terminating
I0420 23:22:01.653704 9356 slave.cpp:1157] Asked to shut down framework 20140420-232201-453759884-55410-9329-0000 by @0.0.0.0:0
I0420 23:22:01.653714 9356 slave.cpp:1182] Shutting down framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.653723 9356 slave.cpp:2461] Shutting down executor '00f7dd55-27d8-484b-8155-dc35dae1bab6' of framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.653800 9356 slave.cpp:2461] Shutting down executor '61c3f349-ba84-4ba3-b270-61d9b4b29c44' of framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.653879 13719 process.cpp:1008] Socket closed while receiving
I0420 23:22:01.653898 13673 exec.cpp:378] Executor asked to shutdown
III0420 23:22:01.653941 9373 master.cpp:711] Slave 20140420-232201-453759884-55410-9329-0 (hemera.apache.org) disconnected
0420 23:22:01.653945 13718 process.cpp:1008] Socket closed while receiving
0420 23:22:01.653946 13673 exec.cpp:393] Executor::shutdown took 10936ns
I0420 23:22:01.653962 9373 master.cpp:1277] Disconnecting slave 20140420-232201-453759884-55410-9329-0
Shutting down
Sending SIGTERM to process tree at pid 13720
I0420 23:22:01.653970 13680 exec.cpp:378] Executor asked to shutdown
I0420 23:22:01.653978 13687 exec.cpp:77] Scheduling shutdown of the executor
I0420 23:22:01.654006 9373 master.cpp:1293] Removing non-checkpointing framework 20140420-232201-453759884-55410-9329-0000 from disconnected slave 20140420-232201-453759884-55410-9329-0(hemera.apache.org)
I0420 23:22:01.654021 9352 hierarchical_allocator_process.hpp:484] Slave 20140420-232201-453759884-55410-9329-0 disconnected
I0420 23:22:01.654032 9373 master.cpp:3156] Removing framework 20140420-232201-453759884-55410-9329-0000 from slave 20140420-232201-453759884-55410-9329-0 (hemera.apache.org)
Shutting down
Sending SIGTERM to process tree at pid 13721
I0420 23:22:01.654063 13680 exec.cpp:393] Executor::shutdown took 38122ns
I0420 23:22:01.654065 13692 exec.cpp:77] Scheduling shutdown of the executor
I0420 23:22:01.655503 9373 master.cpp:2382] Status update TASK_LOST (UUID: 26b43530-c927-47b4-93d3-cc264b5e51fa) for task 61c3f349-ba84-4ba3-b270-61d9b4b29c44 of framework 20140420-232201-453759884-55410-9329-0000 from @0.0.0.0:0
I0420 23:22:01.655612 9354 sched.cpp:620] Scheduler::statusUpdate took 36698ns
I0420 23:22:01.655697 9373 master.hpp:514] Removing task 61c3f349-ba84-4ba3-b270-61d9b4b29c44 with resources cpus(*):1; mem(*):512 on slave 20140420-232201-453759884-55410-9329-0 (hemera.apache.org)
I0420 23:22:01.655897 9364 hierarchical_allocator_process.hpp:637] Recovered cpus(*):1; mem(*):512 (total allocatable: disk(*):1024; ports(*):[31000-32000]; cpus(*):1; mem(*):512) on slave 20140420-232201-453759884-55410-9329-0 from framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.657470 9373 master.cpp:2382] Status update TASK_LOST (UUID: 2d6b3f30-8648-4fe5-9fee-500556f2742f) for task 00f7dd55-27d8-484b-8155-dc35dae1bab6 of framework 20140420-232201-453759884-55410-9329-0000 from @0.0.0.0:0
I0420 23:22:01.657542 9373 master.hpp:514] Removing task 00f7dd55-27d8-484b-8155-dc35dae1bab6 with resources cpus(*):1; mem(*):512 on slave 20140420-232201-453759884-55410-9329-0 (hemera.apache.org)
I0420 23:22:01.657621 9371 sched.cpp:620] Scheduler::statusUpdate took 49433ns
I0420 23:22:01.657651 9353 hierarchical_allocator_process.hpp:637] Recovered cpus(*):1; mem(*):512 (total allocatable: disk(*):1024; ports(*):[31000-32000]; cpus(*):2; mem(*):1024) on slave 20140420-232201-453759884-55410-9329-0 from framework 20140420-232201-453759884-55410-9329-0000
I0420 23:22:01.657950 9372 master.cpp:573] Master terminating
I0420 23:22:01.657992 9374 sched.cpp:731] Stopping framework '20140420-232201-453759884-55410-9329-0000'
[ OK ] SlaveRecoveryTest/0.RemoveNonCheckpointingFramework (785 ms)
[----------] 23 tests from SlaveRecoveryTest/0 (53179 ms total)
[----------] 1 test from ProtobufIOTest
[ RUN ] ProtobufIOTest.Basic
Killing the following process trees:
[
-+- 13720 sh -c sleep 1000
\--- 13722 sleep 1000
]
Killing the following process trees:
[
-+- 13721 sh -c sleep 1000
\--- 13723 sleep 1000
]
[ OK ] ProtobufIOTest.Basic (711 ms)
[----------] 1 test from ProtobufIOTest (711 ms total)
[----------] Global test environment tear-down
../../src/tests/environment.cpp:258: Failure
Failed
Tests completed with child processes remaining:
-+- 9329 /x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/mesos-0.19.0/_build/src/.libs/lt-mesos-tests
|-+- 13635 sh -c /x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/mesos-0.19.0/_build/src/mesos-executor
| \-+- 13642 /x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/mesos-0.19.0/_build/src/.libs/lt-mesos-executor
| \--- 13720 ()
\-+- 13636 sh -c /x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/mesos-0.19.0/_build/src/mesos-executor
\-+- 13641 /x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/mesos-0.19.0/_build/src/.libs/lt-mesos-executor
\--- 13721 ()
[==========] 289 tests from 50 test cases ran. (320801 ms total)
[ PASSED ] 289 tests.
[ FAILED ] 0 tests, listed below:
0 FAILED TESTS
YOU HAVE 1 DISABLED TEST
II0420 23:22:02.481328 13718 process.cpp:1008] Socket closed while receiving
0420 23:22:02.481319 13719 process.cpp:1008] Socket closed while receiving
I0420 23:22:02.481426 13683 exec.cpp:439] Ignoring exited event because the driver is aborted!
I0420 23:22:02.481482 13701 exec.cpp:439] Ignoring exited event because the driver is aborted!
make[4]: *** [check-local] Error 1
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
Command terminated with signal Terminated (pid: 13721)
Command terminated with signal Terminated (pid: 13720)
I0420 23:22:02.652971 13675 exec.cpp:524] Executor sending status update TASK_KILLED (UUID: 4862a7f4-9968-4d01-b525-559d348f7b46) for task 00f7dd55-27d8-484b-8155-dc35dae1bab6 of framework 20140420-232201-453759884-55410-9329-0000
II0420 23:22:02.653146 13704 exec.cpp:524] Executor sending status update TASK_KILLED (UUID: 8fcad71b-ca54-44fd-99ff-d7295b622fa8) for task 61c3f349-ba84-4ba3-b270-61d9b4b29c44 of framework 20140420-232201-453759884-55410-9329-0000
0420 23:22:02.653159 13719 process.cpp:1181] Socket error while connecting
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal :
Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME #2078
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/2078/changes>
Build failed in Jenkins:
Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME #2077
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/2077/changes>
Changes:
[dlester] Adds Viadeo to Powered by Mesos list.
[dlester] Adds 6 recent Mesos presentations to documentation list.
------------------------------------------
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
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-Out-Of-Src-Set-JAVA_HOME/ws/>
Fetching changes from the remote Git repository
Fetching upstream changes from https://git-wip-us.apache.org/repos/asf/mesos.git
Checking out Revision 2271256e28dc7610d4921e72f4e98edd499e7fd2 (origin/master)
[Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME] $ /bin/bash -xe /tmp/hudson6124944206265472630.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 PATH=/home/jenkins/tools/maven/latest:/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:/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
Sun Apr 20 23:29:37 UTC 2014
+ chmod -R +w 3rdparty CHANGELOG Doxyfile LICENSE Makefile.am Makefile.in NOTICE README.md aclocal.m4 ar-lib autom4te.cache bin bootstrap build config.guess config.sub configure configure.ac depcomp docs ec2 frameworks include install-sh ltmain.sh m4 mesos.pc.in missing mpi src support
+ git clean -fdx
Removing 3rdparty/Makefile.in
Removing 3rdparty/libprocess/3rdparty/Makefile.in
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/configure
Removing 3rdparty/libprocess/3rdparty/stout/missing
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.sub
Removing 3rdparty/libprocess/configure
Removing 3rdparty/libprocess/depcomp
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.in
Removing aclocal.m4
Removing ar-lib
Removing autom4te.cache/
Removing build/
Removing config.guess
Removing config.sub
Removing configure
Removing depcomp
Removing ec2/Makefile.in
Removing install-sh
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 missing
Removing src/Makefile.in
+ ./bootstrap
autoreconf: Entering directory `.'
autoreconf: configure.ac: not using Gettext
autoreconf: running: aclocal --warnings=all -I m4
autom4te: cannot create /tmp/araQlN7D/am4t7396.27012: 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