You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2015/12/21 03:49:33 UTC
Build failed in Jenkins: Mesos » gcc,--verbose,ubuntu:14.04,docker||Hadoop #1393
See <https://builds.apache.org/job/Mesos/COMPILER=gcc,CONFIGURATION=--verbose,OS=ubuntu%3A14.04,label_exp=docker%7C%7CHadoop/1393/changes>
Changes:
[benjamin.hindman] Added documentation for `defer` in libprocess README.
------------------------------------------
[...truncated 67063 lines...]
I1221 02:49:14.045240 30647 leveldb.cpp:341] Persisting action (534 bytes) to leveldb took 585902ns
I1221 02:49:14.045282 30647 replica.cpp:712] Persisted action at 5
I1221 02:49:14.046109 30659 replica.cpp:691] Replica received learned notice for position 5 from @0.0.0.0:0
I1221 02:49:14.046628 30659 leveldb.cpp:341] Persisting action (536 bytes) to leveldb took 453625ns
I1221 02:49:14.046659 30659 replica.cpp:712] Persisted action at 5
I1221 02:49:14.046696 30659 replica.cpp:697] Replica learned APPEND action at position 5
I1221 02:49:14.048447 30653 registrar.cpp:484] Successfully updated the 'registry' in 5.939968ms
I1221 02:49:14.048845 30650 log.cpp:702] Attempting to truncate the log to 5
I1221 02:49:14.049134 30650 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 6
I1221 02:49:14.049839 30650 slave.cpp:3371] Received ping from slave-observer(116)@172.17.0.2:46683
I1221 02:49:14.049820 30653 master.cpp:4200] Registered slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S1 at slave(113)@172.17.0.2:46683 (maintenance-host-2) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1221 02:49:14.050662 30656 hierarchical.cpp:465] Added slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S1 (maintenance-host-2) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: )
I1221 02:49:14.050918 30656 hierarchical.cpp:1329] No resources available to allocate!
I1221 02:49:14.050981 30656 hierarchical.cpp:1101] Performed allocation for slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S1 in 270431ns
I1221 02:49:14.051538 30656 replica.cpp:537] Replica received write request for position 6 from (4039)@172.17.0.2:46683
I1221 02:49:14.050205 30650 slave.cpp:904] Registered with master master@172.17.0.2:46683; given slave ID 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S1
I1221 02:49:14.051906 30650 fetcher.cpp:81] Clearing fetcher cache
I1221 02:49:14.052327 30656 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 653421ns
I1221 02:49:14.052400 30653 status_update_manager.cpp:181] Resuming sending status updates
I1221 02:49:14.052547 30656 replica.cpp:712] Persisted action at 6
I1221 02:49:14.052765 30650 slave.cpp:927] Checkpointing SlaveInfo to '/tmp/MasterMaintenanceTest_InverseOffersFilters_OcJ4il/meta/slaves/5b66dd62-bcba-4e42-a87d-c5f4ef688692-S1/slave.info'
I1221 02:49:14.053366 30650 slave.cpp:963] Forwarding total oversubscribed resources
I1221 02:49:14.053676 30656 master.cpp:4542] Received update of slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S1 at slave(113)@172.17.0.2:46683 (maintenance-host-2) with total oversubscribed resources
I1221 02:49:14.053905 30656 replica.cpp:691] Replica received learned notice for position 6 from @0.0.0.0:0
I1221 02:49:14.054471 30656 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 535197ns
I1221 02:49:14.054548 30656 leveldb.cpp:399] Deleting ~2 keys from leveldb took 43902ns
I1221 02:49:14.054576 30656 replica.cpp:712] Persisted action at 6
I1221 02:49:14.054608 30656 replica.cpp:697] Replica learned TRUNCATE action at position 6
I1221 02:49:14.054946 30661 hierarchical.cpp:521] Slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S1 (maintenance-host-2) updated with oversubscribed resources (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: )
I1221 02:49:14.055335 30661 hierarchical.cpp:1329] No resources available to allocate!
I1221 02:49:14.055433 30661 hierarchical.cpp:1101] Performed allocation for slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S1 in 351480ns
I1221 02:49:14.058163 30659 process.cpp:3225] Handling HTTP event for process 'master' with path: '/master/maintenance/schedule'
I1221 02:49:14.058301 30659 http.cpp:315] HTTP POST for /master/maintenance/schedule from 172.17.0.2:36760
I1221 02:49:14.059856 30659 registrar.cpp:439] Applied 1 operations in 266273ns; attempting to update the 'registry'
I1221 02:49:14.061785 30658 log.cpp:683] Attempting to append 734 bytes to the log
I1221 02:49:14.062156 30658 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 7
I1221 02:49:14.063745 30658 replica.cpp:537] Replica received write request for position 7 from (4041)@172.17.0.2:46683
I1221 02:49:14.064204 30658 leveldb.cpp:341] Persisting action (753 bytes) to leveldb took 392578ns
I1221 02:49:14.064244 30658 replica.cpp:712] Persisted action at 7
I1221 02:49:14.065676 30662 replica.cpp:691] Replica received learned notice for position 7 from @0.0.0.0:0
I1221 02:49:14.066442 30662 leveldb.cpp:341] Persisting action (755 bytes) to leveldb took 718734ns
I1221 02:49:14.066478 30662 replica.cpp:712] Persisted action at 7
I1221 02:49:14.066514 30662 replica.cpp:697] Replica learned APPEND action at position 7
I1221 02:49:14.070207 30658 registrar.cpp:484] Successfully updated the 'registry' in 10.240256ms
I1221 02:49:14.071400 30661 master.cpp:4598] Updating unavailability of slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S1 at slave(113)@172.17.0.2:46683 (maintenance-host-2), starting at 2401.58871040266weeks
I1221 02:49:14.071732 30658 log.cpp:702] Attempting to truncate the log to 7
I1221 02:49:14.072283 30651 hierarchical.cpp:1329] No resources available to allocate!
I1221 02:49:14.072325 30651 hierarchical.cpp:1101] Performed allocation for slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S1 in 257879ns
I1221 02:49:14.072398 30654 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 8
I1221 02:49:14.071588 30661 master.cpp:4598] Updating unavailability of slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S0 at slave(112)@172.17.0.2:46683 (maintenance-host), starting at 2401.58871040266weeks
I1221 02:49:14.073288 30661 master.cpp:4598] Updating unavailability of slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S0 at slave(112)@172.17.0.2:46683 (maintenance-host), starting at 2401.58871040266weeks
I1221 02:49:14.073447 30661 master.cpp:4598] Updating unavailability of slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S1 at slave(113)@172.17.0.2:46683 (maintenance-host-2), starting at 2401.58871040266weeks
I1221 02:49:14.073590 30657 hierarchical.cpp:1329] No resources available to allocate!
I1221 02:49:14.073626 30657 hierarchical.cpp:1101] Performed allocation for slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S0 in 196343ns
I1221 02:49:14.073844 30657 hierarchical.cpp:1329] No resources available to allocate!
I1221 02:49:14.073878 30657 hierarchical.cpp:1101] Performed allocation for slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S0 in 142480ns
I1221 02:49:14.074123 30657 hierarchical.cpp:1329] No resources available to allocate!
I1221 02:49:14.074156 30657 hierarchical.cpp:1101] Performed allocation for slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S1 in 143860ns
I1221 02:49:14.074748 30654 replica.cpp:537] Replica received write request for position 8 from (4042)@172.17.0.2:46683
I1221 02:49:14.075404 30654 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 609285ns
I1221 02:49:14.075438 30654 replica.cpp:712] Persisted action at 8
I1221 02:49:14.076407 30628 scheduler.cpp:154] Version: 0.27.0
I1221 02:49:14.077111 30652 replica.cpp:691] Replica received learned notice for position 8 from @0.0.0.0:0
I1221 02:49:14.077682 30652 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 537581ns
I1221 02:49:14.077764 30652 leveldb.cpp:399] Deleting ~2 keys from leveldb took 41092ns
I1221 02:49:14.077793 30652 replica.cpp:712] Persisted action at 8
I1221 02:49:14.077826 30652 replica.cpp:697] Replica learned TRUNCATE action at position 8
I1221 02:49:14.079562 30662 scheduler.cpp:236] New master detected at master@172.17.0.2:46683
I1221 02:49:14.091173 30662 scheduler.cpp:298] Sending SUBSCRIBE call to master@172.17.0.2:46683
I1221 02:49:14.100329 30648 process.cpp:3225] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1221 02:49:14.100463 30648 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:36761
I1221 02:49:14.100788 30648 master.cpp:1891] Received subscription request for HTTP framework 'default'
I1221 02:49:14.100877 30648 master.cpp:1668] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1221 02:49:14.101325 30648 master.cpp:1982] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I1221 02:49:14.101891 30648 master.hpp:1657] Sending heartbeat to 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.101896 30652 hierarchical.cpp:260] Added framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.103755 30662 scheduler.cpp:457] Enqueuing event SUBSCRIBED received from master@172.17.0.2:46683
I1221 02:49:14.105347 30655 master.cpp:5252] Sending 2 offers to framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 (default)
I1221 02:49:14.106235 30652 hierarchical.cpp:1079] Performed allocation for 2 slaves in 4.288416ms
I1221 02:49:14.106271 30662 scheduler.cpp:457] Enqueuing event HEARTBEAT received from master@172.17.0.2:46683
I1221 02:49:14.107131 30655 master.cpp:5342] Sending 2 inverse offers to framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 (default)
I1221 02:49:14.111737 30655 master_maintenance_tests.cpp:177] Ignoring HEARTBEAT event
I1221 02:49:14.112133 30654 scheduler.cpp:457] Enqueuing event OFFERS received from master@172.17.0.2:46683
I1221 02:49:14.113662 30654 scheduler.cpp:457] Enqueuing event OFFERS received from master@172.17.0.2:46683
I1221 02:49:14.125752 30654 hierarchical.cpp:1329] No resources available to allocate!
I1221 02:49:14.126176 30654 hierarchical.cpp:1079] Performed allocation for 2 slaves in 838927ns
I1221 02:49:14.135311 30654 scheduler.cpp:298] Sending ACCEPT call to master@172.17.0.2:46683
I1221 02:49:14.139907 30652 process.cpp:3225] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1221 02:49:14.140040 30652 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:36762
I1221 02:49:14.141342 30652 master.cpp:3055] Processing ACCEPT call for offers: [ 5b66dd62-bcba-4e42-a87d-c5f4ef688692-O0 ] on slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S1 at slave(113)@172.17.0.2:46683 (maintenance-host-2) for framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 (default)
I1221 02:49:14.141495 30652 master.cpp:2742] Authorizing framework principal 'test-principal' to launch task 1eb0c304-5d42-41ae-9211-9daf0a40f78a as user 'mesos'
W1221 02:49:14.143170 30652 validation.cpp:420] Executor executor-1 for task 1eb0c304-5d42-41ae-9211-9daf0a40f78a uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W1221 02:49:14.143235 30652 validation.cpp:432] Executor executor-1 for task 1eb0c304-5d42-41ae-9211-9daf0a40f78a uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I1221 02:49:14.143677 30652 master.hpp:176] Adding task 1eb0c304-5d42-41ae-9211-9daf0a40f78a with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S1 (maintenance-host-2)
I1221 02:49:14.143923 30652 master.cpp:3518] Launching task 1eb0c304-5d42-41ae-9211-9daf0a40f78a of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 (default) with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S1 at slave(113)@172.17.0.2:46683 (maintenance-host-2)
I1221 02:49:14.144368 30657 slave.cpp:1294] Got assigned task 1eb0c304-5d42-41ae-9211-9daf0a40f78a for framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.144506 30647 scheduler.cpp:298] Sending ACCEPT call to master@172.17.0.2:46683
I1221 02:49:14.145051 30657 slave.cpp:1413] Launching task 1eb0c304-5d42-41ae-9211-9daf0a40f78a for framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.145632 30657 paths.cpp:434] Trying to chown '/tmp/MasterMaintenanceTest_InverseOffersFilters_OcJ4il/slaves/5b66dd62-bcba-4e42-a87d-c5f4ef688692-S1/frameworks/5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000/executors/executor-1/runs/8dd7a767-5b05-4741-8357-90bb8aa8e776' to user 'mesos'
I1221 02:49:14.150017 30659 process.cpp:3225] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1221 02:49:14.150101 30659 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:36763
I1221 02:49:14.151116 30659 master.cpp:3055] Processing ACCEPT call for offers: [ 5b66dd62-bcba-4e42-a87d-c5f4ef688692-O1 ] on slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S0 at slave(112)@172.17.0.2:46683 (maintenance-host) for framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 (default)
I1221 02:49:14.151163 30659 master.cpp:2742] Authorizing framework principal 'test-principal' to launch task 01e698a2-6fd1-46a2-bf78-79d1305475a7 as user 'mesos'
I1221 02:49:14.151238 30657 slave.cpp:5211] Launching executor executor-1 of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 with resources in work directory '/tmp/MasterMaintenanceTest_InverseOffersFilters_OcJ4il/slaves/5b66dd62-bcba-4e42-a87d-c5f4ef688692-S1/frameworks/5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000/executors/executor-1/runs/8dd7a767-5b05-4741-8357-90bb8aa8e776'
I1221 02:49:14.153280 30657 exec.cpp:134] Version: 0.27.0
W1221 02:49:14.153307 30647 validation.cpp:420] Executor executor-2 for task 01e698a2-6fd1-46a2-bf78-79d1305475a7 uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W1221 02:49:14.153358 30647 validation.cpp:432] Executor executor-2 for task 01e698a2-6fd1-46a2-bf78-79d1305475a7 uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I1221 02:49:14.153614 30655 exec.cpp:184] Executor started at: executor(48)@172.17.0.2:46683 with pid 30628
I1221 02:49:14.153805 30647 master.hpp:176] Adding task 01e698a2-6fd1-46a2-bf78-79d1305475a7 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S0 (maintenance-host)
I1221 02:49:14.153975 30657 slave.cpp:1631] Queuing task '1eb0c304-5d42-41ae-9211-9daf0a40f78a' for executor 'executor-1' of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.154142 30657 slave.cpp:682] Successfully attached file '/tmp/MasterMaintenanceTest_InverseOffersFilters_OcJ4il/slaves/5b66dd62-bcba-4e42-a87d-c5f4ef688692-S1/frameworks/5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000/executors/executor-1/runs/8dd7a767-5b05-4741-8357-90bb8aa8e776'
I1221 02:49:14.154104 30647 master.cpp:3518] Launching task 01e698a2-6fd1-46a2-bf78-79d1305475a7 of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 (default) with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S0 at slave(112)@172.17.0.2:46683 (maintenance-host)
I1221 02:49:14.154239 30657 slave.cpp:2578] Got registration for executor 'executor-1' of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 from executor(48)@172.17.0.2:46683
I1221 02:49:14.154554 30647 slave.cpp:1294] Got assigned task 01e698a2-6fd1-46a2-bf78-79d1305475a7 for framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.154608 30654 exec.cpp:208] Executor registered on slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S1
I1221 02:49:14.154671 30654 exec.cpp:220] Executor::registered took 34074ns
I1221 02:49:14.155089 30657 slave.cpp:1796] Sending queued task '1eb0c304-5d42-41ae-9211-9daf0a40f78a' to executor 'executor-1' of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 at executor(48)@172.17.0.2:46683
I1221 02:49:14.155216 30647 slave.cpp:1413] Launching task 01e698a2-6fd1-46a2-bf78-79d1305475a7 for framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.155378 30657 exec.cpp:295] Executor asked to run task '1eb0c304-5d42-41ae-9211-9daf0a40f78a'
I1221 02:49:14.155453 30657 exec.cpp:304] Executor::launchTask took 54854ns
I1221 02:49:14.155550 30657 exec.cpp:517] Executor sending status update TASK_RUNNING (UUID: d3c42b03-1233-4990-97a6-4ff3d603b57b) for task 1eb0c304-5d42-41ae-9211-9daf0a40f78a of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.155796 30657 slave.cpp:2937] Handling status update TASK_RUNNING (UUID: d3c42b03-1233-4990-97a6-4ff3d603b57b) for task 1eb0c304-5d42-41ae-9211-9daf0a40f78a of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 from executor(48)@172.17.0.2:46683
I1221 02:49:14.156033 30647 paths.cpp:434] Trying to chown '/tmp/MasterMaintenanceTest_InverseOffersFilters_sgIHho/slaves/5b66dd62-bcba-4e42-a87d-c5f4ef688692-S0/frameworks/5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000/executors/executor-2/runs/94d6c0d4-5085-4153-bcdf-b8ac50e3620d' to user 'mesos'
I1221 02:49:14.156169 30653 status_update_manager.cpp:320] Received status update TASK_RUNNING (UUID: d3c42b03-1233-4990-97a6-4ff3d603b57b) for task 1eb0c304-5d42-41ae-9211-9daf0a40f78a of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.158579 30653 status_update_manager.cpp:497] Creating StatusUpdate stream for task 1eb0c304-5d42-41ae-9211-9daf0a40f78a of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.159132 30653 status_update_manager.cpp:374] Forwarding update TASK_RUNNING (UUID: d3c42b03-1233-4990-97a6-4ff3d603b57b) for task 1eb0c304-5d42-41ae-9211-9daf0a40f78a of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 to the slave
I1221 02:49:14.159436 30657 slave.cpp:3289] Forwarding the update TASK_RUNNING (UUID: d3c42b03-1233-4990-97a6-4ff3d603b57b) for task 1eb0c304-5d42-41ae-9211-9daf0a40f78a of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 to master@172.17.0.2:46683
I1221 02:49:14.159692 30657 slave.cpp:3183] Status update manager successfully handled status update TASK_RUNNING (UUID: d3c42b03-1233-4990-97a6-4ff3d603b57b) for task 1eb0c304-5d42-41ae-9211-9daf0a40f78a of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.159741 30657 slave.cpp:3199] Sending acknowledgement for status update TASK_RUNNING (UUID: d3c42b03-1233-4990-97a6-4ff3d603b57b) for task 1eb0c304-5d42-41ae-9211-9daf0a40f78a of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 to executor(48)@172.17.0.2:46683
I1221 02:49:14.159871 30659 master.cpp:4687] Status update TASK_RUNNING (UUID: d3c42b03-1233-4990-97a6-4ff3d603b57b) for task 1eb0c304-5d42-41ae-9211-9daf0a40f78a of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 from slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S1 at slave(113)@172.17.0.2:46683 (maintenance-host-2)
I1221 02:49:14.159900 30657 exec.cpp:341] Executor received status update acknowledgement d3c42b03-1233-4990-97a6-4ff3d603b57b for task 1eb0c304-5d42-41ae-9211-9daf0a40f78a of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.159931 30659 master.cpp:4735] Forwarding status update TASK_RUNNING (UUID: d3c42b03-1233-4990-97a6-4ff3d603b57b) for task 1eb0c304-5d42-41ae-9211-9daf0a40f78a of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.160392 30659 master.cpp:6347] Updating the state of task 1eb0c304-5d42-41ae-9211-9daf0a40f78a of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I1221 02:49:14.161774 30657 scheduler.cpp:457] Enqueuing event UPDATE received from master@172.17.0.2:46683
I1221 02:49:14.161998 30647 slave.cpp:5211] Launching executor executor-2 of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 with resources in work directory '/tmp/MasterMaintenanceTest_InverseOffersFilters_sgIHho/slaves/5b66dd62-bcba-4e42-a87d-c5f4ef688692-S0/frameworks/5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000/executors/executor-2/runs/94d6c0d4-5085-4153-bcdf-b8ac50e3620d'
I1221 02:49:14.163993 30647 exec.cpp:134] Version: 0.27.0
I1221 02:49:14.164264 30652 exec.cpp:184] Executor started at: executor(49)@172.17.0.2:46683 with pid 30628
I1221 02:49:14.164508 30647 slave.cpp:1631] Queuing task '01e698a2-6fd1-46a2-bf78-79d1305475a7' for executor 'executor-2' of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.164624 30647 slave.cpp:682] Successfully attached file '/tmp/MasterMaintenanceTest_InverseOffersFilters_sgIHho/slaves/5b66dd62-bcba-4e42-a87d-c5f4ef688692-S0/frameworks/5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000/executors/executor-2/runs/94d6c0d4-5085-4153-bcdf-b8ac50e3620d'
I1221 02:49:14.164803 30647 slave.cpp:2578] Got registration for executor 'executor-2' of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 from executor(49)@172.17.0.2:46683
I1221 02:49:14.165139 30659 exec.cpp:208] Executor registered on slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S0
I1221 02:49:14.165197 30659 exec.cpp:220] Executor::registered took 28034ns
I1221 02:49:14.165549 30647 slave.cpp:1796] Sending queued task '01e698a2-6fd1-46a2-bf78-79d1305475a7' to executor 'executor-2' of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 at executor(49)@172.17.0.2:46683
I1221 02:49:14.165849 30656 exec.cpp:295] Executor asked to run task '01e698a2-6fd1-46a2-bf78-79d1305475a7'
I1221 02:49:14.165941 30656 exec.cpp:304] Executor::launchTask took 68392ns
I1221 02:49:14.166076 30656 exec.cpp:517] Executor sending status update TASK_RUNNING (UUID: 63ed3cc4-b969-4759-ba79-27102487b0c9) for task 01e698a2-6fd1-46a2-bf78-79d1305475a7 of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.166350 30660 slave.cpp:2937] Handling status update TASK_RUNNING (UUID: 63ed3cc4-b969-4759-ba79-27102487b0c9) for task 01e698a2-6fd1-46a2-bf78-79d1305475a7 of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 from executor(49)@172.17.0.2:46683
I1221 02:49:14.166669 30656 status_update_manager.cpp:320] Received status update TASK_RUNNING (UUID: 63ed3cc4-b969-4759-ba79-27102487b0c9) for task 01e698a2-6fd1-46a2-bf78-79d1305475a7 of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.166715 30656 status_update_manager.cpp:497] Creating StatusUpdate stream for task 01e698a2-6fd1-46a2-bf78-79d1305475a7 of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.167057 30656 status_update_manager.cpp:374] Forwarding update TASK_RUNNING (UUID: 63ed3cc4-b969-4759-ba79-27102487b0c9) for task 01e698a2-6fd1-46a2-bf78-79d1305475a7 of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 to the slave
I1221 02:49:14.167290 30654 slave.cpp:3289] Forwarding the update TASK_RUNNING (UUID: 63ed3cc4-b969-4759-ba79-27102487b0c9) for task 01e698a2-6fd1-46a2-bf78-79d1305475a7 of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 to master@172.17.0.2:46683
I1221 02:49:14.167516 30654 slave.cpp:3183] Status update manager successfully handled status update TASK_RUNNING (UUID: 63ed3cc4-b969-4759-ba79-27102487b0c9) for task 01e698a2-6fd1-46a2-bf78-79d1305475a7 of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.167567 30654 slave.cpp:3199] Sending acknowledgement for status update TASK_RUNNING (UUID: 63ed3cc4-b969-4759-ba79-27102487b0c9) for task 01e698a2-6fd1-46a2-bf78-79d1305475a7 of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 to executor(49)@172.17.0.2:46683
I1221 02:49:14.167628 30656 master.cpp:4687] Status update TASK_RUNNING (UUID: 63ed3cc4-b969-4759-ba79-27102487b0c9) for task 01e698a2-6fd1-46a2-bf78-79d1305475a7 of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 from slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S0 at slave(112)@172.17.0.2:46683 (maintenance-host)
I1221 02:49:14.167665 30656 master.cpp:4735] Forwarding status update TASK_RUNNING (UUID: 63ed3cc4-b969-4759-ba79-27102487b0c9) for task 01e698a2-6fd1-46a2-bf78-79d1305475a7 of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.167731 30654 exec.cpp:341] Executor received status update acknowledgement 63ed3cc4-b969-4759-ba79-27102487b0c9 for task 01e698a2-6fd1-46a2-bf78-79d1305475a7 of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.168020 30656 master.cpp:6347] Updating the state of task 01e698a2-6fd1-46a2-bf78-79d1305475a7 of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I1221 02:49:14.169190 30655 scheduler.cpp:457] Enqueuing event UPDATE received from master@172.17.0.2:46683
I1221 02:49:14.178793 30656 scheduler.cpp:298] Sending ACKNOWLEDGE call to master@172.17.0.2:46683
I1221 02:49:14.181550 30650 process.cpp:3225] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1221 02:49:14.181617 30650 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:36764
I1221 02:49:14.181785 30650 master.cpp:3844] Processing ACKNOWLEDGE call d3c42b03-1233-4990-97a6-4ff3d603b57b for task 1eb0c304-5d42-41ae-9211-9daf0a40f78a of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 (default) on slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S1
I1221 02:49:14.182167 30661 status_update_manager.cpp:392] Received status update acknowledgement (UUID: d3c42b03-1233-4990-97a6-4ff3d603b57b) for task 1eb0c304-5d42-41ae-9211-9daf0a40f78a of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.182512 30650 slave.cpp:2348] Status update manager successfully handled status update acknowledgement (UUID: d3c42b03-1233-4990-97a6-4ff3d603b57b) for task 1eb0c304-5d42-41ae-9211-9daf0a40f78a of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.190094 30657 scheduler.cpp:298] Sending ACKNOWLEDGE call to master@172.17.0.2:46683
I1221 02:49:14.192445 30654 process.cpp:3225] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1221 02:49:14.192577 30654 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:36765
I1221 02:49:14.192800 30654 master.cpp:3844] Processing ACKNOWLEDGE call 63ed3cc4-b969-4759-ba79-27102487b0c9 for task 01e698a2-6fd1-46a2-bf78-79d1305475a7 of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 (default) on slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S0
I1221 02:49:14.193153 30648 status_update_manager.cpp:392] Received status update acknowledgement (UUID: 63ed3cc4-b969-4759-ba79-27102487b0c9) for task 01e698a2-6fd1-46a2-bf78-79d1305475a7 of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.193503 30654 slave.cpp:2348] Status update manager successfully handled status update acknowledgement (UUID: 63ed3cc4-b969-4759-ba79-27102487b0c9) for task 01e698a2-6fd1-46a2-bf78-79d1305475a7 of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.194653 30660 scheduler.cpp:298] Sending DECLINE call to master@172.17.0.2:46683
I1221 02:49:14.197450 30658 process.cpp:3225] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1221 02:49:14.197616 30658 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:36766
I1221 02:49:14.197844 30658 master.cpp:3570] Processing DECLINE call for offers: [ 5b66dd62-bcba-4e42-a87d-c5f4ef688692-O3 ] for framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 (default)
I1221 02:49:14.198472 30658 hierarchical.cpp:787] Framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 filtered inverse offers from slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S0 for 101secs
I1221 02:49:14.204630 30662 scheduler.cpp:298] Sending ACCEPT call to master@172.17.0.2:46683
I1221 02:49:14.211032 30647 process.cpp:3225] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1221 02:49:14.211129 30647 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:36767
W1221 02:49:14.211846 30647 master.cpp:3018] ACCEPT call used invalid offers '[ 5b66dd62-bcba-4e42-a87d-c5f4ef688692-O2 ]': Offer 5b66dd62-bcba-4e42-a87d-c5f4ef688692-O2 is no longer valid
I1221 02:49:14.212190 30649 hierarchical.cpp:1329] No resources available to allocate!
I1221 02:49:14.212535 30649 hierarchical.cpp:1550] Filtered unavailability on slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S0 for framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:14.212796 30649 hierarchical.cpp:1079] Performed allocation for 2 slaves in 1.026764ms
2015-12-21 02:49:15,042:30628(0x2b34a390e700):ZOO_ERROR@handle_socket_error_msg@1697: Socket [127.0.0.1:36251] zk retcode=-4, errno=111(Connection refused): server refused to accept the client
2015-12-21 02:49:18,379:30628(0x2b34a390e700):ZOO_ERROR@handle_socket_error_msg@1697: Socket [127.0.0.1:36251] zk retcode=-4, errno=111(Connection refused): server refused to accept the client
2015-12-21 02:49:21,719:30628(0x2b34a390e700):ZOO_ERROR@handle_socket_error_msg@1697: Socket [127.0.0.1:36251] zk retcode=-4, errno=111(Connection refused): server refused to accept the client
2015-12-21 02:49:25,055:30628(0x2b34a390e700):ZOO_ERROR@handle_socket_error_msg@1697: Socket [127.0.0.1:36251] zk retcode=-4, errno=111(Connection refused): server refused to accept the client
2015-12-21 02:49:28,392:30628(0x2b34a390e700):ZOO_ERROR@handle_socket_error_msg@1697: Socket [127.0.0.1:36251] zk retcode=-4, errno=111(Connection refused): server refused to accept the client
../../src/tests/master_maintenance_tests.cpp:1591: Failure
Failed to wait 15secs for event
I1221 02:49:29.220235 30648 slave.cpp:3417] executor(49)@172.17.0.2:46683 exited
I1221 02:49:29.220547 30648 slave.cpp:3417] executor(48)@172.17.0.2:46683 exited
I1221 02:49:29.221930 30653 master.cpp:930] Master terminating
W1221 02:49:29.222210 30653 master.cpp:6399] Removing task 1eb0c304-5d42-41ae-9211-9daf0a40f78a with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 on slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S1 at slave(113)@172.17.0.2:46683 (maintenance-host-2) in non-terminal state TASK_RUNNING
I1221 02:49:29.222647 30656 hierarchical.cpp:496] Removed slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S1
I1221 02:49:29.223081 30653 master.cpp:6442] Removing executor 'executor-1' with resources of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 on slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S1 at slave(113)@172.17.0.2:46683 (maintenance-host-2)
W1221 02:49:29.223621 30653 master.cpp:6399] Removing task 01e698a2-6fd1-46a2-bf78-79d1305475a7 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 on slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S0 at slave(112)@172.17.0.2:46683 (maintenance-host) in non-terminal state TASK_RUNNING
I1221 02:49:29.223948 30657 hierarchical.cpp:496] Removed slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S0
I1221 02:49:29.224230 30653 master.cpp:6442] Removing executor 'executor-2' with resources of framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000 on slave 5b66dd62-bcba-4e42-a87d-c5f4ef688692-S0 at slave(112)@172.17.0.2:46683 (maintenance-host)
I1221 02:49:29.224709 30648 hierarchical.cpp:321] Removed framework 5b66dd62-bcba-4e42-a87d-c5f4ef688692-0000
I1221 02:49:29.226141 30650 slave.cpp:3417] master@172.17.0.2:46683 exited
W1221 02:49:29.226169 30650 slave.cpp:3420] Master disconnected! Waiting for a new master to be elected
I1221 02:49:29.226203 30651 slave.cpp:3417] master@172.17.0.2:46683 exited
W1221 02:49:29.226224 30651 slave.cpp:3420] Master disconnected! Waiting for a new master to be elected
F1221 02:49:29.226224 30628 logging.cpp:55] RAW: Pure virtual method called
@ 0x2b33d0ee6560 google::LogMessage::Fail()
@ 0x2b33d0eebc86 google::RawLog__()
@ 0x2b33d011a81a __cxa_pure_virtual
@ 0xa04f67 mesos::internal::tests::Cluster::Slaves::shutdown()
@ 0xf64600 mesos::internal::tests::MesosTest::ShutdownSlaves()
@ 0xf645c2 mesos::internal::tests::MesosTest::Shutdown()
@ 0xf60b5f mesos::internal::tests::MesosTest::TearDown()
@ 0x1561f44 testing::internal::HandleSehExceptionsInMethodIfSupported<>()
@ 0x155ce9a testing::internal::HandleExceptionsInMethodIfSupported<>()
@ 0x153e5f8 testing::Test::Run()
@ 0x153ed32 testing::TestInfo::Run()
@ 0x153f378 testing::TestCase::Run()
@ 0x1545ac0 testing::internal::UnitTestImpl::RunAllTests()
@ 0x1562b69 testing::internal::HandleSehExceptionsInMethodIfSupported<>()
@ 0x155da10 testing::internal::HandleExceptionsInMethodIfSupported<>()
@ 0x154485c testing::UnitTest::Run()
@ 0xd58bcc RUN_ALL_TESTS()
@ 0xd587b9 main
@ 0x2b33d2d66ec5 (unknown)
@ 0x936009 (unknown)
make[4]: *** [check-local] Aborted (core dumped)
make[4]: Leaving directory `/mesos/mesos-0.27.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-0.27.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-0.27.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-0.27.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1450664189-32651
Untagged: mesos-1450664189-32651:latest
Deleted: b86061c877c36bf190e8605b49c3cb899390c1e200b0d216889f358029449e8b
Deleted: 1f30fd796bbc4163a39a082460a800646f56764c2b7ef49098712f2ec499de84
Deleted: b68ae3ef193e4871aa4039da2cc16e1df28e45000cfad1c8f1d39a360d882a04
Deleted: 6b01877c466a19ebcfef077d962a8ee147e5963321279a0e687e50022d63d5a9
Deleted: b140b3e9c96652b46e2dcdaf5895673396f0e718e6a5f618f1e67d53cf599443
Deleted: 82153a4b9405295305de0eb92e97c610b09b66a472c98773ebd696c7acbc3d55
Deleted: 8600ec51799cfe1e781fa58ac7b9ceb3960632be24e54929ee110b688d24310f
Deleted: 6590ae2c5b1b857e56563916918ac3c2c5999b39dea9c723e6852eb0925e8ec5
Deleted: d14ddc417cda668fe2f2ecae942f8ab6ddbf492482fb15c0140461fe7bb5775d
Deleted: 20a641888718fee2a2833d3b03f6c0d0aff943e0c7b05706dcc0d42df0b8c9ec
Deleted: 99f1dab7d9b44439aefdb812e5ec56c7e75c0f5890c13eaa2172fcb7fc46b0c1
Deleted: 8d52aecebce628fe2e2f9652cbc0ba7ed84c8ad27f97c7f9f3b9f72e45065557
Deleted: 3f62ac3f6504322a02c872a0c0db006f0cb4a17d81080472e42ef49a5780d5de
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos » gcc,--verbose,ubuntu:14.04,docker||Hadoop #1394
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos/COMPILER=gcc,CONFIGURATION=--verbose,OS=ubuntu%3A14.04,label_exp=docker%7C%7CHadoop/1394/>