See <https://builds.apache.org/job/Mesos-Reviewbot/19874/display/redirect?page=changes>
Changes: [mpark] Fixed missing `convertResourceFormat` cases in `master::updateSlave`. ------------------------------------------ [...truncated 31.95 MB...] I1022 21:49:03.830294 5715 status_update_manager.cpp:531] Cleaning up status update stream for task 6714b4b6-7d63-4d61-8d47-35a56b9299f7 of framework 1d6b43d9-f7e7-422e-bdde-b6aae84cf0f2-0000 I1022 21:49:03.830319 5703 gc.cpp:90] Scheduling '/tmp/ContentType_SchedulerTest_Message_0_7TwIEC/slaves/1d6b43d9-f7e7-422e-bdde-b6aae84cf0f2-S0/frameworks/1d6b43d9-f7e7-422e-bdde-b6aae84cf0f2-0000' for gc 6.99999039070519days in the future I1022 21:49:03.830335 5701 slave.cpp:869] Agent terminating I1022 21:49:03.830533 5694 master.cpp:1303] Agent 1d6b43d9-f7e7-422e-bdde-b6aae84cf0f2-S0 at slave(816)@172.17.0.4:41816 (da4f1f3e1924) disconnected I1022 21:49:03.830559 5694 master.cpp:3336] Disconnecting agent 1d6b43d9-f7e7-422e-bdde-b6aae84cf0f2-S0 at slave(816)@172.17.0.4:41816 (da4f1f3e1924) I1022 21:49:03.830626 5694 master.cpp:3355] Deactivating agent 1d6b43d9-f7e7-422e-bdde-b6aae84cf0f2-S0 at slave(816)@172.17.0.4:41816 (da4f1f3e1924) I1022 21:49:03.830760 5697 hierarchical.cpp:690] Agent 1d6b43d9-f7e7-422e-bdde-b6aae84cf0f2-S0 deactivated I1022 21:49:03.833765 5712 master.cpp:1145] Master terminating I1022 21:49:03.834528 5699 hierarchical.cpp:626] Removed agent 1d6b43d9-f7e7-422e-bdde-b6aae84cf0f2-S0 [ OK ] ContentType/SchedulerTest.Message/0 (133 ms) [ RUN ] ContentType/SchedulerTest.Message/1 I1022 21:49:03.841037 5691 cluster.cpp:162] Creating default 'local' authorizer I1022 21:49:03.843849 5697 master.cpp:445] Master 2f18d0ae-e6dd-4c21-b689-3a682a16da7a (da4f1f3e1924) started on 172.17.0.4:41816 I1022 21:49:03.843871 5697 master.cpp:447] 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/kghDlQ/credentials" --filter_gpu_resources="true" --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" --port="5050" --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.5.0/_inst/share/mesos/webui" --work_dir="/tmp/kghDlQ/master" --zk_session_timeout="10secs" I1022 21:49:03.844151 5697 master.cpp:496] Master only allowing authenticated frameworks to register I1022 21:49:03.844162 5697 master.cpp:502] Master only allowing authenticated agents to register I1022 21:49:03.844167 5697 master.cpp:508] Master only allowing authenticated HTTP frameworks to register I1022 21:49:03.844173 5697 credentials.hpp:37] Loading credentials for authentication from '/tmp/kghDlQ/credentials' I1022 21:49:03.844461 5697 master.cpp:552] Using default 'crammd5' authenticator I1022 21:49:03.844617 5697 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I1022 21:49:03.844780 5697 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I1022 21:49:03.844894 5697 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I1022 21:49:03.845003 5697 master.cpp:631] Authorization enabled I1022 21:49:03.845147 5702 hierarchical.cpp:171] Initialized hierarchical allocator process I1022 21:49:03.845190 5703 whitelist_watcher.cpp:77] No whitelist given I1022 21:49:03.848208 5692 master.cpp:2198] Elected as the leading master! I1022 21:49:03.848249 5692 master.cpp:1687] Recovering from registrar I1022 21:49:03.848423 5693 registrar.cpp:347] Recovering registrar I1022 21:49:03.849054 5693 registrar.cpp:391] Successfully fetched the registry (0B) in 591872ns I1022 21:49:03.849184 5693 registrar.cpp:495] Applied 1 operations in 43483ns; attempting to update the registry I1022 21:49:03.849748 5693 registrar.cpp:552] Successfully updated the registry in 505856ns I1022 21:49:03.849874 5693 registrar.cpp:424] Successfully recovered registrar I1022 21:49:03.850251 5698 master.cpp:1791] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register I1022 21:49:03.850298 5710 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover W1022 21:49:03.854883 5691 process.cpp:3193] Attempted to spawn already running process [email protected]:41816 I1022 21:49:03.855180 5691 cluster.cpp:448] Creating default 'local' authorizer I1022 21:49:03.857235 5709 slave.cpp:254] Mesos agent started on (817)@172.17.0.4:41816 I1022 21:49:03.857257 5709 slave.cpp:255] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/ContentType_SchedulerTest_Message_1_RUMBEs/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/ContentType_SchedulerTest_Message_1_RUMBEs/credential" --default_role="*" --disallow_sharing_agent_pid_namespace="false" --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/ContentType_SchedulerTest_Message_1_RUMBEs/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/ContentType_SchedulerTest_Message_1_RUMBEs/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/ContentType_SchedulerTest_Message_1_RUMBEs/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --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/ContentType_SchedulerTest_Message_1_RUMBEs" --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/ContentType_SchedulerTest_Message_1_gbV6uE" --zk_session_timeout="10secs" I1022 21:49:03.857663 5709 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentType_SchedulerTest_Message_1_RUMBEs/credential' I1022 21:49:03.857884 5709 slave.cpp:287] Agent using credential for: test-principal I1022 21:49:03.857908 5709 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentType_SchedulerTest_Message_1_RUMBEs/http_credentials' I1022 21:49:03.857923 5691 scheduler.cpp:190] Version: 1.5.0 I1022 21:49:03.858196 5709 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I1022 21:49:03.858201 5713 scheduler.cpp:313] Using default 'basic' HTTP authenticatee I1022 21:49:03.858420 5709 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I1022 21:49:03.858744 5698 scheduler.cpp:496] New master detected at [email protected]:41816 I1022 21:49:03.858777 5698 scheduler.cpp:505] Waiting for 0ns before initiating a re-(connection) attempt with the master I1022 21:49:03.859918 5709 slave.cpp:585] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] I1022 21:49:03.860144 5709 slave.cpp:593] Agent attributes: [ ] I1022 21:49:03.860158 5709 slave.cpp:602] Agent hostname: da4f1f3e1924 I1022 21:49:03.860285 5695 status_update_manager.cpp:177] Pausing sending status updates I1022 21:49:03.862035 5708 state.cpp:64] Recovering state from '/tmp/ContentType_SchedulerTest_Message_1_gbV6uE/meta' I1022 21:49:03.862318 5705 status_update_manager.cpp:203] Recovering status update manager I1022 21:49:03.862646 5714 slave.cpp:6310] Finished recovery I1022 21:49:03.862962 5710 scheduler.cpp:387] Connected with the master at http://172.17.0.4:41816/master/api/v1/scheduler I1022 21:49:03.863461 5699 status_update_manager.cpp:177] Pausing sending status updates I1022 21:49:03.863487 5701 slave.cpp:993] New master detected at [email protected]:41816 I1022 21:49:03.863549 5701 slave.cpp:1028] Detecting new master I1022 21:49:03.864073 5715 scheduler.cpp:249] Sending SUBSCRIBE call to http://172.17.0.4:41816/master/api/v1/scheduler I1022 21:49:03.865871 5703 process.cpp:3938] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' I1022 21:49:03.867590 5692 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:34570 I1022 21:49:03.868094 5692 master.cpp:2580] Received subscription request for HTTP framework 'default' I1022 21:49:03.868216 5692 master.cpp:2263] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }' I1022 21:49:03.868746 5701 master.cpp:2716] Subscribing framework 'default' with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ] I1022 21:49:03.869557 5710 hierarchical.cpp:303] Added framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 I1022 21:49:03.869797 5710 hierarchical.cpp:1488] Performed allocation for 0 agents in 84636ns I1022 21:49:03.870800 5703 scheduler.cpp:738] Enqueuing event SUBSCRIBED received from http://172.17.0.4:41816/master/api/v1/scheduler I1022 21:49:03.871228 5703 scheduler.cpp:738] Enqueuing event HEARTBEAT received from http://172.17.0.4:41816/master/api/v1/scheduler I1022 21:49:03.874183 5696 slave.cpp:1055] Authenticating with master [email protected]:41816 I1022 21:49:03.874284 5696 slave.cpp:1064] Using default CRAM-MD5 authenticatee I1022 21:49:03.874622 5704 authenticatee.cpp:121] Creating new client SASL connection I1022 21:49:03.874996 5706 master.cpp:7947] Authenticating slave(817)@172.17.0.4:41816 I1022 21:49:03.875110 5710 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1494)@172.17.0.4:41816 I1022 21:49:03.875358 5713 authenticator.cpp:98] Creating new server SASL connection I1022 21:49:03.875589 5715 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I1022 21:49:03.875614 5715 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I1022 21:49:03.875725 5694 authenticator.cpp:204] Received SASL authentication start I1022 21:49:03.875792 5694 authenticator.cpp:326] Authentication requires more steps I1022 21:49:03.875900 5702 authenticatee.cpp:259] Received SASL authentication step I1022 21:49:03.876010 5714 authenticator.cpp:232] Received SASL authentication step I1022 21:49:03.876042 5714 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'da4f1f3e1924' server FQDN: 'da4f1f3e1924' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I1022 21:49:03.876056 5714 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I1022 21:49:03.876101 5714 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I1022 21:49:03.876119 5714 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'da4f1f3e1924' server FQDN: 'da4f1f3e1924' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I1022 21:49:03.876130 5714 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I1022 21:49:03.876137 5714 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I1022 21:49:03.876152 5714 authenticator.cpp:318] Authentication success I1022 21:49:03.876240 5712 authenticatee.cpp:299] Authentication success I1022 21:49:03.876296 5703 master.cpp:7977] Successfully authenticated principal 'test-principal' at slave(817)@172.17.0.4:41816 I1022 21:49:03.876368 5711 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1494)@172.17.0.4:41816 I1022 21:49:03.876586 5714 slave.cpp:1147] Successfully authenticated with master [email protected]:41816 I1022 21:49:03.876837 5714 slave.cpp:1626] Will retry registration in 3.150596ms if necessary I1022 21:49:03.877071 5708 master.cpp:5801] Received register agent message from slave(817)@172.17.0.4:41816 (da4f1f3e1924) I1022 21:49:03.877214 5708 master.cpp:3838] Authorizing agent with principal 'test-principal' I1022 21:49:03.877629 5705 master.cpp:5861] Authorized registration of agent at slave(817)@172.17.0.4:41816 (da4f1f3e1924) I1022 21:49:03.877759 5705 master.cpp:5954] Registering agent at slave(817)@172.17.0.4:41816 (da4f1f3e1924) with id 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-S0 I1022 21:49:03.878216 5701 registrar.cpp:495] Applied 1 operations in 70013ns; attempting to update the registry I1022 21:49:03.878926 5701 registrar.cpp:552] Successfully updated the registry in 628992ns I1022 21:49:03.879139 5704 master.cpp:6001] Admitted agent 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-S0 at slave(817)@172.17.0.4:41816 (da4f1f3e1924) I1022 21:49:03.879983 5710 slave.cpp:1193] Registered with master [email protected]:41816; given agent ID 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-S0 I1022 21:49:03.880118 5694 status_update_manager.cpp:184] Resuming sending status updates I1022 21:49:03.880201 5713 hierarchical.cpp:593] Added agent 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-S0 (da4f1f3e1924) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {}) I1022 21:49:03.879906 5704 master.cpp:6032] Registered agent 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-S0 at slave(817)@172.17.0.4:41816 (da4f1f3e1924) with [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] I1022 21:49:03.880313 5710 slave.cpp:1213] Checkpointing SlaveInfo to '/tmp/ContentType_SchedulerTest_Message_1_gbV6uE/meta/slaves/2f18d0ae-e6dd-4c21-b689-3a682a16da7a-S0/slave.info' I1022 21:49:03.880657 5710 slave.cpp:1262] Forwarding total oversubscribed resources {} I1022 21:49:03.880832 5702 master.cpp:6828] Received update of agent 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-S0 at slave(817)@172.17.0.4:41816 (da4f1f3e1924) with total oversubscribed resources {} I1022 21:49:03.880992 5702 master.cpp:6839] Ignoring update on agent 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-S0 at slave(817)@172.17.0.4:41816 (da4f1f3e1924) as it reports no changes I1022 21:49:03.881373 5713 hierarchical.cpp:1488] Performed allocation for 1 agents in 987446ns I1022 21:49:03.881786 5699 master.cpp:7777] Sending 1 offers to framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 (default) I1022 21:49:03.885566 5709 scheduler.cpp:738] Enqueuing event OFFERS received from http://172.17.0.4:41816/master/api/v1/scheduler I1022 21:49:03.888247 5700 scheduler.cpp:249] Sending ACCEPT call to http://172.17.0.4:41816/master/api/v1/scheduler I1022 21:49:03.891360 5704 process.cpp:3938] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' I1022 21:49:03.892896 5692 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:34568 I1022 21:49:03.895081 5692 master.cpp:9400] Removing offer 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-O0 I1022 21:49:03.895257 5692 master.cpp:4196] Processing ACCEPT call for offers: [ 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-O0 ] on agent 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-S0 at slave(817)@172.17.0.4:41816 (da4f1f3e1924) for framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 (default) I1022 21:49:03.895373 5692 master.cpp:3565] Authorizing framework principal 'test-principal' to launch task f130d29c-1767-4098-b156-062694b876ad W1022 21:49:03.897325 5692 validation.cpp:1338] Executor 'default' for task 'f130d29c-1767-4098-b156-062694b876ad' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases. W1022 21:49:03.897361 5692 validation.cpp:1350] Executor 'default' for task 'f130d29c-1767-4098-b156-062694b876ad' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases. I1022 21:49:03.897872 5692 master.cpp:10146] Adding task f130d29c-1767-4098-b156-062694b876ad with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] on agent 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-S0 at slave(817)@172.17.0.4:41816 (da4f1f3e1924) I1022 21:49:03.898500 5692 master.cpp:4879] Launching task f130d29c-1767-4098-b156-062694b876ad of framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 (default) with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] on agent 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-S0 at slave(817)@172.17.0.4:41816 (da4f1f3e1924) I1022 21:49:03.899157 5714 slave.cpp:1747] Got assigned task 'f130d29c-1767-4098-b156-062694b876ad' for framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 I1022 21:49:03.899852 5714 slave.cpp:2015] Authorizing task 'f130d29c-1767-4098-b156-062694b876ad' for framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 I1022 21:49:03.899917 5714 slave.cpp:6809] Authorizing framework principal 'test-principal' to launch task f130d29c-1767-4098-b156-062694b876ad I1022 21:49:03.900588 5696 slave.cpp:2183] Launching task 'f130d29c-1767-4098-b156-062694b876ad' for framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 I1022 21:49:03.901108 5696 paths.cpp:605] Trying to chown '/tmp/ContentType_SchedulerTest_Message_1_gbV6uE/slaves/2f18d0ae-e6dd-4c21-b689-3a682a16da7a-S0/frameworks/2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000/executors/default/runs/eb4240ec-037f-4b7b-b001-c5217a1b7791' to user 'mesos' I1022 21:49:03.901350 5696 slave.cpp:7283] Launching executor 'default' of framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 with resources [] in work directory '/tmp/ContentType_SchedulerTest_Message_1_gbV6uE/slaves/2f18d0ae-e6dd-4c21-b689-3a682a16da7a-S0/frameworks/2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000/executors/default/runs/eb4240ec-037f-4b7b-b001-c5217a1b7791' I1022 21:49:03.901707 5711 hierarchical.cpp:887] Updated allocation of framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 on agent 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-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] I1022 21:49:03.901821 5696 slave.cpp:2874] Launching container eb4240ec-037f-4b7b-b001-c5217a1b7791 for executor 'default' of framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 I1022 21:49:03.902179 5696 slave.cpp:2411] Queued task 'f130d29c-1767-4098-b156-062694b876ad' for executor 'default' of framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 I1022 21:49:03.902262 5696 slave.cpp:944] Successfully attached '/tmp/ContentType_SchedulerTest_Message_1_gbV6uE/slaves/2f18d0ae-e6dd-4c21-b689-3a682a16da7a-S0/frameworks/2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000/executors/default/runs/eb4240ec-037f-4b7b-b001-c5217a1b7791' to virtual path '/tmp/ContentType_SchedulerTest_Message_1_gbV6uE/slaves/2f18d0ae-e6dd-4c21-b689-3a682a16da7a-S0/frameworks/2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000/executors/default/runs/latest' I1022 21:49:03.902303 5696 slave.cpp:944] Successfully attached '/tmp/ContentType_SchedulerTest_Message_1_gbV6uE/slaves/2f18d0ae-e6dd-4c21-b689-3a682a16da7a-S0/frameworks/2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000/executors/default/runs/eb4240ec-037f-4b7b-b001-c5217a1b7791' to virtual path '/frameworks/2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000/executors/default/runs/latest' I1022 21:49:03.902334 5696 slave.cpp:944] Successfully attached '/tmp/ContentType_SchedulerTest_Message_1_gbV6uE/slaves/2f18d0ae-e6dd-4c21-b689-3a682a16da7a-S0/frameworks/2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000/executors/default/runs/eb4240ec-037f-4b7b-b001-c5217a1b7791' to virtual path '/tmp/ContentType_SchedulerTest_Message_1_gbV6uE/slaves/2f18d0ae-e6dd-4c21-b689-3a682a16da7a-S0/frameworks/2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000/executors/default/runs/eb4240ec-037f-4b7b-b001-c5217a1b7791' I1022 21:49:03.904165 5715 executor.cpp:192] Version: 1.5.0 W1022 21:49:03.904222 5715 process.cpp:3193] Attempted to spawn already running process [email protected]:41816 I1022 21:49:03.906651 5712 executor.cpp:410] Connected with the agent I1022 21:49:03.907153 5709 executor.cpp:307] Sending SUBSCRIBE call to http://172.17.0.4:41816/slave(817)/api/v1/executor I1022 21:49:03.908452 5714 process.cpp:3938] Handling HTTP event for process 'slave(817)' with path: '/slave(817)/api/v1/executor' I1022 21:49:03.909790 5696 http.cpp:1185] HTTP POST for /slave(817)/api/v1/executor from 172.17.0.4:34572 I1022 21:49:03.909967 5696 slave.cpp:3743] Received Subscribe request for HTTP executor 'default' of framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 I1022 21:49:03.911083 5696 slave.cpp:2613] Sending queued task 'f130d29c-1767-4098-b156-062694b876ad' to executor 'default' of framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 (via HTTP) I1022 21:49:03.912628 5698 executor.cpp:725] Enqueuing event SUBSCRIBED received from http://172.17.0.4:41816/slave(817)/api/v1/executor I1022 21:49:03.913275 5697 executor.cpp:725] Enqueuing event LAUNCH received from http://172.17.0.4:41816/slave(817)/api/v1/executor I1022 21:49:03.913880 5693 executor.cpp:307] Sending UPDATE call to http://172.17.0.4:41816/slave(817)/api/v1/executor I1022 21:49:03.914958 5706 process.cpp:3938] Handling HTTP event for process 'slave(817)' with path: '/slave(817)/api/v1/executor' I1022 21:49:03.916149 5713 http.cpp:1185] HTTP POST for /slave(817)/api/v1/executor from 172.17.0.4:34574 I1022 21:49:03.916296 5713 slave.cpp:4395] Handling status update TASK_RUNNING (UUID: 5dc458d7-739f-4b00-ba29-34e88c62d5b0) for task f130d29c-1767-4098-b156-062694b876ad of framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 I1022 21:49:03.916890 5710 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 5dc458d7-739f-4b00-ba29-34e88c62d5b0) for task f130d29c-1767-4098-b156-062694b876ad of framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 I1022 21:49:03.916932 5710 status_update_manager.cpp:500] Creating StatusUpdate stream for task f130d29c-1767-4098-b156-062694b876ad of framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 I1022 21:49:03.917419 5710 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 5dc458d7-739f-4b00-ba29-34e88c62d5b0) for task f130d29c-1767-4098-b156-062694b876ad of framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 to the agent I1022 21:49:03.917629 5703 slave.cpp:4876] Forwarding the update TASK_RUNNING (UUID: 5dc458d7-739f-4b00-ba29-34e88c62d5b0) for task f130d29c-1767-4098-b156-062694b876ad of framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 to [email protected]:41816 I1022 21:49:03.917829 5703 slave.cpp:4770] Status update manager successfully handled status update TASK_RUNNING (UUID: 5dc458d7-739f-4b00-ba29-34e88c62d5b0) for task f130d29c-1767-4098-b156-062694b876ad of framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 I1022 21:49:03.918022 5712 master.cpp:7004] Status update TASK_RUNNING (UUID: 5dc458d7-739f-4b00-ba29-34e88c62d5b0) for task f130d29c-1767-4098-b156-062694b876ad of framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 from agent 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-S0 at slave(817)@172.17.0.4:41816 (da4f1f3e1924) I1022 21:49:03.918076 5712 master.cpp:7066] Forwarding status update TASK_RUNNING (UUID: 5dc458d7-739f-4b00-ba29-34e88c62d5b0) for task f130d29c-1767-4098-b156-062694b876ad of framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 I1022 21:49:03.918678 5697 executor.cpp:725] Enqueuing event ACKNOWLEDGED received from http://172.17.0.4:41816/slave(817)/api/v1/executor I1022 21:49:03.918725 5712 master.cpp:9168] Updating the state of task f130d29c-1767-4098-b156-062694b876ad of framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING) I1022 21:49:03.920209 5702 scheduler.cpp:738] Enqueuing event UPDATE received from http://172.17.0.4:41816/master/api/v1/scheduler I1022 21:49:03.921093 5709 scheduler.cpp:249] Sending MESSAGE call to http://172.17.0.4:41816/master/api/v1/scheduler I1022 21:49:03.922581 5700 process.cpp:3938] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' I1022 21:49:03.960155 5694 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:34568 I1022 21:49:03.960660 5694 master.cpp:5734] Processing MESSAGE call from framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 (default) to agent 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-S0 at slave(817)@172.17.0.4:41816 (da4f1f3e1924) I1022 21:49:03.962241 5703 executor.cpp:725] Enqueuing event MESSAGE received from http://172.17.0.4:41816/slave(817)/api/v1/executor I1022 21:49:03.964715 5711 master.cpp:1417] Framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 (default) disconnected I1022 21:49:03.964764 5711 master.cpp:3299] Deactivating framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 (default) I1022 21:49:03.964838 5711 master.cpp:3276] Disconnecting framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 (default) I1022 21:49:03.964926 5711 master.cpp:1432] Giving framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 (default) 0ns to failover I1022 21:49:03.968816 5713 hierarchical.cpp:412] Deactivated framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 I1022 21:49:03.972525 5705 master.cpp:7609] Framework failover timeout, removing framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 (default) I1022 21:49:03.973115 5705 master.cpp:8470] Removing framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 (default) I1022 21:49:03.973670 5705 master.cpp:9168] Updating the state of task f130d29c-1767-4098-b156-062694b876ad of framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED) I1022 21:49:03.974423 5712 slave.cpp:3211] Asked to shut down framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 by [email protected]:41816 I1022 21:49:03.974828 5712 slave.cpp:3236] Shutting down framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 I1022 21:49:03.975169 5712 slave.cpp:5743] Shutting down executor 'default' of framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 (via HTTP) I1022 21:49:03.975059 5705 master.cpp:9262] Removing task f130d29c-1767-4098-b156-062694b876ad with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] of framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 on agent 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-S0 at slave(817)@172.17.0.4:41816 (da4f1f3e1924) I1022 21:49:03.975601 5695 hierarchical.cpp:1163] 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 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-S0 from framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 I1022 21:49:03.976073 5705 master.cpp:9291] Removing executor 'default' with resources [] of framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 on agent 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-S0 at slave(817)@172.17.0.4:41816 (da4f1f3e1924) I1022 21:49:03.976979 5705 hierarchical.cpp:355] Removed framework 2f18d0ae-e6dd-4c21-b689-3a682a16da7a-0000 I1022 21:49:03.987179 5715 executor.cpp:725] Enqueuing event SHUTDOWN received from http://172.17.0.4:41816/slave(817)/api/v1/executor *** Aborted at 1508708943 (unix time) try "date -d @1508708943" if you are using GNU date *** PC: @ 0x559e2470c8d4 testing::internal::UntypedFunctionMockerBase::SetOwnerAndName() *** SIGSEGV (@0x0) received by PID 5691 (TID 0x2b1de43f3700) from PID 0; stack trace: *** @ 0x2b1de6dbeaf7 (unknown) @ 0x2b1de6dc3449 (unknown) @ 0x2b1dd9077330 (unknown) @ 0x559e2470c8d4 testing::internal::UntypedFunctionMockerBase::SetOwnerAndName() @ 0x559e2351ace1 mesos::internal::tests::executor::MockHTTPExecutor<>::shutdown() @ 0x559e23512853 mesos::internal::tests::executor::MockHTTPExecutor<>::event() @ 0x559e2350b768 mesos::internal::tests::executor::TestMesos<>::events() @ 0x559e23531bc5 std::_Mem_fn<>::operator()<>() @ 0x559e23525603 _ZNSt5_BindIFSt7_Mem_fnIMN5mesos8internal5tests8executor9TestMesosINS1_2v18executor5MesosENS7_5EventEEEFvSt5queueIS9_St5dequeIS9_SaIS9_EEEEEPSA_St12_PlaceholderILi1EEEE6__callIvIRKSF_EILm0ELm1EEEET_OSt5tupleIIDpT0_EESt12_Index_tupleIIXspT1_EEE @ 0x559e2351b0df _ZNSt5_BindIFSt7_Mem_fnIMN5mesos8internal5tests8executor9TestMesosINS1_2v18executor5MesosENS7_5EventEEEFvSt5queueIS9_St5dequeIS9_SaIS9_EEEEEPSA_St12_PlaceholderILi1EEEEclIJRKSF_EvEET0_DpOT_ @ 0x559e23512c19 std::_Function_handler<>::_M_invoke() @ 0x2b1dd50abb7d std::function<>::operator()() @ 0x2b1dd50a43fc process::AsyncExecutorProcess::execute<>() @ 0x2b1dd50a4557 _ZZN7process8dispatchI7NothingNS_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v18executor5EventESt5dequeIS8_SaIS8_EEEEESC_SI_RSC_EENS_6FutureIT_EERKNS_3PIDIT0_EEMSO_FSL_T1_T2_EOT3_OT4_ENKUlRSG_SJ_PNS_11ProcessBaseEE_clES10_SJ_S12_ @ 0x2b1dd50bc3f6 _ZNSt5_BindIFZN7process8dispatchI7NothingNS0_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v18executor5EventESt5dequeIS9_SaIS9_EEEEESD_SJ_RSD_EENS0_6FutureIT_EERKNS0_3PIDIT0_EEMSP_FSM_T1_T2_EOT3_OT4_EUlRSH_SK_PNS0_11ProcessBaseEE_SH_SD_St12_PlaceholderILi1EEEE6__callIvIOS13_EILm0ELm1ELm2EEEET_OSt5tupleIIDpT0_EESt12_Index_tupleIIXspT1_EEE @ 0x2b1dd50b8f35 _ZNSt5_BindIFZN7process8dispatchI7NothingNS0_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v18executor5EventESt5dequeIS9_SaIS9_EEEEESD_SJ_RSD_EENS0_6FutureIT_EERKNS0_3PIDIT0_EEMSP_FSM_T1_T2_EOT3_OT4_EUlRSH_SK_PNS0_11ProcessBaseEE_SH_SD_St12_PlaceholderILi1EEEEclIJS13_EvEET0_DpOT_ @ 0x2b1dd50b2ec8 _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEESt5_BindIFZNS0_8dispatchI7NothingNS0_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v18executor5EventESt5dequeISD_SaISD_EEEEESH_SN_RSH_EENS0_6FutureIT_EERKNS0_3PIDIT0_EEMST_FSQ_T1_T2_EOT3_OT4_EUlRSL_SO_S2_E_SL_SH_St12_PlaceholderILi1EEEEE9_M_invokeERKSt9_Any_dataS2_ @ 0x2b1dd68f025b std::function<>::operator()() @ 0x2b1dd68d140d process::ProcessBase::visit() @ 0x2b1dd68dd756 process::DispatchEvent::visit() @ 0x559e23090ac6 process::ProcessBase::serve() @ 0x2b1dd68ce94f process::ProcessManager::resume() @ 0x2b1dd68cadae _ZZN7process14ProcessManager12init_threadsEvENKUlvE_clEv @ 0x2b1dd68dc760 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE @ 0x2b1dd68dc6b7 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEclEv @ 0x2b1dd68dc650 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEE6_M_runEv @ 0x2b1dd88f8a60 (unknown) @ 0x2b1dd906f184 start_thread @ 0x2b1dd9382ffd (unknown) make[4]: *** [check-local] Segmentation fault (core dumped) make[4]: Leaving directory `/mesos/mesos-1.5.0/_build/src' make[3]: *** [check-am] Error 2 make[3]: Leaving directory `/mesos/mesos-1.5.0/_build/src' make[2]: *** [check] Error 2 make[2]: Leaving directory `/mesos/mesos-1.5.0/_build/src' make[1]: *** [check-recursive] Error 1 make[1]: Leaving directory `/mesos/mesos-1.5.0/_build' make: *** [distcheck] Error 1 + docker rmi mesos-1508705121-9247 Untagged: mesos-1508705121-9247:latest Deleted: sha256:e26ffc2dd355a8194841d7f4733b7c96f0551864fa02cb56edb2f06a5b678910 Deleted: sha256:fc5ffb3cd71b3f0103547ab754efd8eb1b36e57418bca94e789cee12e7ef464d Deleted: sha256:51fcdc546757c4ca6469bdc5dd44eb78427c6c839a6c023288aa9692737ae944 Deleted: sha256:a2224dc29ddfc1fbaa023fcbec648bb57d6a0165aa9d233d594a714d141a843c Deleted: sha256:2916241fa980ca5a5d98da64b12204669f0571a1217ae2ce9a537172fd4ba2d9 Deleted: sha256:e54ddef9dba4791eb2a7103bdb13a835441d5b05f3bf76b5923e3dbc9de34f7f Deleted: sha256:794f2b096aaffb71395be98cf3af205442db63508c0a4a209a29d34ebe515b9a Deleted: sha256:361e6eec237e26aebabe4173ca007f8a0d0430d1eba0780cfedd705f3cbb431b Deleted: sha256:3963e8faeca882269d120e05b948ad1c039e8ac62c83543a368114697022f205 Deleted: sha256:5ade1a6e09abc7c083e8ad9e9471e67cc0779dcd83b12c9912287cd82491725f Deleted: sha256:42212725d6a62cfec554816d8b6d85ce04f03597de25344f4ccd0500384f8907 Deleted: sha256:074dd657c843f2409d449d9a61488f2313f6a12f82c1a923f39d01f6d4a99674 Deleted: sha256:fde82245671c645f4e7c447fb57e0a42c56893d70796df41c43c02efec49b803 Deleted: sha256:ec91df3f8cb07c554887e245eee88ffda09e1fa16b91312f1baada415322a7bf Deleted: sha256:b12c3c18e937dda2d4784e14d4b36c94210aaf68f7d0d80b7367cea220ae489a Deleted: sha256:fd377b617cc0502247efdfa1e5375a2b4e5091263d50dd66f7ecab258c883986 Deleted: sha256:107ed0f3c2d2f1cc47ad42191df259af31d67ca39118547d159cc924a1126486 Deleted: sha256:48bcda3d60987f044ca33fa441bdda53a58413fe83440b846a3f027919a120d0 Deleted: sha256:e45e3687de42f1edd8c41ad70f9996605a79ac357688c539a3cb8e3764064dc1 Deleted: sha256:f26b3bfa92ccf0f0ed09b1b1ad4ed818b2d17ddbafeea649c21ea6029019e80e Deleted: sha256:bbf2bae594a65f267da46964faac998ff0eb2eb7de1d0db0779cda121407d9fa Deleted: sha256:32744ad5c9ea5522ca96f39cdca2ecc785f98461136ce6060a2bc57adfa9445f Deleted: sha256:25bb2b0aba61d889ea725719fd20b75a5162fefef469d3f6d4e8d2bf758a6099 Deleted: sha256:db3d5bce6330d95dab7cfdb5ed34b03a6adf11745d1d8d9729f009ad5b2556e9 Deleted: sha256:bc74e6e9a66ad69be664efd8620eb97fcc5a5721d527c8407ec1f58790ab6d14 Deleted: sha256:c0246cf16c2ea0cdfe90fa484b2a27d39458943e19604c7afa6605711f26e3a4 Deleted: sha256:37092084066b688a520b5497e018b30d5eb98416d03e41fedc6e6f8d161ad401 Deleted: sha256:650a2bfe16f973826c4bcdb85cc9bfe3ded8e57b495c147f393f45383bca4d14 Build step 'Execute shell' marked build as failure
