This specific flakiness is tracked here: https://issues.apache.org/jira/browse/MESOS-4059
On Thu, Dec 3, 2015 at 10:25 AM, Apache Jenkins Server < [email protected]> wrote: > See < > https://builds.apache.org/job/Mesos/COMPILER=clang,CONFIGURATION=--verbose,OS=ubuntu%3A14.04,label_exp=docker%7C%7CHadoop/1315/changes > > > > Changes: > > [bernd] Cleanup a leaked reference to a test process living in the stack. > > [bernd] Added documentation about terminate/wait in Processes destructors. > > [bernd] Fixed test flakiness in FetcherTest and FetcherCacheTest. > > [toenshoff] Made unary c-tors for `Unauthorized` response explicit. > > [joris.van.remoortere] Fixed flakey test: > MasterMaintenanceTest.InverseOffersFilters. > > ------------------------------------------ > [...truncated 66992 lines...] > I1203 18:25:04.446012 28738 log.cpp:702] Attempting to truncate the log to > 5 > I1203 18:25:04.446660 28738 coordinator.cpp:348] Coordinator attempting to > write TRUNCATE action at position 6 > I1203 18:25:04.447217 28744 master.cpp:4085] Registered slave > c7900911-cc7a-4dde-92e7-48fe82cddd9e-S1 at slave(112)@172.17.0.2:39622 > (maintenance-host-2) with cpus(*):2; mem(*):1024; disk(*):1024; > ports(*):[31000-32000] > I1203 18:25:04.447616 28738 hierarchical.cpp:380] Added slave > c7900911-cc7a-4dde-92e7-48fe82cddd9e-S1 (maintenance-host-2) with > cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: ) > I1203 18:25:04.447907 28738 hierarchical.cpp:1062] No resources available > to allocate! > I1203 18:25:04.448030 28738 hierarchical.cpp:1155] No inverse offers to > send out! > I1203 18:25:04.448137 28738 hierarchical.cpp:973] Performed allocation for > slave c7900911-cc7a-4dde-92e7-48fe82cddd9e-S1 in 425173ns > I1203 18:25:04.448531 28732 slave.cpp:902] Registered with master > [email protected]:39622; given slave ID > c7900911-cc7a-4dde-92e7-48fe82cddd9e-S1 > I1203 18:25:04.448559 28732 fetcher.cpp:79] Clearing fetcher cache > I1203 18:25:04.448976 28744 status_update_manager.cpp:181] Resuming > sending status updates > I1203 18:25:04.448978 28732 slave.cpp:925] Checkpointing SlaveInfo to > '/tmp/MasterMaintenanceTest_InverseOffersFilters_3H2fr1/meta/slaves/c7900911-cc7a-4dde-92e7-48fe82cddd9e-S1/ > slave.info' > I1203 18:25:04.449422 28744 replica.cpp:538] Replica received write > request for position 6 from (3812)@172.17.0.2:39622 > I1203 18:25:04.449538 28732 slave.cpp:961] Forwarding total oversubscribed > resources > I1203 18:25:04.449640 28732 slave.cpp:3197] Received ping from > slave-observer(116)@172.17.0.2:39622 > I1203 18:25:04.449825 28732 master.cpp:4427] Received update of slave > c7900911-cc7a-4dde-92e7-48fe82cddd9e-S1 at slave(112)@172.17.0.2:39622 > (maintenance-host-2) with total oversubscribed resources > I1203 18:25:04.450196 28744 leveldb.cpp:341] Persisting action (16 bytes) > to leveldb took 569101ns > I1203 18:25:04.450283 28744 replica.cpp:713] Persisted action at 6 > I1203 18:25:04.450387 28736 hierarchical.cpp:434] Slave > c7900911-cc7a-4dde-92e7-48fe82cddd9e-S1 (maintenance-host-2) updated with > oversubscribed resources (total: cpus(*):2; mem(*):1024; disk(*):1024; > ports(*):[31000-32000], allocated: ) > I1203 18:25:04.450614 28736 hierarchical.cpp:1062] No resources available > to allocate! > I1203 18:25:04.450670 28736 hierarchical.cpp:1155] No inverse offers to > send out! > I1203 18:25:04.450697 28736 hierarchical.cpp:973] Performed allocation for > slave c7900911-cc7a-4dde-92e7-48fe82cddd9e-S1 in 272707ns > I1203 18:25:04.451419 28744 replica.cpp:692] Replica received learned > notice for position 6 from @0.0.0.0:0 > I1203 18:25:04.452167 28744 leveldb.cpp:341] Persisting action (18 bytes) > to leveldb took 721533ns > I1203 18:25:04.452246 28744 leveldb.cpp:399] Deleting ~2 keys from leveldb > took 69041ns > I1203 18:25:04.452378 28744 replica.cpp:713] Persisted action at 6 > I1203 18:25:04.452502 28744 replica.cpp:698] Replica learned TRUNCATE > action at position 6 > I1203 18:25:04.454433 28744 process.cpp:3067] Handling HTTP event for > process 'master' with path: '/master/maintenance/schedule' > I1203 18:25:04.454607 28744 http.cpp:336] HTTP POST for > /master/maintenance/schedule from 172.17.0.2:51244 > I1203 18:25:04.455843 28744 registrar.cpp:439] Applied 1 operations in > 227194ns; attempting to update the 'registry' > I1203 18:25:04.457535 28737 log.cpp:683] Attempting to append 734 bytes to > the log > I1203 18:25:04.457907 28737 coordinator.cpp:348] Coordinator attempting to > write APPEND action at position 7 > I1203 18:25:04.459543 28737 replica.cpp:538] Replica received write > request for position 7 from (3813)@172.17.0.2:39622 > I1203 18:25:04.460285 28737 leveldb.cpp:341] Persisting action (753 bytes) > to leveldb took 542873ns > I1203 18:25:04.460388 28737 replica.cpp:713] Persisted action at 7 > I1203 18:25:04.468075 28746 replica.cpp:692] Replica received learned > notice for position 7 from @0.0.0.0:0 > I1203 18:25:04.468783 28746 leveldb.cpp:341] Persisting action (755 bytes) > to leveldb took 556908ns > I1203 18:25:04.468886 28746 replica.cpp:713] Persisted action at 7 > I1203 18:25:04.469027 28746 replica.cpp:698] Replica learned APPEND action > at position 7 > I1203 18:25:04.472160 28739 registrar.cpp:484] Successfully updated the > 'registry' in 16.000256ms > I1203 18:25:04.472617 28746 log.cpp:702] Attempting to truncate the log to > 7 > I1203 18:25:04.473223 28746 coordinator.cpp:348] Coordinator attempting to > write TRUNCATE action at position 8 > I1203 18:25:04.474680 28733 replica.cpp:538] Replica received write > request for position 8 from (3814)@172.17.0.2:39622 > I1203 18:25:04.473700 28739 master.cpp:4483] Updating unavailability of > slave c7900911-cc7a-4dde-92e7-48fe82cddd9e-S1 at slave(112)@ > 172.17.0.2:39622 (maintenance-host-2), starting at 2399.11012475529weeks > I1203 18:25:04.475405 28739 master.cpp:4483] Updating unavailability of > slave c7900911-cc7a-4dde-92e7-48fe82cddd9e-S0 at slave(111)@ > 172.17.0.2:39622 (maintenance-host), starting at 2399.11012475529weeks > I1203 18:25:04.475798 28731 hierarchical.cpp:1062] No resources available > to allocate! > I1203 18:25:04.475878 28731 hierarchical.cpp:1155] No inverse offers to > send out! > I1203 18:25:04.475916 28731 hierarchical.cpp:973] Performed allocation for > slave c7900911-cc7a-4dde-92e7-48fe82cddd9e-S1 in 332768ns > I1203 18:25:04.476156 28731 hierarchical.cpp:1062] No resources available > to allocate! > I1203 18:25:04.476210 28731 hierarchical.cpp:1155] No inverse offers to > send out! > I1203 18:25:04.476253 28731 hierarchical.cpp:973] Performed allocation for > slave c7900911-cc7a-4dde-92e7-48fe82cddd9e-S0 in 249523ns > I1203 18:25:04.476445 28739 master.cpp:4483] Updating unavailability of > slave c7900911-cc7a-4dde-92e7-48fe82cddd9e-S0 at slave(111)@ > 172.17.0.2:39622 (maintenance-host), starting at 2399.11012475529weeks > I1203 18:25:04.476567 28733 leveldb.cpp:341] Persisting action (16 bytes) > to leveldb took 1.499863ms > I1203 18:25:04.476610 28733 replica.cpp:713] Persisted action at 8 > I1203 18:25:04.476780 28731 hierarchical.cpp:1062] No resources available > to allocate! > I1203 18:25:04.476835 28731 hierarchical.cpp:1155] No inverse offers to > send out! > I1203 18:25:04.476871 28731 hierarchical.cpp:973] Performed allocation for > slave c7900911-cc7a-4dde-92e7-48fe82cddd9e-S0 in 250866ns > I1203 18:25:04.477419 28733 replica.cpp:692] Replica received learned > notice for position 8 from @0.0.0.0:0 > I1203 18:25:04.477540 28739 master.cpp:4483] Updating unavailability of > slave c7900911-cc7a-4dde-92e7-48fe82cddd9e-S1 at slave(112)@ > 172.17.0.2:39622 (maintenance-host-2), starting at 2399.11012475529weeks > I1203 18:25:04.477749 28733 leveldb.cpp:341] Persisting action (18 bytes) > to leveldb took 312165ns > I1203 18:25:04.477813 28733 leveldb.cpp:399] Deleting ~2 keys from leveldb > took 48215ns > I1203 18:25:04.477834 28733 replica.cpp:713] Persisted action at 8 > I1203 18:25:04.477874 28733 replica.cpp:698] Replica learned TRUNCATE > action at position 8 > I1203 18:25:04.478059 28745 hierarchical.cpp:1062] No resources available > to allocate! > I1203 18:25:04.478113 28745 hierarchical.cpp:1155] No inverse offers to > send out! > I1203 18:25:04.478139 28745 hierarchical.cpp:973] Performed allocation for > slave c7900911-cc7a-4dde-92e7-48fe82cddd9e-S1 in 282601ns > I1203 18:25:04.485801 28713 scheduler.cpp:154] Version: 0.27.0 > I1203 18:25:04.486544 28731 scheduler.cpp:236] New master detected at > [email protected]:39622 > I1203 18:25:04.497105 28742 scheduler.cpp:298] Sending SUBSCRIBE call to > [email protected]:39622 > I1203 18:25:04.500171 28742 process.cpp:3067] Handling HTTP event for > process 'master' with path: '/master/api/v1/scheduler' > I1203 18:25:04.500269 28742 http.cpp:336] HTTP POST for > /master/api/v1/scheduler from 172.17.0.2:51245 > I1203 18:25:04.500524 28742 master.cpp:1899] Received subscription request > for HTTP framework 'default' > I1203 18:25:04.500558 28742 master.cpp:1676] Authorizing framework > principal 'test-principal' to receive offers for role '*' > I1203 18:25:04.501369 28742 master.cpp:1991] Subscribing framework > 'default' with checkpointing disabled and capabilities [ ] > I1203 18:25:04.502502 28742 hierarchical.cpp:220] Added framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > I1203 18:25:04.504004 28732 master.hpp:1583] Sending heartbeat to > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > I1203 18:25:04.505080 28746 scheduler.cpp:457] Enqueuing event SUBSCRIBED > received from [email protected]:39622 > I1203 18:25:04.505374 28736 master.cpp:5137] Sending 2 offers to framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 (default) > I1203 18:25:04.505616 28742 hierarchical.cpp:957] Performed allocation for > 2 slaves in 3.096168ms > I1203 18:25:04.506080 28737 scheduler.cpp:457] Enqueuing event HEARTBEAT > received from [email protected]:39622 > I1203 18:25:04.506461 28737 master_maintenance_tests.cpp:172] Ignoring > HEARTBEAT event > I1203 18:25:04.507187 28736 master.cpp:5227] Sending 2 inverse offers to > framework c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 (default) > I1203 18:25:04.510395 28734 scheduler.cpp:457] Enqueuing event OFFERS > received from [email protected]:39622 > I1203 18:25:04.511852 28736 scheduler.cpp:457] Enqueuing event OFFERS > received from [email protected]:39622 > I1203 18:25:04.519803 28738 hierarchical.cpp:1062] No resources available > to allocate! > I1203 18:25:04.520179 28738 hierarchical.cpp:957] Performed allocation for > 2 slaves in 1.155669ms > I1203 18:25:04.529461 28741 scheduler.cpp:298] Sending ACCEPT call to > [email protected]:39622 > I1203 18:25:04.532944 28738 process.cpp:3067] Handling HTTP event for > process 'master' with path: '/master/api/v1/scheduler' > I1203 18:25:04.533030 28738 http.cpp:336] HTTP POST for > /master/api/v1/scheduler from 172.17.0.2:51246 > I1203 18:25:04.533910 28738 master.cpp:3010] Processing ACCEPT call for > offers: [ c7900911-cc7a-4dde-92e7-48fe82cddd9e-O0 ] on slave > c7900911-cc7a-4dde-92e7-48fe82cddd9e-S0 at slave(111)@172.17.0.2:39622 > (maintenance-host) for framework c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > (default) > I1203 18:25:04.533983 28738 master.cpp:2742] Authorizing framework > principal 'test-principal' to launch task > 26305fdd-edb0-4764-8b8a-2558f2b2d81b as user 'mesos' > W1203 18:25:04.536110 28738 validation.cpp:420] Executor executor-1 for > task 26305fdd-edb0-4764-8b8a-2558f2b2d81b uses less CPUs (None) than the > minimum required (0.01). Please update your executor, as this will be > mandatory in future releases. > W1203 18:25:04.536183 28738 validation.cpp:432] Executor executor-1 for > task 26305fdd-edb0-4764-8b8a-2558f2b2d81b uses less memory (None) than the > minimum required (32MB). Please update your executor, as this will be > mandatory in future releases. > I1203 18:25:04.536908 28746 scheduler.cpp:298] Sending ACCEPT call to > [email protected]:39622 > I1203 18:25:04.537322 28738 master.hpp:176] Adding task > 26305fdd-edb0-4764-8b8a-2558f2b2d81b with resources cpus(*):2; mem(*):1024; > disk(*):1024; ports(*):[31000-32000] on slave > c7900911-cc7a-4dde-92e7-48fe82cddd9e-S0 (maintenance-host) > I1203 18:25:04.537531 28738 master.cpp:3403] Launching task > 26305fdd-edb0-4764-8b8a-2558f2b2d81b of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 (default) with resources > cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave > c7900911-cc7a-4dde-92e7-48fe82cddd9e-S0 at slave(111)@172.17.0.2:39622 > (maintenance-host) > I1203 18:25:04.538158 28746 slave.cpp:1292] Got assigned task > 26305fdd-edb0-4764-8b8a-2558f2b2d81b for framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > I1203 18:25:04.538915 28746 slave.cpp:1411] Launching task > 26305fdd-edb0-4764-8b8a-2558f2b2d81b for framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > I1203 18:25:04.539091 28740 process.cpp:3067] Handling HTTP event for > process 'master' with path: '/master/api/v1/scheduler' > I1203 18:25:04.539154 28740 http.cpp:336] HTTP POST for > /master/api/v1/scheduler from 172.17.0.2:51247 > I1203 18:25:04.539899 28740 master.cpp:3010] Processing ACCEPT call for > offers: [ c7900911-cc7a-4dde-92e7-48fe82cddd9e-O1 ] on slave > c7900911-cc7a-4dde-92e7-48fe82cddd9e-S1 at slave(112)@172.17.0.2:39622 > (maintenance-host-2) for framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 (default) > I1203 18:25:04.539959 28740 master.cpp:2742] Authorizing framework > principal 'test-principal' to launch task > cafa992b-2be6-49fc-b727-bb3d55f1511d as user 'mesos' > W1203 18:25:04.541446 28731 validation.cpp:420] Executor executor-2 for > task cafa992b-2be6-49fc-b727-bb3d55f1511d uses less CPUs (None) than the > minimum required (0.01). Please update your executor, as this will be > mandatory in future releases. > W1203 18:25:04.541494 28731 validation.cpp:432] Executor executor-2 for > task cafa992b-2be6-49fc-b727-bb3d55f1511d uses less memory (None) than the > minimum required (32MB). Please update your executor, as this will be > mandatory in future releases. > I1203 18:25:04.541916 28731 master.hpp:176] Adding task > cafa992b-2be6-49fc-b727-bb3d55f1511d with resources cpus(*):2; mem(*):1024; > disk(*):1024; ports(*):[31000-32000] on slave > c7900911-cc7a-4dde-92e7-48fe82cddd9e-S1 (maintenance-host-2) > I1203 18:25:04.542186 28731 master.cpp:3403] Launching task > cafa992b-2be6-49fc-b727-bb3d55f1511d of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 (default) with resources > cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave > c7900911-cc7a-4dde-92e7-48fe82cddd9e-S1 at slave(112)@172.17.0.2:39622 > (maintenance-host-2) > I1203 18:25:04.542621 28740 slave.cpp:1292] Got assigned task > cafa992b-2be6-49fc-b727-bb3d55f1511d for framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > I1203 18:25:04.543220 28740 slave.cpp:1411] Launching task > cafa992b-2be6-49fc-b727-bb3d55f1511d for framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > I1203 18:25:04.559017 28746 paths.cpp:434] Trying to chown > '/tmp/MasterMaintenanceTest_InverseOffersFilters_QT4Wpx/slaves/c7900911-cc7a-4dde-92e7-48fe82cddd9e-S0/frameworks/c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000/executors/executor-1/runs/ea81f571-9880-45a2-a9cc-dcf32b83b74a' > to user 'mesos' > I1203 18:25:04.562865 28740 paths.cpp:434] Trying to chown > '/tmp/MasterMaintenanceTest_InverseOffersFilters_3H2fr1/slaves/c7900911-cc7a-4dde-92e7-48fe82cddd9e-S1/frameworks/c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000/executors/executor-2/runs/fdeb01b9-8c56-4508-92b6-0fe11ea9598c' > to user 'mesos' > I1203 18:25:04.571883 28746 slave.cpp:5042] Launching executor executor-1 > of framework c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 with resources in > work directory > '/tmp/MasterMaintenanceTest_InverseOffersFilters_QT4Wpx/slaves/c7900911-cc7a-4dde-92e7-48fe82cddd9e-S0/frameworks/c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000/executors/executor-1/runs/ea81f571-9880-45a2-a9cc-dcf32b83b74a' > I1203 18:25:04.571960 28740 slave.cpp:5042] Launching executor executor-2 > of framework c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 with resources in > work directory > '/tmp/MasterMaintenanceTest_InverseOffersFilters_3H2fr1/slaves/c7900911-cc7a-4dde-92e7-48fe82cddd9e-S1/frameworks/c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000/executors/executor-2/runs/fdeb01b9-8c56-4508-92b6-0fe11ea9598c' > I1203 18:25:04.574251 28740 exec.cpp:134] Version: 0.27.0 > I1203 18:25:04.574630 28732 exec.cpp:184] Executor started at: > executor(48)@172.17.0.2:39622 with pid 28713 > I1203 18:25:04.574880 28740 slave.cpp:1629] Queuing task > 'cafa992b-2be6-49fc-b727-bb3d55f1511d' for executor 'executor-2' of > framework c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > I1203 18:25:04.575081 28740 slave.cpp:2406] Got registration for executor > 'executor-2' of framework c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 from > executor(48)@172.17.0.2:39622 > I1203 18:25:04.576000 28740 slave.cpp:1794] Sending queued task > 'cafa992b-2be6-49fc-b727-bb3d55f1511d' to executor 'executor-2' of > framework c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 at executor(48)@ > 172.17.0.2:39622 > I1203 18:25:04.576120 28746 exec.cpp:134] Version: 0.27.0 > I1203 18:25:04.576207 28745 exec.cpp:208] Executor registered on slave > c7900911-cc7a-4dde-92e7-48fe82cddd9e-S1 > I1203 18:25:04.576243 28731 slave.cpp:680] Successfully attached file > '/tmp/MasterMaintenanceTest_InverseOffersFilters_3H2fr1/slaves/c7900911-cc7a-4dde-92e7-48fe82cddd9e-S1/frameworks/c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000/executors/executor-2/runs/fdeb01b9-8c56-4508-92b6-0fe11ea9598c' > I1203 18:25:04.576272 28731 exec.cpp:184] Executor started at: > executor(49)@172.17.0.2:39622 with pid 28713 > I1203 18:25:04.576289 28745 exec.cpp:220] Executor::registered took 42155ns > I1203 18:25:04.576496 28746 slave.cpp:1629] Queuing task > '26305fdd-edb0-4764-8b8a-2558f2b2d81b' for executor 'executor-1' of > framework c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > I1203 18:25:04.576531 28745 exec.cpp:295] Executor asked to run task > 'cafa992b-2be6-49fc-b727-bb3d55f1511d' > I1203 18:25:04.576599 28746 slave.cpp:680] Successfully attached file > '/tmp/MasterMaintenanceTest_InverseOffersFilters_QT4Wpx/slaves/c7900911-cc7a-4dde-92e7-48fe82cddd9e-S0/frameworks/c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000/executors/executor-1/runs/ea81f571-9880-45a2-a9cc-dcf32b83b74a' > I1203 18:25:04.576653 28745 exec.cpp:304] Executor::launchTask took > 110839ns > I1203 18:25:04.576653 28746 slave.cpp:2406] Got registration for executor > 'executor-1' of framework c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 from > executor(49)@172.17.0.2:39622 > I1203 18:25:04.576758 28745 exec.cpp:517] Executor sending status update > TASK_RUNNING (UUID: 6afd012e-8e88-41b2-8239-a9b852d07ca1) for task > cafa992b-2be6-49fc-b727-bb3d55f1511d of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > I1203 18:25:04.577268 28745 exec.cpp:208] Executor registered on slave > c7900911-cc7a-4dde-92e7-48fe82cddd9e-S0 > I1203 18:25:04.577370 28745 exec.cpp:220] Executor::registered took 36175ns > I1203 18:25:04.577371 28731 slave.cpp:2763] Handling status update > TASK_RUNNING (UUID: 6afd012e-8e88-41b2-8239-a9b852d07ca1) for task > cafa992b-2be6-49fc-b727-bb3d55f1511d of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 from executor(48)@ > 172.17.0.2:39622 > I1203 18:25:04.577510 28746 slave.cpp:1794] Sending queued task > '26305fdd-edb0-4764-8b8a-2558f2b2d81b' to executor 'executor-1' of > framework c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 at executor(49)@ > 172.17.0.2:39622 > I1203 18:25:04.577916 28746 status_update_manager.cpp:320] Received status > update TASK_RUNNING (UUID: 6afd012e-8e88-41b2-8239-a9b852d07ca1) for task > cafa992b-2be6-49fc-b727-bb3d55f1511d of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > I1203 18:25:04.578044 28746 status_update_manager.cpp:497] Creating > StatusUpdate stream for task cafa992b-2be6-49fc-b727-bb3d55f1511d of > framework c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > I1203 18:25:04.578086 28731 exec.cpp:295] Executor asked to run task > '26305fdd-edb0-4764-8b8a-2558f2b2d81b' > I1203 18:25:04.578284 28731 exec.cpp:304] Executor::launchTask took 69408ns > I1203 18:25:04.578366 28731 exec.cpp:517] Executor sending status update > TASK_RUNNING (UUID: 82fc7a7b-e64a-4f4d-ab74-76abac42b4e6) for task > 26305fdd-edb0-4764-8b8a-2558f2b2d81b of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > I1203 18:25:04.578517 28746 status_update_manager.cpp:374] Forwarding > update TASK_RUNNING (UUID: 6afd012e-8e88-41b2-8239-a9b852d07ca1) for task > cafa992b-2be6-49fc-b727-bb3d55f1511d of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 to the slave > I1203 18:25:04.578568 28731 slave.cpp:2763] Handling status update > TASK_RUNNING (UUID: 82fc7a7b-e64a-4f4d-ab74-76abac42b4e6) for task > 26305fdd-edb0-4764-8b8a-2558f2b2d81b of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 from executor(49)@ > 172.17.0.2:39622 > I1203 18:25:04.578970 28731 status_update_manager.cpp:320] Received status > update TASK_RUNNING (UUID: 82fc7a7b-e64a-4f4d-ab74-76abac42b4e6) for task > 26305fdd-edb0-4764-8b8a-2558f2b2d81b of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > I1203 18:25:04.579010 28731 status_update_manager.cpp:497] Creating > StatusUpdate stream for task 26305fdd-edb0-4764-8b8a-2558f2b2d81b of > framework c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > I1203 18:25:04.579059 28737 slave.cpp:3115] Forwarding the update > TASK_RUNNING (UUID: 6afd012e-8e88-41b2-8239-a9b852d07ca1) for task > cafa992b-2be6-49fc-b727-bb3d55f1511d of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 to [email protected]:39622 > I1203 18:25:04.579345 28731 status_update_manager.cpp:374] Forwarding > update TASK_RUNNING (UUID: 82fc7a7b-e64a-4f4d-ab74-76abac42b4e6) for task > 26305fdd-edb0-4764-8b8a-2558f2b2d81b of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 to the slave > I1203 18:25:04.579344 28737 slave.cpp:3009] Status update manager > successfully handled status update TASK_RUNNING (UUID: > 6afd012e-8e88-41b2-8239-a9b852d07ca1) for task > cafa992b-2be6-49fc-b727-bb3d55f1511d of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > I1203 18:25:04.579468 28737 slave.cpp:3025] Sending acknowledgement for > status update TASK_RUNNING (UUID: 6afd012e-8e88-41b2-8239-a9b852d07ca1) for > task cafa992b-2be6-49fc-b727-bb3d55f1511d of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 to executor(48)@172.17.0.2:39622 > I1203 18:25:04.579728 28731 slave.cpp:3115] Forwarding the update > TASK_RUNNING (UUID: 82fc7a7b-e64a-4f4d-ab74-76abac42b4e6) for task > 26305fdd-edb0-4764-8b8a-2558f2b2d81b of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 to [email protected]:39622 > I1203 18:25:04.579774 28737 master.cpp:4572] Status update TASK_RUNNING > (UUID: 6afd012e-8e88-41b2-8239-a9b852d07ca1) for task > cafa992b-2be6-49fc-b727-bb3d55f1511d of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 from slave > c7900911-cc7a-4dde-92e7-48fe82cddd9e-S1 at slave(112)@172.17.0.2:39622 > (maintenance-host-2) > I1203 18:25:04.579819 28737 master.cpp:4620] Forwarding status update > TASK_RUNNING (UUID: 6afd012e-8e88-41b2-8239-a9b852d07ca1) for task > cafa992b-2be6-49fc-b727-bb3d55f1511d of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > I1203 18:25:04.579879 28731 slave.cpp:3009] Status update manager > successfully handled status update TASK_RUNNING (UUID: > 82fc7a7b-e64a-4f4d-ab74-76abac42b4e6) for task > 26305fdd-edb0-4764-8b8a-2558f2b2d81b of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > I1203 18:25:04.580005 28740 exec.cpp:341] Executor received status update > acknowledgement 6afd012e-8e88-41b2-8239-a9b852d07ca1 for task > cafa992b-2be6-49fc-b727-bb3d55f1511d of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > I1203 18:25:04.579922 28731 slave.cpp:3025] Sending acknowledgement for > status update TASK_RUNNING (UUID: 82fc7a7b-e64a-4f4d-ab74-76abac42b4e6) for > task 26305fdd-edb0-4764-8b8a-2558f2b2d81b of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 to executor(49)@172.17.0.2:39622 > I1203 18:25:04.580652 28737 master.cpp:6224] Updating the state of task > cafa992b-2be6-49fc-b727-bb3d55f1511d of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 (latest state: TASK_RUNNING, > status update state: TASK_RUNNING) > I1203 18:25:04.581056 28737 master.cpp:4572] Status update TASK_RUNNING > (UUID: 82fc7a7b-e64a-4f4d-ab74-76abac42b4e6) for task > 26305fdd-edb0-4764-8b8a-2558f2b2d81b of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 from slave > c7900911-cc7a-4dde-92e7-48fe82cddd9e-S0 at slave(111)@172.17.0.2:39622 > (maintenance-host) > I1203 18:25:04.581106 28737 master.cpp:4620] Forwarding status update > TASK_RUNNING (UUID: 82fc7a7b-e64a-4f4d-ab74-76abac42b4e6) for task > 26305fdd-edb0-4764-8b8a-2558f2b2d81b of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > I1203 18:25:04.580662 28734 exec.cpp:341] Executor received status update > acknowledgement 82fc7a7b-e64a-4f4d-ab74-76abac42b4e6 for task > 26305fdd-edb0-4764-8b8a-2558f2b2d81b of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > I1203 18:25:04.581707 28737 master.cpp:6224] Updating the state of task > 26305fdd-edb0-4764-8b8a-2558f2b2d81b of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 (latest state: TASK_RUNNING, > status update state: TASK_RUNNING) > I1203 18:25:04.582212 28737 scheduler.cpp:457] Enqueuing event UPDATE > received from [email protected]:39622 > I1203 18:25:04.585041 28745 scheduler.cpp:457] Enqueuing event UPDATE > received from [email protected]:39622 > I1203 18:25:04.605078 28745 scheduler.cpp:298] Sending ACKNOWLEDGE call to > [email protected]:39622 > I1203 18:25:04.609073 28739 process.cpp:3067] Handling HTTP event for > process 'master' with path: '/master/api/v1/scheduler' > I1203 18:25:04.609181 28739 http.cpp:336] HTTP POST for > /master/api/v1/scheduler from 172.17.0.2:51248 > I1203 18:25:04.609382 28739 master.cpp:3729] Processing ACKNOWLEDGE call > 6afd012e-8e88-41b2-8239-a9b852d07ca1 for task > 26305fdd-edb0-4764-8b8a-2558f2b2d81b of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 (default) on slave > c7900911-cc7a-4dde-92e7-48fe82cddd9e-S0 > I1203 18:25:04.609817 28732 status_update_manager.cpp:392] Received status > update acknowledgement (UUID: 6afd012e-8e88-41b2-8239-a9b852d07ca1) for > task 26305fdd-edb0-4764-8b8a-2558f2b2d81b of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > W1203 18:25:04.610076 28732 status_update_manager.cpp:762] Unexpected > status update acknowledgement (received > 6afd012e-8e88-41b2-8239-a9b852d07ca1, expecting > 82fc7a7b-e64a-4f4d-ab74-76abac42b4e6) for update TASK_RUNNING (UUID: > 82fc7a7b-e64a-4f4d-ab74-76abac42b4e6) for task > 26305fdd-edb0-4764-8b8a-2558f2b2d81b of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > E1203 18:25:04.610339 28736 slave.cpp:2339] Failed to handle status update > acknowledgement (UUID: 6afd012e-8e88-41b2-8239-a9b852d07ca1) for task > 26305fdd-edb0-4764-8b8a-2558f2b2d81b of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000: Duplicate acknowledgement > I1203 18:25:04.614711 28733 scheduler.cpp:298] Sending ACKNOWLEDGE call to > [email protected]:39622 > I1203 18:25:04.618331 28736 process.cpp:3067] Handling HTTP event for > process 'master' with path: '/master/api/v1/scheduler' > I1203 18:25:04.618434 28736 http.cpp:336] HTTP POST for > /master/api/v1/scheduler from 172.17.0.2:51249 > I1203 18:25:04.618621 28736 master.cpp:3729] Processing ACKNOWLEDGE call > 82fc7a7b-e64a-4f4d-ab74-76abac42b4e6 for task > cafa992b-2be6-49fc-b727-bb3d55f1511d of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 (default) on slave > c7900911-cc7a-4dde-92e7-48fe82cddd9e-S1 > I1203 18:25:04.619472 28736 status_update_manager.cpp:392] Received status > update acknowledgement (UUID: 82fc7a7b-e64a-4f4d-ab74-76abac42b4e6) for > task cafa992b-2be6-49fc-b727-bb3d55f1511d of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > W1203 18:25:04.619717 28736 status_update_manager.cpp:762] Unexpected > status update acknowledgement (received > 82fc7a7b-e64a-4f4d-ab74-76abac42b4e6, expecting > 6afd012e-8e88-41b2-8239-a9b852d07ca1) for update TASK_RUNNING (UUID: > 6afd012e-8e88-41b2-8239-a9b852d07ca1) for task > cafa992b-2be6-49fc-b727-bb3d55f1511d of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > E1203 18:25:04.620014 28736 slave.cpp:2339] Failed to handle status update > acknowledgement (UUID: 82fc7a7b-e64a-4f4d-ab74-76abac42b4e6) for task > cafa992b-2be6-49fc-b727-bb3d55f1511d of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000: Duplicate acknowledgement > I1203 18:25:04.621562 28736 scheduler.cpp:298] Sending DECLINE call to > [email protected]:39622 > I1203 18:25:04.626117 28735 process.cpp:3067] Handling HTTP event for > process 'master' with path: '/master/api/v1/scheduler' > I1203 18:25:04.626325 28735 http.cpp:336] HTTP POST for > /master/api/v1/scheduler from 172.17.0.2:51250 > I1203 18:25:04.626641 28735 master.cpp:3455] Processing DECLINE call for > offers: [ c7900911-cc7a-4dde-92e7-48fe82cddd9e-O3 ] for framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 (default) > I1203 18:25:04.627543 28742 hierarchical.cpp:1062] No resources available > to allocate! > I1203 18:25:04.627910 28742 hierarchical.cpp:957] Performed allocation for > 2 slaves in 2.470458ms > I1203 18:25:04.628186 28742 hierarchical.cpp:699] Framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 filtered inverse offers from > slave c7900911-cc7a-4dde-92e7-48fe82cddd9e-S0 for 101secs > I1203 18:25:04.628924 28744 scheduler.cpp:298] Sending ACCEPT call to > [email protected]:39622 > I1203 18:25:04.631536 28734 process.cpp:3067] Handling HTTP event for > process 'master' with path: '/master/api/v1/scheduler' > I1203 18:25:04.631605 28734 http.cpp:336] HTTP POST for > /master/api/v1/scheduler from 172.17.0.2:51251 > W1203 18:25:04.632104 28734 master.cpp:2973] ACCEPT call used invalid > offers '[ c7900911-cc7a-4dde-92e7-48fe82cddd9e-O2 ]': Offer > c7900911-cc7a-4dde-92e7-48fe82cddd9e-O2 is no longer valid > 2015-12-03 > 18:25:04,893:28713(0x2ab9e880b700):ZOO_ERROR@handle_socket_error_msg@1697: > Socket [127.0.0.1:47838] zk retcode=-4, errno=111(Connection refused): > server refused to accept the client > 2015-12-03 > 18:25:08,229:28713(0x2ab9e880b700):ZOO_ERROR@handle_socket_error_msg@1697: > Socket [127.0.0.1:47838] zk retcode=-4, errno=111(Connection refused): > server refused to accept the client > 2015-12-03 > 18:25:11,565:28713(0x2ab9e880b700):ZOO_ERROR@handle_socket_error_msg@1697: > Socket [127.0.0.1:47838] zk retcode=-4, errno=111(Connection refused): > server refused to accept the client > 2015-12-03 > 18:25:14,901:28713(0x2ab9e880b700):ZOO_ERROR@handle_socket_error_msg@1697: > Socket [127.0.0.1:47838] zk retcode=-4, errno=111(Connection refused): > server refused to accept the client > 2015-12-03 > 18:25:18,235:28713(0x2ab9e880b700):ZOO_ERROR@handle_socket_error_msg@1697: > Socket [127.0.0.1:47838] zk retcode=-4, errno=111(Connection refused): > server refused to accept the client > ../../src/tests/master_maintenance_tests.cpp:1559: Failure > Failed to wait 15secs for event > I1203 18:25:19.639402 28740 master.cpp:938] Master terminating > W1203 18:25:19.639631 28740 master.cpp:6276] Removing task > cafa992b-2be6-49fc-b727-bb3d55f1511d with resources cpus(*):2; mem(*):1024; > disk(*):1024; ports(*):[31000-32000] of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 on slave > c7900911-cc7a-4dde-92e7-48fe82cddd9e-S1 at slave(112)@172.17.0.2:39622 > (maintenance-host-2) in non-terminal state TASK_RUNNING > I1203 18:25:19.640571 28740 master.cpp:6319] Removing executor > 'executor-2' with resources of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 on slave > c7900911-cc7a-4dde-92e7-48fe82cddd9e-S1 at slave(112)@172.17.0.2:39622 > (maintenance-host-2) > W1203 18:25:19.641091 28740 master.cpp:6276] Removing task > 26305fdd-edb0-4764-8b8a-2558f2b2d81b with resources cpus(*):2; mem(*):1024; > disk(*):1024; ports(*):[31000-32000] of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 on slave > c7900911-cc7a-4dde-92e7-48fe82cddd9e-S0 at slave(111)@172.17.0.2:39622 > (maintenance-host) in non-terminal state TASK_RUNNING > I1203 18:25:19.641700 28740 master.cpp:6319] Removing executor > 'executor-1' with resources of framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 on slave > c7900911-cc7a-4dde-92e7-48fe82cddd9e-S0 at slave(111)@172.17.0.2:39622 > (maintenance-host) > I1203 18:25:19.643367 28733 hierarchical.cpp:410] Removed slave > c7900911-cc7a-4dde-92e7-48fe82cddd9e-S1 > I1203 18:25:19.644150 28733 hierarchical.cpp:410] Removed slave > c7900911-cc7a-4dde-92e7-48fe82cddd9e-S0 > I1203 18:25:19.644635 28733 hierarchical.cpp:260] Removed framework > c7900911-cc7a-4dde-92e7-48fe82cddd9e-0000 > I1203 18:25:19.645395 28739 slave.cpp:3243] [email protected]:39622 exited > W1203 18:25:19.646028 28739 slave.cpp:3246] Master disconnected! Waiting > for a new master to be elected > I1203 18:25:19.644919 28740 slave.cpp:3243] [email protected]:39622 exited > W1203 18:25:19.647006 28740 slave.cpp:3246] Master disconnected! Waiting > for a new master to be elected > *** Aborted at 1449167119 (unix time) try "date -d @1449167119" if you are > using GNU date *** > PC: @ 0x8c31fe > mesos::internal::tests::Cluster::Slaves::shutdown() > *** SIGSEGV (@0x500010047) received by PID 28713 (TID 0x2ab9021fd940) from > PID 65607; stack trace: *** > @ 0x2ab9138ae0b7 os::Linux::chained_handler() > @ 0x2ab9138b2219 JVM_handle_linux_signal > @ 0x2ab907859340 (unknown) > @ 0x8c31fe > mesos::internal::tests::Cluster::Slaves::shutdown() > @ 0xf23fdb > mesos::internal::tests::MesosTest::ShutdownSlaves() > @ 0xf23f75 mesos::internal::tests::MesosTest::Shutdown() > @ 0xf1f8c7 mesos::internal::tests::MesosTest::TearDown() > @ 0x1662d53 > testing::internal::HandleSehExceptionsInMethodIfSupported<>() > @ 0x1650621 > testing::internal::HandleExceptionsInMethodIfSupported<>() > @ 0x163117a testing::Test::Run() > @ 0x1631dab testing::TestInfo::Run() > @ 0x16324f7 testing::TestCase::Run() > @ 0x1639c52 testing::internal::UnitTestImpl::RunAllTests() > @ 0x1660513 > testing::internal::HandleSehExceptionsInMethodIfSupported<>() > @ 0x1652641 > testing::internal::HandleExceptionsInMethodIfSupported<>() > @ 0x163990b testing::UnitTest::Run() > @ 0xca5141 RUN_ALL_TESTS() > @ 0xca3fe6 main > @ 0x2ab907a88ec5 (unknown) > @ 0x7e703c (unknown) > make[4]: Leaving directory `/mesos/mesos-0.27.0/_build/src' > make[4]: *** [check-local] Segmentation fault > make[3]: Leaving directory `/mesos/mesos-0.27.0/_build/src' > make[3]: *** [check-am] Error 2 > 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-1449165127-27928 > Untagged: mesos-1449165127-27928:latest > Deleted: 68398f9a0db7903300dc04219d37e2f1311403ec5bd07ca2c8cce66fa7d9b144 > Deleted: 278319a9edd2a62e434a62ad98fa3b18f9811d498fd10e8974fc32ee8d345baa > Deleted: e14b8acf0a7efc2a3c0af1f5240eeab99dc3651116c6500debbe2b63904bf0b2 > Deleted: 0b54a8f2cc78e4fcce0b1d72efaad9498a063c6b5de3c903ff45630e057f8c0c > Deleted: bd00cedbdc24f0dd143fcbdfac2907b9782ae4de069faa8d5d1e2989c9eb7488 > Deleted: dd1b5d5a8e55241acb46bef8580e3b67d39f494633f2e2a680fc42de4f6b018c > Deleted: f641a9d42f53729b85eec03ced3062ee9f72f46d996beeb433d6151daea3d6df > Deleted: b84d74f5e45b228074e6d72f4bbdf63c1d8cf398341cf0ccaafe8c561332182f > Deleted: 7ac9ba7138ad17281e99ef4c4411d577b6c9c3e34290039d204f733dc139ab78 > Deleted: 97886a6833a78e4666d2bded68b5898489fee41901b37091c1556d29f434fca8 > Deleted: 9e8f93adf5df5ca1eb63366a2b8c5a939d6ff25072ebf33622f91aef8e4a9fa6 > Deleted: 68549af3aca27bc40f40d00732b3e83df14c7e4117e4224beb1aebcf7a00f6ab > Deleted: 97ee89720e239d38c7e4eefead19309c5ced22d7ac8584cb993a045b3a9ef674 > Build step 'Execute shell' marked build as failure >
