See <https://builds.apache.org/job/Mesos-Reviewbot/17225/display/redirect>
------------------------------------------ [...truncated 10.58 MB...] I0226 06:01:06.191231 30437 slave.cpp:4325] Sending message for framework 9180dd82-1127-4656-beff-2d32dfc601b5-0000 to [email protected]:58326 I0226 06:01:06.191494 30438 sched.cpp:1177] Scheduler::frameworkMessage took 79155ns I0226 06:01:06.191915 30408 sched.cpp:2021] Asked to stop the driver I0226 06:01:06.192009 30439 sched.cpp:1203] Stopping framework 9180dd82-1127-4656-beff-2d32dfc601b5-0000 I0226 06:01:06.192276 30427 master.cpp:7750] Processing TEARDOWN call for framework 9180dd82-1127-4656-beff-2d32dfc601b5-0000 (default) at [email protected]:58326 I0226 06:01:06.192376 30427 master.cpp:7762] Removing framework 9180dd82-1127-4656-beff-2d32dfc601b5-0000 (default) at [email protected]:58326 I0226 06:01:06.192445 30427 master.cpp:3134] Deactivating framework 9180dd82-1127-4656-beff-2d32dfc601b5-0000 (default) at [email protected]:58326 I0226 06:01:06.192816 30430 hierarchical.cpp:415] Deactivated framework 9180dd82-1127-4656-beff-2d32dfc601b5-0000 I0226 06:01:06.192917 30435 slave.cpp:2659] Asked to shut down framework 9180dd82-1127-4656-beff-2d32dfc601b5-0000 by [email protected]:58326 I0226 06:01:06.192939 30427 master.cpp:8347] Updating the state of task 1 of framework 9180dd82-1127-4656-beff-2d32dfc601b5-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED) I0226 06:01:06.192970 30435 slave.cpp:2684] Shutting down framework 9180dd82-1127-4656-beff-2d32dfc601b5-0000 I0226 06:01:06.193032 30435 slave.cpp:5084] Shutting down executor 'default' of framework 9180dd82-1127-4656-beff-2d32dfc601b5-0000 at executor(74)@172.17.0.2:58326 I0226 06:01:06.193233 30430 exec.cpp:415] Executor asked to shutdown I0226 06:01:06.193316 30430 exec.cpp:430] Executor::shutdown took 49606ns I0226 06:01:06.193590 30440 slave.cpp:4389] Got exited event for executor(74)@172.17.0.2:58326 I0226 06:01:06.194232 30427 master.cpp:8441] Removing task 1 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework 9180dd82-1127-4656-beff-2d32dfc601b5-0000 on agent 9180dd82-1127-4656-beff-2d32dfc601b5-S0 at slave(179)@172.17.0.2:58326 (f7098f49577d) I0226 06:01:06.194744 30427 master.cpp:8470] Removing executor 'default' with resources {} of framework 9180dd82-1127-4656-beff-2d32dfc601b5-0000 on agent 9180dd82-1127-4656-beff-2d32dfc601b5-S0 at slave(179)@172.17.0.2:58326 (f7098f49577d) I0226 06:01:06.194849 30430 slave.cpp:4770] Executor 'default' of framework 9180dd82-1127-4656-beff-2d32dfc601b5-0000 exited with status 0 I0226 06:01:06.194929 30429 hierarchical.cpp:1064] Recovered cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: {}) on agent 9180dd82-1127-4656-beff-2d32dfc601b5-S0 from framework 9180dd82-1127-4656-beff-2d32dfc601b5-0000 I0226 06:01:06.194967 30430 slave.cpp:4870] Cleaning up executor 'default' of framework 9180dd82-1127-4656-beff-2d32dfc601b5-0000 at executor(74)@172.17.0.2:58326 I0226 06:01:06.195277 30432 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_qek52b/slaves/9180dd82-1127-4656-beff-2d32dfc601b5-S0/frameworks/9180dd82-1127-4656-beff-2d32dfc601b5-0000/executors/default/runs/b5447350-d82d-46e2-ab2b-260ea44b471b' for gc 6.99999774088889days in the future I0226 06:01:06.195511 30430 slave.cpp:4958] Cleaning up framework 9180dd82-1127-4656-beff-2d32dfc601b5-0000 I0226 06:01:06.195662 30429 status_update_manager.cpp:285] Closing status update streams for framework 9180dd82-1127-4656-beff-2d32dfc601b5-0000 W0226 06:01:06.195675 30427 master.cpp:6323] Ignoring unknown exited executor 'default' of framework 9180dd82-1127-4656-beff-2d32dfc601b5-0000 on agent 9180dd82-1127-4656-beff-2d32dfc601b5-S0 at slave(179)@172.17.0.2:58326 (f7098f49577d) I0226 06:01:06.195724 30429 status_update_manager.cpp:531] Cleaning up status update stream for task 1 of framework 9180dd82-1127-4656-beff-2d32dfc601b5-0000 I0226 06:01:06.195739 30442 hierarchical.cpp:362] Removed framework 9180dd82-1127-4656-beff-2d32dfc601b5-0000 I0226 06:01:06.195812 30430 slave.cpp:803] Agent terminating I0226 06:01:06.195807 30439 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_qek52b/slaves/9180dd82-1127-4656-beff-2d32dfc601b5-S0/frameworks/9180dd82-1127-4656-beff-2d32dfc601b5-0000/executors/default' for gc 6.99999773819556days in the future I0226 06:01:06.196018 30439 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_qek52b/slaves/9180dd82-1127-4656-beff-2d32dfc601b5-S0/frameworks/9180dd82-1127-4656-beff-2d32dfc601b5-0000' for gc 6.99999773503407days in the future I0226 06:01:06.196075 30427 master.cpp:1264] Agent 9180dd82-1127-4656-beff-2d32dfc601b5-S0 at slave(179)@172.17.0.2:58326 (f7098f49577d) disconnected I0226 06:01:06.196148 30427 master.cpp:3171] Disconnecting agent 9180dd82-1127-4656-beff-2d32dfc601b5-S0 at slave(179)@172.17.0.2:58326 (f7098f49577d) I0226 06:01:06.196305 30427 master.cpp:3190] Deactivating agent 9180dd82-1127-4656-beff-2d32dfc601b5-S0 at slave(179)@172.17.0.2:58326 (f7098f49577d) I0226 06:01:06.196486 30433 hierarchical.cpp:618] Agent 9180dd82-1127-4656-beff-2d32dfc601b5-S0 deactivated I0226 06:01:06.199172 30435 master.cpp:1103] Master terminating I0226 06:01:06.200079 30438 hierarchical.cpp:549] Removed agent 9180dd82-1127-4656-beff-2d32dfc601b5-S0 [ OK ] MasterTest.FrameworkMessage (75 ms) [ RUN ] MasterTest.MultipleExecutors I0226 06:01:06.207932 30408 cluster.cpp:160] Creating default 'local' authorizer I0226 06:01:06.210952 30428 master.cpp:383] Master ae230d46-d0a3-4828-a2f0-13d8c335cf98 (f7098f49577d) started on 172.17.0.2:58326 I0226 06:01:06.210988 30428 master.cpp:385] Flags at startup: --acls="" --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate_agents="true" --authenticate_frameworks="true" --authenticate_http_frameworks="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/krLx8u/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-1.3.0/_inst/share/mesos/webui" --work_dir="/tmp/krLx8u/master" --zk_session_timeout="10secs" I0226 06:01:06.211572 30428 master.cpp:435] Master only allowing authenticated frameworks to register I0226 06:01:06.211596 30428 master.cpp:449] Master only allowing authenticated agents to register I0226 06:01:06.211614 30428 master.cpp:462] Master only allowing authenticated HTTP frameworks to register I0226 06:01:06.211634 30428 credentials.hpp:37] Loading credentials for authentication from '/tmp/krLx8u/credentials' I0226 06:01:06.211963 30428 master.cpp:507] Using default 'crammd5' authenticator I0226 06:01:06.212126 30428 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I0226 06:01:06.212290 30428 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I0226 06:01:06.212471 30428 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I0226 06:01:06.212716 30428 master.cpp:587] Authorization enabled I0226 06:01:06.212966 30439 hierarchical.cpp:161] Initialized hierarchical allocator process I0226 06:01:06.212985 30440 whitelist_watcher.cpp:77] No whitelist given I0226 06:01:06.215689 30432 master.cpp:2122] Elected as the leading master! I0226 06:01:06.215733 30432 master.cpp:1646] Recovering from registrar I0226 06:01:06.215906 30441 registrar.cpp:329] Recovering registrar I0226 06:01:06.216604 30427 registrar.cpp:362] Successfully fetched the registry (0B) in 627968ns I0226 06:01:06.216720 30427 registrar.cpp:461] Applied 1 operations in 17812ns; attempting to update the registry I0226 06:01:06.217831 30428 registrar.cpp:506] Successfully updated the registry in 964864ns I0226 06:01:06.217991 30428 registrar.cpp:392] Successfully recovered registrar I0226 06:01:06.218569 30435 master.cpp:1760] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register I0226 06:01:06.218592 30441 hierarchical.cpp:188] Skipping recovery of hierarchical allocator: nothing to recover I0226 06:01:06.223644 30408 cluster.cpp:446] Creating default 'local' authorizer I0226 06:01:06.225515 30429 slave.cpp:211] Mesos agent started on (180)@172.17.0.2:58326 I0226 06:01:06.225545 30429 slave.cpp:212] 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/MasterTest_MultipleExecutors_U5zbXE/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/MasterTest_MultipleExecutors_U5zbXE/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/MasterTest_MultipleExecutors_U5zbXE/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.3.0/_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/MasterTest_MultipleExecutors_U5zbXE" --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/MasterTest_MultipleExecutors_GhfR24" I0226 06:01:06.226269 30429 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterTest_MultipleExecutors_U5zbXE/credential' I0226 06:01:06.226480 30429 slave.cpp:354] Agent using credential for: test-principal I0226 06:01:06.226511 30429 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterTest_MultipleExecutors_U5zbXE/http_credentials' I0226 06:01:06.226878 30429 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0226 06:01:06.227012 30408 sched.cpp:232] Version: 1.3.0 I0226 06:01:06.227094 30429 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I0226 06:01:06.227787 30427 sched.cpp:336] New master detected at [email protected]:58326 I0226 06:01:06.227895 30427 sched.cpp:407] Authenticating with master [email protected]:58326 I0226 06:01:06.227923 30427 sched.cpp:414] Using default CRAM-MD5 authenticatee I0226 06:01:06.228193 30430 authenticatee.cpp:121] Creating new client SASL connection I0226 06:01:06.228500 30440 master.cpp:7208] Authenticating [email protected]:58326 I0226 06:01:06.228736 30434 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(412)@172.17.0.2:58326 I0226 06:01:06.229027 30437 authenticator.cpp:98] Creating new server SASL connection I0226 06:01:06.229154 30429 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0226 06:01:06.229306 30428 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0226 06:01:06.229315 30429 slave.cpp:549] Agent attributes: [ ] I0226 06:01:06.229351 30429 slave.cpp:554] Agent hostname: f7098f49577d I0226 06:01:06.229362 30428 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0226 06:01:06.229537 30440 authenticator.cpp:204] Received SASL authentication start I0226 06:01:06.229548 30433 status_update_manager.cpp:177] Pausing sending status updates I0226 06:01:06.229632 30440 authenticator.cpp:326] Authentication requires more steps I0226 06:01:06.229779 30440 authenticatee.cpp:259] Received SASL authentication step I0226 06:01:06.229948 30439 authenticator.cpp:232] Received SASL authentication step I0226 06:01:06.229997 30439 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f7098f49577d' server FQDN: 'f7098f49577d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0226 06:01:06.230027 30439 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0226 06:01:06.230079 30439 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0226 06:01:06.230134 30439 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f7098f49577d' server FQDN: 'f7098f49577d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0226 06:01:06.230167 30439 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0226 06:01:06.230193 30439 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0226 06:01:06.230226 30439 authenticator.cpp:318] Authentication success I0226 06:01:06.230356 30440 authenticatee.cpp:299] Authentication success I0226 06:01:06.230443 30442 master.cpp:7238] Successfully authenticated principal 'test-principal' at [email protected]:58326 I0226 06:01:06.230475 30441 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(412)@172.17.0.2:58326 I0226 06:01:06.230974 30435 sched.cpp:513] Successfully authenticated with master [email protected]:58326 I0226 06:01:06.231001 30435 sched.cpp:836] Sending SUBSCRIBE call to [email protected]:58326 I0226 06:01:06.231200 30435 sched.cpp:869] Will retry registration in 1.590717518secs if necessary I0226 06:01:06.231407 30437 master.cpp:2789] Received SUBSCRIBE call for framework 'default' at [email protected]:58326 I0226 06:01:06.231454 30435 state.cpp:62] Recovering state from '/tmp/MasterTest_MultipleExecutors_GhfR24/meta' I0226 06:01:06.231515 30437 master.cpp:2158] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }' I0226 06:01:06.231815 30434 status_update_manager.cpp:203] Recovering status update manager I0226 06:01:06.232333 30442 master.cpp:2866] Subscribing framework default with checkpointing disabled and capabilities [ ] I0226 06:01:06.232436 30437 slave.cpp:5559] Finished recovery I0226 06:01:06.233009 30437 slave.cpp:5733] Querying resource estimator for oversubscribable resources I0226 06:01:06.233036 30427 sched.cpp:759] Framework registered with ae230d46-d0a3-4828-a2f0-13d8c335cf98-0000 I0226 06:01:06.233110 30438 hierarchical.cpp:286] Added framework ae230d46-d0a3-4828-a2f0-13d8c335cf98-0000 I0226 06:01:06.233191 30427 sched.cpp:773] Scheduler::registered took 113650ns I0226 06:01:06.233383 30432 slave.cpp:5747] Received oversubscribable resources {} from the resource estimator I0226 06:01:06.233366 30438 hierarchical.cpp:1810] No allocations performed I0226 06:01:06.233458 30438 hierarchical.cpp:1900] No inverse offers to send out! I0226 06:01:06.233541 30438 hierarchical.cpp:1394] Performed allocation for 0 agents in 227361ns I0226 06:01:06.233572 30432 slave.cpp:931] New master detected at [email protected]:58326 I0226 06:01:06.233611 30436 status_update_manager.cpp:177] Pausing sending status updates I0226 06:01:06.233800 30432 slave.cpp:966] Detecting new master I0226 06:01:06.236099 30432 slave.cpp:993] Authenticating with master [email protected]:58326 I0226 06:01:06.236176 30432 slave.cpp:1004] Using default CRAM-MD5 authenticatee I0226 06:01:06.236434 30437 authenticatee.cpp:121] Creating new client SASL connection I0226 06:01:06.236685 30427 master.cpp:7208] Authenticating slave(180)@172.17.0.2:58326 I0226 06:01:06.236829 30431 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(413)@172.17.0.2:58326 I0226 06:01:06.237079 30437 authenticator.cpp:98] Creating new server SASL connection I0226 06:01:06.237315 30433 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0226 06:01:06.237390 30433 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0226 06:01:06.237545 30428 authenticator.cpp:204] Received SASL authentication start I0226 06:01:06.237613 30428 authenticator.cpp:326] Authentication requires more steps I0226 06:01:06.237756 30428 authenticatee.cpp:259] Received SASL authentication step I0226 06:01:06.237968 30433 authenticator.cpp:232] Received SASL authentication step I0226 06:01:06.238004 30433 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f7098f49577d' server FQDN: 'f7098f49577d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0226 06:01:06.238021 30433 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0226 06:01:06.238055 30433 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0226 06:01:06.238102 30433 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f7098f49577d' server FQDN: 'f7098f49577d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0226 06:01:06.238135 30433 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0226 06:01:06.238162 30433 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0226 06:01:06.238196 30433 authenticator.cpp:318] Authentication success I0226 06:01:06.238358 30430 authenticatee.cpp:299] Authentication success I0226 06:01:06.238385 30434 master.cpp:7238] Successfully authenticated principal 'test-principal' at slave(180)@172.17.0.2:58326 I0226 06:01:06.238435 30429 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(413)@172.17.0.2:58326 I0226 06:01:06.239066 30442 slave.cpp:1088] Successfully authenticated with master [email protected]:58326 I0226 06:01:06.239262 30442 slave.cpp:1516] Will retry registration in 783157ns if necessary I0226 06:01:06.239521 30437 master.cpp:5423] Registering agent at slave(180)@172.17.0.2:58326 (f7098f49577d) with id ae230d46-d0a3-4828-a2f0-13d8c335cf98-S0 I0226 06:01:06.240033 30434 registrar.cpp:461] Applied 1 operations in 59711ns; attempting to update the registry I0226 06:01:06.240785 30440 slave.cpp:1516] Will retry registration in 4.677887ms if necessary I0226 06:01:06.240947 30429 master.cpp:5411] Ignoring register agent message from slave(180)@172.17.0.2:58326 (f7098f49577d) as admission is already in progress I0226 06:01:06.241993 30434 registrar.cpp:506] Successfully updated the registry in 1.879808ms I0226 06:01:06.242835 30441 slave.cpp:4347] Received ping from slave-observer(178)@172.17.0.2:58326 I0226 06:01:06.243113 30432 slave.cpp:1134] Registered with master [email protected]:58326; given agent ID ae230d46-d0a3-4828-a2f0-13d8c335cf98-S0 I0226 06:01:06.243158 30432 fetcher.cpp:94] Clearing fetcher cache I0226 06:01:06.243041 30435 master.cpp:5497] Registered agent ae230d46-d0a3-4828-a2f0-13d8c335cf98-S0 at slave(180)@172.17.0.2:58326 (f7098f49577d) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0226 06:01:06.243383 30441 status_update_manager.cpp:184] Resuming sending status updates I0226 06:01:06.243680 30432 slave.cpp:1162] Checkpointing SlaveInfo to '/tmp/MasterTest_MultipleExecutors_GhfR24/meta/slaves/ae230d46-d0a3-4828-a2f0-13d8c335cf98-S0/slave.info' I0226 06:01:06.243731 30433 hierarchical.cpp:516] Added agent ae230d46-d0a3-4828-a2f0-13d8c335cf98-S0 (f7098f49577d) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {}) I0226 06:01:06.244186 30432 slave.cpp:1200] Forwarding total oversubscribed resources {} I0226 06:01:06.244458 30441 master.cpp:6054] Received update of agent ae230d46-d0a3-4828-a2f0-13d8c335cf98-S0 at slave(180)@172.17.0.2:58326 (f7098f49577d) with total oversubscribed resources {} I0226 06:01:06.245352 30433 hierarchical.cpp:1900] No inverse offers to send out! I0226 06:01:06.245425 30433 hierarchical.cpp:1394] Performed allocation for 1 agents in 1.512215ms I0226 06:01:06.245625 30433 hierarchical.cpp:589] Agent ae230d46-d0a3-4828-a2f0-13d8c335cf98-S0 (f7098f49577d) updated with oversubscribed resources {} (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000]) I0226 06:01:06.245929 30433 hierarchical.cpp:1810] No allocations performed I0226 06:01:06.245991 30433 hierarchical.cpp:1900] No inverse offers to send out! I0226 06:01:06.246059 30433 hierarchical.cpp:1394] Performed allocation for 1 agents in 238316ns I0226 06:01:06.246219 30428 master.cpp:7037] Sending 1 offers to framework ae230d46-d0a3-4828-a2f0-13d8c335cf98-0000 (default) at [email protected]:58326 I0226 06:01:06.246754 30437 sched.cpp:933] Scheduler::resourceOffers took 136454ns I0226 06:01:06.249346 30429 master.cpp:3825] Processing ACCEPT call for offers: [ ae230d46-d0a3-4828-a2f0-13d8c335cf98-O0 ] on agent ae230d46-d0a3-4828-a2f0-13d8c335cf98-S0 at slave(180)@172.17.0.2:58326 (f7098f49577d) for framework ae230d46-d0a3-4828-a2f0-13d8c335cf98-0000 (default) at [email protected]:58326 I0226 06:01:06.249495 30429 master.cpp:3401] Authorizing framework principal 'test-principal' to launch task 1 I0226 06:01:06.249891 30429 master.cpp:3401] Authorizing framework principal 'test-principal' to launch task 2 W0226 06:01:06.252214 30429 validation.cpp:1104] Executor 'executor-1' for task '1' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases. W0226 06:01:06.252254 30429 validation.cpp:1116] Executor 'executor-1' for task '1' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases. I0226 06:01:06.252699 30429 master.cpp:9098] Adding task 1 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent ae230d46-d0a3-4828-a2f0-13d8c335cf98-S0 at slave(180)@172.17.0.2:58326 (f7098f49577d) I0226 06:01:06.252951 30429 master.cpp:4475] Launching task 1 of framework ae230d46-d0a3-4828-a2f0-13d8c335cf98-0000 (default) at [email protected]:58326 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent ae230d46-d0a3-4828-a2f0-13d8c335cf98-S0 at slave(180)@172.17.0.2:58326 (f7098f49577d) I0226 06:01:06.253420 30441 slave.cpp:1626] Got assigned task '1' for framework ae230d46-d0a3-4828-a2f0-13d8c335cf98-0000 I0226 06:01:06.254266 30441 slave.cpp:1786] Launching task '1' for framework ae230d46-d0a3-4828-a2f0-13d8c335cf98-0000 W0226 06:01:06.254459 30429 validation.cpp:1104] Executor 'executor-2' for task '2' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases. W0226 06:01:06.254498 30429 validation.cpp:1116] Executor 'executor-2' for task '2' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases. I0226 06:01:06.254968 30429 master.cpp:9098] Adding task 2 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent ae230d46-d0a3-4828-a2f0-13d8c335cf98-S0 at slave(180)@172.17.0.2:58326 (f7098f49577d) I0226 06:01:06.255061 30441 paths.cpp:547] Trying to chown '/tmp/MasterTest_MultipleExecutors_GhfR24/slaves/ae230d46-d0a3-4828-a2f0-13d8c335cf98-S0/frameworks/ae230d46-d0a3-4828-a2f0-13d8c335cf98-0000/executors/executor-1/runs/7dafb550-8f70-4059-94bf-65bddaa356d8' to user 'mesos' I0226 06:01:06.255210 30429 master.cpp:4475] Launching task 2 of framework ae230d46-d0a3-4828-a2f0-13d8c335cf98-0000 (default) at [email protected]:58326 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent ae230d46-d0a3-4828-a2f0-13d8c335cf98-S0 at slave(180)@172.17.0.2:58326 (f7098f49577d) I0226 06:01:06.255364 30441 slave.cpp:6481] Launching executor 'executor-1' of framework ae230d46-d0a3-4828-a2f0-13d8c335cf98-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_GhfR24/slaves/ae230d46-d0a3-4828-a2f0-13d8c335cf98-S0/frameworks/ae230d46-d0a3-4828-a2f0-13d8c335cf98-0000/executors/executor-1/runs/7dafb550-8f70-4059-94bf-65bddaa356d8' I0226 06:01:06.256160 30441 slave.cpp:2119] Queued task '1' for executor 'executor-1' of framework ae230d46-d0a3-4828-a2f0-13d8c335cf98-0000 I0226 06:01:06.256450 30441 slave.cpp:1626] Got assigned task '2' for framework ae230d46-d0a3-4828-a2f0-13d8c335cf98-0000 I0226 06:01:06.257012 30441 slave.cpp:884] Successfully attached file '/tmp/MasterTest_MultipleExecutors_GhfR24/slaves/ae230d46-d0a3-4828-a2f0-13d8c335cf98-S0/frameworks/ae230d46-d0a3-4828-a2f0-13d8c335cf98-0000/executors/executor-1/runs/7dafb550-8f70-4059-94bf-65bddaa356d8' I0226 06:01:06.257123 30441 slave.cpp:1786] Launching task '2' for framework ae230d46-d0a3-4828-a2f0-13d8c335cf98-0000 I0226 06:01:06.257701 30441 paths.cpp:547] Trying to chown '/tmp/MasterTest_MultipleExecutors_GhfR24/slaves/ae230d46-d0a3-4828-a2f0-13d8c335cf98-S0/frameworks/ae230d46-d0a3-4828-a2f0-13d8c335cf98-0000/executors/executor-2/runs/f5b87243-75b9-4496-9a2f-721af77023d0' to user 'mesos' I0226 06:01:06.257943 30441 slave.cpp:6481] Launching executor 'executor-2' of framework ae230d46-d0a3-4828-a2f0-13d8c335cf98-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_GhfR24/slaves/ae230d46-d0a3-4828-a2f0-13d8c335cf98-S0/frameworks/ae230d46-d0a3-4828-a2f0-13d8c335cf98-0000/executors/executor-2/runs/f5b87243-75b9-4496-9a2f-721af77023d0' *** Aborted at 1488088866 (unix time) try "date -d @1488088866" if you are using GNU date *** PC: @ 0x2ae51ede682d (unknown) I0226 06:01:06.258491 30439 exec.cpp:162] Version: 1.3.0 *** SIGSEGV (@0xd0) received by PID 30408 (TID 0x2ae528c26700) from PID 208; stack trace: *** I0226 06:01:06.258707 30431 exec.cpp:212] Executor started at: executor(75)@172.17.0.2:58326 with pid 30408 I0226 06:01:06.258922 30442 hierarchical.cpp:807] Updated allocation of framework ae230d46-d0a3-4828-a2f0-13d8c335cf98-0000 on agent ae230d46-d0a3-4828-a2f0-13d8c335cf98-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] @ 0x2ae5747d92d7 (unknown) I0226 06:01:06.259505 30442 hierarchical.cpp:1064] Recovered ports(*)(allocated: *):[31000-32000]; disk(*)(allocated: *):1024 (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*)(allocated: *):2; mem(*)(allocated: *):1024) on agent ae230d46-d0a3-4828-a2f0-13d8c335cf98-S0 from framework ae230d46-d0a3-4828-a2f0-13d8c335cf98-0000 I0226 06:01:06.259572 30442 hierarchical.cpp:1101] Framework ae230d46-d0a3-4828-a2f0-13d8c335cf98-0000 filtered agent ae230d46-d0a3-4828-a2f0-13d8c335cf98-S0 for 5secs @ 0x2ae5747dd5b9 (unknown) @ 0x2ae51eb9d330 (unknown) @ 0x2ae51ede682d (unknown) @ 0x2ae514a75eb0 os::getenv() @ 0x2ae51bb1aa53 mesos::internal::slave::executorEnvironment() @ 0x2ae51bb15226 mesos::internal::slave::Framework::launchExecutor() @ 0x2ae51baef05b mesos::internal::slave::Slave::_run() @ 0x2ae51bb48d0d _ZZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS_6FutureIbEERKNS1_13FrameworkInfoERKNS1_12ExecutorInfoERK6OptionINS1_8TaskInfoEERKSF_INS1_13TaskGroupInfoEES6_S9_SC_SH_SL_EEvRKNS_3PIDIT_EEMSP_FvT0_T1_T2_T3_T4_ET5_T6_T7_T8_T9_ENKUlPNS_11ProcessBaseEE_clES16_ @ 0x2ae51bb7da4f _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8dispatchIN5mesos8internal5slave5SlaveERKNS0_6FutureIbEERKNS5_13FrameworkInfoERKNS5_12ExecutorInfoERK6OptionINS5_8TaskInfoEERKSJ_INS5_13TaskGroupInfoEESA_SD_SG_SL_SP_EEvRKNS0_3PIDIT_EEMST_FvT0_T1_T2_T3_T4_ET5_T6_T7_T8_T9_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_ @ 0x2ae51c8cb137 std::function<>::operator()() @ 0x2ae51c8b1007 process::ProcessBase::visit() @ 0x2ae51c8bb886 process::DispatchEvent::visit() @ 0x2ae514a4a1f6 process::ProcessBase::serve() @ 0x2ae51c8ad2f4 process::ProcessManager::resume() @ 0x2ae51c8a9b38 _ZZN7process14ProcessManager12init_threadsEvENKUt_clEv @ 0x2ae51c8bafc0 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE @ 0x2ae51c8baf17 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEclEv @ 0x2ae51c8baeb0 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv @ 0x2ae51e41ea60 (unknown) @ 0x2ae51eb95184 start_thread @ 0x2ae51eea537d (unknown) make[4]: *** [check-local] Segmentation fault make[4]: Leaving directory `/mesos/mesos-1.3.0/_build/src' make[3]: *** [check-am] Error 2 make[3]: Leaving directory `/mesos/mesos-1.3.0/_build/src' make[2]: *** [check] Error 2 make[2]: Leaving directory `/mesos/mesos-1.3.0/_build/src' make[1]: *** [check-recursive] Error 1 make[1]: Leaving directory `/mesos/mesos-1.3.0/_build' make: *** [distcheck] Error 1 + docker rmi mesos-1488086472-21628 Untagged: mesos-1488086472-21628:latest Deleted: sha256:549e054439d9839c8b31e0c8101d6dccb20983a65317ec7497a82b924ede4224 Deleted: sha256:1adc87f988d0cd0721b4ffce6cda8489cff96e1b26e69f360f4f456b4845eee4 Deleted: sha256:ea56adbd5b6e5d0195eeb0ff3493f03b4366efe0308c88fad42a274b577342f2 Deleted: sha256:5950a1446ad20d1124d1d417f204c14e53677226f00cf648a034f50f1396c815 Deleted: sha256:6c4288f6969cd81d34b562f8ce9918d9bbdcd224ff9e177b6a261924d3af372b Deleted: sha256:8af0947ffe4a135ac2be1f8a8c536a1433a12c9b301e8055a07b9aedd0bc5edf Deleted: sha256:6e62d36048bd5f4047346dcd3647119299707450657aa32f3731c0b0f3623db8 Deleted: sha256:28a6aed5a78e74d875a5c18c0fbb16d3710c348ac90fb6745045200d930615ca Deleted: sha256:175bc809ddfa3f9175879e3adb044a6d8e09396aad5cd29f6e40619884889ae2 Deleted: sha256:dc6bb609722d2434a699637507bdd4288fbf007b146fbc21db87eec14a683bf0 Deleted: sha256:1d81929af0c27433699f56b805a9a5372e1e026d878af4f569aaca6ae3b06713 Deleted: sha256:6ded0b236c96e453016065a703f95647da6576ba5bfd3f6da31fd8bc82f0efd7 Deleted: sha256:e9b53b5aea124c797050e51ec5cda206c9b789770b60cdd05149a3d1905a2636 Deleted: sha256:0b6a5076b9aa316558c06c35f5c1df7a735c47c769a805c70a8a0dbd50a02180 Deleted: sha256:bd8e044b23a1b3ca095c3f23256827364f826847bb044b6fa32539c661b5367f Deleted: sha256:7440d2102651e21c5bc02830f12ce1b2ef858bcea117e53c3b6e26f97891ee43 Deleted: sha256:6aa3facf6e7a6f9bb96db3acb2dad9bee7e3ca56fb8769b60e65a8e8cfe0f740 Deleted: sha256:2c79a895b6598c80cc2c5bb2bd6e95775ead41646f43ea2d02986fa277c7c9be Deleted: sha256:32b8646f5e11388bfea01754f7cda6207a9021258ce951fb3474166d8b224ec6 Deleted: sha256:89e874df328222fefc3f3d7f0381054f92bfa35ed98d432067b17e07a8eee4e1 Deleted: sha256:a7dcf276fc90bde314b40ca0a1a4c83d990b9a9541e9f00a5d3d9c494b8a4877 Deleted: sha256:442c33b13d8846d4df28f74ab670d2d42e7becd21d86e5af9477484a884d7da1 Deleted: sha256:ce8a6ce0da6b57b8b91e6a46a676a555c36d3e1db0dd16a62e1a754f07928be4 Deleted: sha256:7e602fe58d65c29dbe0c4ca4e86731e131506722cf4ae54e9d45a8cf0bc16677 Build step 'Execute shell' marked build as failure
