You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2017/10/22 21:49:14 UTC
Build failed in Jenkins: Mesos-Reviewbot #19874
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 files@172.17.0.4: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 master@172.17.0.4: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 master@172.17.0.4: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 master@172.17.0.4: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 master@172.17.0.4: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 master@172.17.0.4: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 version@172.17.0.4: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 master@172.17.0.4: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 master@172.17.0.4: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
Re: Build failed in Jenkins: Mesos-Reviewbot #19874
Posted by Alex R <al...@apache.org>.
Yes. This is https://issues.apache.org/jira/browse/MESOS-8096. I'm working
on the patches.
On 31 October 2017 at 20:44, Benjamin Mahler <bm...@apache.org> wrote:
> +alexr
>
> Looks like the destruction order here is wrong and the mock gets called
> after being destructed? Alex I seem to remember you mentioning something
> like this? Is this a known issue?
>
> On Sun, Oct 22, 2017 at 2:49 PM, Apache Jenkins Server <
> jenkins@builds.apache.org> wrote:
>
>> 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 files@172.17.0.4: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://reg
>> istry-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_SchedulerTes
>> t_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_SchedulerTes
>> t_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
>> master@172.17.0.4: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"},{"nam
>> e":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"nam
>> e":"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 <http://172.17.0.4:41816/master/api/v1/schedulerI1022> 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
>> master@172.17.0.4: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 <http://172.17.0.4:41816/master/api/v1/schedulerI1022> 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 <http://172.17.0.4:41816/master/api/v1/schedulerI1022>
>> 21:49:03.871228 5703 scheduler.cpp:738] Enqueuing event HEARTBEAT received
>> from http://172.17.0.4:41816/master/api/v1/scheduler
>> I1022 <http://172.17.0.4:41816/master/api/v1/schedulerI1022>
>> 21:49:03.874183 5696 slave.cpp:1055] Authenticating with master
>> master@172.17.0.4: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 master@172.17.0.4: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
>> master@172.17.0.4:41816; given agent ID 2f18d0ae-e6dd-4c21-b689-3a682a
>> 16da7a-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":{"val
>> ue":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 <http://172.17.0.4:41816/master/api/v1/schedulerI1022>
>> 21:49:03.888247 5700 scheduler.cpp:249] Sending ACCEPT call to
>> http://172.17.0.4:41816/master/api/v1/scheduler
>> I1022 <http://172.17.0.4:41816/master/api/v1/schedulerI1022>
>> 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-062694
>> b876ad
>> 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":{"va
>> lue":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":{"va
>> lue":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-062694
>> b876ad
>> 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_SchedulerTes
>> t_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/execu
>> tors/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 version@172.17.0.4: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 <http://172.17.0.4:41816/slave(817)/api/v1/executorI1022>
>> 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-3a682a
>> 16da7a-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 <http://172.17.0.4:41816/slave(817)/api/v1/executorI1022>
>> 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 <http://172.17.0.4:41816/slave(817)/api/v1/executorI1022>
>> 21:49:03.913880 5693 executor.cpp:307] Sending UPDATE call to
>> http://172.17.0.4:41816/slave(817)/api/v1/executor
>> I1022 <http://172.17.0.4:41816/slave(817)/api/v1/executorI1022>
>> 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 master@172.17.0.4: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 <http://172.17.0.4:41816/slave(817)/api/v1/executorI1022>
>> 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 <http://172.17.0.4:41816/master/api/v1/schedulerI1022>
>> 21:49:03.921093 5709 scheduler.cpp:249] Sending MESSAGE call to
>> http://172.17.0.4:41816/master/api/v1/scheduler
>> I1022 <http://172.17.0.4:41816/master/api/v1/schedulerI1022>
>> 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 <http://172.17.0.4:41816/slave(817)/api/v1/executorI1022>
>> 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 master@172.17.0.4: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":{"va
>> lue":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::UntypedFunc
>> tionMockerBase::SetOwnerAndName()
>> *** SIGSEGV (@0x0) received by PID 5691 (TID 0x2b1de43f3700) from PID 0;
>> stack trace: ***
>> @ 0x2b1de6dbeaf7 (unknown)
>> @ 0x2b1de6dc3449 (unknown)
>> @ 0x2b1dd9077330 (unknown)
>> @ 0x559e2470c8d4 testing::internal::UntypedFunc
>> tionMockerBase::SetOwnerAndName()
>> @ 0x559e2351ace1 mesos::internal::tests::execut
>> or::MockHTTPExecutor<>::shutdown()
>> @ 0x559e23512853 mesos::internal::tests::execut
>> or::MockHTTPExecutor<>::event()
>> @ 0x559e2350b768 mesos::internal::tests::execut
>> or::TestMesos<>::events()
>> @ 0x559e23531bc5 std::_Mem_fn<>::operator()<>()
>> @ 0x559e23525603 _ZNSt5_BindIFSt7_Mem_fnIMN5mes
>> os8internal5tests8executor9TestMesosINS1_2v18executor5MesosE
>> NS7_5EventEEEFvSt5queueIS9_St5dequeIS9_SaIS9_EEEEEPSA_St12_
>> PlaceholderILi1EEEE6__callIvIRKSF_EILm0ELm1EEEET_OSt5tupleII
>> DpT0_EESt12_Index_tupleIIXspT1_EEE
>> @ 0x559e2351b0df _ZNSt5_BindIFSt7_Mem_fnIMN5mes
>> os8internal5tests8executor9TestMesosINS1_2v18executor5MesosE
>> NS7_5EventEEEFvSt5queueIS9_St5dequeIS9_SaIS9_EEEEEPSA_St12_P
>> laceholderILi1EEEEclIJRKSF_EvEET0_DpOT_
>> @ 0x559e23512c19 std::_Function_handler<>::_M_invoke()
>> @ 0x2b1dd50abb7d std::function<>::operator()()
>> @ 0x2b1dd50a43fc process::AsyncExecutorProcess::execute<>()
>> @ 0x2b1dd50a4557 _ZZN7process8dispatchI7Nothing
>> NS_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos
>> 2v18executor5EventESt5dequeIS8_SaIS8_EEEEESC_SI_RSC_EENS_6Fu
>> tureIT_EERKNS_3PIDIT0_EEMSO_FSL_T1_T2_EOT3_OT4_ENKUlRSG_
>> SJ_PNS_11ProcessBaseEE_clES10_SJ_S12_
>> @ 0x2b1dd50bc3f6 _ZNSt5_BindIFZN7process8dispat
>> chI7NothingNS0_20AsyncExecutorProcessERKSt8functionIFvRKSt5q
>> ueueIN5mesos2v18executor5EventESt5dequeIS9_SaIS9_EEEEESD_SJ_
>> RSD_EENS0_6FutureIT_EERKNS0_3PIDIT0_EEMSP_FSM_T1_T2_EOT3_
>> OT4_EUlRSH_SK_PNS0_11ProcessBaseEE_SH_SD_St12_PlaceholderILi
>> 1EEEE6__callIvIOS13_EILm0ELm1ELm2EEEET_OSt5tupleIIDpT0_
>> EESt12_Index_tupleIIXspT1_EEE
>> @ 0x2b1dd50b8f35 _ZNSt5_BindIFZN7process8dispat
>> chI7NothingNS0_20AsyncExecutorProcessERKSt8functionIFvRKSt5q
>> ueueIN5mesos2v18executor5EventESt5dequeIS9_SaIS9_EEEEESD_SJ_
>> RSD_EENS0_6FutureIT_EERKNS0_3PIDIT0_EEMSP_FSM_T1_T2_EOT3_
>> OT4_EUlRSH_SK_PNS0_11ProcessBaseEE_SH_SD_St12_PlaceholderILi
>> 1EEEEclIJS13_EvEET0_DpOT_
>> @ 0x2b1dd50b2ec8 _ZNSt17_Function_handlerIFvPN7
>> process11ProcessBaseEESt5_BindIFZNS0_8dispatchI7NothingN
>> S0_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos
>> 2v18executor5EventESt5dequeISD_SaISD_EEEEESH_SN_RSH_EENS0_6F
>> utureIT_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 _ZZN7process14ProcessManager12
>> init_threadsEvENKUlvE_clEv
>> @ 0x2b1dd68dc760 _ZNSt12_Bind_simpleIFZN7proces
>> s14ProcessManager12init_threadsEvEUlvE_vEE9_M_
>> invokeIIEEEvSt12_Index_tupleIIXspT_EEE
>> @ 0x2b1dd68dc6b7 _ZNSt12_Bind_simpleIFZN7proces
>> s14ProcessManager12init_threadsEvEUlvE_vEEclEv
>> @ 0x2b1dd68dc650 _ZNSt6thread5_ImplISt12_Bind_s
>> impleIFZN7process14ProcessManager12init_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:e26ffc2dd355a8194841d7f4733b7c96f0551864fa02cb56edb2f
>> 06a5b678910
>> Deleted: sha256:fc5ffb3cd71b3f0103547ab754efd8eb1b36e57418bca94e789ce
>> e12e7ef464d
>> Deleted: sha256:51fcdc546757c4ca6469bdc5dd44eb78427c6c839a6c023288aa9
>> 692737ae944
>> Deleted: sha256:a2224dc29ddfc1fbaa023fcbec648bb57d6a0165aa9d233d594a7
>> 14d141a843c
>> Deleted: sha256:2916241fa980ca5a5d98da64b12204669f0571a1217ae2ce9a537
>> 172fd4ba2d9
>> Deleted: sha256:e54ddef9dba4791eb2a7103bdb13a835441d5b05f3bf76b5923e3
>> dbc9de34f7f
>> Deleted: sha256:794f2b096aaffb71395be98cf3af205442db63508c0a4a209a29d
>> 34ebe515b9a
>> Deleted: sha256:361e6eec237e26aebabe4173ca007f8a0d0430d1eba0780cfedd7
>> 05f3cbb431b
>> Deleted: sha256:3963e8faeca882269d120e05b948ad1c039e8ac62c83543a36811
>> 4697022f205
>> Deleted: sha256:5ade1a6e09abc7c083e8ad9e9471e67cc0779dcd83b12c9912287
>> cd82491725f
>> Deleted: sha256:42212725d6a62cfec554816d8b6d85ce04f03597de25344f4ccd0
>> 500384f8907
>> Deleted: sha256:074dd657c843f2409d449d9a61488f2313f6a12f82c1a923f39d0
>> 1f6d4a99674
>> Deleted: sha256:fde82245671c645f4e7c447fb57e0a42c56893d70796df41c43c0
>> 2efec49b803
>> Deleted: sha256:ec91df3f8cb07c554887e245eee88ffda09e1fa16b91312f1baad
>> a415322a7bf
>> Deleted: sha256:b12c3c18e937dda2d4784e14d4b36c94210aaf68f7d0d80b7367c
>> ea220ae489a
>> Deleted: sha256:fd377b617cc0502247efdfa1e5375a2b4e5091263d50dd66f7eca
>> b258c883986
>> Deleted: sha256:107ed0f3c2d2f1cc47ad42191df259af31d67ca39118547d159cc
>> 924a1126486
>> Deleted: sha256:48bcda3d60987f044ca33fa441bdda53a58413fe83440b846a3f0
>> 27919a120d0
>> Deleted: sha256:e45e3687de42f1edd8c41ad70f9996605a79ac357688c539a3cb8
>> e3764064dc1
>> Deleted: sha256:f26b3bfa92ccf0f0ed09b1b1ad4ed818b2d17ddbafeea649c21ea
>> 6029019e80e
>> Deleted: sha256:bbf2bae594a65f267da46964faac998ff0eb2eb7de1d0db0779cd
>> a121407d9fa
>> Deleted: sha256:32744ad5c9ea5522ca96f39cdca2ecc785f98461136ce6060a2bc
>> 57adfa9445f
>> Deleted: sha256:25bb2b0aba61d889ea725719fd20b75a5162fefef469d3f6d4e8d
>> 2bf758a6099
>> Deleted: sha256:db3d5bce6330d95dab7cfdb5ed34b03a6adf11745d1d8d9729f00
>> 9ad5b2556e9
>> Deleted: sha256:bc74e6e9a66ad69be664efd8620eb97fcc5a5721d527c8407ec1f
>> 58790ab6d14
>> Deleted: sha256:c0246cf16c2ea0cdfe90fa484b2a27d39458943e19604c7afa660
>> 5711f26e3a4
>> Deleted: sha256:37092084066b688a520b5497e018b30d5eb98416d03e41fedc6e6
>> f8d161ad401
>> Deleted: sha256:650a2bfe16f973826c4bcdb85cc9bfe3ded8e57b495c147f393f4
>> 5383bca4d14
>> Build step 'Execute shell' marked build as failure
>>
>>
>
Re: Build failed in Jenkins: Mesos-Reviewbot #19874
Posted by Benjamin Mahler <bm...@apache.org>.
+alexr
Looks like the destruction order here is wrong and the mock gets called
after being destructed? Alex I seem to remember you mentioning something
like this? Is this a known issue?
On Sun, Oct 22, 2017 at 2:49 PM, Apache Jenkins Server <
jenkins@builds.apache.org> wrote:
> 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 files@172.17.0.4: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
> master@172.17.0.4: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
> master@172.17.0.4: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
> master@172.17.0.4: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 master@172.17.0.4: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
> master@172.17.0.4: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 version@172.17.0.4: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 master@172.17.0.4: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 master@172.17.0.4: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_
> 20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v1
> 8executor5EventESt5dequeIS8_SaIS8_EEEEESC_SI_RSC_EENS_
> 6FutureIT_EERKNS_3PIDIT0_EEMSO_FSL_T1_T2_EOT3_OT4_ENKUlRSG_SJ_PNS_
> 11ProcessBaseEE_clES10_SJ_S12_
> @ 0x2b1dd50bc3f6 _ZNSt5_BindIFZN7process8dispatchI7NothingNS0_
> 20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v1
> 8executor5EventESt5dequeIS9_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_
> 20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v1
> 8executor5EventESt5dequeIS9_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_handlerIFvPN7process11ProcessB
> aseEESt5_BindIFZNS0_8dispatchI7NothingNS0_20AsyncExecutorProcessERKSt8fu
> nctionIFvRKSt5queueIN5mesos2v18executor5EventESt5dequeISD_
> 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 _ZZN7process14ProcessManager12i
> nit_threadsEvENKUlvE_clEv
> @ 0x2b1dd68dc760 _ZNSt12_Bind_simpleIFZN7process14ProcessMan
> ager12init_threadsEvEUlvE_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
> @ 0x2b1dd68dc6b7 _ZNSt12_Bind_simpleIFZN7process14ProcessMan
> ager12init_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:e26ffc2dd355a8194841d7f4733b7c
> 96f0551864fa02cb56edb2f06a5b678910
> Deleted: sha256:fc5ffb3cd71b3f0103547ab754efd8
> eb1b36e57418bca94e789cee12e7ef464d
> Deleted: sha256:51fcdc546757c4ca6469bdc5dd44eb
> 78427c6c839a6c023288aa9692737ae944
> Deleted: sha256:a2224dc29ddfc1fbaa023fcbec648b
> b57d6a0165aa9d233d594a714d141a843c
> Deleted: sha256:2916241fa980ca5a5d98da64b12204
> 669f0571a1217ae2ce9a537172fd4ba2d9
> Deleted: sha256:e54ddef9dba4791eb2a7103bdb13a8
> 35441d5b05f3bf76b5923e3dbc9de34f7f
> Deleted: sha256:794f2b096aaffb71395be98cf3af20
> 5442db63508c0a4a209a29d34ebe515b9a
> Deleted: sha256:361e6eec237e26aebabe4173ca007f
> 8a0d0430d1eba0780cfedd705f3cbb431b
> Deleted: sha256:3963e8faeca882269d120e05b948ad
> 1c039e8ac62c83543a368114697022f205
> Deleted: sha256:5ade1a6e09abc7c083e8ad9e9471e6
> 7cc0779dcd83b12c9912287cd82491725f
> Deleted: sha256:42212725d6a62cfec554816d8b6d85
> ce04f03597de25344f4ccd0500384f8907
> Deleted: sha256:074dd657c843f2409d449d9a61488f
> 2313f6a12f82c1a923f39d01f6d4a99674
> Deleted: sha256:fde82245671c645f4e7c447fb57e0a
> 42c56893d70796df41c43c02efec49b803
> Deleted: sha256:ec91df3f8cb07c554887e245eee88f
> fda09e1fa16b91312f1baada415322a7bf
> Deleted: sha256:b12c3c18e937dda2d4784e14d4b36c
> 94210aaf68f7d0d80b7367cea220ae489a
> Deleted: sha256:fd377b617cc0502247efdfa1e5375a
> 2b4e5091263d50dd66f7ecab258c883986
> Deleted: sha256:107ed0f3c2d2f1cc47ad42191df259
> af31d67ca39118547d159cc924a1126486
> Deleted: sha256:48bcda3d60987f044ca33fa441bdda
> 53a58413fe83440b846a3f027919a120d0
> Deleted: sha256:e45e3687de42f1edd8c41ad70f9996
> 605a79ac357688c539a3cb8e3764064dc1
> Deleted: sha256:f26b3bfa92ccf0f0ed09b1b1ad4ed8
> 18b2d17ddbafeea649c21ea6029019e80e
> Deleted: sha256:bbf2bae594a65f267da46964faac99
> 8ff0eb2eb7de1d0db0779cda121407d9fa
> Deleted: sha256:32744ad5c9ea5522ca96f39cdca2ec
> c785f98461136ce6060a2bc57adfa9445f
> Deleted: sha256:25bb2b0aba61d889ea725719fd20b7
> 5a5162fefef469d3f6d4e8d2bf758a6099
> Deleted: sha256:db3d5bce6330d95dab7cfdb5ed34b0
> 3a6adf11745d1d8d9729f009ad5b2556e9
> Deleted: sha256:bc74e6e9a66ad69be664efd8620eb9
> 7fcc5a5721d527c8407ec1f58790ab6d14
> Deleted: sha256:c0246cf16c2ea0cdfe90fa484b2a27
> d39458943e19604c7afa6605711f26e3a4
> Deleted: sha256:37092084066b688a520b5497e018b3
> 0d5eb98416d03e41fedc6e6f8d161ad401
> Deleted: sha256:650a2bfe16f973826c4bcdb85cc9bf
> e3ded8e57b495c147f393f45383bca4d14
> Build step 'Execute shell' marked build as failure
>
>
Jenkins build is back to normal : Mesos-Reviewbot #19876
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Reviewbot/19876/display/redirect>
Build failed in Jenkins: Mesos-Reviewbot #19875
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Reviewbot/19875/display/redirect>
------------------------------------------
[...truncated 32.01 MB...]
I1022 23:00:54.331941 5712 process.cpp:3938] Handling HTTP event for process 'slave(821)' with path: '/slave(821)/monitor/statistics.json'
I1022 23:00:54.333185 5704 http.cpp:1185] HTTP GET for /slave(821)/monitor/statistics.json from 172.17.0.4:40976
I1022 23:00:54.333250 5704 http.cpp:976] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I1022 23:00:54.335749 5713 slave.cpp:869] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/1 (25 ms)
[ RUN ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2
I1022 23:00:54.346727 5690 containerizer.cpp:301] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W1022 23:00:54.347292 5690 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W1022 23:00:54.347396 5690 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I1022 23:00:54.347429 5690 provisioner.cpp:255] Using default backend 'copy'
I1022 23:00:54.351054 5711 slave.cpp:254] Mesos agent started on (822)@172.17.0.4:43122
I1022 23:00:54.351160 5711 slave.cpp:255] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_5fsxYf/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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_5fsxYf/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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_5fsxYf/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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_5fsxYf/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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_5fsxYf/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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_5fsxYf" --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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_SJ4EBu" --zk_session_timeout="10secs"
I1022 23:00:54.351647 5711 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_5fsxYf/credential'
I1022 23:00:54.351790 5711 slave.cpp:287] Agent using credential for: test-principal
I1022 23:00:54.351814 5711 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_5fsxYf/http_credentials'
I1022 23:00:54.352104 5711 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1022 23:00:54.352264 5711 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1022 23:00:54.353785 5711 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 23:00:54.354043 5711 slave.cpp:593] Agent attributes: [ ]
I1022 23:00:54.354084 5711 slave.cpp:602] Agent hostname: 0dc86d296905
I1022 23:00:54.354238 5701 status_update_manager.cpp:177] Pausing sending status updates
I1022 23:00:54.355550 5695 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_SJ4EBu/meta'
I1022 23:00:54.355790 5710 status_update_manager.cpp:203] Recovering status update manager
I1022 23:00:54.355957 5714 containerizer.cpp:662] Recovering containerizer
I1022 23:00:54.357074 5709 provisioner.cpp:416] Provisioner recovery complete
I1022 23:00:54.357439 5709 slave.cpp:6310] Finished recovery
I1022 23:00:54.359942 5708 process.cpp:3938] Handling HTTP event for process 'slave(822)' with path: '/slave(822)/containers'
I1022 23:00:54.361057 5703 http.cpp:1185] HTTP GET for /slave(822)/containers from 172.17.0.4:40978
I1022 23:00:54.361114 5703 http.cpp:976] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I1022 23:00:54.363950 5709 slave.cpp:869] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (28 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I1022 23:00:54.373857 5690 containerizer.cpp:301] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W1022 23:00:54.374305 5690 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W1022 23:00:54.374414 5690 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I1022 23:00:54.374449 5690 provisioner.cpp:255] Using default backend 'copy'
I1022 23:00:54.378185 5694 slave.cpp:254] Mesos agent started on (823)@172.17.0.4:43122
I1022 23:00:54.378207 5694 slave.cpp:255] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_N4tbGj/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_N4tbGj/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_N4tbGj/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_N4tbGj/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_N4tbGj/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_N4tbGj" --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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_5xHbfy" --zk_session_timeout="10secs"
I1022 23:00:54.378635 5694 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_N4tbGj/credential'
I1022 23:00:54.378779 5694 slave.cpp:287] Agent using credential for: test-principal
I1022 23:00:54.378803 5694 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_N4tbGj/http_credentials'
I1022 23:00:54.379055 5694 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1022 23:00:54.379195 5694 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1022 23:00:54.380719 5694 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 23:00:54.380977 5694 slave.cpp:593] Agent attributes: [ ]
I1022 23:00:54.380995 5694 slave.cpp:602] Agent hostname: 0dc86d296905
I1022 23:00:54.381125 5704 status_update_manager.cpp:177] Pausing sending status updates
I1022 23:00:54.382423 5696 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_5xHbfy/meta'
I1022 23:00:54.382650 5697 status_update_manager.cpp:203] Recovering status update manager
I1022 23:00:54.382834 5712 containerizer.cpp:662] Recovering containerizer
I1022 23:00:54.383930 5698 provisioner.cpp:416] Provisioner recovery complete
I1022 23:00:54.384240 5692 slave.cpp:6310] Finished recovery
I1022 23:00:54.386803 5691 process.cpp:3938] Handling HTTP event for process 'slave(823)' with path: '/slave(823)/monitor/statistics'
I1022 23:00:54.387871 5706 http.cpp:1185] HTTP GET for /slave(823)/monitor/statistics from 172.17.0.4:40980
I1022 23:00:54.387926 5706 http.cpp:976] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I1022 23:00:54.389627 5706 slave.cpp:869] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (25 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I1022 23:00:54.399930 5690 containerizer.cpp:301] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W1022 23:00:54.400485 5690 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W1022 23:00:54.400588 5690 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I1022 23:00:54.400619 5690 provisioner.cpp:255] Using default backend 'copy'
I1022 23:00:54.404242 5713 slave.cpp:254] Mesos agent started on (824)@172.17.0.4:43122
I1022 23:00:54.404263 5713 slave.cpp:255] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_KXSaDn/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_KXSaDn/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_KXSaDn/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_KXSaDn/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_KXSaDn/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_KXSaDn" --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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_oYin8B" --zk_session_timeout="10secs"
I1022 23:00:54.404670 5713 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_KXSaDn/credential'
I1022 23:00:54.404810 5713 slave.cpp:287] Agent using credential for: test-principal
I1022 23:00:54.404877 5713 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_KXSaDn/http_credentials'
I1022 23:00:54.405166 5713 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1022 23:00:54.405308 5713 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1022 23:00:54.406859 5713 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 23:00:54.407116 5713 slave.cpp:593] Agent attributes: [ ]
I1022 23:00:54.407150 5713 slave.cpp:602] Agent hostname: 0dc86d296905
I1022 23:00:54.407357 5691 status_update_manager.cpp:177] Pausing sending status updates
I1022 23:00:54.408530 5698 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_oYin8B/meta'
I1022 23:00:54.408804 5706 status_update_manager.cpp:203] Recovering status update manager
I1022 23:00:54.409027 5706 containerizer.cpp:662] Recovering containerizer
I1022 23:00:54.410233 5701 provisioner.cpp:416] Provisioner recovery complete
I1022 23:00:54.410599 5691 slave.cpp:6310] Finished recovery
I1022 23:00:54.413187 5700 process.cpp:3938] Handling HTTP event for process 'slave(824)' with path: '/slave(824)/monitor/statistics.json'
I1022 23:00:54.414217 5703 http.cpp:1185] HTTP GET for /slave(824)/monitor/statistics.json from 172.17.0.4:40982
I1022 23:00:54.414278 5703 http.cpp:976] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I1022 23:00:54.416442 5701 slave.cpp:869] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (26 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I1022 23:00:54.425233 5690 containerizer.cpp:301] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W1022 23:00:54.425668 5690 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W1022 23:00:54.425772 5690 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I1022 23:00:54.425799 5690 provisioner.cpp:255] Using default backend 'copy'
I1022 23:00:54.428720 5714 slave.cpp:254] Mesos agent started on (825)@172.17.0.4:43122
I1022 23:00:54.428740 5714 slave.cpp:255] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_PauKPr/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_PauKPr/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_PauKPr/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_PauKPr/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_PauKPr/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_PauKPr" --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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_pXB5gG" --zk_session_timeout="10secs"
I1022 23:00:54.429044 5714 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_PauKPr/credential'
I1022 23:00:54.429164 5714 slave.cpp:287] Agent using credential for: test-principal
I1022 23:00:54.429183 5714 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_PauKPr/http_credentials'
I1022 23:00:54.429375 5714 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1022 23:00:54.429504 5714 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1022 23:00:54.430693 5714 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 23:00:54.430883 5714 slave.cpp:593] Agent attributes: [ ]
I1022 23:00:54.430896 5714 slave.cpp:602] Agent hostname: 0dc86d296905
I1022 23:00:54.430994 5703 status_update_manager.cpp:177] Pausing sending status updates
I1022 23:00:54.432024 5701 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_pXB5gG/meta'
I1022 23:00:54.432243 5709 status_update_manager.cpp:203] Recovering status update manager
I1022 23:00:54.432386 5708 containerizer.cpp:662] Recovering containerizer
I1022 23:00:54.433356 5696 provisioner.cpp:416] Provisioner recovery complete
I1022 23:00:54.433611 5700 slave.cpp:6310] Finished recovery
I1022 23:00:54.435845 5695 process.cpp:3938] Handling HTTP event for process 'slave(825)' with path: '/slave(825)/containers'
I1022 23:00:54.436774 5711 http.cpp:1185] HTTP GET for /slave(825)/containers from 172.17.0.4:40984
I1022 23:00:54.436828 5711 http.cpp:976] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I1022 23:00:54.438117 5691 slave.cpp:869] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (21 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I1022 23:00:54.447145 5690 containerizer.cpp:301] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W1022 23:00:54.447547 5690 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W1022 23:00:54.447638 5690 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I1022 23:00:54.447665 5690 provisioner.cpp:255] Using default backend 'copy'
I1022 23:00:54.449040 5690 cluster.cpp:448] Creating default 'local' authorizer
I1022 23:00:54.450702 5704 slave.cpp:254] Mesos agent started on (826)@172.17.0.4:43122
I1022 23:00:54.450721 5704 slave.cpp:255] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_vISpfw/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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_vISpfw/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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_vISpfw/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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_vISpfw/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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_vISpfw/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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_vISpfw" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_2h7wDK" --zk_session_timeout="10secs"
I1022 23:00:54.451081 5704 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_vISpfw/credential'
I1022 23:00:54.451226 5704 slave.cpp:287] Agent using credential for: test-principal
I1022 23:00:54.451246 5704 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_vISpfw/http_credentials'
I1022 23:00:54.451444 5704 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1022 23:00:54.451570 5704 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1022 23:00:54.453099 5704 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 23:00:54.453466 5704 slave.cpp:593] Agent attributes: [ ]
I1022 23:00:54.453495 5704 slave.cpp:602] Agent hostname: 0dc86d296905
I1022 23:00:54.453634 5691 status_update_manager.cpp:177] Pausing sending status updates
I1022 23:00:54.454735 5696 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_2h7wDK/meta'
I1022 23:00:54.454936 5714 status_update_manager.cpp:203] Recovering status update manager
I1022 23:00:54.455088 5702 containerizer.cpp:662] Recovering containerizer
I1022 23:00:54.456116 5695 provisioner.cpp:416] Provisioner recovery complete
I1022 23:00:54.456367 5708 slave.cpp:6310] Finished recovery
I1022 23:00:54.458547 5692 process.cpp:3938] Handling HTTP event for process 'slave(826)' with path: '/slave(826)/monitor/statistics'
I1022 23:00:54.459522 5707 http.cpp:1185] HTTP GET for /slave(826)/monitor/statistics from 172.17.0.4:40986
I1022 23:00:54.459576 5707 http.cpp:976] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I1022 23:00:54.461638 5713 slave.cpp:869] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (24 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I1022 23:00:54.470679 5690 containerizer.cpp:301] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W1022 23:00:54.471078 5690 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W1022 23:00:54.471173 5690 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I1022 23:00:54.471200 5690 provisioner.cpp:255] Using default backend 'copy'
I1022 23:00:54.472575 5690 cluster.cpp:448] Creating default 'local' authorizer
I1022 23:00:54.474158 5693 slave.cpp:254] Mesos agent started on (827)@172.17.0.4:43122
I1022 23:00:54.474174 5693 slave.cpp:255] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_470YSA/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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_470YSA/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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_470YSA/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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_470YSA/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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_470YSA/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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_470YSA" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_sNZAdP" --zk_session_timeout="10secs"
I1022 23:00:54.474514 5693 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_470YSA/credential'
I1022 23:00:54.474661 5693 slave.cpp:287] Agent using credential for: test-principal
I1022 23:00:54.474681 5693 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_470YSA/http_credentials'
I1022 23:00:54.474915 5693 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1022 23:00:54.475041 5693 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1022 23:00:54.476311 5693 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 23:00:54.476521 5693 slave.cpp:593] Agent attributes: [ ]
I1022 23:00:54.476533 5693 slave.cpp:602] Agent hostname: 0dc86d296905
I1022 23:00:54.476630 5713 status_update_manager.cpp:177] Pausing sending status updates
I1022 23:00:54.477790 5704 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_sNZAdP/meta'
I1022 23:00:54.477984 5708 status_update_manager.cpp:203] Recovering status update manager
I1022 23:00:54.478133 5698 containerizer.cpp:662] Recovering containerizer
I1022 23:00:54.479249 5697 provisioner.cpp:416] Provisioner recovery complete
I1022 23:00:54.479513 5713 slave.cpp:6310] Finished recovery
I1022 23:00:54.481977 5700 process.cpp:3938] Handling HTTP event for process 'slave(827)' with path: '/slave(827)/monitor/statistics.json'
I1022 23:00:54.482913 5710 http.cpp:1185] HTTP GET for /slave(827)/monitor/statistics.json from 172.17.0.4:40988
I1022 23:00:54.482969 5710 http.cpp:976] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I1022 23:00:54.485023 5692 slave.cpp:869] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (23 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I1022 23:00:54.493927 5690 containerizer.cpp:301] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W1022 23:00:54.494324 5690 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W1022 23:00:54.494422 5690 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I1022 23:00:54.494451 5690 provisioner.cpp:255] Using default backend 'copy'
I1022 23:00:54.495833 5690 cluster.cpp:448] Creating default 'local' authorizer
I1022 23:00:54.497427 5711 slave.cpp:254] Mesos agent started on (828)@172.17.0.4:43122
I1022 23:00:54.497444 5711 slave.cpp:255] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_gHooKF/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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_gHooKF/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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_gHooKF/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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_gHooKF/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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_gHooKF/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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_gHooKF" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_wvox1T" --zk_session_timeout="10secs"
I1022 23:00:54.497742 5711 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_gHooKF/credential'
I1022 23:00:54.497864 5711 slave.cpp:287] Agent using credential for: test-principal
I1022 23:00:54.497882 5711 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_gHooKF/http_credentials'
I1022 23:00:54.498078 5711 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1022 23:00:54.498204 5711 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1022 23:00:54.499378 5711 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 23:00:54.499572 5711 slave.cpp:593] Agent attributes: [ ]
I1022 23:00:54.499584 5711 slave.cpp:602] Agent hostname: 0dc86d296905
I1022 23:00:54.499688 5712 status_update_manager.cpp:177] Pausing sending status updates
I1022 23:00:54.500926 5714 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_wvox1T/meta'
I1022 23:00:54.501149 5703 status_update_manager.cpp:203] Recovering status update manager
I1022 23:00:54.501298 5695 containerizer.cpp:662] Recovering containerizer
I1022 23:00:54.502342 5693 provisioner.cpp:416] Provisioner recovery complete
I1022 23:00:54.502611 5712 slave.cpp:6310] Finished recovery
I1022 23:00:54.504828 5706 process.cpp:3938] Handling HTTP event for process 'slave(828)' with path: '/slave(828)/containers'
I1022 23:00:54.505779 5710 http.cpp:1185] HTTP GET for /slave(828)/containers from 172.17.0.4:40990
I1022 23:00:54.505836 5710 http.cpp:976] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I1022 23:00:54.508668 5690 slave.cpp:869] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (24 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (226 ms total)
[----------] 2 tests from ContainerizerType/DefaultContainerDNSFlagTest
[ RUN ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/0
[ OK ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/0 (9 ms)
[ RUN ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/1
[ OK ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/1 (8 ms)
[----------] 2 tests from ContainerizerType/DefaultContainerDNSFlagTest (17 ms total)
[----------] Global test environment tear-down
[==========] 1696 tests from 185 test cases ran. (575019 ms total)
[ PASSED ] 1695 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] ContentType/AgentAPIStreamingTest.AttachInputToNestedContainerSession/0, where GetParam() = application/x-protobuf
1 FAILED TEST
YOU HAVE 21 DISABLED TESTS
I1022 23:00:54.584028 5715 process.cpp:1067] Failed to accept socket: future discarded
make[4]: *** [check-local] Error 1
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-1508709709-25080
Untagged: mesos-1508709709-25080:latest
Deleted: sha256:f2e64af2f9e60d2a24018e0ddfc53a07311749e1cc9177d400838566c4ad2cc8
Deleted: sha256:87ac476bbdad779f23ade865ade59c4f95bf8167e0606aca7accdce854cefcb2
Deleted: sha256:ba68f55f6074192dc177327c57613192e32583632e6a88eb5e14bcc6a2285396
Deleted: sha256:2c1dbb90cbf7ac4d1e12e65b278d5a8103ec6ecfe0af90f61b71a70ca10d3b58
Deleted: sha256:fc81ca7cabf1a3e2b7215d5d44a2fbe863a9f9827161929148f3413ddb3a0b75
Deleted: sha256:e60f92d76f1c896b13db20b06be5759bc05f397d9474da91baa119d846f2445c
Deleted: sha256:d310b77b01cf856acb991485b888f96b4fa511a8a192dd70418d5ec949e43c58
Deleted: sha256:0b2944a864f2a378e5d6a20e8486af5fa58065e6d826fabbff2a2c7c78c83578
Deleted: sha256:b0cb6df311b905782ebe27b845ff68eea94e8356fbf8394cc73523fd9513bf9e
Deleted: sha256:30ad977a570ab3f583ffdc375313add2dfb6592c92dc91439e403cb91c524240
Deleted: sha256:0f17272e2d53ddcd19100bb111bacfc6ba8eb98d4042cac264c9745bc1f21f41
Deleted: sha256:e243afa3cf567ed1876dd93cba48c248382443401ef62796491a44cc9cb626be
Deleted: sha256:beef4e0070654a1dfeef1d44709832cc06b05cc7bce83f7a60d5d7016398d011
Deleted: sha256:4b50113bb77d2e68b1699b71616aa6018533d3ea76cffcaf64e2bd43857cd64a
Deleted: sha256:fc7b53663ad88aeac16668af51f29c3184bc320e81e3c08e2756d8e8d9e4223d
Deleted: sha256:cf81173e270304fed044a9862bc6625e25b9b053df47dcbb7431ca410602ecb0
Deleted: sha256:2bc6cdffd57f1ca77e91171eaa047529cdf13f5b3be04b4447e43753a6e027d7
Deleted: sha256:25e08d7e4e8279b4cb6837a41718f0bc719ffd91d1047dd190fe9a7e552bad1a
Deleted: sha256:496531104b08933cb86dddc683aa727d551d24ca265463a27d52a6470cf570b6
Deleted: sha256:19eb593054f1e6ea13a582e2e3d99c5f4cfc95aa1948b63b1bdc6c57d3e70844
Deleted: sha256:c39c4f3ccee1a522b28ce27ebabe64c1b117ed155f5bd86d086fac10c718dac6
Deleted: sha256:508df3c8dec4f1051ed305f4f3239577d8b4d5e9a2423ca09f6586b53d88dc17
Deleted: sha256:8a1303ad56f0fd96031acd2b2ee7bf62924c1cf3b33b4bdf3043fe6f2a46bdc8
Deleted: sha256:78c0cc4af6f7ddd555771a37e26ad40088b5f7ad026b70c5c028ddc499336354
Deleted: sha256:5f3cd143c284564412c7833a0acb3abca47df65d3db28974582b9e2aa548bf6b
Deleted: sha256:f7a836e35a03b8ff394f76993c6da1e479f6820f1289b3e4f6a336763974665c
Deleted: sha256:ec59b65b1de1ff42704996266e8aab87d0b8f00e68acefd0f4dc2410f98a7726
Deleted: sha256:85b1dffedc4cce3a5b6c65b115de56a1d66c1fc15edc843f1542c324ade1acf0
Build step 'Execute shell' marked build as failure