See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3386/display/redirect?page=changes>
Changes: [zhq527725] Corrected the order of the committer list. ------------------------------------------ [...truncated 3.95 MB...] I0317 03:09:40.906941 25371 authenticator.cpp:326] Authentication requires more steps I0317 03:09:40.906997 25376 authenticatee.cpp:259] Received SASL authentication step I0317 03:09:40.907151 25385 authenticator.cpp:232] Received SASL authentication step I0317 03:09:40.907171 25385 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '458d9e1a9b23' server FQDN: '458d9e1a9b23' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0317 03:09:40.907181 25385 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0317 03:09:40.907197 25385 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0317 03:09:40.907212 25385 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '458d9e1a9b23' server FQDN: '458d9e1a9b23' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0317 03:09:40.907220 25385 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0317 03:09:40.907228 25385 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0317 03:09:40.907245 25385 authenticator.cpp:318] Authentication success I0317 03:09:40.907300 25371 authenticatee.cpp:299] Authentication success I0317 03:09:40.907323 25385 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(163)@172.17.0.2:35932 I0317 03:09:40.907376 25376 master.cpp:7282] Successfully authenticated principal 'test-principal' at slave(76)@172.17.0.2:35932 I0317 03:09:40.907472 25374 slave.cpp:978] Successfully authenticated with master [email protected]:35932 I0317 03:09:40.907569 25374 slave.cpp:1406] Will retry registration in 14.649276ms if necessary I0317 03:09:40.907637 25372 master.cpp:5437] Registering agent at slave(76)@172.17.0.2:35932 (maintenance-host) with id a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S0 I0317 03:09:40.907776 25386 registrar.cpp:463] Applied 1 operations in 17097ns; attempting to update the registry I0317 03:09:40.908160 25386 registrar.cpp:508] Successfully updated the registry in 355840ns I0317 03:09:40.908481 25377 slave.cpp:4421] Received ping from slave-observer(68)@172.17.0.2:35932 I0317 03:09:40.908465 25373 master.cpp:5511] Registered agent a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S0 at slave(76)@172.17.0.2:35932 (maintenance-host) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0317 03:09:40.908620 25377 slave.cpp:1024] Registered with master [email protected]:35932; given agent ID a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S0 I0317 03:09:40.908604 25380 hierarchical.cpp:527] Added agent a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S0 (maintenance-host) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {}) I0317 03:09:40.908646 25377 fetcher.cpp:94] Clearing fetcher cache I0317 03:09:40.908818 25380 hierarchical.cpp:1862] No allocations performed I0317 03:09:40.908843 25383 status_update_manager.cpp:184] Resuming sending status updates I0317 03:09:40.908849 25380 hierarchical.cpp:1446] Performed allocation for 1 agents in 58536ns I0317 03:09:40.908984 25377 slave.cpp:1052] Checkpointing SlaveInfo to '/tmp/MasterMaintenanceTest_InverseOffersFilters_RzbDXV/meta/slaves/a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S0/slave.info' I0317 03:09:40.909296 25377 slave.cpp:1090] Forwarding total oversubscribed resources {} I0317 03:09:40.909365 25377 master.cpp:6098] Received update of agent a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S0 at slave(76)@172.17.0.2:35932 (maintenance-host) with total oversubscribed resources {} I0317 03:09:40.910958 25370 cluster.cpp:446] Creating default 'local' authorizer I0317 03:09:40.911742 25384 slave.cpp:210] Mesos agent started on (77)@172.17.0.2:35932 I0317 03:09:40.911764 25384 slave.cpp:211] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/MasterMaintenanceTest_InverseOffersFilters_xxCzND/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io"; --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/MasterMaintenanceTest_InverseOffersFilters_xxCzND/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname="maintenance-host-2" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/MasterMaintenanceTest_InverseOffersFilters_xxCzND/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/MasterMaintenanceTest_InverseOffersFilters_xxCzND" --sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true" --systemd_enable_support="true" --systemd_runtime_directory="/run/systemd/system" --version="false" --work_dir="/tmp/MasterMaintenanceTest_InverseOffersFilters_Rnv2pH" I0317 03:09:40.912124 25384 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterMaintenanceTest_InverseOffersFilters_xxCzND/credential' I0317 03:09:40.912202 25384 slave.cpp:243] Agent using credential for: test-principal I0317 03:09:40.912214 25384 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterMaintenanceTest_InverseOffersFilters_xxCzND/http_credentials' I0317 03:09:40.912300 25384 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0317 03:09:40.912345 25384 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I0317 03:09:40.912667 25384 slave.cpp:430] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0317 03:09:40.912698 25384 slave.cpp:438] Agent attributes: [ ] I0317 03:09:40.912703 25384 slave.cpp:443] Agent hostname: maintenance-host-2 I0317 03:09:40.912756 25379 status_update_manager.cpp:177] Pausing sending status updates I0317 03:09:40.913089 25374 state.cpp:62] Recovering state from '/tmp/MasterMaintenanceTest_InverseOffersFilters_Rnv2pH/meta' I0317 03:09:40.913264 25382 status_update_manager.cpp:203] Recovering status update manager I0317 03:09:40.913543 25376 slave.cpp:5638] Finished recovery I0317 03:09:40.913924 25376 slave.cpp:5820] Querying resource estimator for oversubscribable resources I0317 03:09:40.914036 25376 slave.cpp:821] New master detected at [email protected]:35932 I0317 03:09:40.914044 25384 status_update_manager.cpp:177] Pausing sending status updates I0317 03:09:40.914082 25376 slave.cpp:856] Detecting new master I0317 03:09:40.914145 25376 slave.cpp:5834] Received oversubscribable resources {} from the resource estimator I0317 03:09:40.917284 25372 slave.cpp:883] Authenticating with master [email protected]:35932 I0317 03:09:40.917315 25372 slave.cpp:894] Using default CRAM-MD5 authenticatee I0317 03:09:40.917397 25381 authenticatee.cpp:121] Creating new client SASL connection I0317 03:09:40.917585 25381 master.cpp:7252] Authenticating slave(77)@172.17.0.2:35932 I0317 03:09:40.917671 25375 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(164)@172.17.0.2:35932 I0317 03:09:40.917774 25376 authenticator.cpp:98] Creating new server SASL connection I0317 03:09:40.918038 25372 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0317 03:09:40.918062 25372 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0317 03:09:40.918164 25379 authenticator.cpp:204] Received SASL authentication start I0317 03:09:40.918215 25379 authenticator.cpp:326] Authentication requires more steps I0317 03:09:40.918265 25379 authenticatee.cpp:259] Received SASL authentication step I0317 03:09:40.918401 25372 authenticator.cpp:232] Received SASL authentication step I0317 03:09:40.918431 25372 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '458d9e1a9b23' server FQDN: '458d9e1a9b23' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0317 03:09:40.918449 25372 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0317 03:09:40.918465 25372 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0317 03:09:40.918478 25372 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '458d9e1a9b23' server FQDN: '458d9e1a9b23' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0317 03:09:40.918488 25372 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0317 03:09:40.918496 25372 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0317 03:09:40.918515 25372 authenticator.cpp:318] Authentication success I0317 03:09:40.918570 25372 authenticatee.cpp:299] Authentication success I0317 03:09:40.918614 25371 master.cpp:7282] Successfully authenticated principal 'test-principal' at slave(77)@172.17.0.2:35932 I0317 03:09:40.918647 25372 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(164)@172.17.0.2:35932 I0317 03:09:40.918859 25384 slave.cpp:978] Successfully authenticated with master [email protected]:35932 I0317 03:09:40.918962 25384 slave.cpp:1406] Will retry registration in 11.365007ms if necessary I0317 03:09:40.919059 25381 master.cpp:5437] Registering agent at slave(77)@172.17.0.2:35932 (maintenance-host-2) with id a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S1 I0317 03:09:40.919235 25371 registrar.cpp:463] Applied 1 operations in 23817ns; attempting to update the registry I0317 03:09:40.919865 25371 registrar.cpp:508] Successfully updated the registry in 581888ns I0317 03:09:40.920142 25377 slave.cpp:4421] Received ping from slave-observer(69)@172.17.0.2:35932 I0317 03:09:40.920174 25384 master.cpp:5511] Registered agent a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S1 at slave(77)@172.17.0.2:35932 (maintenance-host-2) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0317 03:09:40.920294 25377 slave.cpp:1024] Registered with master [email protected]:35932; given agent ID a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S1 I0317 03:09:40.920317 25377 fetcher.cpp:94] Clearing fetcher cache I0317 03:09:40.920302 25382 hierarchical.cpp:527] Added agent a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S1 (maintenance-host-2) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {}) I0317 03:09:40.920434 25382 hierarchical.cpp:1862] No allocations performed I0317 03:09:40.920462 25382 hierarchical.cpp:1446] Performed allocation for 1 agents in 90874ns I0317 03:09:40.920686 25380 status_update_manager.cpp:184] Resuming sending status updates I0317 03:09:40.920732 25377 slave.cpp:1052] Checkpointing SlaveInfo to '/tmp/MasterMaintenanceTest_InverseOffersFilters_Rnv2pH/meta/slaves/a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S1/slave.info' I0317 03:09:40.921020 25377 slave.cpp:1090] Forwarding total oversubscribed resources {} I0317 03:09:40.921156 25377 master.cpp:6098] Received update of agent a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S1 at slave(77)@172.17.0.2:35932 (maintenance-host-2) with total oversubscribed resources {} I0317 03:09:40.921582 25381 process.cpp:3705] Handling HTTP event for process 'master' with path: '/master/maintenance/schedule' I0317 03:09:40.922332 25372 http.cpp:440] HTTP POST for /master/maintenance/schedule from 172.17.0.2:45281 I0317 03:09:40.922608 25374 registrar.cpp:463] Applied 1 operations in 40187ns; attempting to update the registry I0317 03:09:40.923357 25374 registrar.cpp:508] Successfully updated the registry in 706816ns I0317 03:09:40.923522 25382 master.cpp:6160] Updating unavailability of agent a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S0 at slave(76)@172.17.0.2:35932 (maintenance-host), starting at 2468.16219894281weeks I0317 03:09:40.923604 25382 master.cpp:6160] Updating unavailability of agent a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S1 at slave(77)@172.17.0.2:35932 (maintenance-host-2), starting at 2468.16219894281weeks I0317 03:09:40.923710 25380 hierarchical.cpp:1862] No allocations performed I0317 03:09:40.923748 25380 hierarchical.cpp:1446] Performed allocation for 1 agents in 71938ns I0317 03:09:40.923856 25380 hierarchical.cpp:1862] No allocations performed I0317 03:09:40.923874 25380 hierarchical.cpp:1446] Performed allocation for 1 agents in 47342ns I0317 03:09:40.924456 25370 scheduler.cpp:184] Version: 1.3.0 I0317 03:09:40.924784 25381 scheduler.cpp:470] New master detected at [email protected]:35932 I0317 03:09:40.925850 25381 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master I0317 03:09:40.927485 25384 scheduler.cpp:361] Connected with the master at http://172.17.0.2:35932/master/api/v1/scheduler I0317 03:09:40.928102 25384 scheduler.cpp:243] Sending SUBSCRIBE call to http://172.17.0.2:35932/master/api/v1/scheduler I0317 03:09:40.928419 25385 process.cpp:3705] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' I0317 03:09:40.928777 25386 http.cpp:440] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:45283 I0317 03:09:40.928845 25386 master.cpp:2517] Received subscription request for HTTP framework 'default' I0317 03:09:40.928872 25386 master.cpp:2201] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }' I0317 03:09:40.929044 25378 master.cpp:2632] Subscribing framework 'default' with checkpointing disabled and capabilities [ ] I0317 03:09:40.929281 25373 master.hpp:2179] Sending heartbeat to a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 I0317 03:09:40.929304 25382 hierarchical.cpp:271] Added framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 I0317 03:09:40.929632 25381 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from http://172.17.0.2:35932/master/api/v1/scheduler I0317 03:09:40.929744 25382 hierarchical.cpp:1446] Performed allocation for 2 agents in 361215ns I0317 03:09:40.929951 25381 scheduler.cpp:676] Enqueuing event HEARTBEAT received from http://172.17.0.2:35932/master/api/v1/scheduler I0317 03:09:40.929996 25373 master.cpp:7081] Sending 2 offers to framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 (default) I0317 03:09:40.930292 25373 master.cpp:7171] Sending 2 inverse offers to framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 (default) I0317 03:09:40.930829 25374 scheduler.cpp:676] Enqueuing event OFFERS received from http://172.17.0.2:35932/master/api/v1/scheduler I0317 03:09:40.931056 25374 scheduler.cpp:676] Enqueuing event INVERSE_OFFERS received from http://172.17.0.2:35932/master/api/v1/scheduler I0317 03:09:40.939523 25379 hierarchical.cpp:1862] No allocations performed I0317 03:09:40.939635 25379 hierarchical.cpp:1446] Performed allocation for 2 agents in 151807ns I0317 03:09:40.940188 25380 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.2:35932/master/api/v1/scheduler I0317 03:09:40.940546 25380 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.2:35932/master/api/v1/scheduler I0317 03:09:40.940690 25384 process.cpp:3705] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' I0317 03:09:40.941102 25379 process.cpp:3705] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' I0317 03:09:40.941195 25379 http.cpp:440] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:45282 I0317 03:09:40.941386 25379 master.cpp:3839] Processing ACCEPT call for offers: [ a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-O0 ] on agent a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S0 at slave(76)@172.17.0.2:35932 (maintenance-host) for framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 (default) I0317 03:09:40.941427 25379 master.cpp:3415] Authorizing framework principal 'test-principal' to launch task 395dc900-a8f4-4de5-9c34-dcb0059c0535 W0317 03:09:40.942258 25379 validation.cpp:1113] Executor 'executor-1' for task '395dc900-a8f4-4de5-9c34-dcb0059c0535' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases. W0317 03:09:40.942278 25379 validation.cpp:1125] Executor 'executor-1' for task '395dc900-a8f4-4de5-9c34-dcb0059c0535' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases. I0317 03:09:40.942371 25379 master.cpp:9097] Adding task 395dc900-a8f4-4de5-9c34-dcb0059c0535 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S0 at slave(76)@172.17.0.2:35932 (maintenance-host) I0317 03:09:40.942443 25379 master.cpp:4489] Launching task 395dc900-a8f4-4de5-9c34-dcb0059c0535 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 (default) with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S0 at slave(76)@172.17.0.2:35932 (maintenance-host) I0317 03:09:40.942682 25382 slave.cpp:1516] Got assigned task '395dc900-a8f4-4de5-9c34-dcb0059c0535' for framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 I0317 03:09:40.942790 25380 http.cpp:440] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:45282 I0317 03:09:40.943066 25382 slave.cpp:1797] Authorizing task '395dc900-a8f4-4de5-9c34-dcb0059c0535' for framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 I0317 03:09:40.943094 25382 slave.cpp:6257] Authorizing framework principal 'test-principal' to launch task 395dc900-a8f4-4de5-9c34-dcb0059c0535 I0317 03:09:40.943174 25381 hierarchical.cpp:852] Updated allocation of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 on agent a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S0 from cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] to cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] I0317 03:09:40.943212 25380 master.cpp:3839] Processing ACCEPT call for offers: [ a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-O1 ] on agent a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S1 at slave(77)@172.17.0.2:35932 (maintenance-host-2) for framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 (default) I0317 03:09:40.943282 25380 master.cpp:3415] Authorizing framework principal 'test-principal' to launch task 742b05c9-6327-4ffc-9dcb-4640b99f36e5 I0317 03:09:40.943672 25382 slave.cpp:1984] Launching task '395dc900-a8f4-4de5-9c34-dcb0059c0535' for framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 I0317 03:09:40.944247 25382 paths.cpp:547] Trying to chown '/tmp/MasterMaintenanceTest_InverseOffersFilters_RzbDXV/slaves/a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S0/frameworks/a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000/executors/executor-1/runs/3b732b67-9151-4841-93c4-f28ce07d1da8' to user 'mesos' W0317 03:09:40.944284 25380 validation.cpp:1113] Executor 'executor-2' for task '742b05c9-6327-4ffc-9dcb-4640b99f36e5' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases. W0317 03:09:40.944327 25380 validation.cpp:1125] Executor 'executor-2' for task '742b05c9-6327-4ffc-9dcb-4640b99f36e5' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases. I0317 03:09:40.944407 25382 slave.cpp:6604] Launching executor 'executor-1' of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 with resources {} in work directory '/tmp/MasterMaintenanceTest_InverseOffersFilters_RzbDXV/slaves/a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S0/frameworks/a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000/executors/executor-1/runs/3b732b67-9151-4841-93c4-f28ce07d1da8' I0317 03:09:40.944495 25380 master.cpp:9097] Adding task 742b05c9-6327-4ffc-9dcb-4640b99f36e5 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S1 at slave(77)@172.17.0.2:35932 (maintenance-host-2) I0317 03:09:40.944628 25382 slave.cpp:2198] Queued task '395dc900-a8f4-4de5-9c34-dcb0059c0535' for executor 'executor-1' of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 I0317 03:09:40.944679 25382 slave.cpp:774] Successfully attached file '/tmp/MasterMaintenanceTest_InverseOffersFilters_RzbDXV/slaves/a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S0/frameworks/a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000/executors/executor-1/runs/3b732b67-9151-4841-93c4-f28ce07d1da8' I0317 03:09:40.944646 25380 master.cpp:4489] Launching task 742b05c9-6327-4ffc-9dcb-4640b99f36e5 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 (default) with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S1 at slave(77)@172.17.0.2:35932 (maintenance-host-2) I0317 03:09:40.945008 25371 slave.cpp:1516] Got assigned task '742b05c9-6327-4ffc-9dcb-4640b99f36e5' for framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 I0317 03:09:40.945243 25371 slave.cpp:1797] Authorizing task '742b05c9-6327-4ffc-9dcb-4640b99f36e5' for framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 I0317 03:09:40.945266 25371 slave.cpp:6257] Authorizing framework principal 'test-principal' to launch task 742b05c9-6327-4ffc-9dcb-4640b99f36e5 I0317 03:09:40.945384 25372 exec.cpp:162] Version: 1.3.0 I0317 03:09:40.945466 25386 exec.cpp:212] Executor started at: executor(28)@172.17.0.2:35932 with pid 25370 I0317 03:09:40.945693 25385 slave.cpp:3460] Got registration for executor 'executor-1' of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 from executor(28)@172.17.0.2:35932 I0317 03:09:40.945767 25374 hierarchical.cpp:852] Updated allocation of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 on agent a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S1 from cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] to cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] I0317 03:09:40.945989 25375 exec.cpp:237] Executor registered on agent a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S0 I0317 03:09:40.945830 25383 slave.cpp:1984] Launching task '742b05c9-6327-4ffc-9dcb-4640b99f36e5' for framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 I0317 03:09:40.946110 25375 exec.cpp:249] Executor::registered took 65610ns I0317 03:09:40.946301 25376 slave.cpp:2411] Sending queued task '395dc900-a8f4-4de5-9c34-dcb0059c0535' to executor 'executor-1' of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 at executor(28)@172.17.0.2:35932 I0317 03:09:40.946487 25376 exec.cpp:325] Executor asked to run task '395dc900-a8f4-4de5-9c34-dcb0059c0535' I0317 03:09:40.946539 25376 exec.cpp:334] Executor::launchTask took 31822ns I0317 03:09:40.946599 25376 exec.cpp:551] Executor sending status update TASK_RUNNING (UUID: c79cac99-9c00-4cbf-8902-3c290e250718) for task 395dc900-a8f4-4de5-9c34-dcb0059c0535 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 I0317 03:09:40.946732 25376 slave.cpp:3891] Handling status update TASK_RUNNING (UUID: c79cac99-9c00-4cbf-8902-3c290e250718) for task 395dc900-a8f4-4de5-9c34-dcb0059c0535 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 from executor(28)@172.17.0.2:35932 I0317 03:09:40.946782 25383 paths.cpp:547] Trying to chown '/tmp/MasterMaintenanceTest_InverseOffersFilters_Rnv2pH/slaves/a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S1/frameworks/a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000/executors/executor-2/runs/ce426042-360f-4d2b-93ff-edd5c7cfa76f' to user 'mesos' I0317 03:09:40.947013 25383 slave.cpp:6604] Launching executor 'executor-2' of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 with resources {} in work directory '/tmp/MasterMaintenanceTest_InverseOffersFilters_Rnv2pH/slaves/a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S1/frameworks/a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000/executors/executor-2/runs/ce426042-360f-4d2b-93ff-edd5c7cfa76f' I0317 03:09:40.947049 25376 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: c79cac99-9c00-4cbf-8902-3c290e250718) for task 395dc900-a8f4-4de5-9c34-dcb0059c0535 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 I0317 03:09:40.947075 25376 status_update_manager.cpp:500] Creating StatusUpdate stream for task 395dc900-a8f4-4de5-9c34-dcb0059c0535 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 I0317 03:09:40.947219 25376 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: c79cac99-9c00-4cbf-8902-3c290e250718) for task 395dc900-a8f4-4de5-9c34-dcb0059c0535 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 to the agent I0317 03:09:40.947317 25383 slave.cpp:2198] Queued task '742b05c9-6327-4ffc-9dcb-4640b99f36e5' for executor 'executor-2' of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 I0317 03:09:40.947473 25376 slave.cpp:4331] Forwarding the update TASK_RUNNING (UUID: c79cac99-9c00-4cbf-8902-3c290e250718) for task 395dc900-a8f4-4de5-9c34-dcb0059c0535 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 to [email protected]:35932 I0317 03:09:40.947556 25376 slave.cpp:4225] Status update manager successfully handled status update TASK_RUNNING (UUID: c79cac99-9c00-4cbf-8902-3c290e250718) for task 395dc900-a8f4-4de5-9c34-dcb0059c0535 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 I0317 03:09:40.947614 25376 slave.cpp:4241] Sending acknowledgement for status update TASK_RUNNING (UUID: c79cac99-9c00-4cbf-8902-3c290e250718) for task 395dc900-a8f4-4de5-9c34-dcb0059c0535 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 to executor(28)@172.17.0.2:35932 I0317 03:09:40.947731 25376 slave.cpp:774] Successfully attached file '/tmp/MasterMaintenanceTest_InverseOffersFilters_Rnv2pH/slaves/a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S1/frameworks/a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000/executors/executor-2/runs/ce426042-360f-4d2b-93ff-edd5c7cfa76f' I0317 03:09:40.947829 25376 master.cpp:6243] Status update TASK_RUNNING (UUID: c79cac99-9c00-4cbf-8902-3c290e250718) for task 395dc900-a8f4-4de5-9c34-dcb0059c0535 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 from agent a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S0 at slave(76)@172.17.0.2:35932 (maintenance-host) I0317 03:09:40.947870 25376 master.cpp:6311] Forwarding status update TASK_RUNNING (UUID: c79cac99-9c00-4cbf-8902-3c290e250718) for task 395dc900-a8f4-4de5-9c34-dcb0059c0535 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 I0317 03:09:40.948025 25376 master.cpp:8345] Updating the state of task 395dc900-a8f4-4de5-9c34-dcb0059c0535 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING) I0317 03:09:40.948097 25376 exec.cpp:374] Executor received status update acknowledgement c79cac99-9c00-4cbf-8902-3c290e250718 for task 395dc900-a8f4-4de5-9c34-dcb0059c0535 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 *** Aborted at 1489720180 (unix time) try "date -d @1489720180" if you are using GNU date *** I0317 03:09:40.948587 25383 exec.cpp:162] Version: 1.3.0 IPC: @ 0x2ab01567c82d (unknown) 0317 03:09:40.948689 25371 exec.cpp:212] Executor started at: executor(29)@172.17.0.2:35932 with pid 25370 I0317 03:09:40.948683 25380 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.2:35932/master/api/v1/scheduler I0317 03:09:40.948801 25371 slave.cpp:3460] Got registration for executor 'executor-2' of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 from executor(29)@172.17.0.2:35932 *** SIGSEGV (@0xb0) received by PID 25370 (TID 0x2ab01e1d5700) from PID 176; stack trace: *** I0317 03:09:40.948987 25382 exec.cpp:237] Executor registered on agent a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S1 I0317 03:09:40.949021 25382 exec.cpp:249] Executor::registered took 11933ns @ 0x2ab014c13330 (unknown) I0317 03:09:40.949328 25371 slave.cpp:2411] Sending queued task '742b05c9-6327-4ffc-9dcb-4640b99f36e5' to executor 'executor-2' of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 at executor(29)@172.17.0.2:35932 @ 0x2ab01567c82d (unknown) I0317 03:09:40.949453 25371 exec.cpp:325] Executor asked to run task '742b05c9-6327-4ffc-9dcb-4640b99f36e5' I0317 03:09:40.949491 25371 exec.cpp:334] Executor::launchTask took 21394ns I0317 03:09:40.949529 25371 exec.cpp:551] Executor sending status update TASK_RUNNING (UUID: 3940701b-a1f4-4105-ab2d-c9bad07158dd) for task 742b05c9-6327-4ffc-9dcb-4640b99f36e5 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 I0317 03:09:40.949612 25371 slave.cpp:3891] Handling status update TASK_RUNNING (UUID: 3940701b-a1f4-4105-ab2d-c9bad07158dd) for task 742b05c9-6327-4ffc-9dcb-4640b99f36e5 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 from executor(29)@172.17.0.2:35932 @ 0x2ab0156726f1 (unknown) I0317 03:09:40.950006 25383 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 3940701b-a1f4-4105-ab2d-c9bad07158dd) for task 742b05c9-6327-4ffc-9dcb-4640b99f36e5 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 I0317 03:09:40.950093 25383 status_update_manager.cpp:500] Creating StatusUpdate stream for task 742b05c9-6327-4ffc-9dcb-4640b99f36e5 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 @ 0x2ab0156c987e (unknown) I0317 03:09:40.950273 25383 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 3940701b-a1f4-4105-ab2d-c9bad07158dd) for task 742b05c9-6327-4ffc-9dcb-4640b99f36e5 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 to the agent I0317 03:09:40.950453 25382 slave.cpp:4331] Forwarding the update TASK_RUNNING (UUID: 3940701b-a1f4-4105-ab2d-c9bad07158dd) for task 742b05c9-6327-4ffc-9dcb-4640b99f36e5 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 to [email protected]:35932 I0317 03:09:40.950536 25382 slave.cpp:4225] Status update manager successfully handled status update TASK_RUNNING (UUID: 3940701b-a1f4-4105-ab2d-c9bad07158dd) for task 742b05c9-6327-4ffc-9dcb-4640b99f36e5 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 I0317 03:09:40.950558 25382 slave.cpp:4241] Sending acknowledgement for status update TASK_RUNNING (UUID: 3940701b-a1f4-4105-ab2d-c9bad07158dd) for task 742b05c9-6327-4ffc-9dcb-4640b99f36e5 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 to executor(29)@172.17.0.2:35932 I0317 03:09:40.950618 25375 master.cpp:6243] Status update TASK_RUNNING (UUID: 3940701b-a1f4-4105-ab2d-c9bad07158dd) for task 742b05c9-6327-4ffc-9dcb-4640b99f36e5 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 from agent a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-S1 at slave(77)@172.17.0.2:35932 (maintenance-host-2) I0317 03:09:40.950664 25375 master.cpp:6311] Forwarding status update TASK_RUNNING (UUID: 3940701b-a1f4-4105-ab2d-c9bad07158dd) for task 742b05c9-6327-4ffc-9dcb-4640b99f36e5 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 I0317 03:09:40.950700 25383 exec.cpp:374] Executor received status update acknowledgement 3940701b-a1f4-4105-ab2d-c9bad07158dd for task 742b05c9-6327-4ffc-9dcb-4640b99f36e5 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 I0317 03:09:40.950795 25375 master.cpp:8345] Updating the state of task 742b05c9-6327-4ffc-9dcb-4640b99f36e5 of framework a6be3d1b-029b-4afe-9653-e8b76ef4e7f7-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING) @ 0xd5b81f os::strerror() @ 0x2ab0133dc5ad _ZZN7process2io8internal4readEiPvmENKUlvE_clEv @ 0x2ab0133df17c process::io::internal::read() @ 0x2ab0133df4ab process::io::read() @ 0x2ab01341666c process::network::internal::PollSocketImpl::recv() @ 0x2ab013487a58 process::network::internal::SocketImpl::recv() @ 0x2ab0133b84a0 process::http::internal::ConnectionProcess::read() @ 0x2ab0133c8938 process::http::internal::ConnectionProcess::_read() @ 0x2ab013434e51 process::ProcessManager::resume() @ 0x2ab01343e037 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv @ 0x2ab014ed2a60 (unknown) @ 0x2ab014c0b184 start_thread @ 0x2ab01573b37d (unknown) make[3]: *** [CMakeFiles/check] Segmentation fault make[3]: Leaving directory `/mesos/build' make[2]: *** [CMakeFiles/check.dir/all] Error 2 make[2]: Leaving directory `/mesos/build' make[1]: *** [CMakeFiles/check.dir/rule] Error 2 make[1]: Leaving directory `/mesos/build' make: *** [check] Error 2 + docker rmi mesos-1489717738-4372 Untagged: mesos-1489717738-4372:latest Deleted: sha256:cbebbd481e3c2eccbe1fa4b5352d8cbff69a5a074570c371729f01917fc87e8c Deleted: sha256:53f549cf7a46d90f89466a8af15cd2cdf3ee2706d552ec0af5856ed171dcac0d Deleted: sha256:06fd716f32db1ee26562499496e93440ecc6facce76037d86dce87d49180a2b0 Deleted: sha256:3a740f9df952af50b1cda31b761d7d64f3a491ed8234c923452790c3ea1590e9 Deleted: sha256:27b8a66f2d5c6d2ee176ba2eeec0a43e5285c2c820d4bde39e580cef1235e010 Deleted: sha256:e688ef6e07e0aef7af0e773c1476079f9bb8669611ecb8dd63b9d63e91acada2 Deleted: sha256:cf5b06bbabef9ca07c26660390984994f22e8a54d6557a76890cdd3ad0b5b9eb Deleted: sha256:74db5d55d6f067014784ff8201dabc985462d188ad8c79c993c2f24094aa181c Deleted: sha256:29a4ac04ed74c8847952694dbe07962bcd74feda0d87542c512adb1ba65f177b Deleted: sha256:74c28bc7fae98fde7c99d077995e1ced936e9119587f30de965274a23892390c Deleted: sha256:97f632c05ec55cfdde54ad4b6bb15e15ec7af66374dc294573c8920cc44d9943 Deleted: sha256:757a243fbb3edfd260e32c0c30583278fc11688bdb7f6dd8d72937400f4ec276 Deleted: sha256:58dc9b7e496090e96ee33447cd0c5184c2f128fbdbbeedf283c43b0c8dfdb701 Deleted: sha256:ff7cb01de9c9718d866d9d05c14cbd91bede5613d2eb69af95002279a8b1cc79 Deleted: sha256:3f3aec486203fdcf2eb8e587856ec658656bf2e23f356457550a540bcbfcab81 Deleted: sha256:79c55ac42094cd92fd81b1f217fb9d80a44aa3e7e6d0f2186a3dccb3ad18bf74 Deleted: sha256:8a96cec9c3a39a2cce6f19586d7a92d67597ac54115cfc4defcb5732fd56a15a Deleted: sha256:7e053391e7dc808b69c414cdf0db2fa079073c2f7b6fac4bbb114b141419ba66 Deleted: sha256:588e44742d33463912f4d853629ee3724215e2ddeb420299ea6a9650195449c3 Deleted: sha256:537ea5e734171bff2f539b17c9e6f89c696d49640ae0f45b5ab0a3d43b2a4c94 Deleted: sha256:7fbd9615087eee15bd847813db3fee2d51316a0c02a545b3c9e41e7a1ff618bf Deleted: sha256:97482ec6c946be32b799114de5a89a0a0ce58c10929dc7eba2d715c2ba4dd761 Deleted: sha256:4ff3e31e287c1f8c468462e0dcd5b969cc30e70888968565e1a141b32008694f Deleted: sha256:a41fc15214b8bab2e3f4d228bd218856ad10ec9e85974d09be15b5ee9b1b6312 Build step 'Execute shell' marked build as failure
