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/08/11 22:03:19 UTC
Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #4099
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/4099/display/redirect?page=changes>
Changes:
[songzihao1990] Fixed the device number proto 'major' and 'minor' to avoid MACROs.
------------------------------------------
[...truncated 13.99 MB...]
I0811 22:02:57.306259 5194 hierarchical.cpp:412] Deactivated framework 9f20d110-ad43-4889-9052-c764e74716f0-0000
I0811 22:02:57.306893 5194 hierarchical.cpp:355] Removed framework 9f20d110-ad43-4889-9052-c764e74716f0-0000
I0811 22:02:57.307564 5196 state.cpp:64] Recovering state from '/tmp/MasterTest_MaxCompletedFrameworksFlag_zbOH5P/meta'
I0811 22:02:57.307734 5170 process.cpp:3228] Attempting to spawn already spawned process version@172.17.0.4:38601
I0811 22:02:57.308375 5195 status_update_manager.cpp:203] Recovering status update manager
I0811 22:02:57.308676 5189 containerizer.cpp:598] Recovering containerizer
I0811 22:02:57.309620 5170 sched.cpp:232] Version: 1.4.0
I0811 22:02:57.310292 5194 sched.cpp:336] New master detected at master@172.17.0.4:38601
I0811 22:02:57.310570 5194 sched.cpp:407] Authenticating with master master@172.17.0.4:38601
I0811 22:02:57.310595 5194 sched.cpp:414] Using default CRAM-MD5 authenticatee
I0811 22:02:57.310967 5195 authenticatee.cpp:121] Creating new client SASL connection
I0811 22:02:57.311316 5196 master.cpp:7837] Authenticating scheduler-d4f4bc8c-ac21-4cc3-8c42-b3f5b81933a6@172.17.0.4:38601
I0811 22:02:57.311410 5191 provisioner.cpp:416] Provisioner recovery complete
I0811 22:02:57.311657 5194 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(559)@172.17.0.4:38601
I0811 22:02:57.312095 5196 slave.cpp:6210] Finished recovery
I0811 22:02:57.312206 5195 authenticator.cpp:98] Creating new server SASL connection
I0811 22:02:57.312503 5193 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0811 22:02:57.312561 5193 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0811 22:02:57.312739 5196 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0811 22:02:57.312799 5195 authenticator.cpp:204] Received SASL authentication start
I0811 22:02:57.313021 5195 authenticator.cpp:326] Authentication requires more steps
I0811 22:02:57.313143 5195 authenticatee.cpp:259] Received SASL authentication step
I0811 22:02:57.313217 5189 status_update_manager.cpp:177] Pausing sending status updates
I0811 22:02:57.313433 5195 authenticator.cpp:232] Received SASL authentication step
I0811 22:02:57.313552 5195 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'a8ec3e487f20' server FQDN: 'a8ec3e487f20' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0811 22:02:57.313650 5195 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0811 22:02:57.313259 5196 slave.cpp:971] New master detected at master@172.17.0.4:38601
I0811 22:02:57.313846 5195 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0811 22:02:57.313899 5195 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'a8ec3e487f20' server FQDN: 'a8ec3e487f20' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0811 22:02:57.313932 5195 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0811 22:02:57.313930 5196 slave.cpp:1006] Detecting new master
I0811 22:02:57.313969 5195 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0811 22:02:57.314021 5195 authenticator.cpp:318] Authentication success
I0811 22:02:57.314360 5192 authenticatee.cpp:299] Authentication success
I0811 22:02:57.314426 5193 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(559)@172.17.0.4:38601
I0811 22:02:57.314555 5191 master.cpp:7867] Successfully authenticated principal 'test-principal' at scheduler-d4f4bc8c-ac21-4cc3-8c42-b3f5b81933a6@172.17.0.4:38601
I0811 22:02:57.314914 5192 sched.cpp:513] Successfully authenticated with master master@172.17.0.4:38601
I0811 22:02:57.314939 5192 sched.cpp:836] Sending SUBSCRIBE call to master@172.17.0.4:38601
I0811 22:02:57.315140 5192 sched.cpp:869] Will retry registration in 338.801222ms if necessary
I0811 22:02:57.315402 5194 master.cpp:2894] Received SUBSCRIBE call for framework 'default' at scheduler-d4f4bc8c-ac21-4cc3-8c42-b3f5b81933a6@172.17.0.4:38601
I0811 22:02:57.315416 5196 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0811 22:02:57.315642 5194 master.cpp:2228] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0811 22:02:57.316510 5191 master.cpp:2974] Subscribing framework default with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
I0811 22:02:57.317272 5195 sched.cpp:759] Framework registered with 9f20d110-ad43-4889-9052-c764e74716f0-0001
I0811 22:02:57.317378 5195 sched.cpp:773] Scheduler::registered took 53175ns
I0811 22:02:57.317658 5192 hierarchical.cpp:303] Added framework 9f20d110-ad43-4889-9052-c764e74716f0-0001
I0811 22:02:57.317960 5170 sched.cpp:2021] Asked to stop the driver
I0811 22:02:57.317965 5192 hierarchical.cpp:1925] No allocations performed
I0811 22:02:57.318051 5192 hierarchical.cpp:2015] No inverse offers to send out!
I0811 22:02:57.318243 5192 hierarchical.cpp:1468] Performed allocation for 0 agents in 312098ns
I0811 22:02:57.318341 5191 sched.cpp:1203] Stopping framework 9f20d110-ad43-4889-9052-c764e74716f0-0001
I0811 22:02:57.318706 5194 master.cpp:8348] Processing TEARDOWN call for framework 9f20d110-ad43-4889-9052-c764e74716f0-0001 (default) at scheduler-d4f4bc8c-ac21-4cc3-8c42-b3f5b81933a6@172.17.0.4:38601
I0811 22:02:57.318742 5194 master.cpp:8360] Removing framework 9f20d110-ad43-4889-9052-c764e74716f0-0001 (default) at scheduler-d4f4bc8c-ac21-4cc3-8c42-b3f5b81933a6@172.17.0.4:38601
I0811 22:02:57.318758 5194 master.cpp:3264] Deactivating framework 9f20d110-ad43-4889-9052-c764e74716f0-0001 (default) at scheduler-d4f4bc8c-ac21-4cc3-8c42-b3f5b81933a6@172.17.0.4:38601
I0811 22:02:57.319102 5195 hierarchical.cpp:412] Deactivated framework 9f20d110-ad43-4889-9052-c764e74716f0-0001
I0811 22:02:57.319560 5193 hierarchical.cpp:355] Removed framework 9f20d110-ad43-4889-9052-c764e74716f0-0001
I0811 22:02:57.321553 5192 slave.cpp:1033] Authenticating with master master@172.17.0.4:38601
I0811 22:02:57.321633 5192 slave.cpp:1044] Using default CRAM-MD5 authenticatee
I0811 22:02:57.321933 5195 authenticatee.cpp:121] Creating new client SASL connection
I0811 22:02:57.322446 5194 master.cpp:7837] Authenticating slave(264)@172.17.0.4:38601
I0811 22:02:57.322685 5191 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(560)@172.17.0.4:38601
I0811 22:02:57.323133 5196 authenticator.cpp:98] Creating new server SASL connection
I0811 22:02:57.323509 5192 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0811 22:02:57.323539 5192 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0811 22:02:57.323634 5192 authenticator.cpp:204] Received SASL authentication start
I0811 22:02:57.323745 5192 authenticator.cpp:326] Authentication requires more steps
I0811 22:02:57.323839 5192 authenticatee.cpp:259] Received SASL authentication step
I0811 22:02:57.323964 5193 authenticator.cpp:232] Received SASL authentication step
I0811 22:02:57.324090 5193 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'a8ec3e487f20' server FQDN: 'a8ec3e487f20' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0811 22:02:57.324184 5193 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0811 22:02:57.324249 5193 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0811 22:02:57.324417 5193 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'a8ec3e487f20' server FQDN: 'a8ec3e487f20' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0811 22:02:57.324461 5193 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0811 22:02:57.324553 5193 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0811 22:02:57.324589 5193 authenticator.cpp:318] Authentication success
I0811 22:02:57.324900 5193 authenticatee.cpp:299] Authentication success
I0811 22:02:57.325085 5196 master.cpp:7867] Successfully authenticated principal 'test-principal' at slave(264)@172.17.0.4:38601
I0811 22:02:57.325141 5193 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(560)@172.17.0.4:38601
I0811 22:02:57.325664 5195 slave.cpp:1128] Successfully authenticated with master master@172.17.0.4:38601
I0811 22:02:57.326038 5195 slave.cpp:1572] Will retry registration in 14.873589ms if necessary
I0811 22:02:57.326357 5189 master.cpp:5712] Received register agent message from slave(264)@172.17.0.4:38601 (a8ec3e487f20)
I0811 22:02:57.326644 5189 master.cpp:3803] Authorizing agent with principal 'test-principal'
I0811 22:02:57.326952 5189 process.cpp:3933] Handling HTTP event for process 'master' with path: '/master/state'
I0811 22:02:57.327569 5189 master.cpp:5772] Authorized registration of agent at slave(264)@172.17.0.4:38601 (a8ec3e487f20)
I0811 22:02:57.327827 5189 master.cpp:5865] Registering agent at slave(264)@172.17.0.4:38601 (a8ec3e487f20) with id 9f20d110-ad43-4889-9052-c764e74716f0-S0
I0811 22:02:57.328642 5194 registrar.cpp:495] Applied 1 operations in 69127ns; attempting to update the registry
I0811 22:02:57.329418 5194 registrar.cpp:552] Successfully updated the registry in 707840ns
I0811 22:02:57.329732 5191 http.cpp:1166] HTTP GET for /master/state from 172.17.0.4:46030
I0811 22:02:57.331607 5191 master.cpp:5912] Admitted agent 9f20d110-ad43-4889-9052-c764e74716f0-S0 at slave(264)@172.17.0.4:38601 (a8ec3e487f20)
I0811 22:02:57.332772 5193 slave.cpp:4887] Received ping from slave-observer(263)@172.17.0.4:38601
I0811 22:02:57.333222 5195 slave.cpp:1174] Registered with master master@172.17.0.4:38601; given agent ID 9f20d110-ad43-4889-9052-c764e74716f0-S0
I0811 22:02:57.333410 5192 hierarchical.cpp:593] Added agent 9f20d110-ad43-4889-9052-c764e74716f0-S0 (a8ec3e487f20) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0811 22:02:57.333750 5195 slave.cpp:1194] Checkpointing SlaveInfo to '/tmp/MasterTest_MaxCompletedFrameworksFlag_zbOH5P/meta/slaves/9f20d110-ad43-4889-9052-c764e74716f0-S0/slave.info'
I0811 22:02:57.333874 5192 hierarchical.cpp:1925] No allocations performed
I0811 22:02:57.334141 5192 hierarchical.cpp:1468] Performed allocation for 1 agents in 452620ns
I0811 22:02:57.334242 5192 status_update_manager.cpp:184] Resuming sending status updates
I0811 22:02:57.334336 5195 slave.cpp:1232] Forwarding total oversubscribed resources {}
I0811 22:02:57.333024 5191 master.cpp:5943] Registered agent 9f20d110-ad43-4889-9052-c764e74716f0-S0 at slave(264)@172.17.0.4:38601 (a8ec3e487f20) 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"}]
I0811 22:02:57.336498 5191 master.cpp:6688] Received update of agent 9f20d110-ad43-4889-9052-c764e74716f0-S0 at slave(264)@172.17.0.4:38601 (a8ec3e487f20) with total oversubscribed resources {}
I0811 22:02:57.337662 5194 hierarchical.cpp:660] Agent 9f20d110-ad43-4889-9052-c764e74716f0-S0 (a8ec3e487f20) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0811 22:02:57.342298 5170 slave.cpp:843] Agent terminating
I0811 22:02:57.342651 5192 master.cpp:1318] Agent 9f20d110-ad43-4889-9052-c764e74716f0-S0 at slave(264)@172.17.0.4:38601 (a8ec3e487f20) disconnected
I0811 22:02:57.342705 5192 master.cpp:3301] Disconnecting agent 9f20d110-ad43-4889-9052-c764e74716f0-S0 at slave(264)@172.17.0.4:38601 (a8ec3e487f20)
I0811 22:02:57.342772 5192 master.cpp:3320] Deactivating agent 9f20d110-ad43-4889-9052-c764e74716f0-S0 at slave(264)@172.17.0.4:38601 (a8ec3e487f20)
I0811 22:02:57.343118 5192 hierarchical.cpp:690] Agent 9f20d110-ad43-4889-9052-c764e74716f0-S0 deactivated
I0811 22:02:57.364529 5196 master.cpp:1160] Master terminating
I0811 22:02:57.365476 5192 hierarchical.cpp:626] Removed agent 9f20d110-ad43-4889-9052-c764e74716f0-S0
[ OK ] MasterTest.MaxCompletedFrameworksFlag (358 ms)
[ RUN ] MasterTest.MaxCompletedTasksPerFrameworkFlag
I0811 22:02:57.379149 5170 cluster.cpp:162] Creating default 'local' authorizer
I0811 22:02:57.382800 5189 master.cpp:442] Master ade09d8f-a3b1-4f40-9248-b82a314c869a (a8ec3e487f20) started on 172.17.0.4:38601
I0811 22:02:57.382833 5189 master.cpp:444] 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/jcmnO5/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="0" --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.4.0/_inst/share/mesos/webui" --work_dir="/tmp/jcmnO5/master" --zk_session_timeout="10secs"
I0811 22:02:57.383332 5189 master.cpp:494] Master only allowing authenticated frameworks to register
I0811 22:02:57.383358 5189 master.cpp:508] Master only allowing authenticated agents to register
I0811 22:02:57.383518 5189 master.cpp:521] Master only allowing authenticated HTTP frameworks to register
I0811 22:02:57.383533 5189 credentials.hpp:37] Loading credentials for authentication from '/tmp/jcmnO5/credentials'
I0811 22:02:57.384063 5189 master.cpp:566] Using default 'crammd5' authenticator
I0811 22:02:57.384276 5189 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0811 22:02:57.384749 5189 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0811 22:02:57.385156 5189 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0811 22:02:57.385501 5189 master.cpp:646] Authorization enabled
I0811 22:02:57.385892 5195 hierarchical.cpp:171] Initialized hierarchical allocator process
I0811 22:02:57.385994 5193 whitelist_watcher.cpp:77] No whitelist given
I0811 22:02:57.389183 5189 master.cpp:2163] Elected as the leading master!
I0811 22:02:57.389225 5189 master.cpp:1702] Recovering from registrar
I0811 22:02:57.389647 5196 registrar.cpp:347] Recovering registrar
I0811 22:02:57.390456 5196 registrar.cpp:391] Successfully fetched the registry (0B) in 0ns
I0811 22:02:57.390700 5196 registrar.cpp:495] Applied 1 operations in 33248ns; attempting to update the registry
I0811 22:02:57.391698 5196 registrar.cpp:552] Successfully updated the registry in 0ns
I0811 22:02:57.391988 5196 registrar.cpp:424] Successfully recovered registrar
I0811 22:02:57.392666 5189 master.cpp:1801] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0811 22:02:57.392683 5195 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
I0811 22:02:57.398294 5170 process.cpp:3228] Attempting to spawn already spawned process files@172.17.0.4:38601
I0811 22:02:57.398694 5170 cluster.cpp:448] Creating default 'local' authorizer
I0811 22:02:57.401079 5189 slave.cpp:250] Mesos agent started on (265)@172.17.0.4:38601
I0811 22:02:57.401106 5189 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/MasterTest_MaxCompletedTasksPerFrameworkFlag_Jhp03d/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/MasterTest_MaxCompletedTasksPerFrameworkFlag_Jhp03d/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/MasterTest_MaxCompletedTasksPerFrameworkFlag_Jhp03d/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/MasterTest_MaxCompletedTasksPerFrameworkFlag_Jhp03d/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/MasterTest_MaxCompletedTasksPerFrameworkFlag_Jhp03d/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.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/MasterTest_MaxCompletedTasksPerFrameworkFlag_Jhp03d" --sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true" --systemd_enable_support="true" --systemd_runtime_directory="/run/systemd/system" --version="false" --work_dir="/tmp/MasterTest_MaxCompletedTasksPerFrameworkFlag_RwRaWE"
I0811 22:02:57.401628 5189 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterTest_MaxCompletedTasksPerFrameworkFlag_Jhp03d/credential'
I0811 22:02:57.402046 5189 slave.cpp:283] Agent using credential for: test-principal
I0811 22:02:57.402073 5189 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterTest_MaxCompletedTasksPerFrameworkFlag_Jhp03d/http_credentials'
I0811 22:02:57.402427 5189 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0811 22:02:57.402853 5189 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0811 22:02:57.404652 5189 slave.cpp:565] 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"}]
I0811 22:02:57.404860 5189 slave.cpp:573] Agent attributes: [ ]
I0811 22:02:57.405067 5189 slave.cpp:582] Agent hostname: a8ec3e487f20
I0811 22:02:57.405354 5191 status_update_manager.cpp:177] Pausing sending status updates
I0811 22:02:57.407508 5191 state.cpp:64] Recovering state from '/tmp/MasterTest_MaxCompletedTasksPerFrameworkFlag_RwRaWE/meta'
I0811 22:02:57.407922 5192 status_update_manager.cpp:203] Recovering status update manager
I0811 22:02:57.408516 5193 slave.cpp:6210] Finished recovery
I0811 22:02:57.409134 5193 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0811 22:02:57.409423 5193 slave.cpp:971] New master detected at master@172.17.0.4:38601
I0811 22:02:57.409497 5192 status_update_manager.cpp:177] Pausing sending status updates
I0811 22:02:57.409708 5193 slave.cpp:1006] Detecting new master
I0811 22:02:57.409972 5193 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0811 22:02:57.411082 5196 slave.cpp:1033] Authenticating with master master@172.17.0.4:38601
I0811 22:02:57.411175 5196 slave.cpp:1044] Using default CRAM-MD5 authenticatee
I0811 22:02:57.411614 5196 authenticatee.cpp:121] Creating new client SASL connection
I0811 22:02:57.412058 5194 master.cpp:7837] Authenticating slave(265)@172.17.0.4:38601
I0811 22:02:57.412307 5192 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(561)@172.17.0.4:38601
I0811 22:02:57.412714 5192 authenticator.cpp:98] Creating new server SASL connection
I0811 22:02:57.412964 5192 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0811 22:02:57.412988 5192 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0811 22:02:57.413089 5192 authenticator.cpp:204] Received SASL authentication start
I0811 22:02:57.413142 5192 authenticator.cpp:326] Authentication requires more steps
I0811 22:02:57.413270 5193 authenticatee.cpp:259] Received SASL authentication step
I0811 22:02:57.413491 5193 authenticator.cpp:232] Received SASL authentication step
I0811 22:02:57.413550 5193 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'a8ec3e487f20' server FQDN: 'a8ec3e487f20' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0811 22:02:57.413584 5193 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0811 22:02:57.413653 5193 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0811 22:02:57.413775 5193 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'a8ec3e487f20' server FQDN: 'a8ec3e487f20' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0811 22:02:57.413879 5193 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0811 22:02:57.413962 5193 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0811 22:02:57.414067 5193 authenticator.cpp:318] Authentication success
I0811 22:02:57.414301 5189 authenticatee.cpp:299] Authentication success
I0811 22:02:57.414404 5194 master.cpp:7867] Successfully authenticated principal 'test-principal' at slave(265)@172.17.0.4:38601
I0811 22:02:57.414477 5193 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(561)@172.17.0.4:38601
I0811 22:02:57.414968 5194 slave.cpp:1128] Successfully authenticated with master master@172.17.0.4:38601
*** Aborted at 1502488977 (unix time) try "date -d @1502488977" if you are using GNU date ***
I0811 22:02:57.415266 5194 slave.cpp:1572] Will retry registration in 9.805638ms if necessary
I0811 22:02:57.415485 5193 master.cpp:5712] Received register agent message from slave(265)@172.17.0.4:38601 (a8ec3e487f20)
I0811 22:02:57.415639 5193 master.cpp:3803] Authorizing agent with principal 'test-principal'
I0811 22:02:57.416384 5193 master.cpp:5772] Authorized registration of agent at slave(265)@172.17.0.4:38601 (a8ec3e487f20)
I0811 22:02:57.416522 5193 master.cpp:5865] Registering agent at slave(265)@172.17.0.4:38601 (a8ec3e487f20) with id ade09d8f-a3b1-4f40-9248-b82a314c869a-S0
I0811 22:02:57.417249 5193 registrar.cpp:495] Applied 1 operations in 62268ns; attempting to update the registry
I0811 22:02:57.418036 5193 registrar.cpp:552] Successfully updated the registry in 0ns
I0811 22:02:57.418691 5193 master.cpp:5912] Admitted agent ade09d8f-a3b1-4f40-9248-b82a314c869a-S0 at slave(265)@172.17.0.4:38601 (a8ec3e487f20)
I0811 22:02:57.419383 5194 slave.cpp:4887] Received ping from slave-observer(264)@172.17.0.4:38601
I0811 22:02:57.419838 5195 hierarchical.cpp:593] Added agent ade09d8f-a3b1-4f40-9248-b82a314c869a-S0 (a8ec3e487f20) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0811 22:02:57.420231 5194 slave.cpp:1174] Registered with master master@172.17.0.4:38601; given agent ID ade09d8f-a3b1-4f40-9248-b82a314c869a-S0
I0811 22:02:57.420400 5190 status_update_manager.cpp:184] Resuming sending status updates
I0811 22:02:57.420682 5194 slave.cpp:1194] Checkpointing SlaveInfo to '/tmp/MasterTest_MaxCompletedTasksPerFrameworkFlag_RwRaWE/meta/slaves/ade09d8f-a3b1-4f40-9248-b82a314c869a-S0/slave.info'
I0811 22:02:57.420784 5195 hierarchical.cpp:1925] No allocations performed
I0811 22:02:57.420922 5195 hierarchical.cpp:1468] Performed allocation for 1 agents in 357170ns
I0811 22:02:57.419965 5193 master.cpp:5943] Registered agent ade09d8f-a3b1-4f40-9248-b82a314c869a-S0 at slave(265)@172.17.0.4:38601 (a8ec3e487f20) 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"}]
I0811 22:02:57.421385 5194 slave.cpp:1232] Forwarding total oversubscribed resources {}
I0811 22:02:57.421653 5194 master.cpp:6688] Received update of agent ade09d8f-a3b1-4f40-9248-b82a314c869a-S0 at slave(265)@172.17.0.4:38601 (a8ec3e487f20) with total oversubscribed resources {}
I0811 22:02:57.422091 5196 hierarchical.cpp:660] Agent ade09d8f-a3b1-4f40-9248-b82a314c869a-S0 (a8ec3e487f20) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
PC: @ 0x2b9227fc7244 process::EventQueue::Consumer::empty()
*** SIGSEGV (@0x8) received by PID 5170 (TID 0x2b9232bd0700) from PID 8; stack trace: ***
@ 0x2b925a3b1417 (unknown)
@ 0x2b925a3b56f9 (unknown)
@ 0x2b922a666330 (unknown)
@ 0x2b9227fc7244 process::EventQueue::Consumer::empty()
@ 0x2b9227fb3ef2 process::ProcessManager::resume()
@ 0x2b9227fb04ee _ZZN7process14ProcessManager12init_threadsEvENKUlvE_clEv
@ 0x2b9227fc1c5c _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
@ 0x2b9227fc1bb3 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEclEv
@ 0x2b9227fc1b4c _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEE6_M_runEv
@ 0x2b9229ee7a60 (unknown)
@ 0x2b922a65e184 start_thread
@ 0x2b922a971ffd (unknown)
make[4]: *** [check-local] Segmentation fault (core dumped)
make[4]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.4.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1502484488-12277
Untagged: mesos-1502484488-12277:latest
Deleted: sha256:64e0e3e9d50a6175025ba2ddc7520db4c4ae4ce80809eb57273db00eb0d741c7
Deleted: sha256:68b0afe51452092f89ff0ac8d922395d68b1628e6f0fdd39088d10f55d40f0f6
Deleted: sha256:f3b87106e2800c107ef13498183aaf479e6a40df8652c81178c9a412fdc4943e
Deleted: sha256:4b991e0e173399ccb979246eafabf54648e737bf5d703aae5a96e0e5ee2d123c
Deleted: sha256:1bec732d10e0f7476581fa97fa93cb0aa528a25050d068736c8c49ecfa5269fd
Deleted: sha256:19934b5d6a38742519826d768ff2234f75c6352624bd58b765f00f2f6d3d84a5
Deleted: sha256:c2513fa229879b26b371abc4540d1b659dd23ed47b254af62dd9843627389e83
Deleted: sha256:303f07a227ac98b94e030a5a028da79b0c113a309429d9fbeba15b4e21fed060
Deleted: sha256:eed02fd31ab941ef67b596c2f48d71f614633bfa3ccf8869640f4c0340368f34
Deleted: sha256:c1465f8bb0718b76e71150ac97b9638a8b534ef96e173d69382d8bec106d1297
Deleted: sha256:3cfaec1eb587e2524ca7009c28cc79bd975fca906ec5ca0fefa1d8ce3e7d7e76
Deleted: sha256:e6ffb21f7179497cc48734c3c991fa6300a492718370a466e5d1cfaa75586489
Deleted: sha256:067d9099099cad732e0c44a39a31216b0ed2898f596101e5422727ed98c2a0b1
Deleted: sha256:b8fef09bc0540f76d89a02de2f2c56b621d3efbd645c45fd5c3bdb39b5c64599
Deleted: sha256:911e0c38be04c71f9adc919b4cc4f390e34dcd0d879dcd64769fa64302314acc
Deleted: sha256:a6e98fbad588372e3502fea3be8ef308bc5aa7f159494cc0a30537ffd4f44c36
Deleted: sha256:792c2eace4fd8629a51a51995688c3580ebb1b9451aa470d9d5d9951eff52c85
Deleted: sha256:96718a325fbee357fe4be7cfb8521d5b0f7cdeb9ba723cf4421fbf6763b65630
Deleted: sha256:7c22c628a6996807e75f5918ccd5af77019ea7120ba6b12ed10b288699f8f848
Deleted: sha256:1f3f71feaad3ebd480a47833f9804dbe19105f6e8adac17cfcf46564900424b8
Deleted: sha256:14554a136ecad4b79f3eb824b89df31f3265bb02d0850538390f0915ae853566
Deleted: sha256:582e4d39729c10b548d026d45301de04575bf5b41980025d4ccfac3363af5349
Deleted: sha256:e95a15fb482b67eac9df1898235d86bcc5aac59bfe59f179bf7fc5ccdf9dc98b
Deleted: sha256:616a36bcad32a572dccbf9ca48e75af3977f982272a4e676f97004ad5b162ab0
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user songzihao1990@gmail.com
Not sending mail to unregistered user alexander@mesosphere.io
Not sending mail to unregistered user yujie.jay@gmail.com
Jenkins build is back to normal : Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #4103
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/4103/display/redirect?page=changes>
Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #4102
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/4102/display/redirect?page=changes>
Changes:
[songzihao1990] Created staging dir only when needed.
[songzihao1990] Added MESOS-6950 to 1.2.3 CHANGELOG.
------------------------------------------
[...truncated 25.52 MB...]
I0812 06:52:05.580960 30258 slave.cpp:5662] Finished recovery
I0812 06:52:05.581782 30258 slave.cpp:5836] Querying resource estimator for oversubscribable resources
I0812 06:52:05.582135 30258 slave.cpp:5850] Received oversubscribable resources {} from the resource estimator
I0812 06:52:05.584966 30257 process.cpp:3714] Handling HTTP event for process 'slave(699)' with path: '/slave(699)/monitor/statistics.json'
I0812 06:52:05.586447 30257 http.cpp:871] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0812 06:52:05.591284 30232 slave.cpp:809] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/1 (32 ms)
[ RUN ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2
I0812 06:52:05.600970 30232 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0812 06:52:05.601763 30232 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0812 06:52:05.602159 30232 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0812 06:52:05.602444 30232 provisioner.cpp:249] Using default backend 'copy'
I0812 06:52:05.607112 30251 slave.cpp:217] Mesos agent started on (700)@172.17.0.4:46103
I0812 06:52:05.607144 30251 slave.cpp:218] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_bc9a57/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_bc9a57/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_bc9a57/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.3/_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_bc9a57" --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_cPpcoP"
I0812 06:52:05.607650 30251 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_bc9a57/credential'
I0812 06:52:05.607818 30251 slave.cpp:360] Agent using credential for: test-principal
I0812 06:52:05.607841 30251 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_bc9a57/http_credentials'
I0812 06:52:05.608321 30251 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0812 06:52:05.608464 30251 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0812 06:52:05.610061 30251 slave.cpp:547] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0812 06:52:05.610150 30251 slave.cpp:555] Agent attributes: [ ]
I0812 06:52:05.610169 30251 slave.cpp:560] Agent hostname: 4f646ed7871e
I0812 06:52:05.610446 30254 status_update_manager.cpp:177] Pausing sending status updates
I0812 06:52:05.611994 30253 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_cPpcoP/meta'
I0812 06:52:05.621022 30255 status_update_manager.cpp:203] Recovering status update manager
I0812 06:52:05.621233 30255 containerizer.cpp:600] Recovering containerizer
I0812 06:52:05.623244 30252 provisioner.cpp:410] Provisioner recovery complete
I0812 06:52:05.623935 30254 slave.cpp:5662] Finished recovery
I0812 06:52:05.625125 30254 slave.cpp:5836] Querying resource estimator for oversubscribable resources
I0812 06:52:05.625722 30254 slave.cpp:5850] Received oversubscribable resources {} from the resource estimator
I0812 06:52:05.629549 30256 process.cpp:3714] Handling HTTP event for process 'slave(700)' with path: '/slave(700)/containers'
I0812 06:52:05.631603 30256 http.cpp:871] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0812 06:52:05.643718 30232 slave.cpp:809] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (53 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0812 06:52:05.655405 30232 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0812 06:52:05.656168 30232 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0812 06:52:05.656541 30232 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0812 06:52:05.657176 30232 provisioner.cpp:249] Using default backend 'copy'
I0812 06:52:05.661680 30253 slave.cpp:217] Mesos agent started on (701)@172.17.0.4:46103
I0812 06:52:05.661713 30253 slave.cpp:218] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_z1RPnl/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_z1RPnl/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_z1RPnl/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.3/_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_z1RPnl" --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_V9Hix2"
I0812 06:52:05.662437 30253 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_z1RPnl/credential'
I0812 06:52:05.662708 30253 slave.cpp:360] Agent using credential for: test-principal
I0812 06:52:05.662737 30253 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_z1RPnl/http_credentials'
I0812 06:52:05.663141 30253 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0812 06:52:05.663300 30253 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0812 06:52:05.665612 30253 slave.cpp:547] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0812 06:52:05.665704 30253 slave.cpp:555] Agent attributes: [ ]
I0812 06:52:05.665722 30253 slave.cpp:560] Agent hostname: 4f646ed7871e
I0812 06:52:05.665922 30258 status_update_manager.cpp:177] Pausing sending status updates
I0812 06:52:05.667723 30258 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_V9Hix2/meta'
I0812 06:52:05.668202 30254 status_update_manager.cpp:203] Recovering status update manager
I0812 06:52:05.668669 30254 containerizer.cpp:600] Recovering containerizer
I0812 06:52:05.671103 30252 provisioner.cpp:410] Provisioner recovery complete
I0812 06:52:05.671519 30251 slave.cpp:5662] Finished recovery
I0812 06:52:05.672258 30251 slave.cpp:5836] Querying resource estimator for oversubscribable resources
I0812 06:52:05.672703 30254 slave.cpp:5850] Received oversubscribable resources {} from the resource estimator
I0812 06:52:05.676463 30258 process.cpp:3714] Handling HTTP event for process 'slave(701)' with path: '/slave(701)/monitor/statistics'
I0812 06:52:05.678746 30258 http.cpp:871] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0812 06:52:05.682296 30232 slave.cpp:809] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (37 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0812 06:52:05.692937 30232 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0812 06:52:05.693646 30232 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0812 06:52:05.694000 30232 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0812 06:52:05.694291 30232 provisioner.cpp:249] Using default backend 'copy'
I0812 06:52:05.698251 30252 slave.cpp:217] Mesos agent started on (702)@172.17.0.4:46103
I0812 06:52:05.698290 30252 slave.cpp:218] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_ZEmG8y/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_ZEmG8y/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_ZEmG8y/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.3/_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_ZEmG8y" --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_QEXybg"
I0812 06:52:05.698917 30252 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_ZEmG8y/credential'
I0812 06:52:05.699085 30252 slave.cpp:360] Agent using credential for: test-principal
I0812 06:52:05.699169 30252 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_ZEmG8y/http_credentials'
I0812 06:52:05.699439 30252 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0812 06:52:05.699677 30252 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0812 06:52:05.700908 30252 slave.cpp:547] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0812 06:52:05.700999 30252 slave.cpp:555] Agent attributes: [ ]
I0812 06:52:05.701016 30252 slave.cpp:560] Agent hostname: 4f646ed7871e
I0812 06:52:05.701316 30256 status_update_manager.cpp:177] Pausing sending status updates
I0812 06:52:05.703083 30257 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_QEXybg/meta'
I0812 06:52:05.703641 30257 status_update_manager.cpp:203] Recovering status update manager
I0812 06:52:05.703938 30258 containerizer.cpp:600] Recovering containerizer
I0812 06:52:05.705997 30251 provisioner.cpp:410] Provisioner recovery complete
I0812 06:52:05.706665 30251 slave.cpp:5662] Finished recovery
I0812 06:52:05.707459 30251 slave.cpp:5836] Querying resource estimator for oversubscribable resources
I0812 06:52:05.707744 30251 slave.cpp:5850] Received oversubscribable resources {} from the resource estimator
I0812 06:52:05.711022 30255 process.cpp:3714] Handling HTTP event for process 'slave(702)' with path: '/slave(702)/monitor/statistics.json'
I0812 06:52:05.712855 30255 http.cpp:871] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0812 06:52:05.716400 30256 slave.cpp:809] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (32 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0812 06:52:05.726312 30232 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0812 06:52:05.727226 30232 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0812 06:52:05.727648 30232 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0812 06:52:05.727937 30232 provisioner.cpp:249] Using default backend 'copy'
I0812 06:52:05.731984 30251 slave.cpp:217] Mesos agent started on (703)@172.17.0.4:46103
I0812 06:52:05.732017 30251 slave.cpp:218] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_vCslhN/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_vCslhN/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_vCslhN/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.3/_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_vCslhN" --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_AIhleu"
I0812 06:52:05.732527 30251 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_vCslhN/credential'
I0812 06:52:05.732697 30251 slave.cpp:360] Agent using credential for: test-principal
I0812 06:52:05.732725 30251 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_vCslhN/http_credentials'
I0812 06:52:05.733197 30251 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0812 06:52:05.733336 30251 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0812 06:52:05.734788 30251 slave.cpp:547] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0812 06:52:05.734877 30251 slave.cpp:555] Agent attributes: [ ]
I0812 06:52:05.734896 30251 slave.cpp:560] Agent hostname: 4f646ed7871e
I0812 06:52:05.735080 30258 status_update_manager.cpp:177] Pausing sending status updates
I0812 06:52:05.736933 30255 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_AIhleu/meta'
I0812 06:52:05.737287 30258 status_update_manager.cpp:203] Recovering status update manager
I0812 06:52:05.737578 30255 containerizer.cpp:600] Recovering containerizer
I0812 06:52:05.739130 30255 provisioner.cpp:410] Provisioner recovery complete
I0812 06:52:05.739630 30255 slave.cpp:5662] Finished recovery
I0812 06:52:05.740571 30255 slave.cpp:5836] Querying resource estimator for oversubscribable resources
I0812 06:52:05.740957 30251 slave.cpp:5850] Received oversubscribable resources {} from the resource estimator
I0812 06:52:05.744184 30253 process.cpp:3714] Handling HTTP event for process 'slave(703)' with path: '/slave(703)/containers'
I0812 06:52:05.745777 30253 http.cpp:871] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0812 06:52:05.748785 30232 slave.cpp:809] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (32 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0812 06:52:05.758663 30232 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0812 06:52:05.759382 30232 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0812 06:52:05.759764 30232 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0812 06:52:05.760036 30232 provisioner.cpp:249] Using default backend 'copy'
I0812 06:52:05.762609 30232 cluster.cpp:446] Creating default 'local' authorizer
I0812 06:52:05.765167 30258 slave.cpp:217] Mesos agent started on (704)@172.17.0.4:46103
I0812 06:52:05.765197 30258 slave.cpp:218] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_s9JNM1/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_s9JNM1/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_s9JNM1/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.3/_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_s9JNM1" --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_M8F9DI"
I0812 06:52:05.765768 30258 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_s9JNM1/credential'
I0812 06:52:05.765988 30258 slave.cpp:360] Agent using credential for: test-principal
I0812 06:52:05.766016 30258 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_s9JNM1/http_credentials'
I0812 06:52:05.766319 30258 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0812 06:52:05.766461 30258 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0812 06:52:05.767722 30258 slave.cpp:547] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0812 06:52:05.767812 30258 slave.cpp:555] Agent attributes: [ ]
I0812 06:52:05.767830 30258 slave.cpp:560] Agent hostname: 4f646ed7871e
I0812 06:52:05.769387 30258 status_update_manager.cpp:177] Pausing sending status updates
I0812 06:52:05.769722 30253 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_M8F9DI/meta'
I0812 06:52:05.770232 30254 status_update_manager.cpp:203] Recovering status update manager
I0812 06:52:05.770754 30257 containerizer.cpp:600] Recovering containerizer
I0812 06:52:05.772266 30254 provisioner.cpp:410] Provisioner recovery complete
I0812 06:52:05.773342 30257 slave.cpp:5662] Finished recovery
I0812 06:52:05.773849 30257 slave.cpp:5836] Querying resource estimator for oversubscribable resources
I0812 06:52:05.774595 30257 slave.cpp:5850] Received oversubscribable resources {} from the resource estimator
I0812 06:52:05.777917 30256 process.cpp:3714] Handling HTTP event for process 'slave(704)' with path: '/slave(704)/monitor/statistics'
I0812 06:52:05.779808 30256 http.cpp:871] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0812 06:52:05.784467 30257 slave.cpp:809] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (36 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0812 06:52:05.795786 30232 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0812 06:52:05.796478 30232 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0812 06:52:05.797081 30232 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0812 06:52:05.797384 30232 provisioner.cpp:249] Using default backend 'copy'
I0812 06:52:05.799268 30232 cluster.cpp:446] Creating default 'local' authorizer
I0812 06:52:05.801436 30252 slave.cpp:217] Mesos agent started on (705)@172.17.0.4:46103
I0812 06:52:05.801462 30252 slave.cpp:218] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_n8wBHg/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_n8wBHg/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_n8wBHg/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.3/_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_n8wBHg" --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_RgNrsX"
I0812 06:52:05.801935 30252 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_n8wBHg/credential'
I0812 06:52:05.802160 30252 slave.cpp:360] Agent using credential for: test-principal
I0812 06:52:05.802187 30252 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_n8wBHg/http_credentials'
I0812 06:52:05.802459 30252 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0812 06:52:05.802680 30252 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0812 06:52:05.803880 30252 slave.cpp:547] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0812 06:52:05.803969 30252 slave.cpp:555] Agent attributes: [ ]
I0812 06:52:05.803988 30252 slave.cpp:560] Agent hostname: 4f646ed7871e
I0812 06:52:05.805714 30252 status_update_manager.cpp:177] Pausing sending status updates
I0812 06:52:05.806290 30255 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_RgNrsX/meta'
I0812 06:52:05.807046 30255 status_update_manager.cpp:203] Recovering status update manager
I0812 06:52:05.807344 30254 containerizer.cpp:600] Recovering containerizer
I0812 06:52:05.809780 30252 provisioner.cpp:410] Provisioner recovery complete
I0812 06:52:05.810274 30254 slave.cpp:5662] Finished recovery
I0812 06:52:05.811221 30254 slave.cpp:5836] Querying resource estimator for oversubscribable resources
I0812 06:52:05.811764 30254 slave.cpp:5850] Received oversubscribable resources {} from the resource estimator
I0812 06:52:05.815397 30251 process.cpp:3714] Handling HTTP event for process 'slave(705)' with path: '/slave(705)/monitor/statistics.json'
I0812 06:52:05.817137 30251 http.cpp:871] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0812 06:52:05.821265 30232 slave.cpp:809] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (35 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0812 06:52:05.831279 30232 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0812 06:52:05.831989 30232 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0812 06:52:05.832345 30232 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0812 06:52:05.833192 30232 provisioner.cpp:249] Using default backend 'copy'
I0812 06:52:05.835053 30232 cluster.cpp:446] Creating default 'local' authorizer
I0812 06:52:05.837355 30253 slave.cpp:217] Mesos agent started on (706)@172.17.0.4:46103
I0812 06:52:05.837380 30253 slave.cpp:218] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_24VG1v/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_24VG1v/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_24VG1v/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.3/_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_24VG1v" --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_ia6hGc"
I0812 06:52:05.838457 30253 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_24VG1v/credential'
I0812 06:52:05.838663 30253 slave.cpp:360] Agent using credential for: test-principal
I0812 06:52:05.838692 30253 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_24VG1v/http_credentials'
I0812 06:52:05.839370 30253 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0812 06:52:05.839526 30253 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0812 06:52:05.840981 30253 slave.cpp:547] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0812 06:52:05.841081 30253 slave.cpp:555] Agent attributes: [ ]
I0812 06:52:05.841100 30253 slave.cpp:560] Agent hostname: 4f646ed7871e
I0812 06:52:05.841375 30255 status_update_manager.cpp:177] Pausing sending status updates
I0812 06:52:05.847434 30258 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_ia6hGc/meta'
I0812 06:52:05.847956 30252 status_update_manager.cpp:203] Recovering status update manager
I0812 06:52:05.848178 30252 containerizer.cpp:600] Recovering containerizer
I0812 06:52:05.850226 30253 provisioner.cpp:410] Provisioner recovery complete
I0812 06:52:05.850725 30256 slave.cpp:5662] Finished recovery
I0812 06:52:05.851668 30256 slave.cpp:5836] Querying resource estimator for oversubscribable resources
I0812 06:52:05.852394 30256 slave.cpp:5850] Received oversubscribable resources {} from the resource estimator
I0812 06:52:05.856876 30255 process.cpp:3714] Handling HTTP event for process 'slave(706)' with path: '/slave(706)/containers'
I0812 06:52:05.858700 30255 http.cpp:871] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0812 06:52:05.863514 30232 slave.cpp:809] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (42 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (346 ms total)
[----------] Global test environment tear-down
[==========] 1498 tests from 168 test cases ran. (472675 ms total)
[ PASSED ] 1497 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] OversubscriptionTest.RescindRevocableOfferWithIncreasedRevocable
1 FAILED TEST
YOU HAVE 11 DISABLED TESTS
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.2.3/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.2.3/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.2.3/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.2.3/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1502516758-138
Untagged: mesos-1502516758-138:latest
Deleted: sha256:da3080f59abda7a70a843da79eb2aafdf3fa38992ebcc358a4632c199f80990b
Deleted: sha256:4e77d1b73d0854400f3699a89edf0201f0566c31010079f9fcbc65f6a9cc9341
Deleted: sha256:ace4f77ddc834d5f039f821033e1afbe9990ada7622c56a6c134360818b7fa4f
Deleted: sha256:57afabdec48b6de9998af82c7deeab7d31f66e4a124c60c61314aae315354306
Deleted: sha256:dad6e24a32c1fb8fed121359231fdf6eeb0dd40c5acd60add3555fcffb36609e
Deleted: sha256:122b0d56c3b3ea7d5c20ea5b782dd4e0fdf3691d8a6dca56b0911b0c4338cc8f
Deleted: sha256:4f39b362c2e86da6aa6126e8cd81100510bdf9b7b0dea4f15cc7291400450d89
Deleted: sha256:bd1061bfce5614e2db62f8821645c18acfe3c178830f46f803302aa5156fd71f
Deleted: sha256:6e91372fa3001529e3bd5bef38fdc91e0f1c3f81a4ae6e3ce37524f598e779c6
Deleted: sha256:bf488019476099f7ebc8f0e52731f3924225122e32552aa7f93a0b4febdfdd82
Deleted: sha256:19ec8cff8e79bc6799f8560150dd110e140a2497a619f0c815e490b806102f9a
Deleted: sha256:ba89d166681c16f9ca841daba1fd477e21d5078db7d7d111325e88d89c1ed620
Deleted: sha256:12f29f015ca65017b48d8d159017fc4ea20b432a6b82f0653cbbc39f92a60f3f
Deleted: sha256:190e08618f388d6d3aaf0706800acaaf937104d3fa8166fb39b6b3e9e324e059
Deleted: sha256:ada0ac36f5fb2a96cced800ed49a142dc0bafb2881419590a7ef870f4b30307d
Deleted: sha256:ddecda9a86f01f31bb22e93cf2b04d72e6a664c72a3615269b7cd24638f8a54a
Deleted: sha256:0c46c88c4b59a32cf329edf00ed8433ac2fc4c0477b0517a52f7bd769e228f4f
Deleted: sha256:8271125cb2609459fd873c11966a5559c503e0e3fab7b4b65bcb668b7e88f123
Deleted: sha256:46828d1801bb189f1541aacfffe4888359e8a147a528ab4572ebf3b17d8c5490
Deleted: sha256:7e0d755b839a207ee3293089a4eb0174e1f074d53130b23e617878d8c2956622
Deleted: sha256:cede10e667aa7de8e80cd1d96df6d66b9a59b21f4dd28ee2bcbe9ccf90a0c14f
Deleted: sha256:1022916096f2a3b41c1e1c01558fb1f8424925ae752cd170c93fdc1169f67ada
Deleted: sha256:284a61b1ac154a9f4786711c0035899605c416df490ed253475769ef418fc103
Deleted: sha256:efc83e15e41596de078c676c9fcd59b370ea37c62c86edf56c3c2704c74929f7
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user songzihao1990@gmail.com
Not sending mail to unregistered user alexander@mesosphere.io
Not sending mail to unregistered user yujie.jay@gmail.com
Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #4101
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/4101/display/redirect?page=changes>
Changes:
[songzihao1990] Created staging dir only when needed.
[songzihao1990] Added MESOS-6950 to 1.3.2 CHANGELOG.
------------------------------------------
[...truncated 20.53 MB...]
I0812 05:40:14.835602 30453 slave.cpp:3510] Status update manager successfully handled status update acknowledgement (UUID: 28929006-71d1-4ee6-a42f-e7a43dbf56ad) for task 2 of framework 19d2323c-5c25-4e67-9ec6-b5f0093631e2-0000
I0812 05:40:14.835652 30453 slave.cpp:7382] Completing task 2
I0812 05:40:14.835791 30453 slave.cpp:5317] Cleaning up executor 'default' of framework 19d2323c-5c25-4e67-9ec6-b5f0093631e2-0000 at executor(145)@172.17.0.4:34443
I0812 05:40:14.836233 30448 gc.cpp:55] Scheduling '/tmp/SlaveTest_ExecutorShutdownGracePeriod_vmF6wT/slaves/19d2323c-5c25-4e67-9ec6-b5f0093631e2-S0/frameworks/19d2323c-5c25-4e67-9ec6-b5f0093631e2-0000/executors/default/runs/48fa6422-4048-4d5a-ac73-d2148278d1df' for gc 6.99999054782222days in the future
I0812 05:40:14.836602 30448 gc.cpp:55] Scheduling '/tmp/SlaveTest_ExecutorShutdownGracePeriod_vmF6wT/slaves/19d2323c-5c25-4e67-9ec6-b5f0093631e2-S0/frameworks/19d2323c-5c25-4e67-9ec6-b5f0093631e2-0000/executors/default' for gc 6.99999054782222days in the future
I0812 05:40:14.836617 30453 slave.cpp:5405] Cleaning up framework 19d2323c-5c25-4e67-9ec6-b5f0093631e2-0000
I0812 05:40:14.836843 30448 status_update_manager.cpp:285] Closing status update streams for framework 19d2323c-5c25-4e67-9ec6-b5f0093631e2-0000
I0812 05:40:14.837118 30451 gc.cpp:55] Scheduling '/tmp/SlaveTest_ExecutorShutdownGracePeriod_vmF6wT/slaves/19d2323c-5c25-4e67-9ec6-b5f0093631e2-S0/frameworks/19d2323c-5c25-4e67-9ec6-b5f0093631e2-0000' for gc 6.99999054782222days in the future
I0812 05:40:14.837896 30429 sched.cpp:2021] Asked to stop the driver
I0812 05:40:14.838230 30450 sched.cpp:1203] Stopping framework 19d2323c-5c25-4e67-9ec6-b5f0093631e2-0000
I0812 05:40:14.838474 30454 master.cpp:7988] Processing TEARDOWN call for framework 19d2323c-5c25-4e67-9ec6-b5f0093631e2-0000 (default) at scheduler-d6454e89-89ad-4062-afac-a4006824a8ae@172.17.0.4:34443
I0812 05:40:14.838512 30454 master.cpp:8000] Removing framework 19d2323c-5c25-4e67-9ec6-b5f0093631e2-0000 (default) at scheduler-d6454e89-89ad-4062-afac-a4006824a8ae@172.17.0.4:34443
I0812 05:40:14.838546 30454 master.cpp:3160] Deactivating framework 19d2323c-5c25-4e67-9ec6-b5f0093631e2-0000 (default) at scheduler-d6454e89-89ad-4062-afac-a4006824a8ae@172.17.0.4:34443
I0812 05:40:14.839015 30452 hierarchical.cpp:374] Deactivated framework 19d2323c-5c25-4e67-9ec6-b5f0093631e2-0000
I0812 05:40:14.839202 30452 slave.cpp:3063] Asked to shut down framework 19d2323c-5c25-4e67-9ec6-b5f0093631e2-0000 by master@172.17.0.4:34443
I0812 05:40:14.839263 30452 slave.cpp:3078] Cannot shut down unknown framework 19d2323c-5c25-4e67-9ec6-b5f0093631e2-0000
I0812 05:40:14.839793 30450 hierarchical.cpp:325] Removed framework 19d2323c-5c25-4e67-9ec6-b5f0093631e2-0000
I0812 05:40:14.842948 30453 slave.cpp:796] Agent terminating
I0812 05:40:14.843319 30455 master.cpp:1313] Agent 19d2323c-5c25-4e67-9ec6-b5f0093631e2-S0 at slave(534)@172.17.0.4:34443 (d4234aed7808) disconnected
I0812 05:40:14.843374 30455 master.cpp:3197] Disconnecting agent 19d2323c-5c25-4e67-9ec6-b5f0093631e2-S0 at slave(534)@172.17.0.4:34443 (d4234aed7808)
I0812 05:40:14.843730 30455 master.cpp:3216] Deactivating agent 19d2323c-5c25-4e67-9ec6-b5f0093631e2-S0 at slave(534)@172.17.0.4:34443 (d4234aed7808)
I0812 05:40:14.844127 30453 hierarchical.cpp:653] Agent 19d2323c-5c25-4e67-9ec6-b5f0093631e2-S0 deactivated
I0812 05:40:14.847326 30429 master.cpp:1155] Master terminating
I0812 05:40:14.848579 30449 hierarchical.cpp:558] Removed agent 19d2323c-5c25-4e67-9ec6-b5f0093631e2-S0
[ OK ] SlaveTest.ExecutorShutdownGracePeriod (154 ms)
[ RUN ] SlaveTest.RunTaskGroup
I0812 05:40:14.864682 30429 cluster.cpp:162] Creating default 'local' authorizer
I0812 05:40:14.867913 30450 master.cpp:436] Master ff825c64-b7f2-4e77-ab90-202010eaba71 (d4234aed7808) started on 172.17.0.4:34443
I0812 05:40:14.867939 30450 master.cpp:438] 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/DYgYcI/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --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.3.2/_inst/share/mesos/webui" --work_dir="/tmp/DYgYcI/master" --zk_session_timeout="10secs"
I0812 05:40:14.868810 30450 master.cpp:488] Master only allowing authenticated frameworks to register
I0812 05:40:14.868852 30450 master.cpp:502] Master only allowing authenticated agents to register
I0812 05:40:14.868866 30450 master.cpp:515] Master only allowing authenticated HTTP frameworks to register
I0812 05:40:14.868878 30450 credentials.hpp:37] Loading credentials for authentication from '/tmp/DYgYcI/credentials'
I0812 05:40:14.869307 30450 master.cpp:560] Using default 'crammd5' authenticator
I0812 05:40:14.869953 30450 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0812 05:40:14.870225 30450 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0812 05:40:14.870514 30450 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0812 05:40:14.870762 30450 master.cpp:640] Authorization enabled
I0812 05:40:14.871150 30448 hierarchical.cpp:158] Initialized hierarchical allocator process
I0812 05:40:14.871273 30453 whitelist_watcher.cpp:77] No whitelist given
I0812 05:40:14.874591 30450 master.cpp:2161] Elected as the leading master!
I0812 05:40:14.874629 30450 master.cpp:1700] Recovering from registrar
I0812 05:40:14.875021 30451 registrar.cpp:345] Recovering registrar
I0812 05:40:14.875838 30451 registrar.cpp:389] Successfully fetched the registry (0B) in 745216ns
I0812 05:40:14.876098 30451 registrar.cpp:493] Applied 1 operations in 39958ns; attempting to update the registry
I0812 05:40:14.877069 30451 registrar.cpp:550] Successfully updated the registry in 879104ns
I0812 05:40:14.877455 30451 registrar.cpp:422] Successfully recovered registrar
I0812 05:40:14.878293 30454 master.cpp:1799] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0812 05:40:14.878314 30449 hierarchical.cpp:185] Skipping recovery of hierarchical allocator: nothing to recover
I0812 05:40:14.883859 30429 cluster.cpp:448] Creating default 'local' authorizer
I0812 05:40:14.886981 30429 scheduler.cpp:184] Version: 1.3.2
I0812 05:40:14.887130 30452 slave.cpp:231] Mesos agent started on (535)@172.17.0.4:34443
I0812 05:40:14.887157 30452 slave.cpp:232] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/SlaveTest_RunTaskGroup_npao7C/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/SlaveTest_RunTaskGroup_npao7C/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/SlaveTest_RunTaskGroup_npao7C/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.3.2/_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/SlaveTest_RunTaskGroup_npao7C" --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/SlaveTest_RunTaskGroup_QiCaFa"
I0812 05:40:14.887622 30452 credentials.hpp:86] Loading credential for authentication from '/tmp/SlaveTest_RunTaskGroup_npao7C/credential'
I0812 05:40:14.887886 30452 slave.cpp:264] Agent using credential for: test-principal
I0812 05:40:14.887912 30452 credentials.hpp:37] Loading credentials for authentication from '/tmp/SlaveTest_RunTaskGroup_npao7C/http_credentials'
I0812 05:40:14.888084 30454 scheduler.cpp:470] New master detected at master@172.17.0.4:34443
I0812 05:40:14.888137 30454 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0812 05:40:14.888478 30452 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0812 05:40:14.888880 30452 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0812 05:40:14.893795 30448 scheduler.cpp:361] Connected with the master at http://172.17.0.4:34443/master/api/v1/scheduler
I0812 05:40:14.895002 30455 scheduler.cpp:243] Sending SUBSCRIBE call to http://172.17.0.4:34443/master/api/v1/scheduler
I0812 05:40:14.895002 30452 slave.cpp:531] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0812 05:40:14.895368 30452 slave.cpp:539] Agent attributes: [ ]
I0812 05:40:14.896817 30454 process.cpp:3741] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0812 05:40:14.896426 30452 slave.cpp:544] Agent hostname: d4234aed7808
I0812 05:40:14.898721 30455 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:49060
I0812 05:40:14.899154 30453 status_update_manager.cpp:177] Pausing sending status updates
I0812 05:40:14.899389 30455 master.cpp:2513] Received subscription request for HTTP framework 'default'
I0812 05:40:14.899603 30455 master.cpp:2197] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0812 05:40:14.901048 30455 master.cpp:2628] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I0812 05:40:14.902240 30455 hierarchical.cpp:273] Added framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000
I0812 05:40:14.902294 30448 master.hpp:2194] Sending heartbeat to ff825c64-b7f2-4e77-ab90-202010eaba71-0000
I0812 05:40:14.903636 30448 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from http://172.17.0.4:34443/master/api/v1/scheduler
I0812 05:40:14.904119 30455 hierarchical.cpp:1850] No allocations performed
I0812 05:40:14.905057 30455 hierarchical.cpp:1940] No inverse offers to send out!
I0812 05:40:14.905230 30455 hierarchical.cpp:1434] Performed allocation for 0 agents in 1.15387ms
I0812 05:40:14.904983 30448 scheduler.cpp:676] Enqueuing event HEARTBEAT received from http://172.17.0.4:34443/master/api/v1/scheduler
I0812 05:40:14.906682 30452 state.cpp:62] Recovering state from '/tmp/SlaveTest_RunTaskGroup_QiCaFa/meta'
I0812 05:40:14.907124 30455 status_update_manager.cpp:203] Recovering status update manager
I0812 05:40:14.907634 30451 slave.cpp:6075] Finished recovery
I0812 05:40:14.908484 30451 slave.cpp:6257] Querying resource estimator for oversubscribable resources
I0812 05:40:14.908867 30451 slave.cpp:924] New master detected at master@172.17.0.4:34443
I0812 05:40:14.908900 30454 status_update_manager.cpp:177] Pausing sending status updates
I0812 05:40:14.909284 30451 slave.cpp:959] Detecting new master
I0812 05:40:14.909541 30451 slave.cpp:6271] Received oversubscribable resources {} from the resource estimator
I0812 05:40:14.915885 30454 slave.cpp:986] Authenticating with master master@172.17.0.4:34443
I0812 05:40:14.915966 30454 slave.cpp:997] Using default CRAM-MD5 authenticatee
I0812 05:40:14.916524 30451 authenticatee.cpp:121] Creating new client SASL connection
I0812 05:40:14.916925 30454 master.cpp:7475] Authenticating slave(535)@172.17.0.4:34443
I0812 05:40:14.917060 30449 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1079)@172.17.0.4:34443
I0812 05:40:14.917598 30451 authenticator.cpp:98] Creating new server SASL connection
I0812 05:40:14.917920 30449 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0812 05:40:14.917976 30449 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0812 05:40:14.918356 30449 authenticator.cpp:204] Received SASL authentication start
I0812 05:40:14.918874 30449 authenticator.cpp:326] Authentication requires more steps
I0812 05:40:14.919100 30451 authenticatee.cpp:259] Received SASL authentication step
I0812 05:40:14.919266 30451 authenticator.cpp:232] Received SASL authentication step
I0812 05:40:14.919329 30451 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'd4234aed7808' server FQDN: 'd4234aed7808' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0812 05:40:14.919459 30451 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0812 05:40:14.919713 30451 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0812 05:40:14.919787 30451 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'd4234aed7808' server FQDN: 'd4234aed7808' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0812 05:40:14.919832 30451 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0812 05:40:14.919971 30451 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0812 05:40:14.920038 30451 authenticator.cpp:318] Authentication success
I0812 05:40:14.920578 30453 authenticatee.cpp:299] Authentication success
I0812 05:40:14.920768 30451 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1079)@172.17.0.4:34443
I0812 05:40:14.921120 30455 master.cpp:7505] Successfully authenticated principal 'test-principal' at slave(535)@172.17.0.4:34443
I0812 05:40:14.921500 30453 slave.cpp:1081] Successfully authenticated with master master@172.17.0.4:34443
I0812 05:40:14.921869 30453 slave.cpp:1509] Will retry registration in 10.886804ms if necessary
I0812 05:40:14.922124 30454 master.cpp:5429] Received register agent message from slave(535)@172.17.0.4:34443 (d4234aed7808)
I0812 05:40:14.922255 30454 master.cpp:3659] Authorizing agent with principal 'test-principal'
I0812 05:40:14.923087 30454 master.cpp:5564] Registering agent at slave(535)@172.17.0.4:34443 (d4234aed7808) with id ff825c64-b7f2-4e77-ab90-202010eaba71-S0
I0812 05:40:14.923565 30454 registrar.cpp:493] Applied 1 operations in 58012ns; attempting to update the registry
I0812 05:40:14.924428 30454 registrar.cpp:550] Successfully updated the registry in 570880ns
I0812 05:40:14.925226 30451 slave.cpp:4794] Received ping from slave-observer(506)@172.17.0.4:34443
I0812 05:40:14.925729 30453 hierarchical.cpp:525] Added agent ff825c64-b7f2-4e77-ab90-202010eaba71-S0 (d4234aed7808) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0812 05:40:14.926010 30451 slave.cpp:1127] Registered with master master@172.17.0.4:34443; given agent ID ff825c64-b7f2-4e77-ab90-202010eaba71-S0
I0812 05:40:14.926196 30451 fetcher.cpp:94] Clearing fetcher cache
I0812 05:40:14.925935 30450 master.cpp:5639] Registered agent ff825c64-b7f2-4e77-ab90-202010eaba71-S0 at slave(535)@172.17.0.4:34443 (d4234aed7808) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0812 05:40:14.926839 30451 slave.cpp:1155] Checkpointing SlaveInfo to '/tmp/SlaveTest_RunTaskGroup_QiCaFa/meta/slaves/ff825c64-b7f2-4e77-ab90-202010eaba71-S0/slave.info'
I0812 05:40:14.926990 30452 status_update_manager.cpp:184] Resuming sending status updates
I0812 05:40:14.927417 30451 slave.cpp:1193] Forwarding total oversubscribed resources {}
I0812 05:40:14.927703 30451 master.cpp:6324] Received update of agent ff825c64-b7f2-4e77-ab90-202010eaba71-S0 at slave(535)@172.17.0.4:34443 (d4234aed7808) with total oversubscribed resources {}
I0812 05:40:14.928817 30453 hierarchical.cpp:1940] No inverse offers to send out!
I0812 05:40:14.929505 30452 master.cpp:7305] Sending 1 offers to framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000 (default)
I0812 05:40:14.930258 30453 hierarchical.cpp:1434] Performed allocation for 1 agents in 3.928738ms
I0812 05:40:14.932201 30452 scheduler.cpp:676] Enqueuing event OFFERS received from http://172.17.0.4:34443/master/api/v1/scheduler
I0812 05:40:14.935523 30454 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.4:34443/master/api/v1/scheduler
I0812 05:40:14.937803 30449 process.cpp:3741] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0812 05:40:14.940008 30450 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:49058
I0812 05:40:14.941661 30450 master.cpp:3875] Processing ACCEPT call for offers: [ ff825c64-b7f2-4e77-ab90-202010eaba71-O0 ] on agent ff825c64-b7f2-4e77-ab90-202010eaba71-S0 at slave(535)@172.17.0.4:34443 (d4234aed7808) for framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000 (default)
I0812 05:40:14.942004 30450 master.cpp:3426] Authorizing framework principal 'test-principal' to launch task fe392c92-a5ca-4128-bb8d-0818835993d5
I0812 05:40:14.942905 30450 master.cpp:3426] Authorizing framework principal 'test-principal' to launch task 324751d8-adf4-4dc9-81a1-1b5d2b9ab7b8
I0812 05:40:14.949158 30450 master.cpp:9320] Adding task fe392c92-a5ca-4128-bb8d-0818835993d5 with resources cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 on agent ff825c64-b7f2-4e77-ab90-202010eaba71-S0 at slave(535)@172.17.0.4:34443 (d4234aed7808)
I0812 05:40:14.949744 30450 master.cpp:9320] Adding task 324751d8-adf4-4dc9-81a1-1b5d2b9ab7b8 with resources cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 on agent ff825c64-b7f2-4e77-ab90-202010eaba71-S0 at slave(535)@172.17.0.4:34443 (d4234aed7808)
I0812 05:40:14.950201 30450 master.cpp:4736] Launching task group { 324751d8-adf4-4dc9-81a1-1b5d2b9ab7b8, fe392c92-a5ca-4128-bb8d-0818835993d5 } of framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000 (default) with resources cpus(*)(allocated: *):0.2; mem(*)(allocated: *):64; disk(*)(allocated: *):64 on agent ff825c64-b7f2-4e77-ab90-202010eaba71-S0 at slave(535)@172.17.0.4:34443 (d4234aed7808)
I0812 05:40:14.950906 30455 slave.cpp:1619] Got assigned task group containing tasks [ fe392c92-a5ca-4128-bb8d-0818835993d5, 324751d8-adf4-4dc9-81a1-1b5d2b9ab7b8 ] for framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000
I0812 05:40:14.951617 30450 hierarchical.cpp:1114] Recovered cpus(*)(allocated: *):1.7; mem(*)(allocated: *):928; disk(*)(allocated: *):928; ports(*)(allocated: *):[31000-32000] (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*)(allocated: *):0.3; mem(*)(allocated: *):96; disk(*)(allocated: *):96) on agent ff825c64-b7f2-4e77-ab90-202010eaba71-S0 from framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000
I0812 05:40:14.951768 30450 hierarchical.cpp:1151] Framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000 filtered agent ff825c64-b7f2-4e77-ab90-202010eaba71-S0 for 5secs
I0812 05:40:14.952697 30455 slave.cpp:1900] Authorizing task group containing tasks [ fe392c92-a5ca-4128-bb8d-0818835993d5, 324751d8-adf4-4dc9-81a1-1b5d2b9ab7b8 ] for framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000
I0812 05:40:14.952802 30455 slave.cpp:6694] Authorizing framework principal 'test-principal' to launch task fe392c92-a5ca-4128-bb8d-0818835993d5
I0812 05:40:14.953253 30455 slave.cpp:6694] Authorizing framework principal 'test-principal' to launch task 324751d8-adf4-4dc9-81a1-1b5d2b9ab7b8
I0812 05:40:14.955127 30455 slave.cpp:2087] Launching task group containing tasks [ fe392c92-a5ca-4128-bb8d-0818835993d5, 324751d8-adf4-4dc9-81a1-1b5d2b9ab7b8 ] for framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000
I0812 05:40:14.955945 30455 paths.cpp:573] Trying to chown '/tmp/SlaveTest_RunTaskGroup_QiCaFa/slaves/ff825c64-b7f2-4e77-ab90-202010eaba71-S0/frameworks/ff825c64-b7f2-4e77-ab90-202010eaba71-0000/executors/default/runs/83d43487-3b86-4c15-947e-189f4f218f8a' to user 'mesos'
I0812 05:40:14.956709 30455 slave.cpp:7038] Launching executor 'default' of framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000 with resources cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 in work directory '/tmp/SlaveTest_RunTaskGroup_QiCaFa/slaves/ff825c64-b7f2-4e77-ab90-202010eaba71-S0/frameworks/ff825c64-b7f2-4e77-ab90-202010eaba71-0000/executors/default/runs/83d43487-3b86-4c15-947e-189f4f218f8a'
I0812 05:40:14.959306 30451 executor.cpp:192] Version: 1.3.2
I0812 05:40:14.960021 30455 slave.cpp:2316] Queued task group containing tasks [ fe392c92-a5ca-4128-bb8d-0818835993d5, 324751d8-adf4-4dc9-81a1-1b5d2b9ab7b8 ] for executor 'default' of framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000
I0812 05:40:14.960484 30455 slave.cpp:877] Successfully attached file '/tmp/SlaveTest_RunTaskGroup_QiCaFa/slaves/ff825c64-b7f2-4e77-ab90-202010eaba71-S0/frameworks/ff825c64-b7f2-4e77-ab90-202010eaba71-0000/executors/default/runs/83d43487-3b86-4c15-947e-189f4f218f8a'
I0812 05:40:14.962484 30454 executor.cpp:410] Connected with the agent
I0812 05:40:14.963312 30453 executor.cpp:307] Sending SUBSCRIBE call to http://172.17.0.4:34443/slave(535)/api/v1/executor
I0812 05:40:14.965889 30449 process.cpp:3741] Handling HTTP event for process 'slave(535)' with path: '/slave(535)/api/v1/executor'
I0812 05:40:14.967680 30451 http.cpp:1115] HTTP POST for /slave(535)/api/v1/executor from 172.17.0.4:49064
I0812 05:40:14.968014 30451 slave.cpp:3574] Received Subscribe request for HTTP executor 'default' of framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000
I0812 05:40:14.969800 30451 slave.cpp:2558] Sending queued task group task group containing tasks [ fe392c92-a5ca-4128-bb8d-0818835993d5, 324751d8-adf4-4dc9-81a1-1b5d2b9ab7b8 ] to executor 'default' of framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000 (via HTTP)
I0812 05:40:14.972560 30452 executor.cpp:725] Enqueuing event SUBSCRIBED received from http://172.17.0.4:34443/slave(535)/api/v1/executor
I0812 05:40:14.976032 30449 executor.cpp:725] Enqueuing event LAUNCH_GROUP received from http://172.17.0.4:34443/slave(535)/api/v1/executor
I0812 05:40:14.986484 30448 master.cpp:1430] Framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000 (default) disconnected
I0812 05:40:14.986704 30448 master.cpp:3160] Deactivating framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000 (default)
I0812 05:40:14.987061 30448 master.cpp:3137] Disconnecting framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000 (default)
I0812 05:40:14.987128 30448 master.cpp:1445] Giving framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000 (default) 0ns to failover
I0812 05:40:14.987812 30448 hierarchical.cpp:374] Deactivated framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000
I0812 05:40:14.988847 30454 master.cpp:7146] Framework failover timeout, removing framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000 (default)
I0812 05:40:14.988878 30454 master.cpp:8000] Removing framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000 (default)
I0812 05:40:14.989279 30448 slave.cpp:3063] Asked to shut down framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000 by master@172.17.0.4:34443
I0812 05:40:14.989287 30454 master.cpp:8568] Updating the state of task 324751d8-adf4-4dc9-81a1-1b5d2b9ab7b8 of framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0812 05:40:14.989631 30448 slave.cpp:3088] Shutting down framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000
I0812 05:40:14.989884 30448 slave.cpp:5531] Shutting down executor 'default' of framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000 (via HTTP)
I0812 05:40:14.990332 30454 master.cpp:8662] Removing task 324751d8-adf4-4dc9-81a1-1b5d2b9ab7b8 with resources cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 of framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000 on agent ff825c64-b7f2-4e77-ab90-202010eaba71-S0 at slave(535)@172.17.0.4:34443 (d4234aed7808)
I0812 05:40:14.990572 30454 master.cpp:8568] Updating the state of task fe392c92-a5ca-4128-bb8d-0818835993d5 of framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0812 05:40:14.990984 30448 hierarchical.cpp:1114] Recovered cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*)(allocated: *):0.2; mem(*)(allocated: *):64; disk(*)(allocated: *):64) on agent ff825c64-b7f2-4e77-ab90-202010eaba71-S0 from framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000
I0812 05:40:14.991066 30454 master.cpp:8662] Removing task fe392c92-a5ca-4128-bb8d-0818835993d5 with resources cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 of framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000 on agent ff825c64-b7f2-4e77-ab90-202010eaba71-S0 at slave(535)@172.17.0.4:34443 (d4234aed7808)
I0812 05:40:14.991446 30454 master.cpp:8691] Removing executor 'default' with resources cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 of framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000 on agent ff825c64-b7f2-4e77-ab90-202010eaba71-S0 at slave(535)@172.17.0.4:34443 (d4234aed7808)
I0812 05:40:14.991761 30448 hierarchical.cpp:1114] Recovered cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32) on agent ff825c64-b7f2-4e77-ab90-202010eaba71-S0 from framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000
I0812 05:40:14.992497 30448 hierarchical.cpp:1114] Recovered cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: {}) on agent ff825c64-b7f2-4e77-ab90-202010eaba71-S0 from framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000
I0812 05:40:14.992892 30448 hierarchical.cpp:325] Removed framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000
I0812 05:40:14.993697 30452 executor.cpp:725] Enqueuing event SHUTDOWN received from http://172.17.0.4:34443/slave(535)/api/v1/executor
I0812 05:40:14.994810 30452 slave.cpp:5217] Executor 'default' of framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000 exited with status 0
*** Aborted at 1502516414 (unix time) try "date -d @1502516414" if you are using GNU date ***
I0812 05:40:14.996114 30452 slave.cpp:5317] Cleaning up executor 'default' of framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000 (via HTTP)
I0812 05:40:14.996778 30452 slave.cpp:5405] Cleaning up framework ff825c64-b7f2-4e77-ab90-202010eaba71-0000
PC: @ 0x55f09d5bb942 testing::internal::UntypedFunctionMockerBase::SetOwnerAndName()
*** SIGSEGV (@0x2ab9b27a89e3) received by PID 30429 (TID 0x2ab9bcfb8700) from PID 18446744072408959459; stack trace: ***
@ 0x2ab9e87d9417 (unknown)
@ 0x2ab9e87dd6f9 (unknown)
@ 0x2ab9b4b13330 (unknown)
@ 0x55f09d5bb942 testing::internal::UntypedFunctionMockerBase::SetOwnerAndName()
@ 0x55f09c5a2c31 mesos::internal::tests::executor::MockHTTPExecutor<>::shutdown()
@ 0x55f09c59b9e1 mesos::internal::tests::executor::MockHTTPExecutor<>::event()
@ 0x55f09c593fda mesos::internal::tests::executor::TestMesos<>::events()
@ 0x55f09c5b9103 std::_Mem_fn<>::operator()<>()
@ 0x55f09c5ace07 _ZNSt5_BindIFSt7_Mem_fnIMN5mesos8internal5tests8executor9TestMesosINS1_2v18executor5MesosENS7_5EventEEEFvSt5queueIS9_St5dequeIS9_SaIS9_EEEEEPSA_St12_PlaceholderILi1EEEE6__callIvIRKSF_EILm0ELm1EEEET_OSt5tupleIIDpT0_EESt12_Index_tupleIIXspT1_EEE
@ 0x55f09c5a302f _ZNSt5_BindIFSt7_Mem_fnIMN5mesos8internal5tests8executor9TestMesosINS1_2v18executor5MesosENS7_5EventEEEFvSt5queueIS9_St5dequeIS9_SaIS9_EEEEEPSA_St12_PlaceholderILi1EEEEclIJRKSF_EvEET0_DpOT_
@ 0x55f09c59bda7 std::_Function_handler<>::_M_invoke()
@ 0x2ab9b1303c6b std::function<>::operator()()
@ 0x2ab9b12fd6da process::AsyncExecutorProcess::execute<>()
@ 0x2ab9b12fd80d _ZZN7process8dispatchI7NothingNS_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v18executor5EventESt5dequeIS8_SaIS8_EEEEESC_SG_SC_EENS_6FutureIT_EERKNS_3PIDIT0_EEMSN_FSK_T1_T2_ET3_T4_ENKUlPNS_11ProcessBaseEE_clESY_
@ 0x2ab9b130a184 _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8dispatchI7NothingNS0_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v18executor5EventESt5dequeISC_SaISC_EEEEESG_SK_SG_EENS0_6FutureIT_EERKNS0_3PIDIT0_EEMSR_FSO_T1_T2_ET3_T4_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_
@ 0x2ab9b27966cd std::function<>::operator()()
@ 0x2ab9b277c2c1 process::ProcessBase::visit()
@ 0x2ab9b2786bd0 process::DispatchEvent::visit()
@ 0x55f09c1a0716 process::ProcessBase::serve()
@ 0x2ab9b27785ea process::ProcessManager::resume()
@ 0x2ab9b2774db8 _ZZN7process14ProcessManager12init_threadsEvENKUt_clEv
@ 0x2ab9b2786334 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
@ 0x2ab9b278628b _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEclEv
@ 0x2ab9b2786224 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv
@ 0x2ab9b4394a60 (unknown)
@ 0x2ab9b4b0b184 start_thread
@ 0x2ab9b4e1effd (unknown)
make[4]: *** [check-local] Segmentation fault (core dumped)
make[4]: Leaving directory `/mesos/mesos-1.3.2/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.3.2/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.3.2/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.3.2/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1502512479-11713
Untagged: mesos-1502512479-11713:latest
Deleted: sha256:48406daf44aee6cd8ca378461bb05a4362b3bfc6d3ff5f5d7c1657422b5f700a
Deleted: sha256:5cc5ad636c9ee5fe48c0cd4550977fbf19d2bc14be83f1baf2610434996885ad
Deleted: sha256:85684b7de1059d29c0e0bb3cdc1c82bcdab2eb45d99e93338ffc02766e569f04
Deleted: sha256:ee6887885aaad6da1dcd93b79ffa34c73b73827855f49e56ea870ca138db55db
Deleted: sha256:55f2b5ba7d49cf2c38a820b04cac7fb02904cddf81207b997a8020d35339a445
Deleted: sha256:241926b248d47f34e277caab1c473c4b8dc91bace2a89cb6a89418053251b2e9
Deleted: sha256:005cdeabf506c7e29a133813fda5ef15dc39022cf656b3c627fd3a37a8b6d29a
Deleted: sha256:c8008e8820a07b551a88aa069c39f11bdf81382ad8cbadb0dd3aab8bd5e62f82
Deleted: sha256:f0c465acee17dd5af124da703cbbc133b2f450d98fb3f2924ba22e4a4f5d458c
Deleted: sha256:3c75a20610e4c05d17c5035d6b1c963c87cf76d119f833ac613bc8a4a0aad923
Deleted: sha256:7bef715bf54942427a683cd0db2bf614838edf112329fdb9616443e85bc866a6
Deleted: sha256:5c3517da3871c3f1d3d9277b7e3b1b4d166fa622dd4530fd4f4ab0bf32ff5cb9
Deleted: sha256:657b627644d20f3158d35ff414763f118df6cd3b9ddb469df663d70f0c6e7cda
Deleted: sha256:e2410d58db051c3d4aa26b5c65c793b8f3d66b914bbc9826e87a2319b9b727be
Deleted: sha256:ef0c55c63bb520fbe837a0c8e4cef6e84ec811f861b1de5ef1206c36c59f0f06
Deleted: sha256:8360ad2e320a6dc5c6a60bfd798f8ffb860e36d31d172f435f96ccf99893aed2
Deleted: sha256:d433a47328eb53e2034c4fe76bba54bae70af6da5d02f740482c3a2b6698c208
Deleted: sha256:6f56de8fb33ce727d7dbec9c7de16663bee03456be202e4dc6b2f463642f4954
Deleted: sha256:cd62d15bf5fe8316ed7ecc3e79ae43ca13b116eb6b5a2f82eebdd08880a362c8
Deleted: sha256:1bf10268794ee3bdb0a4e06b8e277ea516ba90b05b7096ddf599d199986cf393
Deleted: sha256:30c7d67dfc348f54424681e60b4b5a487adc36b1ea169f9aaeb73809d2e5dcca
Deleted: sha256:af920bcb326b7745b9c4b58159af813c389170cd508bb02c4fc116a82cd08aa8
Deleted: sha256:58382888c17713c3ca8207200c94c703605189d3cb8d048132807e99e18268a8
Deleted: sha256:ee6c7e40549d6f3917f94ed242d6f2c1b01cd01e6a43ac6103dbce1b22d3dfe6
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user songzihao1990@gmail.com
Not sending mail to unregistered user alexander@mesosphere.io
Not sending mail to unregistered user yujie.jay@gmail.com
Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #4100
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/4100/display/redirect?page=changes>
Changes:
[songzihao1990] Created staging dir only when needed.
[songzihao1990] Added MESOS-6950 to 1.3.2 CHANGELOG.
[songzihao1990] Added MESOS-6950 to 1.2.3 CHANGELOG.
[songzihao1990] Added MESOS-6950 to 1.1.3 CHANGELOG.
------------------------------------------
[...truncated 30.92 MB...]
I0812 00:52:33.293900 5199 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_TBOKlh/http_credentials'
I0812 00:52:33.294214 5199 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0812 00:52:33.294656 5199 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0812 00:52:33.296212 5199 slave.cpp:565] 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"}]
I0812 00:52:33.296433 5199 slave.cpp:573] Agent attributes: [ ]
I0812 00:52:33.296461 5199 slave.cpp:582] Agent hostname: ea1236f6ba4c
I0812 00:52:33.296689 5194 status_update_manager.cpp:177] Pausing sending status updates
I0812 00:52:33.299290 5194 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_F8ehS2/meta'
I0812 00:52:33.299887 5199 status_update_manager.cpp:203] Recovering status update manager
I0812 00:52:33.300194 5194 containerizer.cpp:598] Recovering containerizer
I0812 00:52:33.308921 5196 provisioner.cpp:416] Provisioner recovery complete
I0812 00:52:33.309528 5197 slave.cpp:6210] Finished recovery
I0812 00:52:33.310410 5197 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0812 00:52:33.310842 5193 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0812 00:52:33.314759 5193 process.cpp:3933] Handling HTTP event for process 'slave(799)' with path: '/slave(799)/containers'
I0812 00:52:33.316648 5195 http.cpp:1166] HTTP GET for /slave(799)/containers from 172.17.0.4:44772
I0812 00:52:33.316727 5195 http.cpp:957] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0812 00:52:33.321946 5173 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (58 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0812 00:52:33.345793 5173 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0812 00:52:33.346346 5173 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0812 00:52:33.346503 5173 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0812 00:52:33.346568 5173 provisioner.cpp:255] Using default backend 'copy'
I0812 00:52:33.350862 5198 slave.cpp:250] Mesos agent started on (800)@172.17.0.4:34085
I0812 00:52:33.350894 5198 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_w4K6Nd/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_w4K6Nd/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_w4K6Nd/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_w4K6Nd/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_w4K6Nd/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.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_w4K6Nd" --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_gb3qaZ"
I0812 00:52:33.351289 5198 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_w4K6Nd/credential'
I0812 00:52:33.351490 5198 slave.cpp:283] Agent using credential for: test-principal
I0812 00:52:33.351517 5198 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_w4K6Nd/http_credentials'
I0812 00:52:33.351790 5198 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0812 00:52:33.352012 5198 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0812 00:52:33.354012 5198 slave.cpp:565] 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"}]
I0812 00:52:33.354271 5198 slave.cpp:573] Agent attributes: [ ]
I0812 00:52:33.354292 5198 slave.cpp:582] Agent hostname: ea1236f6ba4c
I0812 00:52:33.354485 5193 status_update_manager.cpp:177] Pausing sending status updates
I0812 00:52:33.356221 5192 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_gb3qaZ/meta'
I0812 00:52:33.356775 5192 status_update_manager.cpp:203] Recovering status update manager
I0812 00:52:33.357013 5198 containerizer.cpp:598] Recovering containerizer
I0812 00:52:33.358624 5193 provisioner.cpp:416] Provisioner recovery complete
I0812 00:52:33.359274 5193 slave.cpp:6210] Finished recovery
I0812 00:52:33.360334 5193 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0812 00:52:33.360725 5193 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0812 00:52:33.364048 5193 process.cpp:3933] Handling HTTP event for process 'slave(800)' with path: '/slave(800)/monitor/statistics'
I0812 00:52:33.366489 5195 http.cpp:1166] HTTP GET for /slave(800)/monitor/statistics from 172.17.0.4:44776
I0812 00:52:33.366595 5195 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0812 00:52:33.370409 5173 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (45 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0812 00:52:33.391649 5173 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0812 00:52:33.392252 5173 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0812 00:52:33.392417 5173 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0812 00:52:33.392468 5173 provisioner.cpp:255] Using default backend 'copy'
I0812 00:52:33.396484 5192 slave.cpp:250] Mesos agent started on (801)@172.17.0.4:34085
I0812 00:52:33.396519 5192 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Ps3lNa/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_Ps3lNa/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Ps3lNa/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_Ps3lNa/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_Ps3lNa/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.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_Ps3lNa" --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_nvvD1V"
I0812 00:52:33.396958 5192 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Ps3lNa/credential'
I0812 00:52:33.397181 5192 slave.cpp:283] Agent using credential for: test-principal
I0812 00:52:33.397243 5192 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Ps3lNa/http_credentials'
I0812 00:52:33.397545 5192 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0812 00:52:33.397802 5192 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0812 00:52:33.399428 5192 slave.cpp:565] 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"}]
I0812 00:52:33.399631 5192 slave.cpp:573] Agent attributes: [ ]
I0812 00:52:33.399653 5192 slave.cpp:582] Agent hostname: ea1236f6ba4c
I0812 00:52:33.401633 5195 status_update_manager.cpp:177] Pausing sending status updates
I0812 00:52:33.401856 5199 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_nvvD1V/meta'
I0812 00:52:33.402365 5199 status_update_manager.cpp:203] Recovering status update manager
I0812 00:52:33.402618 5199 containerizer.cpp:598] Recovering containerizer
I0812 00:52:33.404593 5199 provisioner.cpp:416] Provisioner recovery complete
I0812 00:52:33.404989 5197 slave.cpp:6210] Finished recovery
I0812 00:52:33.405467 5197 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0812 00:52:33.406121 5197 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0812 00:52:33.411279 5193 process.cpp:3933] Handling HTTP event for process 'slave(801)' with path: '/slave(801)/monitor/statistics.json'
I0812 00:52:33.413061 5196 http.cpp:1166] HTTP GET for /slave(801)/monitor/statistics.json from 172.17.0.4:44778
I0812 00:52:33.413139 5196 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0812 00:52:33.420646 5173 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (42 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0812 00:52:33.431874 5173 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0812 00:52:33.432409 5173 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0812 00:52:33.432556 5173 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0812 00:52:33.432593 5173 provisioner.cpp:255] Using default backend 'copy'
I0812 00:52:33.437722 5197 slave.cpp:250] Mesos agent started on (802)@172.17.0.4:34085
I0812 00:52:33.437769 5197 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_lugog8/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_lugog8/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_lugog8/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_lugog8/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_lugog8/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.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_lugog8" --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_RXvunT"
I0812 00:52:33.438292 5197 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_lugog8/credential'
I0812 00:52:33.438513 5197 slave.cpp:283] Agent using credential for: test-principal
I0812 00:52:33.438678 5197 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_lugog8/http_credentials'
I0812 00:52:33.439180 5197 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0812 00:52:33.439496 5197 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0812 00:52:33.441251 5197 slave.cpp:565] 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"}]
I0812 00:52:33.441452 5197 slave.cpp:573] Agent attributes: [ ]
I0812 00:52:33.441488 5197 slave.cpp:582] Agent hostname: ea1236f6ba4c
I0812 00:52:33.441983 5195 status_update_manager.cpp:177] Pausing sending status updates
I0812 00:52:33.445605 5197 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_RXvunT/meta'
I0812 00:52:33.446143 5195 status_update_manager.cpp:203] Recovering status update manager
I0812 00:52:33.446584 5195 containerizer.cpp:598] Recovering containerizer
I0812 00:52:33.449393 5195 provisioner.cpp:416] Provisioner recovery complete
I0812 00:52:33.450871 5197 slave.cpp:6210] Finished recovery
I0812 00:52:33.451750 5197 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0812 00:52:33.452265 5197 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0812 00:52:33.456374 5199 process.cpp:3933] Handling HTTP event for process 'slave(802)' with path: '/slave(802)/containers'
I0812 00:52:33.458376 5199 http.cpp:1166] HTTP GET for /slave(802)/containers from 172.17.0.4:44782
I0812 00:52:33.458490 5199 http.cpp:957] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0812 00:52:33.462321 5173 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (41 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0812 00:52:33.474177 5173 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0812 00:52:33.474755 5173 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0812 00:52:33.474907 5173 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0812 00:52:33.474947 5173 provisioner.cpp:255] Using default backend 'copy'
I0812 00:52:33.477121 5173 cluster.cpp:448] Creating default 'local' authorizer
I0812 00:52:33.479940 5192 slave.cpp:250] Mesos agent started on (803)@172.17.0.4:34085
I0812 00:52:33.479975 5192 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_itvtd6/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_itvtd6/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_itvtd6/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_itvtd6/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_itvtd6/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.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_itvtd6" --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_89SedR"
I0812 00:52:33.480998 5192 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_itvtd6/credential'
I0812 00:52:33.481324 5192 slave.cpp:283] Agent using credential for: test-principal
I0812 00:52:33.481395 5192 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_itvtd6/http_credentials'
I0812 00:52:33.481935 5192 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0812 00:52:33.482283 5192 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0812 00:52:33.484143 5192 slave.cpp:565] 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"}]
I0812 00:52:33.484388 5192 slave.cpp:573] Agent attributes: [ ]
I0812 00:52:33.484423 5192 slave.cpp:582] Agent hostname: ea1236f6ba4c
I0812 00:52:33.485252 5193 status_update_manager.cpp:177] Pausing sending status updates
I0812 00:52:33.488533 5197 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_89SedR/meta'
I0812 00:52:33.498946 5195 status_update_manager.cpp:203] Recovering status update manager
I0812 00:52:33.499347 5199 containerizer.cpp:598] Recovering containerizer
I0812 00:52:33.501907 5199 provisioner.cpp:416] Provisioner recovery complete
I0812 00:52:33.502425 5198 slave.cpp:6210] Finished recovery
I0812 00:52:33.503478 5198 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0812 00:52:33.504047 5198 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0812 00:52:33.508256 5195 process.cpp:3933] Handling HTTP event for process 'slave(803)' with path: '/slave(803)/monitor/statistics'
I0812 00:52:33.510761 5195 http.cpp:1166] HTTP GET for /slave(803)/monitor/statistics from 172.17.0.4:44784
I0812 00:52:33.510867 5195 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0812 00:52:33.523191 5173 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (62 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0812 00:52:33.536653 5173 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0812 00:52:33.537236 5173 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0812 00:52:33.537374 5173 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0812 00:52:33.537415 5173 provisioner.cpp:255] Using default backend 'copy'
I0812 00:52:33.539429 5173 cluster.cpp:448] Creating default 'local' authorizer
I0812 00:52:33.541522 5199 slave.cpp:250] Mesos agent started on (804)@172.17.0.4:34085
I0812 00:52:33.541555 5199 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_iw5uQ4/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_iw5uQ4/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_iw5uQ4/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_iw5uQ4/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_iw5uQ4/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.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_iw5uQ4" --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_y2jiFP"
I0812 00:52:33.542029 5199 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_iw5uQ4/credential'
I0812 00:52:33.542256 5199 slave.cpp:283] Agent using credential for: test-principal
I0812 00:52:33.542312 5199 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_iw5uQ4/http_credentials'
I0812 00:52:33.542644 5199 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0812 00:52:33.542886 5199 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0812 00:52:33.544513 5199 slave.cpp:565] 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"}]
I0812 00:52:33.544723 5199 slave.cpp:573] Agent attributes: [ ]
I0812 00:52:33.544745 5199 slave.cpp:582] Agent hostname: ea1236f6ba4c
I0812 00:52:33.546828 5194 status_update_manager.cpp:177] Pausing sending status updates
I0812 00:52:33.547052 5195 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_y2jiFP/meta'
I0812 00:52:33.547623 5198 status_update_manager.cpp:203] Recovering status update manager
I0812 00:52:33.547920 5196 containerizer.cpp:598] Recovering containerizer
I0812 00:52:33.550231 5196 provisioner.cpp:416] Provisioner recovery complete
I0812 00:52:33.551141 5195 slave.cpp:6210] Finished recovery
I0812 00:52:33.551848 5195 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0812 00:52:33.552208 5195 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0812 00:52:33.557884 5193 process.cpp:3933] Handling HTTP event for process 'slave(804)' with path: '/slave(804)/monitor/statistics.json'
I0812 00:52:33.559747 5193 http.cpp:1166] HTTP GET for /slave(804)/monitor/statistics.json from 172.17.0.4:44788
I0812 00:52:33.559828 5193 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0812 00:52:33.569296 5173 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (45 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0812 00:52:33.582123 5173 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0812 00:52:33.582723 5173 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0812 00:52:33.582900 5173 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0812 00:52:33.582942 5173 provisioner.cpp:255] Using default backend 'copy'
I0812 00:52:33.584967 5173 cluster.cpp:448] Creating default 'local' authorizer
I0812 00:52:33.586977 5198 slave.cpp:250] Mesos agent started on (805)@172.17.0.4:34085
I0812 00:52:33.587010 5198 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_IFCQZ3/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_IFCQZ3/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_IFCQZ3/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_IFCQZ3/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_IFCQZ3/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.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_IFCQZ3" --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_vsIIGO"
I0812 00:52:33.587460 5198 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_IFCQZ3/credential'
I0812 00:52:33.587638 5198 slave.cpp:283] Agent using credential for: test-principal
I0812 00:52:33.587666 5198 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_IFCQZ3/http_credentials'
I0812 00:52:33.587975 5198 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0812 00:52:33.588205 5198 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0812 00:52:33.589704 5198 slave.cpp:565] 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"}]
I0812 00:52:33.589951 5198 slave.cpp:573] Agent attributes: [ ]
I0812 00:52:33.589973 5198 slave.cpp:582] Agent hostname: ea1236f6ba4c
I0812 00:52:33.590591 5196 status_update_manager.cpp:177] Pausing sending status updates
I0812 00:52:33.594292 5198 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_vsIIGO/meta'
I0812 00:52:33.594705 5196 status_update_manager.cpp:203] Recovering status update manager
I0812 00:52:33.594962 5196 containerizer.cpp:598] Recovering containerizer
I0812 00:52:33.597416 5195 provisioner.cpp:416] Provisioner recovery complete
I0812 00:52:33.598327 5198 slave.cpp:6210] Finished recovery
I0812 00:52:33.599465 5198 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0812 00:52:33.599941 5198 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0812 00:52:33.603476 5196 process.cpp:3933] Handling HTTP event for process 'slave(805)' with path: '/slave(805)/containers'
I0812 00:52:33.605806 5196 http.cpp:1166] HTTP GET for /slave(805)/containers from 172.17.0.4:44790
I0812 00:52:33.605898 5196 http.cpp:957] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0812 00:52:33.613505 5173 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (43 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (493 ms total)
[----------] 2 tests from ContainerizerType/DefaultContainerDNSFlagTest
[ RUN ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/0
[ OK ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/0 (12 ms)
[ RUN ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/1
[ OK ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/1 (13 ms)
[----------] 2 tests from ContainerizerType/DefaultContainerDNSFlagTest (25 ms total)
[----------] Global test environment tear-down
[==========] 1655 tests from 182 test cases ran. (640957 ms total)
[ PASSED ] 1653 tests.
[ FAILED ] 2 tests, listed below:
[ FAILED ] RegistrarTest.Remove
[ FAILED ] IOSwitchboardTest.KillSwitchboardContainerDestroyed
2 FAILED TESTS
YOU HAVE 20 DISABLED TESTS
I0812 00:52:33.698474 5200 process.cpp:1072] Failed to accept socket: future discarded
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.4.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1502494256-31853
Untagged: mesos-1502494256-31853:latest
Deleted: sha256:ed9b76d5ce294ca69895eea95964e30ce14ef8d06f4d5f57595b74a3641b4f9e
Deleted: sha256:91174ec53e5d4318846dcd28b0a08db7b3508d3d3d353cf4838d4a3ece420687
Deleted: sha256:35988f8c7dfb4ce208b48648c2cd8ac7088c6db10394482df351046a1c1c0493
Deleted: sha256:76d480b16da230ba0e2a89cba0a9c5df6adbb2fd0824da7c557f39761cb2cd3f
Deleted: sha256:9a0a06325fb1eba32a7b7de68d9084556980d6530e6f555ce501303c481f4d31
Deleted: sha256:9eb7819121f396821ae7ed66763bb3188cadec5c4747f46bfe35b1276ebe3157
Deleted: sha256:8e40898999db49d8d7b1bf78b9f4ab94370280f03ae88e08624e7ff5cec5dbc5
Deleted: sha256:717c720cc88c1983bbeb75319d66da113336c8fa44cde5bb19e13e159f90a1b5
Deleted: sha256:011aea0391763fc02c9176bf047b968a8e8e0d31e097b39ddbec0a22d15298ac
Deleted: sha256:1b8fe03e5f6cdbe8e7f9a0092668f3b6e19d5f15eb466d5e26769274fa346b85
Deleted: sha256:1c38117934b7d4920b5c8c64b547c2aeefffc735c0eb921cb0b4fb2b423499ff
Deleted: sha256:1ee8b57816ae08b816c83d705eb6be4ebfb3bdc763ad728ab78a1c0bee882998
Deleted: sha256:de8702117e9a6a228fe053f42e320a611689d7ec42a89e63a412230dc7dc812d
Deleted: sha256:6179e6abdbb02ea1ad557266972de765cf75d1142a0f24746df0c01bbddcd779
Deleted: sha256:9b8850176bf26956fffcf6a732eb582f275b1491d7ab2cc4744dafc88dab0f7b
Deleted: sha256:61b9af2f46a8d572c787286106a949a2abe8f3b7569c210737df1ae8c98c105e
Deleted: sha256:27d002b6b6d66269c429c5a3104824a82818c8d9a54f1971c28440eab4359543
Deleted: sha256:3664c7c90e2d1688ccff3b2d7dc676bb92132a211afaefbf511502a2bdcc7480
Deleted: sha256:1ff100ee2935517d9fb2644fb26f729db82eadc7ea174ca41972990cb3c61865
Deleted: sha256:eadc39230c059fc99778e185853694f23b7fe91547eea0555f3d7ff730608493
Deleted: sha256:725c99a249baa310829b7e8ba57f4ad585b26aeb9f04dbc3d79ec5b2e2248ab3
Deleted: sha256:2c10adb0763d9a186771a2157691e4d68189b495adc170430eb48dd95d7c5991
Deleted: sha256:b54174222436c3298f9cdef38e9261d36d55796dceea59be2f3be960735f16d1
Deleted: sha256:f0df869c66e2dad9bae545b69f7bc5f4d13e1efb03f4d25aa1db703264d81d6a
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user songzihao1990@gmail.com
Not sending mail to unregistered user alexander@mesosphere.io
Not sending mail to unregistered user yujie.jay@gmail.com