See <https://builds.apache.org/job/Mesos-Reviewbot/17527/display/redirect>
------------------------------------------ [...truncated 10.54 MB...] I0323 01:40:50.915997 30541 exec.cpp:405] Executor::frameworkMessage took 47977ns I0323 01:40:50.916039 30551 slave.cpp:3180] Status update manager successfully handled status update acknowledgement (UUID: 6032790e-e78f-4bc3-bfab-b0dfee01415d) for task 1 of framework a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-0000 I0323 01:40:50.916659 30551 slave.cpp:4399] Sending message for framework a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-0000 to [email protected]:38745 I0323 01:40:50.916986 30545 sched.cpp:1177] Scheduler::frameworkMessage took 75845ns I0323 01:40:50.917520 30521 sched.cpp:2021] Asked to stop the driver I0323 01:40:50.917626 30552 sched.cpp:1203] Stopping framework a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-0000 I0323 01:40:50.917892 30551 master.cpp:7765] Processing TEARDOWN call for framework a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-0000 (default) at [email protected]:38745 I0323 01:40:50.917930 30551 master.cpp:7777] Removing framework a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-0000 (default) at [email protected]:38745 I0323 01:40:50.917960 30551 master.cpp:3148] Deactivating framework a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-0000 (default) at [email protected]:38745 I0323 01:40:50.918202 30540 hierarchical.cpp:376] Deactivated framework a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-0000 I0323 01:40:50.918290 30551 master.cpp:8345] Updating the state of task 1 of framework a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED) I0323 01:40:50.918295 30547 slave.cpp:2738] Asked to shut down framework a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-0000 by [email protected]:38745 I0323 01:40:50.918470 30547 slave.cpp:2763] Shutting down framework a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-0000 I0323 01:40:50.918527 30547 slave.cpp:5150] Shutting down executor 'default' of framework a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-0000 at executor(74)@172.17.0.2:38745 I0323 01:40:50.918633 30555 exec.cpp:415] Executor asked to shutdown I0323 01:40:50.918759 30555 exec.cpp:430] Executor::shutdown took 101340ns I0323 01:40:50.918965 30550 slave.cpp:4463] Got exited event for executor(74)@172.17.0.2:38745 I0323 01:40:50.919453 30551 master.cpp:8439] Removing task 1 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-0000 on agent a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-S0 at slave(179)@172.17.0.2:38745 (8ae39d239eab) I0323 01:40:50.919916 30551 master.cpp:8468] Removing executor 'default' with resources {} of framework a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-0000 on agent a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-S0 at slave(179)@172.17.0.2:38745 (8ae39d239eab) I0323 01:40:50.919986 30547 hierarchical.cpp:1116] 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 a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-S0 from framework a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-0000 I0323 01:40:50.920615 30544 slave.cpp:4836] Executor 'default' of framework a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-0000 exited with status 0 I0323 01:40:50.920944 30550 hierarchical.cpp:323] Removed framework a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-0000 I0323 01:40:50.920946 30544 slave.cpp:4936] Cleaning up executor 'default' of framework a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-0000 at executor(74)@172.17.0.2:38745 W0323 01:40:50.921097 30547 master.cpp:6367] Ignoring unknown exited executor 'default' of framework a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-0000 on agent a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-S0 at slave(179)@172.17.0.2:38745 (8ae39d239eab) I0323 01:40:50.921432 30552 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_A6mDFB/slaves/a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-S0/frameworks/a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-0000/executors/default/runs/3285015d-75d2-413d-813d-eb9d528e50c5' for gc 6.99998933806815days in the future I0323 01:40:50.921727 30544 slave.cpp:5024] Cleaning up framework a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-0000 I0323 01:40:50.921727 30543 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_A6mDFB/slaves/a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-S0/frameworks/a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-0000/executors/default' for gc 6.99998933361185days in the future I0323 01:40:50.921926 30553 status_update_manager.cpp:285] Closing status update streams for framework a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-0000 I0323 01:40:50.921980 30553 status_update_manager.cpp:531] Cleaning up status update stream for task 1 of framework a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-0000 I0323 01:40:50.922019 30547 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_A6mDFB/slaves/a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-S0/frameworks/a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-0000' for gc 6.99998932930667days in the future I0323 01:40:50.922053 30544 slave.cpp:693] Agent terminating I0323 01:40:50.922323 30549 master.cpp:1317] Agent a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-S0 at slave(179)@172.17.0.2:38745 (8ae39d239eab) disconnected I0323 01:40:50.922363 30549 master.cpp:3185] Disconnecting agent a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-S0 at slave(179)@172.17.0.2:38745 (8ae39d239eab) I0323 01:40:50.922442 30549 master.cpp:3204] Deactivating agent a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-S0 at slave(179)@172.17.0.2:38745 (8ae39d239eab) I0323 01:40:50.922621 30545 hierarchical.cpp:655] Agent a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-S0 deactivated I0323 01:40:50.925776 30540 master.cpp:1156] Master terminating I0323 01:40:50.926767 30543 hierarchical.cpp:560] Removed agent a2a532e6-a1e7-4c8b-8d75-ec80edd2cb35-S0 [ OK ] MasterTest.FrameworkMessage (75 ms) [ RUN ] MasterTest.MultipleExecutors I0323 01:40:50.934711 30521 cluster.cpp:160] Creating default 'local' authorizer I0323 01:40:50.937989 30549 master.cpp:437] Master a83b8faa-d37a-4995-aefb-bcca2b5fc393 (8ae39d239eab) started on 172.17.0.2:38745 I0323 01:40:50.938052 30549 master.cpp:439] 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/toL5zF/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/toL5zF/master" --zk_session_timeout="10secs" I0323 01:40:50.938810 30549 master.cpp:489] Master only allowing authenticated frameworks to register I0323 01:40:50.938833 30549 master.cpp:503] Master only allowing authenticated agents to register I0323 01:40:50.938848 30549 master.cpp:516] Master only allowing authenticated HTTP frameworks to register I0323 01:40:50.938864 30549 credentials.hpp:37] Loading credentials for authentication from '/tmp/toL5zF/credentials' I0323 01:40:50.939245 30549 master.cpp:561] Using default 'crammd5' authenticator I0323 01:40:50.939463 30549 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I0323 01:40:50.939921 30549 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I0323 01:40:50.940134 30549 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I0323 01:40:50.940361 30549 master.cpp:641] Authorization enabled I0323 01:40:50.940671 30547 whitelist_watcher.cpp:77] No whitelist given I0323 01:40:50.940678 30550 hierarchical.cpp:159] Initialized hierarchical allocator process I0323 01:40:50.943244 30550 master.cpp:2165] Elected as the leading master! I0323 01:40:50.943289 30550 master.cpp:1704] Recovering from registrar I0323 01:40:50.943562 30543 registrar.cpp:331] Recovering registrar I0323 01:40:50.944420 30555 registrar.cpp:364] Successfully fetched the registry (0B) in 662784ns I0323 01:40:50.944527 30555 registrar.cpp:463] Applied 1 operations in 18587ns; attempting to update the registry I0323 01:40:50.945524 30554 registrar.cpp:508] Successfully updated the registry in 920064ns I0323 01:40:50.945658 30554 registrar.cpp:394] Successfully recovered registrar I0323 01:40:50.946322 30542 hierarchical.cpp:186] Skipping recovery of hierarchical allocator: nothing to recover I0323 01:40:50.946329 30549 master.cpp:1803] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register I0323 01:40:50.951409 30521 cluster.cpp:446] Creating default 'local' authorizer I0323 01:40:50.953232 30551 slave.cpp:210] Mesos agent started on (180)@172.17.0.2:38745 I0323 01:40:50.953253 30551 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/MasterTest_MultipleExecutors_PDmQOc/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_PDmQOc/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_PDmQOc/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_PDmQOc" --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_I3mscr" I0323 01:40:50.953773 30551 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterTest_MultipleExecutors_PDmQOc/credential' I0323 01:40:50.954015 30551 slave.cpp:243] Agent using credential for: test-principal I0323 01:40:50.954179 30551 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterTest_MultipleExecutors_PDmQOc/http_credentials' I0323 01:40:50.954437 30551 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0323 01:40:50.954610 30521 sched.cpp:232] Version: 1.3.0 I0323 01:40:50.954610 30551 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I0323 01:40:50.955262 30554 sched.cpp:336] New master detected at [email protected]:38745 I0323 01:40:50.955363 30554 sched.cpp:407] Authenticating with master [email protected]:38745 I0323 01:40:50.955389 30554 sched.cpp:414] Using default CRAM-MD5 authenticatee I0323 01:40:50.955703 30545 authenticatee.cpp:121] Creating new client SASL connection I0323 01:40:50.956084 30548 master.cpp:7252] Authenticating [email protected]:38745 I0323 01:40:50.956243 30547 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(413)@172.17.0.2:38745 I0323 01:40:50.956387 30551 slave.cpp:430] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0323 01:40:50.956511 30551 slave.cpp:438] Agent attributes: [ ] I0323 01:40:50.956526 30551 slave.cpp:443] Agent hostname: 8ae39d239eab I0323 01:40:50.956540 30548 authenticator.cpp:98] Creating new server SASL connection I0323 01:40:50.956683 30547 status_update_manager.cpp:177] Pausing sending status updates I0323 01:40:50.956902 30549 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0323 01:40:50.956946 30549 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0323 01:40:50.957094 30549 authenticator.cpp:204] Received SASL authentication start I0323 01:40:50.957255 30549 authenticator.cpp:326] Authentication requires more steps I0323 01:40:50.957408 30545 authenticatee.cpp:259] Received SASL authentication step I0323 01:40:50.957546 30545 authenticator.cpp:232] Received SASL authentication step I0323 01:40:50.957589 30545 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '8ae39d239eab' server FQDN: '8ae39d239eab' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0323 01:40:50.957609 30545 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0323 01:40:50.957656 30545 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0323 01:40:50.957684 30545 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '8ae39d239eab' server FQDN: '8ae39d239eab' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0323 01:40:50.957698 30545 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0323 01:40:50.957707 30545 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0323 01:40:50.957726 30545 authenticator.cpp:318] Authentication success I0323 01:40:50.957929 30545 authenticatee.cpp:299] Authentication success I0323 01:40:50.958081 30555 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(413)@172.17.0.2:38745 I0323 01:40:50.958149 30546 state.cpp:62] Recovering state from '/tmp/MasterTest_MultipleExecutors_I3mscr/meta' I0323 01:40:50.958418 30547 master.cpp:7282] Successfully authenticated principal 'test-principal' at [email protected]:38745 I0323 01:40:50.958648 30540 sched.cpp:513] Successfully authenticated with master [email protected]:38745 I0323 01:40:50.958683 30540 sched.cpp:836] Sending SUBSCRIBE call to [email protected]:38745 I0323 01:40:50.958773 30543 status_update_manager.cpp:203] Recovering status update manager I0323 01:40:50.958993 30540 sched.cpp:869] Will retry registration in 426.840909ms if necessary I0323 01:40:50.959221 30550 master.cpp:2817] Received SUBSCRIBE call for framework 'default' at [email protected]:38745 I0323 01:40:50.959370 30547 slave.cpp:5638] Finished recovery I0323 01:40:50.959408 30550 master.cpp:2201] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }' I0323 01:40:50.960016 30550 master.cpp:2894] Subscribing framework default with checkpointing disabled and capabilities [ ] I0323 01:40:50.960139 30547 slave.cpp:5820] Querying resource estimator for oversubscribable resources I0323 01:40:50.960544 30551 slave.cpp:821] New master detected at [email protected]:38745 I0323 01:40:50.960583 30541 status_update_manager.cpp:177] Pausing sending status updates I0323 01:40:50.960665 30551 slave.cpp:856] Detecting new master I0323 01:40:50.960734 30547 sched.cpp:759] Framework registered with a83b8faa-d37a-4995-aefb-bcca2b5fc393-0000 I0323 01:40:50.960815 30547 sched.cpp:773] Scheduler::registered took 38292ns I0323 01:40:50.960903 30551 slave.cpp:5834] Received oversubscribable resources {} from the resource estimator I0323 01:40:50.960937 30546 hierarchical.cpp:271] Added framework a83b8faa-d37a-4995-aefb-bcca2b5fc393-0000 I0323 01:40:50.961114 30546 hierarchical.cpp:1862] No allocations performed I0323 01:40:50.961164 30546 hierarchical.cpp:1952] No inverse offers to send out! I0323 01:40:50.961237 30546 hierarchical.cpp:1446] Performed allocation for 0 agents in 182987ns I0323 01:40:50.967064 30547 slave.cpp:883] Authenticating with master [email protected]:38745 I0323 01:40:50.967152 30547 slave.cpp:894] Using default CRAM-MD5 authenticatee I0323 01:40:50.967465 30553 authenticatee.cpp:121] Creating new client SASL connection I0323 01:40:50.967800 30550 master.cpp:7252] Authenticating slave(180)@172.17.0.2:38745 I0323 01:40:50.967929 30555 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(414)@172.17.0.2:38745 I0323 01:40:50.968274 30553 authenticator.cpp:98] Creating new server SASL connection I0323 01:40:50.968523 30540 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0323 01:40:50.968612 30540 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0323 01:40:50.968755 30542 authenticator.cpp:204] Received SASL authentication start I0323 01:40:50.968821 30542 authenticator.cpp:326] Authentication requires more steps I0323 01:40:50.968955 30540 authenticatee.cpp:259] Received SASL authentication step I0323 01:40:50.969094 30542 authenticator.cpp:232] Received SASL authentication step I0323 01:40:50.969138 30542 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '8ae39d239eab' server FQDN: '8ae39d239eab' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0323 01:40:50.969164 30542 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0323 01:40:50.969218 30542 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0323 01:40:50.969260 30542 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '8ae39d239eab' server FQDN: '8ae39d239eab' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0323 01:40:50.969285 30542 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0323 01:40:50.969306 30542 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0323 01:40:50.969337 30542 authenticator.cpp:318] Authentication success I0323 01:40:50.969442 30540 authenticatee.cpp:299] Authentication success I0323 01:40:50.969486 30545 master.cpp:7282] Successfully authenticated principal 'test-principal' at slave(180)@172.17.0.2:38745 I0323 01:40:50.969576 30541 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(414)@172.17.0.2:38745 I0323 01:40:50.969934 30542 slave.cpp:978] Successfully authenticated with master [email protected]:38745 I0323 01:40:50.970165 30542 slave.cpp:1406] Will retry registration in 5.022221ms if necessary I0323 01:40:50.970372 30553 master.cpp:5437] Registering agent at slave(180)@172.17.0.2:38745 (8ae39d239eab) with id a83b8faa-d37a-4995-aefb-bcca2b5fc393-S0 I0323 01:40:50.970870 30544 registrar.cpp:463] Applied 1 operations in 68862ns; attempting to update the registry I0323 01:40:50.972769 30544 registrar.cpp:508] Successfully updated the registry in 1.815808ms I0323 01:40:50.973767 30552 slave.cpp:4421] Received ping from slave-observer(178)@172.17.0.2:38745 I0323 01:40:50.973964 30548 master.cpp:5511] Registered agent a83b8faa-d37a-4995-aefb-bcca2b5fc393-S0 at slave(180)@172.17.0.2:38745 (8ae39d239eab) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0323 01:40:50.974087 30552 slave.cpp:1024] Registered with master [email protected]:38745; given agent ID a83b8faa-d37a-4995-aefb-bcca2b5fc393-S0 I0323 01:40:50.974133 30552 fetcher.cpp:94] Clearing fetcher cache I0323 01:40:50.974591 30552 slave.cpp:1052] Checkpointing SlaveInfo to '/tmp/MasterTest_MultipleExecutors_I3mscr/meta/slaves/a83b8faa-d37a-4995-aefb-bcca2b5fc393-S0/slave.info' I0323 01:40:50.974573 30541 hierarchical.cpp:527] Added agent a83b8faa-d37a-4995-aefb-bcca2b5fc393-S0 (8ae39d239eab) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {}) I0323 01:40:50.974848 30553 status_update_manager.cpp:184] Resuming sending status updates I0323 01:40:50.975069 30552 slave.cpp:1090] Forwarding total oversubscribed resources {} I0323 01:40:50.975294 30540 master.cpp:6098] Received update of agent a83b8faa-d37a-4995-aefb-bcca2b5fc393-S0 at slave(180)@172.17.0.2:38745 (8ae39d239eab) with total oversubscribed resources {} I0323 01:40:50.976323 30541 hierarchical.cpp:1952] No inverse offers to send out! I0323 01:40:50.976409 30541 hierarchical.cpp:1446] Performed allocation for 1 agents in 1.64616ms I0323 01:40:50.977108 30552 master.cpp:7081] Sending 1 offers to framework a83b8faa-d37a-4995-aefb-bcca2b5fc393-0000 (default) at [email protected]:38745 I0323 01:40:50.977723 30542 sched.cpp:933] Scheduler::resourceOffers took 153170ns I0323 01:40:50.980734 30547 master.cpp:3839] Processing ACCEPT call for offers: [ a83b8faa-d37a-4995-aefb-bcca2b5fc393-O0 ] on agent a83b8faa-d37a-4995-aefb-bcca2b5fc393-S0 at slave(180)@172.17.0.2:38745 (8ae39d239eab) for framework a83b8faa-d37a-4995-aefb-bcca2b5fc393-0000 (default) at [email protected]:38745 I0323 01:40:50.980872 30547 master.cpp:3415] Authorizing framework principal 'test-principal' to launch task 1 I0323 01:40:50.981168 30547 master.cpp:3415] Authorizing framework principal 'test-principal' to launch task 2 W0323 01:40:50.983616 30552 validation.cpp:1113] 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. W0323 01:40:50.983660 30552 validation.cpp:1125] 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. I0323 01:40:50.984112 30552 master.cpp:9097] Adding task 1 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent a83b8faa-d37a-4995-aefb-bcca2b5fc393-S0 at slave(180)@172.17.0.2:38745 (8ae39d239eab) I0323 01:40:50.984340 30552 master.cpp:4489] Launching task 1 of framework a83b8faa-d37a-4995-aefb-bcca2b5fc393-0000 (default) at [email protected]:38745 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent a83b8faa-d37a-4995-aefb-bcca2b5fc393-S0 at slave(180)@172.17.0.2:38745 (8ae39d239eab) I0323 01:40:50.984887 30546 slave.cpp:1516] Got assigned task '1' for framework a83b8faa-d37a-4995-aefb-bcca2b5fc393-0000 I0323 01:40:50.985841 30546 slave.cpp:1797] Authorizing task '1' for framework a83b8faa-d37a-4995-aefb-bcca2b5fc393-0000 W0323 01:40:50.985841 30552 validation.cpp:1113] 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. W0323 01:40:50.985911 30552 validation.cpp:1125] 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. I0323 01:40:50.985931 30546 slave.cpp:6257] Authorizing framework principal 'test-principal' to launch task 1 I0323 01:40:50.986382 30552 master.cpp:9097] Adding task 2 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent a83b8faa-d37a-4995-aefb-bcca2b5fc393-S0 at slave(180)@172.17.0.2:38745 (8ae39d239eab) I0323 01:40:50.986608 30552 master.cpp:4489] Launching task 2 of framework a83b8faa-d37a-4995-aefb-bcca2b5fc393-0000 (default) at [email protected]:38745 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent a83b8faa-d37a-4995-aefb-bcca2b5fc393-S0 at slave(180)@172.17.0.2:38745 (8ae39d239eab) I0323 01:40:50.987176 30550 slave.cpp:1516] Got assigned task '2' for framework a83b8faa-d37a-4995-aefb-bcca2b5fc393-0000 I0323 01:40:50.987906 30550 slave.cpp:1984] Launching task '1' for framework a83b8faa-d37a-4995-aefb-bcca2b5fc393-0000 I0323 01:40:50.988780 30550 paths.cpp:547] Trying to chown '/tmp/MasterTest_MultipleExecutors_I3mscr/slaves/a83b8faa-d37a-4995-aefb-bcca2b5fc393-S0/frameworks/a83b8faa-d37a-4995-aefb-bcca2b5fc393-0000/executors/executor-1/runs/07c063cc-089e-4e2b-80bf-3795915ea432' to user 'mesos' I0323 01:40:50.989120 30550 slave.cpp:6604] Launching executor 'executor-1' of framework a83b8faa-d37a-4995-aefb-bcca2b5fc393-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_I3mscr/slaves/a83b8faa-d37a-4995-aefb-bcca2b5fc393-S0/frameworks/a83b8faa-d37a-4995-aefb-bcca2b5fc393-0000/executors/executor-1/runs/07c063cc-089e-4e2b-80bf-3795915ea432' I0323 01:40:50.989846 30550 slave.cpp:2198] Queued task '1' for executor 'executor-1' of framework a83b8faa-d37a-4995-aefb-bcca2b5fc393-0000 I0323 01:40:50.990002 30550 slave.cpp:1797] Authorizing task '2' for framework a83b8faa-d37a-4995-aefb-bcca2b5fc393-0000 I0323 01:40:50.990077 30550 slave.cpp:6257] Authorizing framework principal 'test-principal' to launch task 2 I0323 01:40:50.990612 30550 slave.cpp:774] Successfully attached file '/tmp/MasterTest_MultipleExecutors_I3mscr/slaves/a83b8faa-d37a-4995-aefb-bcca2b5fc393-S0/frameworks/a83b8faa-d37a-4995-aefb-bcca2b5fc393-0000/executors/executor-1/runs/07c063cc-089e-4e2b-80bf-3795915ea432' I0323 01:40:50.991063 30540 hierarchical.cpp:852] Updated allocation of framework a83b8faa-d37a-4995-aefb-bcca2b5fc393-0000 on agent a83b8faa-d37a-4995-aefb-bcca2b5fc393-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] I0323 01:40:50.991114 30545 slave.cpp:1984] Launching task '2' for framework a83b8faa-d37a-4995-aefb-bcca2b5fc393-0000 I0323 01:40:50.991639 30545 paths.cpp:547] Trying to chown '/tmp/MasterTest_MultipleExecutors_I3mscr/slaves/a83b8faa-d37a-4995-aefb-bcca2b5fc393-S0/frameworks/a83b8faa-d37a-4995-aefb-bcca2b5fc393-0000/executors/executor-2/runs/c2a6cd63-8630-4177-8960-7da5c2b91f56' to user 'mesos' I0323 01:40:50.991854 30540 hierarchical.cpp:1116] 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 a83b8faa-d37a-4995-aefb-bcca2b5fc393-S0 from framework a83b8faa-d37a-4995-aefb-bcca2b5fc393-0000 I0323 01:40:50.991909 30545 slave.cpp:6604] Launching executor 'executor-2' of framework a83b8faa-d37a-4995-aefb-bcca2b5fc393-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_I3mscr/slaves/a83b8faa-d37a-4995-aefb-bcca2b5fc393-S0/frameworks/a83b8faa-d37a-4995-aefb-bcca2b5fc393-0000/executors/executor-2/runs/c2a6cd63-8630-4177-8960-7da5c2b91f56' I0323 01:40:50.991925 30540 hierarchical.cpp:1153] Framework a83b8faa-d37a-4995-aefb-bcca2b5fc393-0000 filtered agent a83b8faa-d37a-4995-aefb-bcca2b5fc393-S0 for 5secs *** Aborted at 1490233250 (unix time) try "date -d @1490233250" if you are using GNU date *** PC: @ 0x2ba05f10682d (unknown) I0323 01:40:50.992640 30543 exec.cpp:162] Version: 1.3.0 *** SIGSEGV (@0xf0) received by PID 30521 (TID 0x2ba067d7d700) from PID 240; stack trace: *** I0323 01:40:50.993053 30544 exec.cpp:212] Executor started at: executor(75)@172.17.0.2:38745 with pid 30521 @ 0x2ba0b47d92d7 (unknown) @ 0x2ba0b47dd5b9 (unknown) @ 0x2ba05eebd330 (unknown) @ 0x2ba05f10682d (unknown) @ 0x2ba054b68796 os::getenv() @ 0x2ba05bdd5cd3 mesos::internal::slave::executorEnvironment() @ 0x2ba05bdd034c mesos::internal::slave::Framework::launchExecutor() @ 0x2ba05bda9f11 mesos::internal::slave::Slave::__run() @ 0x2ba05be05ec7 _ZZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS_6FutureISt4listIbSaIbEEEERKNS1_13FrameworkInfoERKNS1_12ExecutorInfoERK6OptionINS1_8TaskInfoEERKSI_INS1_13TaskGroupInfoEES9_SC_SF_SK_SO_EEvRKNS_3PIDIT_EEMSS_FvT0_T1_T2_T3_T4_ET5_T6_T7_T8_T9_ENKUlPNS_11ProcessBaseEE_clES19_ @ 0x2ba05be3c6be _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8dispatchIN5mesos8internal5slave5SlaveERKNS0_6FutureISt4listIbSaIbEEEERKNS5_13FrameworkInfoERKNS5_12ExecutorInfoERK6OptionINS5_8TaskInfoEERKSM_INS5_13TaskGroupInfoEESD_SG_SJ_SO_SS_EEvRKNS0_3PIDIT_EEMSW_FvT0_T1_T2_T3_T4_ET5_T6_T7_T8_T9_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_ @ 0x2ba05cb950a1 std::function<>::operator()() @ 0x2ba05cb7ae93 process::ProcessBase::visit() @ 0x2ba05cb857cc process::DispatchEvent::visit() @ 0x2ba054b3cb46 process::ProcessBase::serve() @ 0x2ba05cb77180 process::ProcessManager::resume() @ 0x2ba05cb739c4 _ZZN7process14ProcessManager12init_threadsEvENKUt_clEv @ 0x2ba05cb84f06 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE @ 0x2ba05cb84e5d _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEclEv @ 0x2ba05cb84df6 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv @ 0x2ba05e73ea60 (unknown) @ 0x2ba05eeb5184 start_thread @ 0x2ba05f1c8bed (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-1490230283-4123 Untagged: mesos-1490230283-4123:latest Deleted: sha256:90a34420f3e9847e3ae33e83ee3b0628b71b6d464fb03a7a77692b2dd3385019 Deleted: sha256:633712b0e5fa3e8bbc060d82ca19d656cc8462df65f58f45dca59fbf4eaf0ef8 Deleted: sha256:2f73d30008544888d89a82b9cfd7aa0b3079ae6724a238787b4e5fe66ad03433 Deleted: sha256:ee074af9fcd8391967e87241e18d4ae23a85d7fc355a5a537df3f4f918067a99 Deleted: sha256:be150fa0563924b0f21972d7edce5fb41f8b3f1b39260c594c76f983bd17733e Deleted: sha256:7756e287c42b7b3f16da162ecaed55316810ffcac940114a4ce6a87cd997bfe0 Deleted: sha256:743a1e6904b636dcd1097613e1b2bf71fbcdd334597acfbacae8a5a3948d6523 Deleted: sha256:f3951375be9e9f6474a3358debe0b1063a5054bfab07623e49768b741a6e5130 Deleted: sha256:80ff520bfcaa70d29da93aae973c13b599d779c59308824f24e7131ff5a0182c Deleted: sha256:f2414afba4e8a0d0087916422b16ad2fcc043e1c1efd1d012fdd291c809e995b Deleted: sha256:41de4e762d3a5767b84e9ccae176122ccd7d91009af39b33101d143ee640644d Deleted: sha256:5dddd40dcf2b79e193061157eeda96f5ee2c47d8013efc71dfd6030460895dc7 Deleted: sha256:92a620ba469521ad4b23fc99ce0917885b662b3af28ffd30398403fbb2f8300b Deleted: sha256:15add3ab2597e553d7b60be339b76fcbc2d1efbb076dd98d992c2ee789121ba2 Deleted: sha256:27be940ec6e4bc2436aefb28e4c2deb5e7147ffb79478bf4612cf01ecb8ea378 Deleted: sha256:57f6ca3b248992677af8baba61fd32610dcd7940813cbc358614e09fd1d7118e Deleted: sha256:326dd95f4d2cf3c11b7c309b1ba11b1af6d81aaacb70221f024acc6fee40add9 Deleted: sha256:a227f760ed1528ab4d17b22410959104b7467f5bb6df24b6e4e7ee9263f2d2d5 Deleted: sha256:fed11947323ca276eac586610ebd6652e4831c335dde8ae12788c1a621066d6a Deleted: sha256:6d45cef28d79327a022b71f62af8256b091a8399e24fb20d44ae59210794de14 Deleted: sha256:4f0fc4f7da3ec3f49991c428ee993fe15f3200703e8c6af5b95313987911d878 Deleted: sha256:205c4cc166f1c7e5f5db5eaf818b30270e465ac68a808a5bc9acae3d283e88a7 Deleted: sha256:1ab28eaaf6d20a81270f979d0b7e37d07ef4760acaa0ff526309a6714781774d Deleted: sha256:431ed2585cbd5b5d1ffc1fe763c9bca0e9597855a3c52678f085999e81ef30c3 Build step 'Execute shell' marked build as failure
