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/01/16 08:49:13 UTC
Build failed in Jenkins: Mesos-Reviewbot #16736
See <https://builds.apache.org/job/Mesos-Reviewbot/16736/>
------------------------------------------
[...truncated 140565 lines...]
I0116 06:39:28.590029 30045 slave.cpp:3320] Got registration for executor '78c83352-cc72-416a-addb-aa414db28c88' of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000 from executor(1)@172.17.0.3:48408
I0116 06:39:28.590503 30045 slave.cpp:3406] Checkpointing executor pid 'executor(1)@172.17.0.3:48408' to '/tmp/IOSwitchboardTest_ContainerAttachAfterSlaveRestart_YiLu3X/meta/slaves/feb0a716-c5e0-41ca-8051-1bb12ac308ad-S0/frameworks/feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000/executors/78c83352-cc72-416a-addb-aa414db28c88/runs/fd01c13b-f4d6-4301-858d-b325002ef444/pids/libprocess.pid'
I0116 06:39:28.593618 30045 slave.cpp:2266] Sending queued task '78c83352-cc72-416a-addb-aa414db28c88' to executor '78c83352-cc72-416a-addb-aa414db28c88' of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000 at executor(1)@172.17.0.3:48408
I0116 06:39:28.621268 30045 slave.cpp:3751] Handling status update TASK_RUNNING (UUID: 04d7abb8-35dd-4e51-97f6-cdc46c8371c9) for task 78c83352-cc72-416a-addb-aa414db28c88 of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000 from executor(1)@172.17.0.3:48408
I0116 06:39:28.624258 30035 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 04d7abb8-35dd-4e51-97f6-cdc46c8371c9) for task 78c83352-cc72-416a-addb-aa414db28c88 of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000
I0116 06:39:28.624338 30035 status_update_manager.cpp:500] Creating StatusUpdate stream for task 78c83352-cc72-416a-addb-aa414db28c88 of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000
I0116 06:39:28.625594 30035 status_update_manager.cpp:832] Checkpointing UPDATE for status update TASK_RUNNING (UUID: 04d7abb8-35dd-4e51-97f6-cdc46c8371c9) for task 78c83352-cc72-416a-addb-aa414db28c88 of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000
I0116 06:39:28.626045 30035 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 04d7abb8-35dd-4e51-97f6-cdc46c8371c9) for task 78c83352-cc72-416a-addb-aa414db28c88 of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000 to the agent
I0116 06:39:28.626667 30035 slave.cpp:4191] Forwarding the update TASK_RUNNING (UUID: 04d7abb8-35dd-4e51-97f6-cdc46c8371c9) for task 78c83352-cc72-416a-addb-aa414db28c88 of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000 to master@172.17.0.3:54154
I0116 06:39:28.626883 30035 slave.cpp:4085] Status update manager successfully handled status update TASK_RUNNING (UUID: 04d7abb8-35dd-4e51-97f6-cdc46c8371c9) for task 78c83352-cc72-416a-addb-aa414db28c88 of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000
I0116 06:39:28.626940 30035 slave.cpp:4101] Sending acknowledgement for status update TASK_RUNNING (UUID: 04d7abb8-35dd-4e51-97f6-cdc46c8371c9) for task 78c83352-cc72-416a-addb-aa414db28c88 of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000 to executor(1)@172.17.0.3:48408
I0116 06:39:28.627557 30035 master.cpp:5846] Status update TASK_RUNNING (UUID: 04d7abb8-35dd-4e51-97f6-cdc46c8371c9) for task 78c83352-cc72-416a-addb-aa414db28c88 of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000 from agent feb0a716-c5e0-41ca-8051-1bb12ac308ad-S0 at slave(511)@172.17.0.3:54154 (011079022f20)
I0116 06:39:28.627630 30035 master.cpp:5908] Forwarding status update TASK_RUNNING (UUID: 04d7abb8-35dd-4e51-97f6-cdc46c8371c9) for task 78c83352-cc72-416a-addb-aa414db28c88 of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000
I0116 06:39:28.627856 30035 master.cpp:7947] Updating the state of task 78c83352-cc72-416a-addb-aa414db28c88 of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0116 06:39:28.628231 30035 sched.cpp:1041] Scheduler::statusUpdate took 164548ns
I0116 06:39:28.628693 30035 master.cpp:4948] Processing ACKNOWLEDGE call 04d7abb8-35dd-4e51-97f6-cdc46c8371c9 for task 78c83352-cc72-416a-addb-aa414db28c88 of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000 (default) at scheduler-37fda66b-b05b-4094-9243-7c90ecca06e5@172.17.0.3:54154 on agent feb0a716-c5e0-41ca-8051-1bb12ac308ad-S0
I0116 06:39:28.629400 30045 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 04d7abb8-35dd-4e51-97f6-cdc46c8371c9) for task 78c83352-cc72-416a-addb-aa414db28c88 of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000
I0116 06:39:28.629639 30045 status_update_manager.cpp:832] Checkpointing ACK for status update TASK_RUNNING (UUID: 04d7abb8-35dd-4e51-97f6-cdc46c8371c9) for task 78c83352-cc72-416a-addb-aa414db28c88 of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000
I0116 06:39:28.629945 30035 slave.cpp:3040] Status update manager successfully handled status update acknowledgement (UUID: 04d7abb8-35dd-4e51-97f6-cdc46c8371c9) for task 78c83352-cc72-416a-addb-aa414db28c88 of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000
I0116 06:39:28.630389 30012 slave.cpp:796] Agent terminating
I0116 06:39:28.631043 30012 containerizer.cpp:220] Using isolation: posix/cpu,filesystem/posix,network/cni
I0116 06:39:28.631279 30042 master.cpp:1261] Agent feb0a716-c5e0-41ca-8051-1bb12ac308ad-S0 at slave(511)@172.17.0.3:54154 (011079022f20) disconnected
I0116 06:39:28.631383 30042 master.cpp:3051] Disconnecting agent feb0a716-c5e0-41ca-8051-1bb12ac308ad-S0 at slave(511)@172.17.0.3:54154 (011079022f20)
I0116 06:39:28.631470 30042 master.cpp:3070] Deactivating agent feb0a716-c5e0-41ca-8051-1bb12ac308ad-S0 at slave(511)@172.17.0.3:54154 (011079022f20)
I0116 06:39:28.631770 30042 hierarchical.cpp:577] Agent feb0a716-c5e0-41ca-8051-1bb12ac308ad-S0 deactivated
W0116 06:39:28.631793 30012 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W0116 06:39:28.631981 30012 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0116 06:39:28.650274 30012 cluster.cpp:446] Creating default 'local' authorizer
I0116 06:39:28.652493 30044 slave.cpp:209] Mesos agent started on (512)@172.17.0.3:54154
I0116 06:39:28.652519 30044 slave.cpp:210] 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/IOSwitchboardTest_ContainerAttachAfterSlaveRestart_ru4dtU/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/IOSwitchboardTest_ContainerAttachAfterSlaveRestart_ru4dtU/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/IOSwitchboardTest_ContainerAttachAfterSlaveRestart_ru4dtU/http_credentials" --http_heartbeat_interval="30secs" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/IOSwitchboardTest_ContainerAttachAfterSlaveRestart_ru4dtU" --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/IOSwitchboardTest_ContainerAttachAfterSlaveRestart_YiLu3X"
I0116 06:39:28.653290 30044 credentials.hpp:86] Loading credential for authentication from '/tmp/IOSwitchboardTest_ContainerAttachAfterSlaveRestart_ru4dtU/credential'
I0116 06:39:28.653527 30044 slave.cpp:352] Agent using credential for: test-principal
I0116 06:39:28.653555 30044 credentials.hpp:37] Loading credentials for authentication from '/tmp/IOSwitchboardTest_ContainerAttachAfterSlaveRestart_ru4dtU/http_credentials'
I0116 06:39:28.653872 30044 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0116 06:39:28.654034 30044 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0116 06:39:28.655297 30044 slave.cpp:539] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0116 06:39:28.655376 30044 slave.cpp:547] Agent attributes: [ ]
I0116 06:39:28.655390 30044 slave.cpp:552] Agent hostname: 011079022f20
I0116 06:39:28.657286 30031 state.cpp:60] Recovering state from '/tmp/IOSwitchboardTest_ContainerAttachAfterSlaveRestart_YiLu3X/meta'
I0116 06:39:28.657351 30031 state.cpp:703] No committed checkpointed resources found at '/tmp/IOSwitchboardTest_ContainerAttachAfterSlaveRestart_YiLu3X/meta/resources/resources.info'
I0116 06:39:28.662854 30038 fetcher.cpp:90] Clearing fetcher cache
I0116 06:39:28.662955 30038 slave.cpp:5505] Recovering framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000
I0116 06:39:28.663067 30038 slave.cpp:6495] Recovering executor '78c83352-cc72-416a-addb-aa414db28c88' of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000
I0116 06:39:28.664427 30036 status_update_manager.cpp:203] Recovering status update manager
I0116 06:39:28.664463 30036 status_update_manager.cpp:211] Recovering executor '78c83352-cc72-416a-addb-aa414db28c88' of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000
I0116 06:39:28.664628 30036 status_update_manager.cpp:500] Creating StatusUpdate stream for task 78c83352-cc72-416a-addb-aa414db28c88 of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000
I0116 06:39:28.665393 30036 status_update_manager.cpp:808] Replaying status update stream for task 78c83352-cc72-416a-addb-aa414db28c88
I0116 06:39:28.666303 30036 containerizer.cpp:599] Recovering containerizer
I0116 06:39:28.666414 30036 containerizer.cpp:655] Recovering container fd01c13b-f4d6-4301-858d-b325002ef444 for executor '78c83352-cc72-416a-addb-aa414db28c88' of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000
I0116 06:39:28.669528 30037 provisioner.cpp:251] Provisioner recovery complete
I0116 06:39:28.670712 30040 slave.cpp:5357] Sending reconnect request to executor '78c83352-cc72-416a-addb-aa414db28c88' of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000 at executor(1)@172.17.0.3:48408
**** DEADLOCK DETECTED! ****
You are waiting on process __limiter__(530)@172.17.0.3:54154 that it is currently executing.
I0116 06:39:28.674520 30012 sched.cpp:2021] Asked to stop the driver
I0116 06:39:28.674703 30032 slave.cpp:3510] Re-registering executor '78c83352-cc72-416a-addb-aa414db28c88' of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000
I0116 06:39:28.674736 30033 sched.cpp:1203] Stopping framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000
I0116 06:39:28.675056 30033 master.cpp:7371] Processing TEARDOWN call for framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000 (default) at scheduler-37fda66b-b05b-4094-9243-7c90ecca06e5@172.17.0.3:54154
I0116 06:39:28.675091 30033 master.cpp:7383] Removing framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000 (default) at scheduler-37fda66b-b05b-4094-9243-7c90ecca06e5@172.17.0.3:54154
I0116 06:39:28.675271 30033 master.cpp:7947] Updating the state of task 78c83352-cc72-416a-addb-aa414db28c88 of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0116 06:39:28.675693 30032 hierarchical.cpp:386] Deactivated framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000
I0116 06:39:28.676024 30033 master.cpp:8043] Removing task 78c83352-cc72-416a-addb-aa414db28c88 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000 on agent feb0a716-c5e0-41ca-8051-1bb12ac308ad-S0 at slave(511)@172.17.0.3:54154 (011079022f20)
I0116 06:39:28.676703 30032 hierarchical.cpp:1011] Recovered cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: {}) on agent feb0a716-c5e0-41ca-8051-1bb12ac308ad-S0 from framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000
I0116 06:39:28.677275 30032 hierarchical.cpp:337] Removed framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000
I0116 06:39:28.678323 30033 containerizer.cpp:2118] Destroying container fd01c13b-f4d6-4301-858d-b325002ef444 in RUNNING state
I0116 06:39:28.678772 30033 launcher.cpp:149] Asked to destroy container fd01c13b-f4d6-4301-858d-b325002ef444
I0116 06:39:28.691141 30038 slave.cpp:4323] Got exited event for executor(1)@172.17.0.3:48408
W0116 06:39:28.691241 30038 slave.cpp:4328] Master disconnected! Waiting for a new master to be elected
E0116 06:39:28.781450 30034 switchboard.cpp:886] Unexpected termination of I/O switchboard server: 'IOSwitchboard' exited with status: 1 for container fd01c13b-f4d6-4301-858d-b325002ef444
I0116 06:39:28.782179 30039 containerizer.cpp:2481] Container fd01c13b-f4d6-4301-858d-b325002ef444 has exited
I0116 06:39:28.785096 30037 provisioner.cpp:322] Ignoring destroy request for unknown container fd01c13b-f4d6-4301-858d-b325002ef444
I0116 06:39:28.785882 30041 slave.cpp:4686] Executor '78c83352-cc72-416a-addb-aa414db28c88' of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000 terminated with signal Killed
I0116 06:39:28.786178 30041 slave.cpp:3751] Handling status update TASK_FAILED (UUID: fa5a2d65-82a3-425b-9353-999e8b477b76) for task 78c83352-cc72-416a-addb-aa414db28c88 of framework feb0a716-c5e0-41ca-8051-1bb12ac308ad-0000 from @0.0.0.0:0
W0116 06:39:28.787345 30034 containerizer.cpp:1933] Ignoring update for unknown container fd01c13b-f4d6-4301-858d-b325002ef444
I0116 06:39:28.787691 30032 slave.cpp:796] Agent terminating
I0116 06:39:28.793189 30040 master.cpp:1100] Master terminating
I0116 06:39:28.793987 30038 hierarchical.cpp:510] Removed agent feb0a716-c5e0-41ca-8051-1bb12ac308ad-S0
[ OK ] IOSwitchboardTest.ContainerAttachAfterSlaveRestart (538 ms)
[----------] 5 tests from IOSwitchboardTest (7320 ms total)
[----------] 3 tests from MesosContainerizerTest
[ RUN ] MesosContainerizerTest.Launch
I0116 06:39:28.805977 30012 containerizer.cpp:220] Using isolation: posix/cpu,filesystem/posix,network/cni
W0116 06:39:28.807188 30012 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W0116 06:39:28.807881 30012 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0116 06:39:28.810817 30032 containerizer.cpp:599] Recovering containerizer
I0116 06:39:28.812356 30041 provisioner.cpp:251] Provisioner recovery complete
I0116 06:39:28.813707 30043 containerizer.cpp:991] Starting container a07c1b0b-83fd-43a1-9ecc-6e6001e3e332 for executor 'executor' of framework
I0116 06:39:28.816192 30038 containerizer.cpp:1540] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"shell":true,"value":"exit 42"},"environment":{"variables":[{"name":"MESOS_SANDBOX","value":"\/tmp\/MesosContainerizerTest_Launch_SxCsEa"}]},"working_directory":"\/tmp\/MesosContainerizerTest_Launch_SxCsEa"}" --pipe_read="20" --pipe_write="21" --runtime_directory="/tmp/MesosContainerizerTest_Launch_i1C9Pc/containers/a07c1b0b-83fd-43a1-9ecc-6e6001e3e332" --unshare_namespace_mnt="false"'
I0116 06:39:28.819425 30038 launcher.cpp:133] Forked child with pid '9243' for container 'a07c1b0b-83fd-43a1-9ecc-6e6001e3e332'
I0116 06:39:28.819744 30038 containerizer.cpp:1639] Checkpointing container's forked pid 9243 to '/tmp/MesosContainerizerTest_Launch_ESWa3e/meta/slaves/frameworks/executors/executor/runs/a07c1b0b-83fd-43a1-9ecc-6e6001e3e332/pids/forked.pid'
I0116 06:39:28.823665 30034 fetcher.cpp:349] Starting to fetch URIs for container: a07c1b0b-83fd-43a1-9ecc-6e6001e3e332, directory: /tmp/MesosContainerizerTest_Launch_SxCsEa
I0116 06:39:28.984781 30034 containerizer.cpp:2481] Container a07c1b0b-83fd-43a1-9ecc-6e6001e3e332 has exited
I0116 06:39:28.984843 30034 containerizer.cpp:2118] Destroying container a07c1b0b-83fd-43a1-9ecc-6e6001e3e332 in RUNNING state
I0116 06:39:28.985307 30034 launcher.cpp:149] Asked to destroy container a07c1b0b-83fd-43a1-9ecc-6e6001e3e332
I0116 06:39:28.989998 30031 provisioner.cpp:322] Ignoring destroy request for unknown container a07c1b0b-83fd-43a1-9ecc-6e6001e3e332
[ OK ] MesosContainerizerTest.Launch (193 ms)
[ RUN ] MesosContainerizerTest.Destroy
I0116 06:39:28.999275 30012 containerizer.cpp:220] Using isolation: posix/cpu,filesystem/posix,network/cni
W0116 06:39:28.999984 30012 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W0116 06:39:29.000269 30012 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0116 06:39:29.002123 30032 containerizer.cpp:599] Recovering containerizer
I0116 06:39:29.004272 30043 provisioner.cpp:251] Provisioner recovery complete
I0116 06:39:29.005759 30033 containerizer.cpp:991] Starting container 858e44d9-b2a5-4d08-bd53-de00e1c76aef for executor 'executor' of framework
I0116 06:39:29.007997 30037 containerizer.cpp:1540] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"shell":true,"value":"sleep 1000"},"environment":{"variables":[{"name":"MESOS_SANDBOX","value":"\/tmp\/MesosContainerizerTest_Destroy_RxsEvZ"}]},"working_directory":"\/tmp\/MesosContainerizerTest_Destroy_RxsEvZ"}" --pipe_read="20" --pipe_write="21" --runtime_directory="/tmp/MesosContainerizerTest_Destroy_I2kdc1/containers/858e44d9-b2a5-4d08-bd53-de00e1c76aef" --unshare_namespace_mnt="false"'
I0116 06:39:29.010856 30037 launcher.cpp:133] Forked child with pid '9258' for container '858e44d9-b2a5-4d08-bd53-de00e1c76aef'
I0116 06:39:29.011143 30037 containerizer.cpp:1639] Checkpointing container's forked pid 9258 to '/tmp/MesosContainerizerTest_Destroy_c4QPT2/meta/slaves/frameworks/executors/executor/runs/858e44d9-b2a5-4d08-bd53-de00e1c76aef/pids/forked.pid'
I0116 06:39:29.013985 30043 fetcher.cpp:349] Starting to fetch URIs for container: 858e44d9-b2a5-4d08-bd53-de00e1c76aef, directory: /tmp/MesosContainerizerTest_Destroy_RxsEvZ
I0116 06:39:29.017554 30031 containerizer.cpp:2118] Destroying container 858e44d9-b2a5-4d08-bd53-de00e1c76aef in RUNNING state
I0116 06:39:29.017875 30031 launcher.cpp:149] Asked to destroy container 858e44d9-b2a5-4d08-bd53-de00e1c76aef
I0116 06:39:29.086052 30044 containerizer.cpp:2481] Container 858e44d9-b2a5-4d08-bd53-de00e1c76aef has exited
I0116 06:39:29.088980 30046 provisioner.cpp:322] Ignoring destroy request for unknown container 858e44d9-b2a5-4d08-bd53-de00e1c76aef
[ OK ] MesosContainerizerTest.Destroy (97 ms)
[ RUN ] MesosContainerizerTest.StatusWithContainerID
I0116 06:39:29.097596 30012 containerizer.cpp:220] Using isolation: posix/cpu,filesystem/posix,network/cni
W0116 06:39:29.098254 30012 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W0116 06:39:29.098454 30012 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0116 06:39:29.100081 30046 containerizer.cpp:599] Recovering containerizer
I0116 06:39:29.101786 30036 provisioner.cpp:251] Provisioner recovery complete
I0116 06:39:29.102674 30033 containerizer.cpp:991] Starting container 62da37c2-5d2a-4873-b4c3-87afdcdaf9a3 for executor 'executor' of framework
I0116 06:39:29.104862 30034 containerizer.cpp:1540] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"shell":true,"value":"sleep 1000"},"environment":{"variables":[{"name":"MESOS_SANDBOX","value":"\/tmp\/MesosContainerizerTest_StatusWithContainerID_70bKoQ"}]},"working_directory":"\/tmp\/MesosContainerizerTest_StatusWithContainerID_70bKoQ"}" --pipe_read="20" --pipe_write="21" --runtime_directory="/tmp/MesosContainerizerTest_StatusWithContainerID_yh9tPR/containers/62da37c2-5d2a-4873-b4c3-87afdcdaf9a3" --unshare_namespace_mnt="false"'
I0116 06:39:29.108968 30034 launcher.cpp:133] Forked child with pid '9265' for container '62da37c2-5d2a-4873-b4c3-87afdcdaf9a3'
I0116 06:39:29.109282 30034 containerizer.cpp:1639] Checkpointing container's forked pid 9265 to '/tmp/MesosContainerizerTest_StatusWithContainerID_Jwg7gT/meta/slaves/frameworks/executors/executor/runs/62da37c2-5d2a-4873-b4c3-87afdcdaf9a3/pids/forked.pid'
I0116 06:39:29.113200 30032 fetcher.cpp:349] Starting to fetch URIs for container: 62da37c2-5d2a-4873-b4c3-87afdcdaf9a3, directory: /tmp/MesosContainerizerTest_StatusWithContainerID_70bKoQ
I0116 06:39:29.118737 30038 containerizer.cpp:2118] Destroying container 62da37c2-5d2a-4873-b4c3-87afdcdaf9a3 in RUNNING state
I0116 06:39:29.119174 30038 launcher.cpp:149] Asked to destroy container 62da37c2-5d2a-4873-b4c3-87afdcdaf9a3
I0116 06:39:29.186887 30041 containerizer.cpp:2481] Container 62da37c2-5d2a-4873-b4c3-87afdcdaf9a3 has exited
I0116 06:39:29.188616 30031 provisioner.cpp:322] Ignoring destroy request for unknown container 62da37c2-5d2a-4873-b4c3-87afdcdaf9a3
[ OK ] MesosContainerizerTest.StatusWithContainerID (98 ms)
[----------] 3 tests from MesosContainerizerTest (392 ms total)
[----------] 4 tests from MesosContainerizerIsolatorPreparationTest
[ RUN ] MesosContainerizerIsolatorPreparationTest.ScriptSucceeds
W0116 06:39:29.197129 30012 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W0116 06:39:29.197301 30012 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0116 06:39:29.198444 30039 containerizer.cpp:991] Starting container 86139438-3399-4e1c-8888-dddcaa57b16d for executor 'executor' of framework
I0116 06:39:29.200103 30039 containerizer.cpp:1540] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"shell":true,"value":"exit 0"},"environment":{"variables":[{"name":"MESOS_SANDBOX","value":"\/tmp\/rXKYnM"}]},"pre_exec_commands":[{"shell":true,"value":"touch \/tmp\/rXKYnM\/child.script.executed"}],"working_directory":"\/tmp\/rXKYnM"}" --pipe_read="20" --pipe_write="21" --runtime_directory="/tmp/MesosContainerizerIsolatorPreparationTest_ScriptSucceeds_faa00J/containers/86139438-3399-4e1c-8888-dddcaa57b16d" --unshare_namespace_mnt="false"'
I0116 06:39:29.204665 30039 launcher.cpp:133] Forked child with pid '9269' for container '86139438-3399-4e1c-8888-dddcaa57b16d'
I0116 06:39:29.208647 30037 fetcher.cpp:349] Starting to fetch URIs for container: 86139438-3399-4e1c-8888-dddcaa57b16d, directory: /tmp/rXKYnM
Executing pre-exec command '{"shell":true,"value":"touch \/tmp\/rXKYnM\/child.script.executed"}'
I0116 06:39:29.389698 30044 containerizer.cpp:2481] Container 86139438-3399-4e1c-8888-dddcaa57b16d has exited
I0116 06:39:29.389760 30044 containerizer.cpp:2118] Destroying container 86139438-3399-4e1c-8888-dddcaa57b16d in RUNNING state
I0116 06:39:29.390090 30044 launcher.cpp:149] Asked to destroy container 86139438-3399-4e1c-8888-dddcaa57b16d
I0116 06:39:29.397105 30041 provisioner.cpp:322] Ignoring destroy request for unknown container 86139438-3399-4e1c-8888-dddcaa57b16d
W0116 06:39:29.399153 30038 containerizer.cpp:2106] Attempted to destroy unknown container 86139438-3399-4e1c-8888-dddcaa57b16d
[ OK ] MesosContainerizerIsolatorPreparationTest.ScriptSucceeds (213 ms)
[ RUN ] MesosContainerizerIsolatorPreparationTest.ScriptFails
W0116 06:39:29.412133 30012 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W0116 06:39:29.412541 30012 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0116 06:39:29.416049 30045 containerizer.cpp:991] Starting container c90e7a9b-4dbe-4d2e-b8dd-179128f8869d for executor 'executor' of framework
I0116 06:39:29.417634 30045 containerizer.cpp:1540] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"shell":true,"value":"exit 0"},"environment":{"variables":[{"name":"MESOS_SANDBOX","value":"\/tmp\/RjDTdI"}]},"pre_exec_commands":[{"shell":true,"value":"touch \/tmp\/RjDTdI\/child.script.executed && exit 1"}],"working_directory":"\/tmp\/RjDTdI"}" --pipe_read="20" --pipe_write="21" --runtime_directory="/tmp/MesosContainerizerIsolatorPreparationTest_ScriptFails_20tDYG/containers/c90e7a9b-4dbe-4d2e-b8dd-179128f8869d" --unshare_namespace_mnt="false"'
I0116 06:39:29.420526 30045 launcher.cpp:133] Forked child with pid '9286' for container 'c90e7a9b-4dbe-4d2e-b8dd-179128f8869d'
I0116 06:39:29.424428 30045 fetcher.cpp:349] Starting to fetch URIs for container: c90e7a9b-4dbe-4d2e-b8dd-179128f8869d, directory: /tmp/RjDTdI
Executing pre-exec command '{"shell":true,"value":"touch \/tmp\/RjDTdI\/child.script.executed && exit 1"}'
Failed to execute pre-exec command '{"shell":true,"value":"touch \/tmp\/RjDTdI\/child.script.executed && exit 1"}'
I0116 06:39:29.592581 30038 containerizer.cpp:2481] Container c90e7a9b-4dbe-4d2e-b8dd-179128f8869d has exited
I0116 06:39:29.592841 30038 containerizer.cpp:2118] Destroying container c90e7a9b-4dbe-4d2e-b8dd-179128f8869d in RUNNING state
I0116 06:39:29.593439 30038 launcher.cpp:149] Asked to destroy container c90e7a9b-4dbe-4d2e-b8dd-179128f8869d
I0116 06:39:29.597817 30045 provisioner.cpp:322] Ignoring destroy request for unknown container c90e7a9b-4dbe-4d2e-b8dd-179128f8869d
W0116 06:39:29.598879 30045 containerizer.cpp:2106] Attempted to destroy unknown container c90e7a9b-4dbe-4d2e-b8dd-179128f8869d
[ OK ] MesosContainerizerIsolatorPreparationTest.ScriptFails (193 ms)
[ RUN ] MesosContainerizerIsolatorPreparationTest.MultipleScripts
W0116 06:39:29.604463 30012 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W0116 06:39:29.604663 30012 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0116 06:39:29.605980 30031 containerizer.cpp:991] Starting container 10d3e340-487a-4355-8920-6943c56123f5 for executor 'executor' of framework
I0116 06:39:29.607785 30031 containerizer.cpp:1540] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"shell":true,"value":"exit 0"},"environment":{"variables":[{"name":"MESOS_SANDBOX","value":"\/tmp\/3ifXfG"}]},"pre_exec_commands":[{"shell":true,"value":"touch \/tmp\/3ifXfG\/child.script.executed.1 && exit 0"},{"shell":true,"value":"touch \/tmp\/3ifXfG\/child.script.executed.2 && exit 1"}],"working_directory":"\/tmp\/3ifXfG"}" --pipe_read="20" --pipe_write="21" --runtime_directory="/tmp/MesosContainerizerIsolatorPreparationTest_MultipleScripts_KCzh1F/containers/10d3e340-487a-4355-8920-6943c56123f5" --unshare_namespace_mnt="false"'
I0116 06:39:29.610872 30031 launcher.cpp:133] Forked child with pid '9302' for container '10d3e340-487a-4355-8920-6943c56123f5'
I0116 06:39:29.614440 30039 fetcher.cpp:349] Starting to fetch URIs for container: 10d3e340-487a-4355-8920-6943c56123f5, directory: /tmp/3ifXfG
Executing pre-exec command '{"shell":true,"value":"touch \/tmp\/3ifXfG\/child.script.executed.1 && exit 0"}'
Executing pre-exec command '{"shell":true,"value":"touch \/tmp\/3ifXfG\/child.script.executed.2 && exit 1"}'
Failed to execute pre-exec command '{"shell":true,"value":"touch \/tmp\/3ifXfG\/child.script.executed.2 && exit 1"}'
I0116 06:39:29.795511 30038 containerizer.cpp:2481] Container 10d3e340-487a-4355-8920-6943c56123f5 has exited
I0116 06:39:29.795579 30038 containerizer.cpp:2118] Destroying container 10d3e340-487a-4355-8920-6943c56123f5 in RUNNING state
I0116 06:39:29.796222 30038 launcher.cpp:149] Asked to destroy container 10d3e340-487a-4355-8920-6943c56123f5
I0116 06:39:29.813666 30036 provisioner.cpp:322] Ignoring destroy request for unknown container 10d3e340-487a-4355-8920-6943c56123f5
W0116 06:39:29.815148 30036 containerizer.cpp:2106] Attempted to destroy unknown container 10d3e340-487a-4355-8920-6943c56123f5
[ OK ] MesosContainerizerIsolatorPreparationTest.MultipleScripts (216 ms)
[ RUN ] MesosContainerizerIsolatorPreparationTest.ExecutorEnvironmentVariable
W0116 06:39:29.822427 30012 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W0116 06:39:29.822629 30012 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0116 06:39:29.830355 30045 containerizer.cpp:991] Starting container e639d3ea-e62d-4078-876e-5f58d2125c79 for executor 'executor' of framework
I0116 06:39:29.832574 30045 containerizer.cpp:1540] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"shell":true,"value":"if [ -n \"$LIBPROCESS_IP\" ]; then touch $TEST_ENVIRONMENT; fi"},"environment":{"variables":[{"name":"LIBPROCESS_IP","value":"127.0.0.1"},{"name":"LIBPROCESS_PORT","value":"0"},{"name":"MESOS_AGENT_ENDPOINT","value":"0.0.0.0:0"},{"name":"MESOS_CHECKPOINT","value":"0"},{"name":"MESOS_DIRECTORY","value":"\/tmp\/oqjPmG"},{"name":"MESOS_EXECUTOR_ID","value":"executor"},{"name":"MESOS_EXECUTOR_SHUTDOWN_GRACE_PERIOD","value":"5secs"},{"name":"MESOS_FRAMEWORK_ID","value":""},{"name":"MESOS_HTTP_COMMAND_EXECUTOR","value":"0"},{"name":"MESOS_SLAVE_ID","value":""},{"name":"MESOS_SLAVE_PID","value":"@0.0.0.0:0"},{"name":"MESOS_SANDBOX","value":"\/tmp\/oqjPmG"},{"name":"TEST_ENVIRONMENT","value":"\/tmp\/oqjPmG\/child.script.executed"}]},"working_directory":"\/tmp\/oqjPmG"}" --pipe_read="20" --pipe_write="21" --runtime_directory="/tmp/MesosContainerizerIsolatorPreparationTest_ExecutorEnvironmentVariable_5I0SgH/containers/e639d3ea-e62d-4078-876e-5f58d2125c79" --unshare_namespace_mnt="false"'
I0116 06:39:29.836164 30045 launcher.cpp:133] Forked child with pid '9320' for container 'e639d3ea-e62d-4078-876e-5f58d2125c79'
I0116 06:39:29.839587 30045 fetcher.cpp:349] Starting to fetch URIs for container: e639d3ea-e62d-4078-876e-5f58d2125c79, directory: /tmp/oqjPmG
I0116 06:39:29.997498 30041 containerizer.cpp:2481] Container e639d3ea-e62d-4078-876e-5f58d2125c79 has exited
I0116 06:39:29.997570 30041 containerizer.cpp:2118] Destroying container e639d3ea-e62d-4078-876e-5f58d2125c79 in RUNNING state
I0116 06:39:29.997930 30041 launcher.cpp:149] Asked to destroy container e639d3ea-e62d-4078-876e-5f58d2125c79
I0116 06:39:30.002019 30036 provisioner.cpp:322] Ignoring destroy request for unknown container e639d3ea-e62d-4078-876e-5f58d2125c79
W0116 06:39:30.003082 30033 containerizer.cpp:2106] Attempted to destroy unknown container e639d3ea-e62d-4078-876e-5f58d2125c79
[ OK ] MesosContainerizerIsolatorPreparationTest.ExecutorEnvironmentVariable (187 ms)
[----------] 4 tests from MesosContainerizerIsolatorPreparationTest (812 ms total)
[----------] 1 test from MesosContainerizerExecuteTest
[ RUN ] MesosContainerizerExecuteTest.IoRedirection
I0116 06:39:30.008565 30012 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0116 06:39:30.009688 30012 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W0116 06:39:30.009865 30012 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0116 06:39:30.011970 30041 containerizer.cpp:991] Starting container bfddb43a-9e8f-46b0-a575-c22508d68e18 for executor 'executor' of framework
I0116 06:39:30.016082 30034 containerizer.cpp:1540] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"shell":true,"value":"(echo 'this is stderr' 1>&2) && echo 'this is stdout'"},"environment":{"variables":[{"name":"MESOS_SANDBOX","value":"\/tmp\/XM5sHI"}]},"err":{"path":"\/tmp\/XM5sHI\/stderr","type":"PATH"},"out":{"path":"\/tmp\/XM5sHI\/stdout","type":"PATH"},"working_directory":"\/tmp\/XM5sHI"}" --pipe_read="20" --pipe_write="21" --runtime_directory="/tmp/MesosContainerizerExecuteTest_IoRedirection_h628zK/containers/bfddb43a-9e8f-46b0-a575-c22508d68e18" --unshare_namespace_mnt="false"'
I0116 06:39:30.019781 30034 launcher.cpp:133] Forked child with pid '9336' for container 'bfddb43a-9e8f-46b0-a575-c22508d68e18'
I0116 06:39:30.023286 30039 fetcher.cpp:349] Starting to fetch URIs for container: bfddb43a-9e8f-46b0-a575-c22508d68e18, directory: /tmp/XM5sHI
I0116 06:39:30.199658 30031 containerizer.cpp:2481] Container bfddb43a-9e8f-46b0-a575-c22508d68e18 has exited
I0116 06:39:30.199728 30031 containerizer.cpp:2118] Destroying container bfddb43a-9e8f-46b0-a575-c22508d68e18 in RUNNING state
I0116 06:39:30.200820 30031 launcher.cpp:149] Asked to destroy container bfddb43a-9e8f-46b0-a575-c22508d68e18
I0116 06:39:30.207123 30032 provisioner.cpp:322] Ignoring destroy request for unknown container bfddb43a-9e8f-46b0-a575-c22508d68e18
[ OK ] MesosContainerizerExecuteTest.IoRedirection (206 ms)
[----------] 1 test from MesosContainerizerExecuteTest (206 ms total)
[----------] 4 tests from MesosContainerizerDestroyTest
[ RUN ] MesosContainerizerDestroyTest.DestroyWhileFetching
W0116 06:39:30.216126 30012 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W0116 06:39:30.216298 30012 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0116 06:39:30.217664 30033 containerizer.cpp:991] Starting container 7a0de9f8-4f63-4e3f-8705-268eb7e26323 for executor 'executor' of framework
I0116 06:39:30.219363 30033 containerizer.cpp:1540] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"shell":true,"value":"exit 0"},"environment":{"variables":[{"name":"MESOS_SANDBOX","value":"\/tmp\/iv671M"}]},"working_directory":"\/tmp\/iv671M"}" --pipe_read="20" --pipe_write="21" --runtime_directory="/tmp/MesosContainerizerDestroyTest_DestroyWhileFetching_Cgo4ZP/containers/7a0de9f8-4f63-4e3f-8705-268eb7e26323" --unshare_namespace_mnt="false"'
I0116 06:39:30.222594 30033 launcher.cpp:133] Forked child with pid '9352' for container '7a0de9f8-4f63-4e3f-8705-268eb7e26323'
I0116 06:39:30.226776 30046 fetcher.cpp:349] Starting to fetch URIs for container: 7a0de9f8-4f63-4e3f-8705-268eb7e26323, directory: /tmp/iv671M
I0116 06:39:30.227536 30043 containerizer.cpp:2118] Destroying container 7a0de9f8-4f63-4e3f-8705-268eb7e26323 in FETCHING state
I0116 06:39:30.227943 30043 launcher.cpp:149] Asked to destroy container 7a0de9f8-4f63-4e3f-8705-268eb7e26323
I0116 06:39:30.300673 30039 containerizer.cpp:2481] Container 7a0de9f8-4f63-4e3f-8705-268eb7e26323 has exited
I0116 06:39:30.301579 30041 provisioner.cpp:322] Ignoring destroy request for unknown container 7a0de9f8-4f63-4e3f-8705-268eb7e26323
[ OK ] MesosContainerizerDestroyTest.DestroyWhileFetching (92 ms)
[ RUN ] MesosContainerizerDestroyTest.DestroyWhilePreparing
W0116 06:39:30.309465 30012 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W0116 06:39:30.309926 30012 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0116 06:39:30.312026 30045 containerizer.cpp:991] Starting container 72e91cb2-7c79-4a68-9881-2940a519102a for executor 'executor' of framework
I0116 06:39:30.313733 30045 containerizer.cpp:2118] Destroying container 72e91cb2-7c79-4a68-9881-2940a519102a in PREPARING state
I0116 06:39:30.314208 30045 containerizer.cpp:2189] Waiting for the isolators to complete preparing before destroying container 72e91cb2-7c79-4a68-9881-2940a519102a
I0116 06:39:30.316962 30036 provisioner.cpp:322] Ignoring destroy request for unknown container 72e91cb2-7c79-4a68-9881-2940a519102a
[ OK ] MesosContainerizerDestroyTest.DestroyWhilePreparing (14 ms)
[ RUN ] MesosContainerizerDestroyTest.DestroyUnknownContainer
I0116 06:39:30.324007 30012 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0116 06:39:30.325104 30012 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W0116 06:39:30.325578 30012 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
W0116 06:39:30.328106 30046 containerizer.cpp:2106] Attempted to destroy unknown container 5d3c416e-d131-4595-bec7-60b101102c53
[ OK ] MesosContainerizerDestroyTest.DestroyUnknownContainer (43 ms)
[ RUN ] MesosContainerizerDestroyTest.LauncherDestroyFailure
W0116 06:39:30.369200 30012 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W0116 06:39:30.369807 30012 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0116 06:39:30.372546 30039 containerizer.cpp:991] Starting container 926dfc00-e1b6-424e-8a07-a164a5848616 for executor 'executor' of framework
I0116 06:39:30.374096 30039 containerizer.cpp:1540] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"shell":true,"value":"sleep 1000"},"environment":{"variables":[{"name":"MESOS_SANDBOX","value":"\/tmp\/QR9KQ3"}]},"working_directory":"\/tmp\/QR9KQ3"}" --pipe_read="22" --pipe_write="24" --runtime_directory="/tmp/MesosContainerizerDestroyTest_LauncherDestroyFailure_nq5aC7/containers/926dfc00-e1b6-424e-8a07-a164a5848616" --unshare_namespace_mnt="false"'
I0116 06:39:30.378142 30039 launcher.cpp:133] Forked child with pid '9354' for container '926dfc00-e1b6-424e-8a07-a164a5848616'
I0116 06:39:30.381603 30037 fetcher.cpp:349] Starting to fetch URIs for container: 926dfc00-e1b6-424e-8a07-a164a5848616, directory: /tmp/QR9KQ3
I0116 06:39:30.385031 30031 containerizer.cpp:2118] Destroying container 926dfc00-e1b6-424e-8a07-a164a5848616 in RUNNING state
I0116 06:39:30.386385 30031 launcher.cpp:149] Asked to destroy container 926dfc00-e1b6-424e-8a07-a164a5848616
I0116 06:39:30.402544 30031 containerizer.cpp:2481] Container 926dfc00-e1b6-424e-8a07-a164a5848616 has exited
Build timed out (after 180 minutes). Marking the build as failed.
Build was aborted
++ docker rmi mesos-1484545838-22567
Error response from daemon: conflict: unable to remove repository reference "mesos-1484545838-22567" (must force) - container 011079022f20 is using its referenced image c326b5f98fe6
Jenkins build is back to normal : Mesos-Reviewbot #16738
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Reviewbot/16738/>
Re: Build failed in Jenkins: Mesos-Reviewbot #16737
Posted by Vinod Kone <vi...@apache.org>.
@neil, can you look into this?
On Mon, Jan 16, 2017 at 10:52 AM, Apache Jenkins Server <
jenkins@builds.apache.org> wrote:
> See <https://builds.apache.org/job/Mesos-Reviewbot/16737/>
>
> ------------------------------------------
> [...truncated 171048 lines...]
> I0116 09:51:46.475677 29995 containerizer.cpp:220] Using isolation:
> posix/cpu,posix/mem,filesystem/posix,network/cni
> W0116 09:51:46.476682 29995 backend.cpp:76] Failed to create 'aufs'
> backend: AufsBackend requires root privileges, but is running as user mesos
> W0116 09:51:46.476922 29995 backend.cpp:76] Failed to create 'bind'
> backend: BindBackend requires root privileges
> I0116 09:51:46.481760 30016 slave.cpp:209] Mesos agent started on (678)@
> 172.17.0.2:35655
> I0116 09:51:46.481792 30016 slave.cpp:210] 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_1_AG7fH1/credential" --default_role="*"
> --disk_watch_interval="1mins" --docker="docker"
> --docker_kill_orphans="true" --docker_registry="https://
> registry-1.docker.io" --docker_remove_delay="6hrs"
> --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns"
> --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_
> dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false"
> --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs"
> --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_
> AuthorizedRequest_1_AG7fH1/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_1_AG7fH1/http_credentials" --http_heartbeat_interval="30secs"
> --image_provisioner_backend="copy" --initialize_driver_logging="true"
> --isolation="posix/cpu,posix/mem" --launcher="posix"
> --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0"
> --logging_level="INFO" --max_completed_executors_per_framework="150"
> --oversubscribed_resources_interval="15secs" --perf_duration="10secs"
> --perf_interval="1mins" --qos_correction_interval_min="0ns"
> --quiet="false" --recover="reconnect" --recovery_timeout="15mins"
> --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;
> mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true"
> --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_AG7fH1"
> --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_1_HzmNzx"
> I0116 09:51:46.482417 30016 credentials.hpp:86] Loading credential for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> AuthorizedRequest_1_AG7fH1/credential'
> I0116 09:51:46.482627 30016 slave.cpp:352] Agent using credential for:
> test-principal
> I0116 09:51:46.482647 30016 credentials.hpp:37] Loading credentials for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> AuthorizedRequest_1_AG7fH1/http_credentials'
> I0116 09:51:46.482873 30016 http.cpp:922] Using default 'basic' HTTP
> authenticator for realm 'mesos-agent-readonly'
> I0116 09:51:46.483042 30016 http.cpp:922] Using default 'basic' HTTP
> authenticator for realm 'mesos-agent-readwrite'
> I0116 09:51:46.484311 30016 slave.cpp:539] Agent resources: cpus(*):2;
> mem(*):1024; disk(*):1024; ports(*):[31000-32000]
> I0116 09:51:46.484393 30016 slave.cpp:547] Agent attributes: [ ]
> I0116 09:51:46.484412 30016 slave.cpp:552] Agent hostname: e2ceffa41f81
> I0116 09:51:46.485888 30015 state.cpp:60] Recovering state from
> '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_HzmNzx/meta'
> I0116 09:51:46.486254 30024 status_update_manager.cpp:203] Recovering
> status update manager
> I0116 09:51:46.486477 30026 containerizer.cpp:599] Recovering containerizer
> I0116 09:51:46.487916 30027 provisioner.cpp:251] Provisioner recovery
> complete
> I0116 09:51:46.488291 30014 slave.cpp:5417] Finished recovery
> I0116 09:51:46.488873 30014 slave.cpp:5591] Querying resource estimator
> for oversubscribable resources
> I0116 09:51:46.489140 30027 slave.cpp:5605] Received oversubscribable
> resources {} from the resource estimator
> I0116 09:51:46.492074 30018 process.cpp:3676] Handling HTTP event for
> process 'slave(678)' with path: '/slave(678)/monitor/statistics.json'
> I0116 09:51:46.493597 30025 http.cpp:874] Authorizing principal
> 'test-principal' to GET the '/monitor/statistics.json' endpoint
> I0116 09:51:46.497017 30028 slave.cpp:796] Agent terminating
> [ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/1 (34 ms)
> [ RUN ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2
> I0116 09:51:46.508632 29995 containerizer.cpp:220] Using isolation:
> posix/cpu,posix/mem,filesystem/posix,network/cni
> W0116 09:51:46.509348 29995 backend.cpp:76] Failed to create 'aufs'
> backend: AufsBackend requires root privileges, but is running as user mesos
> W0116 09:51:46.509543 29995 backend.cpp:76] Failed to create 'bind'
> backend: BindBackend requires root privileges
> I0116 09:51:46.513051 30025 slave.cpp:209] Mesos agent started on (679)@
> 172.17.0.2:35655
> I0116 09:51:46.513083 30025 slave.cpp:210] 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_2VPZtY/credential" --default_role="*"
> --disk_watch_interval="1mins" --docker="docker"
> --docker_kill_orphans="true" --docker_registry="https://
> registry-1.docker.io" --docker_remove_delay="6hrs"
> --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns"
> --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_
> dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false"
> --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs"
> --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_
> AuthorizedRequest_2_2VPZtY/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_2VPZtY/http_credentials" --http_heartbeat_interval="30secs"
> --image_provisioner_backend="copy" --initialize_driver_logging="true"
> --isolation="posix/cpu,posix/mem" --launcher="posix"
> --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0"
> --logging_level="INFO" --max_completed_executors_per_framework="150"
> --oversubscribed_resources_interval="15secs" --perf_duration="10secs"
> --perf_interval="1mins" --qos_correction_interval_min="0ns"
> --quiet="false" --recover="reconnect" --recovery_timeout="15mins"
> --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;
> mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true"
> --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_2VPZtY"
> --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_diz0gu"
> I0116 09:51:46.513836 30025 credentials.hpp:86] Loading credential for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> AuthorizedRequest_2_2VPZtY/credential'
> I0116 09:51:46.514055 30025 slave.cpp:352] Agent using credential for:
> test-principal
> I0116 09:51:46.514088 30025 credentials.hpp:37] Loading credentials for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> AuthorizedRequest_2_2VPZtY/http_credentials'
> I0116 09:51:46.514416 30025 http.cpp:922] Using default 'basic' HTTP
> authenticator for realm 'mesos-agent-readonly'
> I0116 09:51:46.514598 30025 http.cpp:922] Using default 'basic' HTTP
> authenticator for realm 'mesos-agent-readwrite'
> I0116 09:51:46.515904 30025 slave.cpp:539] Agent resources: cpus(*):2;
> mem(*):1024; disk(*):1024; ports(*):[31000-32000]
> I0116 09:51:46.516005 30025 slave.cpp:547] Agent attributes: [ ]
> I0116 09:51:46.516022 30025 slave.cpp:552] Agent hostname: e2ceffa41f81
> I0116 09:51:46.517729 30027 state.cpp:60] Recovering state from
> '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_diz0gu/meta'
> I0116 09:51:46.518080 30017 status_update_manager.cpp:203] Recovering
> status update manager
> I0116 09:51:46.518301 30016 containerizer.cpp:599] Recovering containerizer
> I0116 09:51:46.520084 30019 provisioner.cpp:251] Provisioner recovery
> complete
> I0116 09:51:46.520517 30022 slave.cpp:5417] Finished recovery
> I0116 09:51:46.521075 30022 slave.cpp:5591] Querying resource estimator
> for oversubscribable resources
> I0116 09:51:46.521334 30017 slave.cpp:5605] Received oversubscribable
> resources {} from the resource estimator
> I0116 09:51:46.524288 30024 process.cpp:3676] Handling HTTP event for
> process 'slave(679)' with path: '/slave(679)/containers'
> I0116 09:51:46.525705 30026 http.cpp:874] Authorizing principal
> 'test-principal' to GET the '/containers' endpoint
> I0116 09:51:46.530148 30023 slave.cpp:796] Agent terminating
> [ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (33 ms)
> [ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
> I0116 09:51:46.542531 29995 containerizer.cpp:220] Using isolation:
> posix/cpu,posix/mem,filesystem/posix,network/cni
> W0116 09:51:46.543054 29995 backend.cpp:76] Failed to create 'aufs'
> backend: AufsBackend requires root privileges, but is running as user mesos
> W0116 09:51:46.543205 29995 backend.cpp:76] Failed to create 'bind'
> backend: BindBackend requires root privileges
> I0116 09:51:46.546699 30020 slave.cpp:209] Mesos agent started on (680)@
> 172.17.0.2:35655
> I0116 09:51:46.546722 30020 slave.cpp:210] 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_283CCV/credential" --default_role="*"
> --disk_watch_interval="1mins" --docker="docker"
> --docker_kill_orphans="true" --docker_registry="https://
> registry-1.docker.io" --docker_remove_delay="6hrs"
> --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns"
> --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_
> dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false"
> --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs"
> --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_
> UnauthorizedRequest_0_283CCV/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_283CCV/http_credentials" --http_heartbeat_interval="30secs"
> --image_provisioner_backend="copy" --initialize_driver_logging="true"
> --isolation="posix/cpu,posix/mem" --launcher="posix"
> --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0"
> --logging_level="INFO" --max_completed_executors_per_framework="150"
> --oversubscribed_resources_interval="15secs" --perf_duration="10secs"
> --perf_interval="1mins" --qos_correction_interval_min="0ns"
> --quiet="false" --recover="reconnect" --recovery_timeout="15mins"
> --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;
> mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true"
> --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_283CCV"
> --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_dMm5jr"
> I0116 09:51:46.547276 30020 credentials.hpp:86] Loading credential for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> UnauthorizedRequest_0_283CCV/credential'
> I0116 09:51:46.547462 30020 slave.cpp:352] Agent using credential for:
> test-principal
> I0116 09:51:46.547482 30020 credentials.hpp:37] Loading credentials for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> UnauthorizedRequest_0_283CCV/http_credentials'
> I0116 09:51:46.547718 30020 http.cpp:922] Using default 'basic' HTTP
> authenticator for realm 'mesos-agent-readonly'
> I0116 09:51:46.547843 30020 http.cpp:922] Using default 'basic' HTTP
> authenticator for realm 'mesos-agent-readwrite'
> I0116 09:51:46.548887 30020 slave.cpp:539] Agent resources: cpus(*):2;
> mem(*):1024; disk(*):1024; ports(*):[31000-32000]
> I0116 09:51:46.548974 30020 slave.cpp:547] Agent attributes: [ ]
> I0116 09:51:46.548987 30020 slave.cpp:552] Agent hostname: e2ceffa41f81
> I0116 09:51:46.550458 30024 state.cpp:60] Recovering state from
> '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_dMm5jr/meta'
> I0116 09:51:46.550839 30029 status_update_manager.cpp:203] Recovering
> status update manager
> I0116 09:51:46.551076 30022 containerizer.cpp:599] Recovering containerizer
> I0116 09:51:46.552680 30017 provisioner.cpp:251] Provisioner recovery
> complete
> I0116 09:51:46.553056 30024 slave.cpp:5417] Finished recovery
> I0116 09:51:46.553587 30024 slave.cpp:5591] Querying resource estimator
> for oversubscribable resources
> I0116 09:51:46.553863 30023 slave.cpp:5605] Received oversubscribable
> resources {} from the resource estimator
> I0116 09:51:46.556442 30025 process.cpp:3676] Handling HTTP event for
> process 'slave(680)' with path: '/slave(680)/monitor/statistics'
> I0116 09:51:46.558060 30017 http.cpp:874] Authorizing principal
> 'test-principal' to GET the '/monitor/statistics' endpoint
> I0116 09:51:46.561043 30018 slave.cpp:796] Agent terminating
> [ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (29 ms)
> [ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
> I0116 09:51:46.573585 29995 containerizer.cpp:220] Using isolation:
> posix/cpu,posix/mem,filesystem/posix,network/cni
> W0116 09:51:46.574321 29995 backend.cpp:76] Failed to create 'aufs'
> backend: AufsBackend requires root privileges, but is running as user mesos
> W0116 09:51:46.574524 29995 backend.cpp:76] Failed to create 'bind'
> backend: BindBackend requires root privileges
> I0116 09:51:46.578233 30023 slave.cpp:209] Mesos agent started on (681)@
> 172.17.0.2:35655
> I0116 09:51:46.578258 30023 slave.cpp:210] 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_Qkek5S/credential" --default_role="*"
> --disk_watch_interval="1mins" --docker="docker"
> --docker_kill_orphans="true" --docker_registry="https://
> registry-1.docker.io" --docker_remove_delay="6hrs"
> --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns"
> --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_
> dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false"
> --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs"
> --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_
> UnauthorizedRequest_1_Qkek5S/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_Qkek5S/http_credentials" --http_heartbeat_interval="30secs"
> --image_provisioner_backend="copy" --initialize_driver_logging="true"
> --isolation="posix/cpu,posix/mem" --launcher="posix"
> --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0"
> --logging_level="INFO" --max_completed_executors_per_framework="150"
> --oversubscribed_resources_interval="15secs" --perf_duration="10secs"
> --perf_interval="1mins" --qos_correction_interval_min="0ns"
> --quiet="false" --recover="reconnect" --recovery_timeout="15mins"
> --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;
> mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true"
> --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Qkek5S"
> --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_Pa4PHo"
> I0116 09:51:46.578958 30023 credentials.hpp:86] Loading credential for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> UnauthorizedRequest_1_Qkek5S/credential'
> I0116 09:51:46.579126 30023 slave.cpp:352] Agent using credential for:
> test-principal
> I0116 09:51:46.579146 30023 credentials.hpp:37] Loading credentials for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> UnauthorizedRequest_1_Qkek5S/http_credentials'
> I0116 09:51:46.579442 30023 http.cpp:922] Using default 'basic' HTTP
> authenticator for realm 'mesos-agent-readonly'
> I0116 09:51:46.579633 30023 http.cpp:922] Using default 'basic' HTTP
> authenticator for realm 'mesos-agent-readwrite'
> I0116 09:51:46.581562 30023 slave.cpp:539] Agent resources: cpus(*):2;
> mem(*):1024; disk(*):1024; ports(*):[31000-32000]
> I0116 09:51:46.581728 30023 slave.cpp:547] Agent attributes: [ ]
> I0116 09:51:46.581768 30023 slave.cpp:552] Agent hostname: e2ceffa41f81
> I0116 09:51:46.583212 30025 state.cpp:60] Recovering state from
> '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Pa4PHo/meta'
> I0116 09:51:46.583648 30016 status_update_manager.cpp:203] Recovering
> status update manager
> I0116 09:51:46.583866 30023 containerizer.cpp:599] Recovering containerizer
> I0116 09:51:46.585520 30025 provisioner.cpp:251] Provisioner recovery
> complete
> I0116 09:51:46.585973 30020 slave.cpp:5417] Finished recovery
> I0116 09:51:46.586565 30020 slave.cpp:5591] Querying resource estimator
> for oversubscribable resources
> I0116 09:51:46.586885 30026 slave.cpp:5605] Received oversubscribable
> resources {} from the resource estimator
> I0116 09:51:46.589584 30015 process.cpp:3676] Handling HTTP event for
> process 'slave(681)' with path: '/slave(681)/monitor/statistics.json'
> I0116 09:51:46.591138 30024 http.cpp:874] Authorizing principal
> 'test-principal' to GET the '/monitor/statistics.json' endpoint
> I0116 09:51:46.594167 30027 slave.cpp:796] Agent terminating
> [ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (31 ms)
> [ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
> I0116 09:51:46.604389 29995 containerizer.cpp:220] Using isolation:
> posix/cpu,posix/mem,filesystem/posix,network/cni
> W0116 09:51:46.604957 29995 backend.cpp:76] Failed to create 'aufs'
> backend: AufsBackend requires root privileges, but is running as user mesos
> W0116 09:51:46.605130 29995 backend.cpp:76] Failed to create 'bind'
> backend: BindBackend requires root privileges
> I0116 09:51:46.608289 30023 slave.cpp:209] Mesos agent started on (682)@
> 172.17.0.2:35655
> I0116 09:51:46.608315 30023 slave.cpp:210] 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_e0VISQ/credential" --default_role="*"
> --disk_watch_interval="1mins" --docker="docker"
> --docker_kill_orphans="true" --docker_registry="https://
> registry-1.docker.io" --docker_remove_delay="6hrs"
> --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns"
> --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_
> dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false"
> --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs"
> --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_
> UnauthorizedRequest_2_e0VISQ/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_e0VISQ/http_credentials" --http_heartbeat_interval="30secs"
> --image_provisioner_backend="copy" --initialize_driver_logging="true"
> --isolation="posix/cpu,posix/mem" --launcher="posix"
> --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0"
> --logging_level="INFO" --max_completed_executors_per_framework="150"
> --oversubscribed_resources_interval="15secs" --perf_duration="10secs"
> --perf_interval="1mins" --qos_correction_interval_min="0ns"
> --quiet="false" --recover="reconnect" --recovery_timeout="15mins"
> --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;
> mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true"
> --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_e0VISQ"
> --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_3Rw9pm"
> I0116 09:51:46.608819 30023 credentials.hpp:86] Loading credential for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> UnauthorizedRequest_2_e0VISQ/credential'
> I0116 09:51:46.609014 30023 slave.cpp:352] Agent using credential for:
> test-principal
> I0116 09:51:46.609040 30023 credentials.hpp:37] Loading credentials for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> UnauthorizedRequest_2_e0VISQ/http_credentials'
> I0116 09:51:46.609347 30023 http.cpp:922] Using default 'basic' HTTP
> authenticator for realm 'mesos-agent-readonly'
> I0116 09:51:46.609520 30023 http.cpp:922] Using default 'basic' HTTP
> authenticator for realm 'mesos-agent-readwrite'
> I0116 09:51:46.610852 30023 slave.cpp:539] Agent resources: cpus(*):2;
> mem(*):1024; disk(*):1024; ports(*):[31000-32000]
> I0116 09:51:46.610965 30023 slave.cpp:547] Agent attributes: [ ]
> I0116 09:51:46.610991 30023 slave.cpp:552] Agent hostname: e2ceffa41f81
> I0116 09:51:46.612813 30015 state.cpp:60] Recovering state from
> '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_3Rw9pm/meta'
> I0116 09:51:46.613232 30029 status_update_manager.cpp:203] Recovering
> status update manager
> I0116 09:51:46.613477 30022 containerizer.cpp:599] Recovering containerizer
> I0116 09:51:46.615188 30026 provisioner.cpp:251] Provisioner recovery
> complete
> I0116 09:51:46.615689 30015 slave.cpp:5417] Finished recovery
> I0116 09:51:46.616334 30015 slave.cpp:5591] Querying resource estimator
> for oversubscribable resources
> I0116 09:51:46.616644 30014 slave.cpp:5605] Received oversubscribable
> resources {} from the resource estimator
> I0116 09:51:46.619860 30017 process.cpp:3676] Handling HTTP event for
> process 'slave(682)' with path: '/slave(682)/containers'
> I0116 09:51:46.621522 30019 http.cpp:874] Authorizing principal
> 'test-principal' to GET the '/containers' endpoint
> I0116 09:51:46.624193 30021 slave.cpp:796] Agent terminating
> [ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (31 ms)
> [ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
> I0116 09:51:46.638782 29995 containerizer.cpp:220] Using isolation:
> posix/cpu,posix/mem,filesystem/posix,network/cni
> W0116 09:51:46.639811 29995 backend.cpp:76] Failed to create 'aufs'
> backend: AufsBackend requires root privileges, but is running as user mesos
> W0116 09:51:46.640041 29995 backend.cpp:76] Failed to create 'bind'
> backend: BindBackend requires root privileges
> I0116 09:51:46.642457 29995 cluster.cpp:446] Creating default 'local'
> authorizer
> I0116 09:51:46.644047 30028 slave.cpp:209] Mesos agent started on (683)@
> 172.17.0.2:35655
> I0116 09:51:46.644073 30028 slave.cpp:210] 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_QyJJ0O/credential" --default_role="*"
> --disk_watch_interval="1mins" --docker="docker"
> --docker_kill_orphans="true" --docker_registry="https://
> registry-1.docker.io" --docker_remove_delay="6hrs"
> --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns"
> --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_
> dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false"
> --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs"
> --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_QyJJ0O/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_QyJJ0O/http_credentials"
> --http_heartbeat_interval="30secs" --image_provisioner_backend="copy"
> --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem"
> --launcher="posix" --launcher_dir="/mesos/mesos-1.2.0/_build/src"
> --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150"
> --oversubscribed_resources_interval="15secs" --perf_duration="10secs"
> --perf_interval="1mins" --qos_correction_interval_min="0ns"
> --quiet="false" --recover="reconnect" --recovery_timeout="15mins"
> --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;
> mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true"
> --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_QyJJ0O"
> --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_VSkQsk"
> I0116 09:51:46.644632 30028 credentials.hpp:86] Loading credential for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> NoAuthorizer_0_QyJJ0O/credential'
> I0116 09:51:46.644876 30028 slave.cpp:352] Agent using credential for:
> test-principal
> I0116 09:51:46.644902 30028 credentials.hpp:37] Loading credentials for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> NoAuthorizer_0_QyJJ0O/http_credentials'
> I0116 09:51:46.645268 30028 http.cpp:922] Using default 'basic' HTTP
> authenticator for realm 'mesos-agent-readonly'
> I0116 09:51:46.645401 30028 http.cpp:922] Using default 'basic' HTTP
> authenticator for realm 'mesos-agent-readwrite'
> I0116 09:51:46.646754 30028 slave.cpp:539] Agent resources: cpus(*):2;
> mem(*):1024; disk(*):1024; ports(*):[31000-32000]
> I0116 09:51:46.646878 30028 slave.cpp:547] Agent attributes: [ ]
> I0116 09:51:46.646898 30028 slave.cpp:552] Agent hostname: e2ceffa41f81
> I0116 09:51:46.648572 30023 state.cpp:60] Recovering state from
> '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_VSkQsk/meta'
> I0116 09:51:46.648880 30027 status_update_manager.cpp:203] Recovering
> status update manager
> I0116 09:51:46.649127 30024 containerizer.cpp:599] Recovering containerizer
> I0116 09:51:46.650606 30023 provisioner.cpp:251] Provisioner recovery
> complete
> I0116 09:51:46.650980 30014 slave.cpp:5417] Finished recovery
> I0116 09:51:46.651558 30014 slave.cpp:5591] Querying resource estimator
> for oversubscribable resources
> I0116 09:51:46.651875 30027 slave.cpp:5605] Received oversubscribable
> resources {} from the resource estimator
> I0116 09:51:46.654917 30023 process.cpp:3676] Handling HTTP event for
> process 'slave(683)' with path: '/slave(683)/monitor/statistics'
> I0116 09:51:46.656316 30028 http.cpp:874] Authorizing principal
> 'test-principal' to GET the '/monitor/statistics' endpoint
> I0116 09:51:46.659951 30015 slave.cpp:796] Agent terminating
> [ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (35 ms)
> [ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
> I0116 09:51:46.673064 29995 containerizer.cpp:220] Using isolation:
> posix/cpu,posix/mem,filesystem/posix,network/cni
> W0116 09:51:46.673629 29995 backend.cpp:76] Failed to create 'aufs'
> backend: AufsBackend requires root privileges, but is running as user mesos
> W0116 09:51:46.673831 29995 backend.cpp:76] Failed to create 'bind'
> backend: BindBackend requires root privileges
> I0116 09:51:46.675446 29995 cluster.cpp:446] Creating default 'local'
> authorizer
> I0116 09:51:46.677063 30029 slave.cpp:209] Mesos agent started on (684)@
> 172.17.0.2:35655
> I0116 09:51:46.677089 30029 slave.cpp:210] 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_2SlHvN/credential" --default_role="*"
> --disk_watch_interval="1mins" --docker="docker"
> --docker_kill_orphans="true" --docker_registry="https://
> registry-1.docker.io" --docker_remove_delay="6hrs"
> --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns"
> --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_
> dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false"
> --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs"
> --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_2SlHvN/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_2SlHvN/http_credentials"
> --http_heartbeat_interval="30secs" --image_provisioner_backend="copy"
> --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem"
> --launcher="posix" --launcher_dir="/mesos/mesos-1.2.0/_build/src"
> --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150"
> --oversubscribed_resources_interval="15secs" --perf_duration="10secs"
> --perf_interval="1mins" --qos_correction_interval_min="0ns"
> --quiet="false" --recover="reconnect" --recovery_timeout="15mins"
> --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;
> mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true"
> --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_2SlHvN"
> --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_VGY6Ri"
> I0116 09:51:46.677721 30029 credentials.hpp:86] Loading credential for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> NoAuthorizer_1_2SlHvN/credential'
> I0116 09:51:46.677924 30029 slave.cpp:352] Agent using credential for:
> test-principal
> I0116 09:51:46.677952 30029 credentials.hpp:37] Loading credentials for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> NoAuthorizer_1_2SlHvN/http_credentials'
> I0116 09:51:46.678208 30029 http.cpp:922] Using default 'basic' HTTP
> authenticator for realm 'mesos-agent-readonly'
> I0116 09:51:46.678366 30029 http.cpp:922] Using default 'basic' HTTP
> authenticator for realm 'mesos-agent-readwrite'
> I0116 09:51:46.679630 30029 slave.cpp:539] Agent resources: cpus(*):2;
> mem(*):1024; disk(*):1024; ports(*):[31000-32000]
> I0116 09:51:46.679725 30029 slave.cpp:547] Agent attributes: [ ]
> I0116 09:51:46.679747 30029 slave.cpp:552] Agent hostname: e2ceffa41f81
> I0116 09:51:46.681366 30028 state.cpp:60] Recovering state from
> '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_VGY6Ri/meta'
> I0116 09:51:46.681709 30027 status_update_manager.cpp:203] Recovering
> status update manager
> I0116 09:51:46.681936 30015 containerizer.cpp:599] Recovering containerizer
> I0116 09:51:46.683468 30015 provisioner.cpp:251] Provisioner recovery
> complete
> I0116 09:51:46.683886 30018 slave.cpp:5417] Finished recovery
> I0116 09:51:46.684502 30018 slave.cpp:5591] Querying resource estimator
> for oversubscribable resources
> I0116 09:51:46.684775 30020 slave.cpp:5605] Received oversubscribable
> resources {} from the resource estimator
> I0116 09:51:46.687891 30022 process.cpp:3676] Handling HTTP event for
> process 'slave(684)' with path: '/slave(684)/monitor/statistics.json'
> I0116 09:51:46.690178 30018 http.cpp:874] Authorizing principal
> 'test-principal' to GET the '/monitor/statistics.json' endpoint
> I0116 09:51:46.694223 30016 slave.cpp:796] Agent terminating
> [ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (33 ms)
> [ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
> I0116 09:51:46.705404 29995 containerizer.cpp:220] Using isolation:
> posix/cpu,posix/mem,filesystem/posix,network/cni
> W0116 09:51:46.705979 29995 backend.cpp:76] Failed to create 'aufs'
> backend: AufsBackend requires root privileges, but is running as user mesos
> W0116 09:51:46.706132 29995 backend.cpp:76] Failed to create 'bind'
> backend: BindBackend requires root privileges
> I0116 09:51:46.707629 29995 cluster.cpp:446] Creating default 'local'
> authorizer
> I0116 09:51:46.709239 30019 slave.cpp:209] Mesos agent started on (685)@
> 172.17.0.2:35655
> I0116 09:51:46.709260 30019 slave.cpp:210] 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_07OmmM/credential" --default_role="*"
> --disk_watch_interval="1mins" --docker="docker"
> --docker_kill_orphans="true" --docker_registry="https://
> registry-1.docker.io" --docker_remove_delay="6hrs"
> --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns"
> --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_
> dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false"
> --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs"
> --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_07OmmM/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_07OmmM/http_credentials"
> --http_heartbeat_interval="30secs" --image_provisioner_backend="copy"
> --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem"
> --launcher="posix" --launcher_dir="/mesos/mesos-1.2.0/_build/src"
> --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150"
> --oversubscribed_resources_interval="15secs" --perf_duration="10secs"
> --perf_interval="1mins" --qos_correction_interval_min="0ns"
> --quiet="false" --recover="reconnect" --recovery_timeout="15mins"
> --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;
> mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true"
> --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_07OmmM"
> --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_ZZdmDh"
> I0116 09:51:46.709749 30019 credentials.hpp:86] Loading credential for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> NoAuthorizer_2_07OmmM/credential'
> I0116 09:51:46.709928 30019 slave.cpp:352] Agent using credential for:
> test-principal
> I0116 09:51:46.709956 30019 credentials.hpp:37] Loading credentials for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> NoAuthorizer_2_07OmmM/http_credentials'
> I0116 09:51:46.710218 30019 http.cpp:922] Using default 'basic' HTTP
> authenticator for realm 'mesos-agent-readonly'
> I0116 09:51:46.710355 30019 http.cpp:922] Using default 'basic' HTTP
> authenticator for realm 'mesos-agent-readwrite'
> I0116 09:51:46.711472 30019 slave.cpp:539] Agent resources: cpus(*):2;
> mem(*):1024; disk(*):1024; ports(*):[31000-32000]
> I0116 09:51:46.711549 30019 slave.cpp:547] Agent attributes: [ ]
> I0116 09:51:46.711562 30019 slave.cpp:552] Agent hostname: e2ceffa41f81
> I0116 09:51:46.713201 30021 state.cpp:60] Recovering state from
> '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_ZZdmDh/meta'
> I0116 09:51:46.713732 30025 status_update_manager.cpp:203] Recovering
> status update manager
> I0116 09:51:46.713961 30026 containerizer.cpp:599] Recovering containerizer
> I0116 09:51:46.715881 30021 provisioner.cpp:251] Provisioner recovery
> complete
> I0116 09:51:46.716437 30024 slave.cpp:5417] Finished recovery
> I0116 09:51:46.717211 30024 slave.cpp:5591] Querying resource estimator
> for oversubscribable resources
> I0116 09:51:46.717609 30016 slave.cpp:5605] Received oversubscribable
> resources {} from the resource estimator
> I0116 09:51:46.720813 30023 process.cpp:3676] Handling HTTP event for
> process 'slave(685)' with path: '/slave(685)/containers'
> I0116 09:51:46.722326 30014 http.cpp:874] Authorizing principal
> 'test-principal' to GET the '/containers' endpoint
> I0116 09:51:46.726469 30019 slave.cpp:796] Agent terminating
> [ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (32 ms)
> [----------] 9 tests from Endpoint/SlaveEndpointTest (300 ms total)
>
> [----------] Global test environment tear-down
> [==========] 1448 tests from 164 test cases ran. (422988 ms total)
> [ PASSED ] 1447 tests.
> [ FAILED ] 1 test, listed below:
> [ FAILED ] FaultToleranceTest.FrameworkReregister
>
> 1 FAILED TEST
> YOU HAVE 14 DISABLED TESTS
>
> make[4]: *** [check-local] Error 1
> make[4]: Leaving directory `/mesos/mesos-1.2.0/_build/src'
> make[3]: *** [check-am] Error 2
> make[3]: Leaving directory `/mesos/mesos-1.2.0/_build/src'
> make[2]: *** [check] Error 2
> make[2]: Leaving directory `/mesos/mesos-1.2.0/_build/src'
> make[1]: *** [check-recursive] Error 1
> make[1]: Leaving directory `/mesos/mesos-1.2.0/_build'
> make: *** [distcheck] Error 1
> + docker rmi mesos-1484557246-15527
> Untagged: mesos-1484557246-15527:latest
> Deleted: sha256:7e41de3bcd89de24d2fa1732bbf3b7
> 94315d57c4b39272819a3352d81e66fda7
> Deleted: sha256:3f6233d3d412d3c2f0e5b139662726
> 087a62de91e42bcfdbe6e29f16cf168a23
> Deleted: sha256:33d2cfbd359052567396d05fa7d728
> 358ade0ac7c19448cf92c19eb49eef33c0
> Deleted: sha256:0c3332f718962c35fd4e057e96c499
> 2cead66190e3dad31a3a06ed4f9e06f593
> Deleted: sha256:dac2d6d60faf5096869c781be0055f
> 76e7cc9fc11dfeb6c55eef6dc46213e668
> Deleted: sha256:dba0ff0440cf8fdae0611e8c4f2b8e
> a943aba113a2cea180616465a35c96d7b5
> Deleted: sha256:25788368e293262f41ac6a0cee1620
> 440ade6ab611c0bd63a179155ce4bb21f6
> Deleted: sha256:b331f2b012fd0d73f71fc8b108fa74
> c60f92532c044aa7c89e047d600375e8a8
> Deleted: sha256:08713ecad5b9582ca5dc964b143e3d
> 7d96ae1007fccd437c3fa282a28ed6c812
> Deleted: sha256:f0e7c7649e66da55f977e7c9a5f2f7
> 4e420818b97793e63fe6cf2aeba5bad72a
> Deleted: sha256:dff9b65efc5da7bf593769012fca1b
> 273ff65e61c9ce33557038f77d509b81e2
> Deleted: sha256:9e9afcccf4a164a4cab96a39dcfae3
> 2e865ec5a1510acb7b1a5da47536a367a0
> Deleted: sha256:d9f66a16251428503ead9223880864
> bada17004c0b8386fd1447d5c869efe47b
> Deleted: sha256:1d83ae0590cb47b6d908e14c8edc95
> 5f2001185219b52a3c7979fdcdfa6fa543
> Deleted: sha256:043c7708b6e96b2126cbcf93771444
> 784e406e2999fc007ef7bcc7958126a2f0
> Deleted: sha256:312106843ae2f45d1b2fa20c66ddb0
> 218ef2866c937c1ee01f33afafd5fe11e5
> Deleted: sha256:f12d0668d5f137baee384875fba45a
> 5554f2ed5a352354b6586cedb2d3a02164
> Deleted: sha256:263a1dd3cfe471a0459f980a3a02e0
> 5e922357e6bb4a8632ec7ce91d68027846
> Deleted: sha256:55008d69864fe805b9caffb9c2a1a9
> 3f3faf98eca874a94e8e59e97f79c087e0
> Deleted: sha256:2bd3154e97de566b758629fd7559ed
> fe520ae2cc15e48ebe3b2287b569b22a8e
> Deleted: sha256:a9b827d4b09db7670234d5b1540e14
> ca2889a98689c865da57028145026fcfa5
> Deleted: sha256:2ff7af7b209346b763568ca675e3e5
> cfc526a54899110cb80e564bd300c7777b
> Deleted: sha256:5f49c4d879bed096cdc0419c13e00c
> 75468316639bbd83088ddfd8a71e3ee45b
> Deleted: sha256:fbc0794a6e54fbabc24a52cdb68a74
> a37416b8b85c8e40d0533e4cc582bc99b1
> Build step 'Execute shell' marked build as failure
>
Build failed in Jenkins: Mesos-Reviewbot #16737
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Reviewbot/16737/>
------------------------------------------
[...truncated 171048 lines...]
I0116 09:51:46.475677 29995 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0116 09:51:46.476682 29995 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W0116 09:51:46.476922 29995 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0116 09:51:46.481760 30016 slave.cpp:209] Mesos agent started on (678)@172.17.0.2:35655
I0116 09:51:46.481792 30016 slave.cpp:210] 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_1_AG7fH1/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_AG7fH1/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_1_AG7fH1/http_credentials" --http_heartbeat_interval="30secs" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_AG7fH1" --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_1_HzmNzx"
I0116 09:51:46.482417 30016 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_AG7fH1/credential'
I0116 09:51:46.482627 30016 slave.cpp:352] Agent using credential for: test-principal
I0116 09:51:46.482647 30016 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_AG7fH1/http_credentials'
I0116 09:51:46.482873 30016 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0116 09:51:46.483042 30016 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0116 09:51:46.484311 30016 slave.cpp:539] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0116 09:51:46.484393 30016 slave.cpp:547] Agent attributes: [ ]
I0116 09:51:46.484412 30016 slave.cpp:552] Agent hostname: e2ceffa41f81
I0116 09:51:46.485888 30015 state.cpp:60] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_HzmNzx/meta'
I0116 09:51:46.486254 30024 status_update_manager.cpp:203] Recovering status update manager
I0116 09:51:46.486477 30026 containerizer.cpp:599] Recovering containerizer
I0116 09:51:46.487916 30027 provisioner.cpp:251] Provisioner recovery complete
I0116 09:51:46.488291 30014 slave.cpp:5417] Finished recovery
I0116 09:51:46.488873 30014 slave.cpp:5591] Querying resource estimator for oversubscribable resources
I0116 09:51:46.489140 30027 slave.cpp:5605] Received oversubscribable resources {} from the resource estimator
I0116 09:51:46.492074 30018 process.cpp:3676] Handling HTTP event for process 'slave(678)' with path: '/slave(678)/monitor/statistics.json'
I0116 09:51:46.493597 30025 http.cpp:874] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0116 09:51:46.497017 30028 slave.cpp:796] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/1 (34 ms)
[ RUN ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2
I0116 09:51:46.508632 29995 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0116 09:51:46.509348 29995 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W0116 09:51:46.509543 29995 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0116 09:51:46.513051 30025 slave.cpp:209] Mesos agent started on (679)@172.17.0.2:35655
I0116 09:51:46.513083 30025 slave.cpp:210] 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_2VPZtY/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_2VPZtY/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_2VPZtY/http_credentials" --http_heartbeat_interval="30secs" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_2VPZtY" --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_diz0gu"
I0116 09:51:46.513836 30025 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_2VPZtY/credential'
I0116 09:51:46.514055 30025 slave.cpp:352] Agent using credential for: test-principal
I0116 09:51:46.514088 30025 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_2VPZtY/http_credentials'
I0116 09:51:46.514416 30025 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0116 09:51:46.514598 30025 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0116 09:51:46.515904 30025 slave.cpp:539] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0116 09:51:46.516005 30025 slave.cpp:547] Agent attributes: [ ]
I0116 09:51:46.516022 30025 slave.cpp:552] Agent hostname: e2ceffa41f81
I0116 09:51:46.517729 30027 state.cpp:60] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_diz0gu/meta'
I0116 09:51:46.518080 30017 status_update_manager.cpp:203] Recovering status update manager
I0116 09:51:46.518301 30016 containerizer.cpp:599] Recovering containerizer
I0116 09:51:46.520084 30019 provisioner.cpp:251] Provisioner recovery complete
I0116 09:51:46.520517 30022 slave.cpp:5417] Finished recovery
I0116 09:51:46.521075 30022 slave.cpp:5591] Querying resource estimator for oversubscribable resources
I0116 09:51:46.521334 30017 slave.cpp:5605] Received oversubscribable resources {} from the resource estimator
I0116 09:51:46.524288 30024 process.cpp:3676] Handling HTTP event for process 'slave(679)' with path: '/slave(679)/containers'
I0116 09:51:46.525705 30026 http.cpp:874] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0116 09:51:46.530148 30023 slave.cpp:796] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (33 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0116 09:51:46.542531 29995 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0116 09:51:46.543054 29995 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W0116 09:51:46.543205 29995 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0116 09:51:46.546699 30020 slave.cpp:209] Mesos agent started on (680)@172.17.0.2:35655
I0116 09:51:46.546722 30020 slave.cpp:210] 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_283CCV/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_283CCV/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_283CCV/http_credentials" --http_heartbeat_interval="30secs" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_283CCV" --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_dMm5jr"
I0116 09:51:46.547276 30020 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_283CCV/credential'
I0116 09:51:46.547462 30020 slave.cpp:352] Agent using credential for: test-principal
I0116 09:51:46.547482 30020 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_283CCV/http_credentials'
I0116 09:51:46.547718 30020 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0116 09:51:46.547843 30020 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0116 09:51:46.548887 30020 slave.cpp:539] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0116 09:51:46.548974 30020 slave.cpp:547] Agent attributes: [ ]
I0116 09:51:46.548987 30020 slave.cpp:552] Agent hostname: e2ceffa41f81
I0116 09:51:46.550458 30024 state.cpp:60] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_dMm5jr/meta'
I0116 09:51:46.550839 30029 status_update_manager.cpp:203] Recovering status update manager
I0116 09:51:46.551076 30022 containerizer.cpp:599] Recovering containerizer
I0116 09:51:46.552680 30017 provisioner.cpp:251] Provisioner recovery complete
I0116 09:51:46.553056 30024 slave.cpp:5417] Finished recovery
I0116 09:51:46.553587 30024 slave.cpp:5591] Querying resource estimator for oversubscribable resources
I0116 09:51:46.553863 30023 slave.cpp:5605] Received oversubscribable resources {} from the resource estimator
I0116 09:51:46.556442 30025 process.cpp:3676] Handling HTTP event for process 'slave(680)' with path: '/slave(680)/monitor/statistics'
I0116 09:51:46.558060 30017 http.cpp:874] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0116 09:51:46.561043 30018 slave.cpp:796] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (29 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0116 09:51:46.573585 29995 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0116 09:51:46.574321 29995 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W0116 09:51:46.574524 29995 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0116 09:51:46.578233 30023 slave.cpp:209] Mesos agent started on (681)@172.17.0.2:35655
I0116 09:51:46.578258 30023 slave.cpp:210] 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_Qkek5S/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Qkek5S/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_Qkek5S/http_credentials" --http_heartbeat_interval="30secs" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Qkek5S" --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_Pa4PHo"
I0116 09:51:46.578958 30023 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Qkek5S/credential'
I0116 09:51:46.579126 30023 slave.cpp:352] Agent using credential for: test-principal
I0116 09:51:46.579146 30023 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Qkek5S/http_credentials'
I0116 09:51:46.579442 30023 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0116 09:51:46.579633 30023 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0116 09:51:46.581562 30023 slave.cpp:539] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0116 09:51:46.581728 30023 slave.cpp:547] Agent attributes: [ ]
I0116 09:51:46.581768 30023 slave.cpp:552] Agent hostname: e2ceffa41f81
I0116 09:51:46.583212 30025 state.cpp:60] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Pa4PHo/meta'
I0116 09:51:46.583648 30016 status_update_manager.cpp:203] Recovering status update manager
I0116 09:51:46.583866 30023 containerizer.cpp:599] Recovering containerizer
I0116 09:51:46.585520 30025 provisioner.cpp:251] Provisioner recovery complete
I0116 09:51:46.585973 30020 slave.cpp:5417] Finished recovery
I0116 09:51:46.586565 30020 slave.cpp:5591] Querying resource estimator for oversubscribable resources
I0116 09:51:46.586885 30026 slave.cpp:5605] Received oversubscribable resources {} from the resource estimator
I0116 09:51:46.589584 30015 process.cpp:3676] Handling HTTP event for process 'slave(681)' with path: '/slave(681)/monitor/statistics.json'
I0116 09:51:46.591138 30024 http.cpp:874] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0116 09:51:46.594167 30027 slave.cpp:796] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (31 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0116 09:51:46.604389 29995 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0116 09:51:46.604957 29995 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W0116 09:51:46.605130 29995 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0116 09:51:46.608289 30023 slave.cpp:209] Mesos agent started on (682)@172.17.0.2:35655
I0116 09:51:46.608315 30023 slave.cpp:210] 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_e0VISQ/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_e0VISQ/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_e0VISQ/http_credentials" --http_heartbeat_interval="30secs" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_e0VISQ" --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_3Rw9pm"
I0116 09:51:46.608819 30023 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_e0VISQ/credential'
I0116 09:51:46.609014 30023 slave.cpp:352] Agent using credential for: test-principal
I0116 09:51:46.609040 30023 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_e0VISQ/http_credentials'
I0116 09:51:46.609347 30023 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0116 09:51:46.609520 30023 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0116 09:51:46.610852 30023 slave.cpp:539] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0116 09:51:46.610965 30023 slave.cpp:547] Agent attributes: [ ]
I0116 09:51:46.610991 30023 slave.cpp:552] Agent hostname: e2ceffa41f81
I0116 09:51:46.612813 30015 state.cpp:60] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_3Rw9pm/meta'
I0116 09:51:46.613232 30029 status_update_manager.cpp:203] Recovering status update manager
I0116 09:51:46.613477 30022 containerizer.cpp:599] Recovering containerizer
I0116 09:51:46.615188 30026 provisioner.cpp:251] Provisioner recovery complete
I0116 09:51:46.615689 30015 slave.cpp:5417] Finished recovery
I0116 09:51:46.616334 30015 slave.cpp:5591] Querying resource estimator for oversubscribable resources
I0116 09:51:46.616644 30014 slave.cpp:5605] Received oversubscribable resources {} from the resource estimator
I0116 09:51:46.619860 30017 process.cpp:3676] Handling HTTP event for process 'slave(682)' with path: '/slave(682)/containers'
I0116 09:51:46.621522 30019 http.cpp:874] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0116 09:51:46.624193 30021 slave.cpp:796] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (31 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0116 09:51:46.638782 29995 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0116 09:51:46.639811 29995 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W0116 09:51:46.640041 29995 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0116 09:51:46.642457 29995 cluster.cpp:446] Creating default 'local' authorizer
I0116 09:51:46.644047 30028 slave.cpp:209] Mesos agent started on (683)@172.17.0.2:35655
I0116 09:51:46.644073 30028 slave.cpp:210] 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_QyJJ0O/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_QyJJ0O/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_QyJJ0O/http_credentials" --http_heartbeat_interval="30secs" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_QyJJ0O" --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_VSkQsk"
I0116 09:51:46.644632 30028 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_QyJJ0O/credential'
I0116 09:51:46.644876 30028 slave.cpp:352] Agent using credential for: test-principal
I0116 09:51:46.644902 30028 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_QyJJ0O/http_credentials'
I0116 09:51:46.645268 30028 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0116 09:51:46.645401 30028 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0116 09:51:46.646754 30028 slave.cpp:539] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0116 09:51:46.646878 30028 slave.cpp:547] Agent attributes: [ ]
I0116 09:51:46.646898 30028 slave.cpp:552] Agent hostname: e2ceffa41f81
I0116 09:51:46.648572 30023 state.cpp:60] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_VSkQsk/meta'
I0116 09:51:46.648880 30027 status_update_manager.cpp:203] Recovering status update manager
I0116 09:51:46.649127 30024 containerizer.cpp:599] Recovering containerizer
I0116 09:51:46.650606 30023 provisioner.cpp:251] Provisioner recovery complete
I0116 09:51:46.650980 30014 slave.cpp:5417] Finished recovery
I0116 09:51:46.651558 30014 slave.cpp:5591] Querying resource estimator for oversubscribable resources
I0116 09:51:46.651875 30027 slave.cpp:5605] Received oversubscribable resources {} from the resource estimator
I0116 09:51:46.654917 30023 process.cpp:3676] Handling HTTP event for process 'slave(683)' with path: '/slave(683)/monitor/statistics'
I0116 09:51:46.656316 30028 http.cpp:874] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0116 09:51:46.659951 30015 slave.cpp:796] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (35 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0116 09:51:46.673064 29995 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0116 09:51:46.673629 29995 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W0116 09:51:46.673831 29995 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0116 09:51:46.675446 29995 cluster.cpp:446] Creating default 'local' authorizer
I0116 09:51:46.677063 30029 slave.cpp:209] Mesos agent started on (684)@172.17.0.2:35655
I0116 09:51:46.677089 30029 slave.cpp:210] 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_2SlHvN/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_2SlHvN/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_2SlHvN/http_credentials" --http_heartbeat_interval="30secs" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_2SlHvN" --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_VGY6Ri"
I0116 09:51:46.677721 30029 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_2SlHvN/credential'
I0116 09:51:46.677924 30029 slave.cpp:352] Agent using credential for: test-principal
I0116 09:51:46.677952 30029 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_2SlHvN/http_credentials'
I0116 09:51:46.678208 30029 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0116 09:51:46.678366 30029 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0116 09:51:46.679630 30029 slave.cpp:539] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0116 09:51:46.679725 30029 slave.cpp:547] Agent attributes: [ ]
I0116 09:51:46.679747 30029 slave.cpp:552] Agent hostname: e2ceffa41f81
I0116 09:51:46.681366 30028 state.cpp:60] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_VGY6Ri/meta'
I0116 09:51:46.681709 30027 status_update_manager.cpp:203] Recovering status update manager
I0116 09:51:46.681936 30015 containerizer.cpp:599] Recovering containerizer
I0116 09:51:46.683468 30015 provisioner.cpp:251] Provisioner recovery complete
I0116 09:51:46.683886 30018 slave.cpp:5417] Finished recovery
I0116 09:51:46.684502 30018 slave.cpp:5591] Querying resource estimator for oversubscribable resources
I0116 09:51:46.684775 30020 slave.cpp:5605] Received oversubscribable resources {} from the resource estimator
I0116 09:51:46.687891 30022 process.cpp:3676] Handling HTTP event for process 'slave(684)' with path: '/slave(684)/monitor/statistics.json'
I0116 09:51:46.690178 30018 http.cpp:874] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0116 09:51:46.694223 30016 slave.cpp:796] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (33 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0116 09:51:46.705404 29995 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0116 09:51:46.705979 29995 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W0116 09:51:46.706132 29995 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0116 09:51:46.707629 29995 cluster.cpp:446] Creating default 'local' authorizer
I0116 09:51:46.709239 30019 slave.cpp:209] Mesos agent started on (685)@172.17.0.2:35655
I0116 09:51:46.709260 30019 slave.cpp:210] 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_07OmmM/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_07OmmM/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_07OmmM/http_credentials" --http_heartbeat_interval="30secs" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_07OmmM" --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_ZZdmDh"
I0116 09:51:46.709749 30019 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_07OmmM/credential'
I0116 09:51:46.709928 30019 slave.cpp:352] Agent using credential for: test-principal
I0116 09:51:46.709956 30019 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_07OmmM/http_credentials'
I0116 09:51:46.710218 30019 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0116 09:51:46.710355 30019 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0116 09:51:46.711472 30019 slave.cpp:539] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0116 09:51:46.711549 30019 slave.cpp:547] Agent attributes: [ ]
I0116 09:51:46.711562 30019 slave.cpp:552] Agent hostname: e2ceffa41f81
I0116 09:51:46.713201 30021 state.cpp:60] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_ZZdmDh/meta'
I0116 09:51:46.713732 30025 status_update_manager.cpp:203] Recovering status update manager
I0116 09:51:46.713961 30026 containerizer.cpp:599] Recovering containerizer
I0116 09:51:46.715881 30021 provisioner.cpp:251] Provisioner recovery complete
I0116 09:51:46.716437 30024 slave.cpp:5417] Finished recovery
I0116 09:51:46.717211 30024 slave.cpp:5591] Querying resource estimator for oversubscribable resources
I0116 09:51:46.717609 30016 slave.cpp:5605] Received oversubscribable resources {} from the resource estimator
I0116 09:51:46.720813 30023 process.cpp:3676] Handling HTTP event for process 'slave(685)' with path: '/slave(685)/containers'
I0116 09:51:46.722326 30014 http.cpp:874] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0116 09:51:46.726469 30019 slave.cpp:796] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (32 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (300 ms total)
[----------] Global test environment tear-down
[==========] 1448 tests from 164 test cases ran. (422988 ms total)
[ PASSED ] 1447 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] FaultToleranceTest.FrameworkReregister
1 FAILED TEST
YOU HAVE 14 DISABLED TESTS
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.2.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.2.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.2.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.2.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1484557246-15527
Untagged: mesos-1484557246-15527:latest
Deleted: sha256:7e41de3bcd89de24d2fa1732bbf3b794315d57c4b39272819a3352d81e66fda7
Deleted: sha256:3f6233d3d412d3c2f0e5b139662726087a62de91e42bcfdbe6e29f16cf168a23
Deleted: sha256:33d2cfbd359052567396d05fa7d728358ade0ac7c19448cf92c19eb49eef33c0
Deleted: sha256:0c3332f718962c35fd4e057e96c4992cead66190e3dad31a3a06ed4f9e06f593
Deleted: sha256:dac2d6d60faf5096869c781be0055f76e7cc9fc11dfeb6c55eef6dc46213e668
Deleted: sha256:dba0ff0440cf8fdae0611e8c4f2b8ea943aba113a2cea180616465a35c96d7b5
Deleted: sha256:25788368e293262f41ac6a0cee1620440ade6ab611c0bd63a179155ce4bb21f6
Deleted: sha256:b331f2b012fd0d73f71fc8b108fa74c60f92532c044aa7c89e047d600375e8a8
Deleted: sha256:08713ecad5b9582ca5dc964b143e3d7d96ae1007fccd437c3fa282a28ed6c812
Deleted: sha256:f0e7c7649e66da55f977e7c9a5f2f74e420818b97793e63fe6cf2aeba5bad72a
Deleted: sha256:dff9b65efc5da7bf593769012fca1b273ff65e61c9ce33557038f77d509b81e2
Deleted: sha256:9e9afcccf4a164a4cab96a39dcfae32e865ec5a1510acb7b1a5da47536a367a0
Deleted: sha256:d9f66a16251428503ead9223880864bada17004c0b8386fd1447d5c869efe47b
Deleted: sha256:1d83ae0590cb47b6d908e14c8edc955f2001185219b52a3c7979fdcdfa6fa543
Deleted: sha256:043c7708b6e96b2126cbcf93771444784e406e2999fc007ef7bcc7958126a2f0
Deleted: sha256:312106843ae2f45d1b2fa20c66ddb0218ef2866c937c1ee01f33afafd5fe11e5
Deleted: sha256:f12d0668d5f137baee384875fba45a5554f2ed5a352354b6586cedb2d3a02164
Deleted: sha256:263a1dd3cfe471a0459f980a3a02e05e922357e6bb4a8632ec7ce91d68027846
Deleted: sha256:55008d69864fe805b9caffb9c2a1a93f3faf98eca874a94e8e59e97f79c087e0
Deleted: sha256:2bd3154e97de566b758629fd7559edfe520ae2cc15e48ebe3b2287b569b22a8e
Deleted: sha256:a9b827d4b09db7670234d5b1540e14ca2889a98689c865da57028145026fcfa5
Deleted: sha256:2ff7af7b209346b763568ca675e3e5cfc526a54899110cb80e564bd300c7777b
Deleted: sha256:5f49c4d879bed096cdc0419c13e00c75468316639bbd83088ddfd8a71e3ee45b
Deleted: sha256:fbc0794a6e54fbabc24a52cdb68a74a37416b8b85c8e40d0533e4cc582bc99b1
Build step 'Execute shell' marked build as failure