You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2017/08/11 09:22:28 UTC

Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #4096

See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/4096/display/redirect?page=changes>

Changes:

[alexr] Added MESOS-6743 to 1.1.3, 1.2.3, 1.3.2 CHANGELOGs.

[alexr] Added a 'UNKNOWN' field to the Update.State enumeration.

[yujie.jay] Removed `--disable-zlib` and fixed `--with-zlib` for Mesos.

[yujie.jay] Removed `--disable-zlib` and fixed `--with-zlib` for libprocess.

[yujie.jay] Bundled gRPC v1.4.2 into 3rdparty libraries.

[yujie.jay] Updated LICENSE information for grpc 1.4.2.

[yujie.jay] Added a patch for building/installing the bundled gRPC library.

[yujie.jay] Added gRPC support in libprocess.

[yujie.jay] Added unit tests for gRPC support in libprocess.

[yujie.jay] Refactored OpenSSL library checks in Mesos.

[yujie.jay] Refactored OpenSSL library checks in libprocess.

[yujie.jay] Building gRPC with Autotools.

[yujie.jay] Building gRPC support in libprocess with Autotools.

[alexr] Fixed a typo in a test.

------------------------------------------
[...truncated 27.39 MB...]
I0811 09:22:13.533717  5191 master.cpp:5477] Processing ACKNOWLEDGE call ccfe340d-9a18-4476-b814-5e202a618df6 for task 8453986d-21e4-4f20-8313-4f6306e4d48a of framework d74b273f-8840-4551-b8fb-774d54a629d3-0000 (default) at scheduler-d42e9a6d-cf50-4ef8-8aa4-2dc4ef184eb8@172.17.0.4:45160 on agent d74b273f-8840-4551-b8fb-774d54a629d3-S0
I0811 09:22:13.534065  5168 sched.cpp:2021] Asked to stop the driver
I0811 09:22:13.533896  5191 master.cpp:9027] Removing task 8453986d-21e4-4f20-8313-4f6306e4d48a with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] of framework d74b273f-8840-4551-b8fb-774d54a629d3-0000 on agent d74b273f-8840-4551-b8fb-774d54a629d3-S0 at slave(693)@172.17.0.4:45160 (f7c49c468881)
I0811 09:22:13.534926  5190 sched.cpp:1203] Stopping framework d74b273f-8840-4551-b8fb-774d54a629d3-0000
I0811 09:22:13.535542  5191 status_update_manager.cpp:395] Received status update acknowledgement (UUID: ccfe340d-9a18-4476-b814-5e202a618df6) for task 8453986d-21e4-4f20-8313-4f6306e4d48a of framework d74b273f-8840-4551-b8fb-774d54a629d3-0000
I0811 09:22:13.535984  5187 master.cpp:8348] Processing TEARDOWN call for framework d74b273f-8840-4551-b8fb-774d54a629d3-0000 (default) at scheduler-d42e9a6d-cf50-4ef8-8aa4-2dc4ef184eb8@172.17.0.4:45160
I0811 09:22:13.536051  5187 master.cpp:8360] Removing framework d74b273f-8840-4551-b8fb-774d54a629d3-0000 (default) at scheduler-d42e9a6d-cf50-4ef8-8aa4-2dc4ef184eb8@172.17.0.4:45160
I0811 09:22:13.536092  5187 master.cpp:3264] Deactivating framework d74b273f-8840-4551-b8fb-774d54a629d3-0000 (default) at scheduler-d42e9a6d-cf50-4ef8-8aa4-2dc4ef184eb8@172.17.0.4:45160
I0811 09:22:13.536542  5193 hierarchical.cpp:412] Deactivated framework d74b273f-8840-4551-b8fb-774d54a629d3-0000
I0811 09:22:13.536712  5193 slave.cpp:3159] Asked to shut down framework d74b273f-8840-4551-b8fb-774d54a629d3-0000 by master@172.17.0.4:45160
I0811 09:22:13.536890  5193 slave.cpp:3184] Shutting down framework d74b273f-8840-4551-b8fb-774d54a629d3-0000
I0811 09:22:13.537196  5193 slave.cpp:5651] Shutting down executor '8453986d-21e4-4f20-8313-4f6306e4d48a' of framework d74b273f-8840-4551-b8fb-774d54a629d3-0000 (via HTTP)
I0811 09:22:13.537339  5187 hierarchical.cpp:355] Removed framework d74b273f-8840-4551-b8fb-774d54a629d3-0000
I0811 09:22:13.538301  5191 status_update_manager.cpp:531] Cleaning up status update stream for task 8453986d-21e4-4f20-8313-4f6306e4d48a of framework d74b273f-8840-4551-b8fb-774d54a629d3-0000
I0811 09:22:13.539487  5187 containerizer.cpp:2121] Destroying container 56a30360-4979-4ccb-b91f-884e6e4e29a4 in RUNNING state
I0811 09:22:13.539548  5187 containerizer.cpp:2627] Transitioning the state of container 56a30360-4979-4ccb-b91f-884e6e4e29a4 from RUNNING to DESTROYING
I0811 09:22:13.539994  5187 launcher.cpp:156] Asked to destroy container 56a30360-4979-4ccb-b91f-884e6e4e29a4
I0811 09:22:13.540616  5191 slave.cpp:3609] Status update manager successfully handled status update acknowledgement (UUID: ccfe340d-9a18-4476-b814-5e202a618df6) for task 8453986d-21e4-4f20-8313-4f6306e4d48a of framework d74b273f-8840-4551-b8fb-774d54a629d3-0000
I0811 09:22:13.540700  5191 slave.cpp:7561] Completing task 8453986d-21e4-4f20-8313-4f6306e4d48a
I0811 09:22:13.542488 19636 executor.cpp:171] Received ACKNOWLEDGED event
I0811 09:22:13.543867 19636 executor.cpp:171] Received ACKNOWLEDGED event
I0811 09:22:13.565485  5188 containerizer.cpp:2527] Container 56a30360-4979-4ccb-b91f-884e6e4e29a4 has exited
I0811 09:22:13.569667  5192 provisioner.cpp:490] Ignoring destroy request for unknown container 56a30360-4979-4ccb-b91f-884e6e4e29a4
I0811 09:22:13.570864  5193 slave.cpp:5329] Executor '8453986d-21e4-4f20-8313-4f6306e4d48a' of framework d74b273f-8840-4551-b8fb-774d54a629d3-0000 terminated with signal Killed
I0811 09:22:13.570935  5193 slave.cpp:5429] Cleaning up executor '8453986d-21e4-4f20-8313-4f6306e4d48a' of framework d74b273f-8840-4551-b8fb-774d54a629d3-0000 (via HTTP)
I0811 09:22:13.571350  5191 gc.cpp:59] Scheduling '/tmp/HTTPCommandExecutor_CommandExecutorTest_TaskKillingCapability_1_J3wui5/slaves/d74b273f-8840-4551-b8fb-774d54a629d3-S0/frameworks/d74b273f-8840-4551-b8fb-774d54a629d3-0000/executors/8453986d-21e4-4f20-8313-4f6306e4d48a/runs/56a30360-4979-4ccb-b91f-884e6e4e29a4' for gc 6.99999338885333days in the future
I0811 09:22:13.571468  5193 slave.cpp:5525] Cleaning up framework d74b273f-8840-4551-b8fb-774d54a629d3-0000
I0811 09:22:13.571887  5191 gc.cpp:59] Scheduling '/tmp/HTTPCommandExecutor_CommandExecutorTest_TaskKillingCapability_1_J3wui5/slaves/d74b273f-8840-4551-b8fb-774d54a629d3-S0/frameworks/d74b273f-8840-4551-b8fb-774d54a629d3-0000/executors/8453986d-21e4-4f20-8313-4f6306e4d48a' for gc 6.99999338669037days in the future
I0811 09:22:13.571952  5188 status_update_manager.cpp:285] Closing status update streams for framework d74b273f-8840-4551-b8fb-774d54a629d3-0000
I0811 09:22:13.572312  5187 gc.cpp:59] Scheduling '/tmp/HTTPCommandExecutor_CommandExecutorTest_TaskKillingCapability_1_J3wui5/slaves/d74b273f-8840-4551-b8fb-774d54a629d3-S0/frameworks/d74b273f-8840-4551-b8fb-774d54a629d3-0000' for gc 6.99999337704889days in the future
I0811 09:22:13.572337  5193 slave.cpp:843] Agent terminating
I0811 09:22:13.572764  5193 master.cpp:1318] Agent d74b273f-8840-4551-b8fb-774d54a629d3-S0 at slave(693)@172.17.0.4:45160 (f7c49c468881) disconnected
I0811 09:22:13.572832  5193 master.cpp:3301] Disconnecting agent d74b273f-8840-4551-b8fb-774d54a629d3-S0 at slave(693)@172.17.0.4:45160 (f7c49c468881)
I0811 09:22:13.573040  5193 master.cpp:3320] Deactivating agent d74b273f-8840-4551-b8fb-774d54a629d3-S0 at slave(693)@172.17.0.4:45160 (f7c49c468881)
I0811 09:22:13.573462  5189 hierarchical.cpp:690] Agent d74b273f-8840-4551-b8fb-774d54a629d3-S0 deactivated
I0811 09:22:13.580816  5168 master.cpp:1160] Master terminating
I0811 09:22:13.581684  5190 hierarchical.cpp:626] Removed agent d74b273f-8840-4551-b8fb-774d54a629d3-S0
[       OK ] HTTPCommandExecutor/CommandExecutorTest.TaskKillingCapability/1 (501 ms)
[ RUN      ] HTTPCommandExecutor/CommandExecutorTest.NoTransitionFromKillingToRunning/0
I0811 09:22:13.599194  5168 cluster.cpp:162] Creating default 'local' authorizer
I0811 09:22:13.602869  5192 master.cpp:442] Master c72d9fbd-1025-458d-b8af-b56df1103ecc (f7c49c468881) started on 172.17.0.4:45160
I0811 09:22:13.602968  5192 master.cpp:444] Flags at startup: --acls="" --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate_agents="true" --authenticate_frameworks="true" --authenticate_http_frameworks="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/JoT1bQ/credentials" --filter_gpu_resources="true" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --port="5050" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-1.4.0/_inst/share/mesos/webui" --work_dir="/tmp/JoT1bQ/master" --zk_session_timeout="10secs"
I0811 09:22:13.603772  5192 master.cpp:494] Master only allowing authenticated frameworks to register
I0811 09:22:13.603794  5192 master.cpp:508] Master only allowing authenticated agents to register
I0811 09:22:13.603801  5192 master.cpp:521] Master only allowing authenticated HTTP frameworks to register
I0811 09:22:13.603811  5192 credentials.hpp:37] Loading credentials for authentication from '/tmp/JoT1bQ/credentials'
I0811 09:22:13.604296  5192 master.cpp:566] Using default 'crammd5' authenticator
I0811 09:22:13.604650  5192 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0811 09:22:13.604995  5192 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0811 09:22:13.605298  5192 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0811 09:22:13.605816  5192 master.cpp:646] Authorization enabled
I0811 09:22:13.606017  5190 hierarchical.cpp:171] Initialized hierarchical allocator process
I0811 09:22:13.606201  5187 whitelist_watcher.cpp:77] No whitelist given
I0811 09:22:13.611861  5192 master.cpp:2163] Elected as the leading master!
I0811 09:22:13.611908  5192 master.cpp:1702] Recovering from registrar
I0811 09:22:13.612912  5191 registrar.cpp:347] Recovering registrar
I0811 09:22:13.613850  5191 registrar.cpp:391] Successfully fetched the registry (0B) in 878848ns
I0811 09:22:13.614078  5191 registrar.cpp:495] Applied 1 operations in 38866ns; attempting to update the registry
I0811 09:22:13.614816  5191 registrar.cpp:552] Successfully updated the registry in 674048ns
I0811 09:22:13.615043  5191 registrar.cpp:424] Successfully recovered registrar
I0811 09:22:13.615520  5187 master.cpp:1801] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0811 09:22:13.615658  5187 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
I0811 09:22:13.621999  5168 process.cpp:3228] Attempting to spawn already spawned process files@172.17.0.4:45160
I0811 09:22:13.623258  5168 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0811 09:22:13.623860  5168 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0811 09:22:13.624130  5168 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0811 09:22:13.624264  5168 provisioner.cpp:255] Using default backend 'copy'
I0811 09:22:13.626493  5168 cluster.cpp:448] Creating default 'local' authorizer
I0811 09:22:13.629262  5193 slave.cpp:250] Mesos agent started on (694)@172.17.0.4:45160
I0811 09:22:13.629740  5168 process.cpp:3228] Attempting to spawn already spawned process version@172.17.0.4:45160
I0811 09:22:13.629302  5193 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/HTTPCommandExecutor_CommandExecutorTest_NoTransitionFromKillingToRunning_0_vONMGs/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/HTTPCommandExecutor_CommandExecutorTest_NoTransitionFromKillingToRunning_0_vONMGs/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/HTTPCommandExecutor_CommandExecutorTest_NoTransitionFromKillingToRunning_0_vONMGs/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/HTTPCommandExecutor_CommandExecutorTest_NoTransitionFromKillingToRunning_0_vONMGs/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/HTTPCommandExecutor_CommandExecutorTest_NoTransitionFromKillingToRunning_0_vONMGs/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/HTTPCommandExecutor_CommandExecutorTest_NoTransitionFromKillingToRunning_0_vONMGs" --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/HTTPCommandExecutor_CommandExecutorTest_NoTransitionFromKillingToRunning_0_O8nor9"
I0811 09:22:13.630805  5193 credentials.hpp:86] Loading credential for authentication from '/tmp/HTTPCommandExecutor_CommandExecutorTest_NoTransitionFromKillingToRunning_0_vONMGs/credential'
I0811 09:22:13.631225  5193 slave.cpp:283] Agent using credential for: test-principal
I0811 09:22:13.631255  5193 credentials.hpp:37] Loading credentials for authentication from '/tmp/HTTPCommandExecutor_CommandExecutorTest_NoTransitionFromKillingToRunning_0_vONMGs/http_credentials'
I0811 09:22:13.631407  5168 sched.cpp:232] Version: 1.4.0
I0811 09:22:13.631769  5193 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0811 09:22:13.632357  5193 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0811 09:22:13.632535  5187 sched.cpp:336] New master detected at master@172.17.0.4:45160
I0811 09:22:13.632738  5187 sched.cpp:407] Authenticating with master master@172.17.0.4:45160
I0811 09:22:13.632798  5187 sched.cpp:414] Using default CRAM-MD5 authenticatee
I0811 09:22:13.633174  5189 authenticatee.cpp:121] Creating new client SASL connection
I0811 09:22:13.633641  5191 master.cpp:7837] Authenticating scheduler-801f85bd-382e-42f4-91d5-eb387e347857@172.17.0.4:45160
I0811 09:22:13.633973  5194 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1322)@172.17.0.4:45160
I0811 09:22:13.634492  5194 authenticator.cpp:98] Creating new server SASL connection
I0811 09:22:13.634866  5187 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0811 09:22:13.634924  5187 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0811 09:22:13.635077  5187 authenticator.cpp:204] Received SASL authentication start
I0811 09:22:13.635190  5187 authenticator.cpp:326] Authentication requires more steps
I0811 09:22:13.635380  5187 authenticatee.cpp:259] Received SASL authentication step
I0811 09:22:13.635540  5187 authenticator.cpp:232] Received SASL authentication step
I0811 09:22:13.635617  5187 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f7c49c468881' server FQDN: 'f7c49c468881' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0811 09:22:13.635675  5187 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0811 09:22:13.635779  5187 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0811 09:22:13.635861  5187 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f7c49c468881' server FQDN: 'f7c49c468881' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0811 09:22:13.635915  5187 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0811 09:22:13.635978  5187 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0811 09:22:13.636723  5187 authenticator.cpp:318] Authentication success
I0811 09:22:13.636975  5194 authenticatee.cpp:299] Authentication success
I0811 09:22:13.637058  5187 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1322)@172.17.0.4:45160
I0811 09:22:13.637100  5190 master.cpp:7867] Successfully authenticated principal 'test-principal' at scheduler-801f85bd-382e-42f4-91d5-eb387e347857@172.17.0.4:45160
I0811 09:22:13.637528  5191 sched.cpp:513] Successfully authenticated with master master@172.17.0.4:45160
I0811 09:22:13.637562  5191 sched.cpp:836] Sending SUBSCRIBE call to master@172.17.0.4:45160
I0811 09:22:13.637835  5191 sched.cpp:869] Will retry registration in 1.643460909secs if necessary
I0811 09:22:13.638012  5187 master.cpp:2894] Received SUBSCRIBE call for framework 'default' at scheduler-801f85bd-382e-42f4-91d5-eb387e347857@172.17.0.4:45160
I0811 09:22:13.638128  5187 master.cpp:2228] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0811 09:22:13.638685  5190 master.cpp:2974] Subscribing framework default with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT, TASK_KILLING_STATE ]
*** Aborted at 1502443333 (unix time) try "date -d @1502443333" if you are using GNU date ***
I0811 09:22:13.639444  5190 sched.cpp:759] Framework registered with c72d9fbd-1025-458d-b8af-b56df1103ecc-0000
I0811 09:22:13.639500  5190 sched.cpp:773] Scheduler::registered took 24764ns
I0811 09:22:13.639789  5187 hierarchical.cpp:303] Added framework c72d9fbd-1025-458d-b8af-b56df1103ecc-0000
I0811 09:22:13.640069  5187 hierarchical.cpp:1925] No allocations performed
I0811 09:22:13.640146  5187 hierarchical.cpp:2015] No inverse offers to send out!
I0811 09:22:13.640249  5187 hierarchical.cpp:1468] Performed allocation for 0 agents in 258124ns
I0811 09:22:13.641923  5193 slave.cpp:565] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0811 09:22:13.642145  5193 slave.cpp:573] Agent attributes: [  ]
I0811 09:22:13.642168  5193 slave.cpp:582] Agent hostname: f7c49c468881
I0811 09:22:13.643735  5190 status_update_manager.cpp:177] Pausing sending status updates
I0811 09:22:13.648509  5190 state.cpp:64] Recovering state from '/tmp/HTTPCommandExecutor_CommandExecutorTest_NoTransitionFromKillingToRunning_0_O8nor9/meta'
I0811 09:22:13.649081  5187 status_update_manager.cpp:203] Recovering status update manager
I0811 09:22:13.649404  5191 containerizer.cpp:598] Recovering containerizer
I0811 09:22:13.651360  5190 provisioner.cpp:416] Provisioner recovery complete
I0811 09:22:13.651835  5190 slave.cpp:6210] Finished recovery
I0811 09:22:13.652550  5190 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0811 09:22:13.652879  5190 slave.cpp:971] New master detected at master@172.17.0.4:45160
I0811 09:22:13.653046  5187 status_update_manager.cpp:177] Pausing sending status updates
I0811 09:22:13.653208  5190 slave.cpp:1006] Detecting new master
I0811 09:22:13.653549  5190 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0811 09:22:13.659708  5191 slave.cpp:1033] Authenticating with master master@172.17.0.4:45160
I0811 09:22:13.659946  5191 slave.cpp:1044] Using default CRAM-MD5 authenticatee
I0811 09:22:13.660609  5189 authenticatee.cpp:121] Creating new client SASL connection
I0811 09:22:13.661103  5187 master.cpp:7837] Authenticating slave(694)@172.17.0.4:45160
I0811 09:22:13.661394  5188 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1323)@172.17.0.4:45160
I0811 09:22:13.661952  5188 authenticator.cpp:98] Creating new server SASL connection
I0811 09:22:13.662339  5188 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0811 09:22:13.662376  5188 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0811 09:22:13.662647  5188 authenticator.cpp:204] Received SASL authentication start
I0811 09:22:13.662729  5188 authenticator.cpp:326] Authentication requires more steps
I0811 09:22:13.663028  5188 authenticatee.cpp:259] Received SASL authentication step
I0811 09:22:13.663156  5188 authenticator.cpp:232] Received SASL authentication step
I0811 09:22:13.663442  5188 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f7c49c468881' server FQDN: 'f7c49c468881' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0811 09:22:13.663472  5188 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0811 09:22:13.663527  5188 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0811 09:22:13.663560  5188 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f7c49c468881' server FQDN: 'f7c49c468881' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0811 09:22:13.663583  5188 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0811 09:22:13.663591  5188 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0811 09:22:13.663612  5188 authenticator.cpp:318] Authentication success
I0811 09:22:13.664084  5187 authenticatee.cpp:299] Authentication success
I0811 09:22:13.664294  5191 master.cpp:7867] Successfully authenticated principal 'test-principal' at slave(694)@172.17.0.4:45160
I0811 09:22:13.664528  5189 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1323)@172.17.0.4:45160
I0811 09:22:13.664543  5187 slave.cpp:1128] Successfully authenticated with master master@172.17.0.4:45160
I0811 09:22:13.664955  5187 slave.cpp:1572] Will retry registration in 13.826459ms if necessary
I0811 09:22:13.665201  5191 master.cpp:5712] Received register agent message from slave(694)@172.17.0.4:45160 (f7c49c468881)
I0811 09:22:13.665436  5191 master.cpp:3803] Authorizing agent with principal 'test-principal'
I0811 09:22:13.666298  5192 master.cpp:5772] Authorized registration of agent at slave(694)@172.17.0.4:45160 (f7c49c468881)
I0811 09:22:13.666429  5192 master.cpp:5865] Registering agent at slave(694)@172.17.0.4:45160 (f7c49c468881) with id c72d9fbd-1025-458d-b8af-b56df1103ecc-S0
I0811 09:22:13.667490  5189 registrar.cpp:495] Applied 1 operations in 151478ns; attempting to update the registry
I0811 09:22:13.668495  5189 registrar.cpp:552] Successfully updated the registry in 921088ns
I0811 09:22:13.668879  5190 master.cpp:5912] Admitted agent c72d9fbd-1025-458d-b8af-b56df1103ecc-S0 at slave(694)@172.17.0.4:45160 (f7c49c468881)
I0811 09:22:13.669631  5187 slave.cpp:4887] Received ping from slave-observer(637)@172.17.0.4:45160
I0811 09:22:13.669868  5187 slave.cpp:1174] Registered with master master@172.17.0.4:45160; given agent ID c72d9fbd-1025-458d-b8af-b56df1103ecc-S0
I0811 09:22:13.669652  5190 master.cpp:5943] Registered agent c72d9fbd-1025-458d-b8af-b56df1103ecc-S0 at slave(694)@172.17.0.4:45160 (f7c49c468881) with [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0811 09:22:13.670199  5190 status_update_manager.cpp:184] Resuming sending status updates
I0811 09:22:13.670511  5187 slave.cpp:1194] Checkpointing SlaveInfo to '/tmp/HTTPCommandExecutor_CommandExecutorTest_NoTransitionFromKillingToRunning_0_O8nor9/meta/slaves/c72d9fbd-1025-458d-b8af-b56df1103ecc-S0/slave.info'
I0811 09:22:13.670616  5193 hierarchical.cpp:593] Added agent c72d9fbd-1025-458d-b8af-b56df1103ecc-S0 (f7c49c468881) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0811 09:22:13.671092  5187 slave.cpp:1232] Forwarding total oversubscribed resources {}
I0811 09:22:13.671345  5187 master.cpp:6688] Received update of agent c72d9fbd-1025-458d-b8af-b56df1103ecc-S0 at slave(694)@172.17.0.4:45160 (f7c49c468881) with total oversubscribed resources {}
I0811 09:22:13.672360  5193 hierarchical.cpp:2015] No inverse offers to send out!
I0811 09:22:13.672425  5193 hierarchical.cpp:1468] Performed allocation for 1 agents in 1.308299ms
I0811 09:22:13.672739  5193 hierarchical.cpp:660] Agent c72d9fbd-1025-458d-b8af-b56df1103ecc-S0 (f7c49c468881) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0811 09:22:13.673094  5191 master.cpp:7667] Sending 1 offers to framework c72d9fbd-1025-458d-b8af-b56df1103ecc-0000 (default) at scheduler-801f85bd-382e-42f4-91d5-eb387e347857@172.17.0.4:45160
I0811 09:22:13.673720  5191 sched.cpp:933] Scheduler::resourceOffers took 113989ns
I0811 09:22:13.676255  5190 master.cpp:9164] Removing offer c72d9fbd-1025-458d-b8af-b56df1103ecc-O0
I0811 09:22:13.676499  5190 master.cpp:4153] Processing ACCEPT call for offers: [ c72d9fbd-1025-458d-b8af-b56df1103ecc-O0 ] on agent c72d9fbd-1025-458d-b8af-b56df1103ecc-S0 at slave(694)@172.17.0.4:45160 (f7c49c468881) for framework c72d9fbd-1025-458d-b8af-b56df1103ecc-0000 (default) at scheduler-801f85bd-382e-42f4-91d5-eb387e347857@172.17.0.4:45160
I0811 09:22:13.676708  5190 master.cpp:3530] Authorizing framework principal 'test-principal' to launch task 179c720b-e238-4cea-970e-6a8672fc77db
I0811 09:22:13.680145  5188 master.cpp:9724] Adding task 179c720b-e238-4cea-970e-6a8672fc77db with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] on agent c72d9fbd-1025-458d-b8af-b56df1103ecc-S0 at slave(694)@172.17.0.4:45160 (f7c49c468881)
I0811 09:22:13.681010  5188 master.cpp:4816] Launching task 179c720b-e238-4cea-970e-6a8672fc77db of framework c72d9fbd-1025-458d-b8af-b56df1103ecc-0000 (default) at scheduler-801f85bd-382e-42f4-91d5-eb387e347857@172.17.0.4:45160 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] on agent c72d9fbd-1025-458d-b8af-b56df1103ecc-S0 at slave(694)@172.17.0.4:45160 (f7c49c468881)
I0811 09:22:13.682354  5193 slave.cpp:1701] Got assigned task '179c720b-e238-4cea-970e-6a8672fc77db' for framework c72d9fbd-1025-458d-b8af-b56df1103ecc-0000
I0811 09:22:13.683470  5193 slave.cpp:1982] Authorizing task '179c720b-e238-4cea-970e-6a8672fc77db' for framework c72d9fbd-1025-458d-b8af-b56df1103ecc-0000
I0811 09:22:13.683542  5193 slave.cpp:6709] Authorizing framework principal 'test-principal' to launch task 179c720b-e238-4cea-970e-6a8672fc77db
I0811 09:22:13.684603  5188 hierarchical.cpp:887] Updated allocation of framework c72d9fbd-1025-458d-b8af-b56df1103ecc-0000 on agent c72d9fbd-1025-458d-b8af-b56df1103ecc-S0 from cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] to cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000]
I0811 09:22:13.685745  5190 slave.cpp:2169] Launching task '179c720b-e238-4cea-970e-6a8672fc77db' for framework c72d9fbd-1025-458d-b8af-b56df1103ecc-0000
I0811 09:22:13.686645  5190 paths.cpp:578] Trying to chown '/tmp/HTTPCommandExecutor_CommandExecutorTest_NoTransitionFromKillingToRunning_0_O8nor9/slaves/c72d9fbd-1025-458d-b8af-b56df1103ecc-S0/frameworks/c72d9fbd-1025-458d-b8af-b56df1103ecc-0000/executors/179c720b-e238-4cea-970e-6a8672fc77db/runs/5ccbe4ec-c693-4d0d-a37f-3cd27ca40b64' to user 'mesos'
I0811 09:22:13.687120  5190 slave.cpp:7165] Launching executor '179c720b-e238-4cea-970e-6a8672fc77db' of framework c72d9fbd-1025-458d-b8af-b56df1103ecc-0000 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":0.1},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":32.0},"type":"SCALAR"}] in work directory '/tmp/HTTPCommandExecutor_CommandExecutorTest_NoTransitionFromKillingToRunning_0_O8nor9/slaves/c72d9fbd-1025-458d-b8af-b56df1103ecc-S0/frameworks/c72d9fbd-1025-458d-b8af-b56df1103ecc-0000/executors/179c720b-e238-4cea-970e-6a8672fc77db/runs/5ccbe4ec-c693-4d0d-a37f-3cd27ca40b64'
I0811 09:22:13.688549  5190 slave.cpp:2856] Launching container 5ccbe4ec-c693-4d0d-a37f-3cd27ca40b64 for executor '179c720b-e238-4cea-970e-6a8672fc77db' of framework c72d9fbd-1025-458d-b8af-b56df1103ecc-0000
I0811 09:22:13.689049  5193 containerizer.cpp:1072] Starting container 5ccbe4ec-c693-4d0d-a37f-3cd27ca40b64
I0811 09:22:13.689257  5190 slave.cpp:2398] Queued task '179c720b-e238-4cea-970e-6a8672fc77db' for executor '179c720b-e238-4cea-970e-6a8672fc77db' of framework c72d9fbd-1025-458d-b8af-b56df1103ecc-0000
I0811 09:22:13.689493  5190 slave.cpp:924] Successfully attached file '/tmp/HTTPCommandExecutor_CommandExecutorTest_NoTransitionFromKillingToRunning_0_O8nor9/slaves/c72d9fbd-1025-458d-b8af-b56df1103ecc-S0/frameworks/c72d9fbd-1025-458d-b8af-b56df1103ecc-0000/executors/179c720b-e238-4cea-970e-6a8672fc77db/runs/5ccbe4ec-c693-4d0d-a37f-3cd27ca40b64'
I0811 09:22:13.689683  5190 slave.cpp:924] Successfully attached file '/tmp/HTTPCommandExecutor_CommandExecutorTest_NoTransitionFromKillingToRunning_0_O8nor9/slaves/c72d9fbd-1025-458d-b8af-b56df1103ecc-S0/frameworks/c72d9fbd-1025-458d-b8af-b56df1103ecc-0000/executors/179c720b-e238-4cea-970e-6a8672fc77db/runs/5ccbe4ec-c693-4d0d-a37f-3cd27ca40b64'
I0811 09:22:13.690013  5193 containerizer.cpp:2627] Transitioning the state of container 5ccbe4ec-c693-4d0d-a37f-3cd27ca40b64 from PROVISIONING to PREPARING
PC: @     0x2b1b52f49128 process::EventQueue::Consumer::empty()
I0811 09:22:13.695734  5193 containerizer.cpp:1646] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"arguments":["mesos-executor","--launcher_dir=\/mesos\/mesos-1.4.0\/_build\/src"],"shell":false,"value":"\/mesos\/mesos-1.4.0\/_build\/src\/mesos-executor"},"environment":{"variables":[{"name":"LIBPROCESS_PORT","type":"VALUE","value":"0"},{"name":"MESOS_AGENT_ENDPOINT","type":"VALUE","value":"172.17.0.4:45160"},{"name":"MESOS_CHECKPOINT","type":"VALUE","value":"0"},{"name":"MESOS_DIRECTORY","type":"VALUE","value":"\/tmp\/HTTPCommandExecutor_CommandExecutorTest_NoTransitionFromKillingToRunning_0_O8nor9\/slaves\/c72d9fbd-1025-458d-b8af-b56df1103ecc-S0\/frameworks\/c72d9fbd-1025-458d-b8af-b56df1103ecc-0000\/executors\/179c720b-e238-4cea-970e-6a8672fc77db\/runs\/5ccbe4ec-c693-4d0d-a37f-3cd27ca40b64"},{"name":"MESOS_EXECUTOR_ID","type":"VALUE","value":"179c720b-e238-4cea-970e-6a8672fc77db"},{"name":"MESOS_EXECUTOR_SHUTDOWN_GRACE_PERIOD","type":"VALUE","value":"7secs"},{"name":"MESOS_FRAMEWORK_ID","type":"VALUE","value":"c72d9fbd-1025-458d-b8af-b56df1103ecc-0000"},{"name":"MESOS_HTTP_COMMAND_EXECUTOR","type":"VALUE","value":"0"},{"name":"MESOS_SLAVE_ID","type":"VALUE","value":"c72d9fbd-1025-458d-b8af-b56df1103ecc-S0"},{"name":"MESOS_SLAVE_PID","type":"VALUE","value":"slave(694)@172.17.0.4:45160"},{"name":"MESOS_SANDBOX","type":"VALUE","value":"\/tmp\/HTTPCommandExecutor_CommandExecutorTest_NoTransitionFromKillingToRunning_0_O8nor9\/slaves\/c72d9fbd-1025-458d-b8af-b56df1103ecc-S0\/frameworks\/c72d9fbd-1025-458d-b8af-b56df1103ecc-0000\/executors\/179c720b-e238-4cea-970e-6a8672fc77db\/runs\/5ccbe4ec-c693-4d0d-a37f-3cd27ca40b64"}]},"task_environment":{},"user":"mesos","working_directory":"\/tmp\/HTTPCommandExecutor_CommandExecutorTest_NoTransitionFromKillingToRunning_0_O8nor9\/slaves\/c72d9fbd-1025-458d-b8af-b56df1103ecc-S0\/frameworks\/c72d9fbd-1025-458d-b8af-b56df1103ecc-0000\/executors\/179c720b-e238-4cea-970e-6a8672fc77db\/runs\/5ccbe4ec-c693-4d0d-a37f-3cd27ca40b64"}" --pipe_read="24" --pipe_write="26" --runtime_directory="/tmp/HTTPCommandExecutor_CommandExecutorTest_NoTransitionFromKillingToRunning_0_vONMGs/containers/5ccbe4ec-c693-4d0d-a37f-3cd27ca40b64" --unshare_namespace_mnt="false"'
*** SIGSEGV (@0x8) received by PID 5168 (TID 0x2b1b5e958700) from PID 8; stack trace: ***
I0811 09:22:13.701653  5193 launcher.cpp:140] Forked child with pid '19658' for container '5ccbe4ec-c693-4d0d-a37f-3cd27ca40b64'
    @     0x2b1b8538d417 (unknown)
I0811 09:22:13.702811  5193 containerizer.cpp:2627] Transitioning the state of container 5ccbe4ec-c693-4d0d-a37f-3cd27ca40b64 from PREPARING to ISOLATING
    @     0x2b1b853916f9 (unknown)
I0811 09:22:13.706128  5193 containerizer.cpp:2627] Transitioning the state of container 5ccbe4ec-c693-4d0d-a37f-3cd27ca40b64 from ISOLATING to FETCHING
    @     0x2b1b555e7330 (unknown)
I0811 09:22:13.706683  5190 fetcher.cpp:379] Starting to fetch URIs for container: 5ccbe4ec-c693-4d0d-a37f-3cd27ca40b64, directory: /tmp/HTTPCommandExecutor_CommandExecutorTest_NoTransitionFromKillingToRunning_0_O8nor9/slaves/c72d9fbd-1025-458d-b8af-b56df1103ecc-S0/frameworks/c72d9fbd-1025-458d-b8af-b56df1103ecc-0000/executors/179c720b-e238-4cea-970e-6a8672fc77db/runs/5ccbe4ec-c693-4d0d-a37f-3cd27ca40b64
I0811 09:22:13.708462  5187 containerizer.cpp:2627] Transitioning the state of container 5ccbe4ec-c693-4d0d-a37f-3cd27ca40b64 from FETCHING to RUNNING
    @     0x2b1b52f49128 process::EventQueue::Consumer::empty()
    @     0x2b1b52f35dd6 process::ProcessManager::resume()
    @     0x2b1b52f323d2 _ZZN7process14ProcessManager12init_threadsEvENKUlvE_clEv
    @     0x2b1b52f43b40 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
    @     0x2b1b52f43a97 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEclEv
    @     0x2b1b52f43a30 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEE6_M_runEv
    @     0x2b1b54e68a60 (unknown)
    @     0x2b1b555df184 start_thread
    @     0x2b1b558f2ffd (unknown)
I0811 09:22:13.926259 19672 exec.cpp:162] Version: 1.4.0
I0811 09:22:13.944594 19687 exec.cpp:517] Agent exited ... shutting down
make[4]: *** [check-local] Segmentation fault (core dumped)
E0811 09:22:13.946056 19694 process.cpp:2584] Failed to shutdown socket with fd 6, address 172.17.0.4:44720: Transport endpoint is not connected
make[4]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.4.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1502438037-8854
Untagged: mesos-1502438037-8854:latest
Deleted: sha256:e5a20ae9bf5b9cf7a0cb88942ece7c42717ef2f96b00f484474266196ab29203
Deleted: sha256:9d9e0a44698bc0a52237653299371b81038f64d8bdebd625291111aa1caede75
Deleted: sha256:9b67a9639e7eacc4072b24c62d773dbd9c148ddfc03ef5c5868e83cafae00002
Deleted: sha256:bf30f1e8716ceee4a7562d19ae0fad7b96598939b387914fe78fb410f62680db
Deleted: sha256:f7adce9c8818104d1a0e79c53e70fcf16eb3597a5e91d3135a63c26b50822cc3
Deleted: sha256:9593c978d623c9f3dc2bc3ee3c6c0b6ebba4f923e746fda95077300e75a188cc
Deleted: sha256:500d9fec8bb844086d691ef950698beb0b55a4c2de5e7901c953fa93dceb985d
Deleted: sha256:f43f9f5bfb93b48a58d16d41d6e075085994f5480317d5b17af2e88223657777
Deleted: sha256:9e562c9d5f099a286309d81c5993bc5655d45de149d8fc628a91c08b64c05790
Deleted: sha256:27c00efb93209be7a294c05e7e81c956d00f2acc6468d027b9d794797af4bf53
Deleted: sha256:f4026b194c4e7b035e25dc183605eff84099bb549693e673a834b31ca422af24
Deleted: sha256:d14a2dba1e77bb9d747af1788bc18b64892349b7cf93f282abff4ccb04afb4ed
Deleted: sha256:1fbbf47299e13994c8e98fbb87f9ca38e4d6739b1021792fe6843be6bdebde83
Deleted: sha256:78a7aa93db8d583bcd0a64d1754e867cfa5d69b10f087b2060ae0fabef4d0db8
Deleted: sha256:251da5e3924824f36f53b724327815b215de23361114b7ab5d274fe9f328d204
Deleted: sha256:5a140a04fe02a4490eeceac859bba7c5f914276831a0556af29d4decf9fba99c
Deleted: sha256:cb6f90a3eb5b8a2422b6aacf8d157bb038b1db43906379f8b7473ada677e56a0
Deleted: sha256:e4f36943765163b60d65b8c90785a3c5f7ce99c1789095e4a5060a89b87f28e4
Deleted: sha256:075ebb9fb6bc7365bef068a48d9b73f272b64913af5caf12df1a68d2e6b44c34
Deleted: sha256:801b58bfeb0d4f4d72ef0f1635775aa0eeaa644e16672ee1422df975edc40158
Deleted: sha256:7655392c6501071dbe7ccba68671b0354d8f8afed1eb8d0ca0df18de05594366
Deleted: sha256:8842bc14485fa1afe1c4503bcf68238c11c62d8badeea40e791ad5b183b4729e
Deleted: sha256:a654915e41c4d8271903c413434fa95180147ffde4602135202356a94b3f7e47
Deleted: sha256:c64342acbb3c3e53945e925e248d4c35d5625b9d014d64f776d1e08ca839b891
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user yujie.jay@gmail.com

Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #4097

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/4097/display/redirect>

------------------------------------------
[...truncated 31.15 MB...]
I0811 11:36:11.910717  5192 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0811 11:36:11.911025  5192 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0811 11:36:11.913795  5192 slave.cpp:565] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0811 11:36:11.914134  5192 slave.cpp:573] Agent attributes: [  ]
I0811 11:36:11.914170  5192 slave.cpp:582] Agent hostname: a0fdaf75194e
I0811 11:36:11.914522  5194 status_update_manager.cpp:177] Pausing sending status updates
I0811 11:36:11.917022  5196 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_Mh1duV/meta'
I0811 11:36:11.917742  5196 status_update_manager.cpp:203] Recovering status update manager
I0811 11:36:11.918140  5196 containerizer.cpp:598] Recovering containerizer
I0811 11:36:11.920246  5196 provisioner.cpp:416] Provisioner recovery complete
I0811 11:36:11.921272  5196 slave.cpp:6210] Finished recovery
I0811 11:36:11.922369  5196 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0811 11:36:11.922843  5196 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0811 11:36:11.927676  5196 process.cpp:3933] Handling HTTP event for process 'slave(799)' with path: '/slave(799)/containers'
I0811 11:36:11.930096  5196 http.cpp:1166] HTTP GET for /slave(799)/containers from 172.17.0.4:38102
I0811 11:36:11.930402  5196 http.cpp:957] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0811 11:36:11.955330  5192 slave.cpp:843] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (119 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0811 11:36:12.016355  5170 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0811 11:36:12.017074  5170 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0811 11:36:12.017284  5170 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0811 11:36:12.017349  5170 provisioner.cpp:255] Using default backend 'copy'
I0811 11:36:12.022454  5195 slave.cpp:250] Mesos agent started on (800)@172.17.0.4:33738
I0811 11:36:12.022488  5195 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_cJSZ9L/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_cJSZ9L/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_cJSZ9L/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_cJSZ9L/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_cJSZ9L/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_cJSZ9L" --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_C4Ft6o"
I0811 11:36:12.023027  5195 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_cJSZ9L/credential'
I0811 11:36:12.023308  5195 slave.cpp:283] Agent using credential for: test-principal
I0811 11:36:12.023337  5195 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_cJSZ9L/http_credentials'
I0811 11:36:12.023686  5195 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0811 11:36:12.024013  5195 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0811 11:36:12.025915  5195 slave.cpp:565] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0811 11:36:12.026127  5195 slave.cpp:573] Agent attributes: [  ]
I0811 11:36:12.026144  5195 slave.cpp:582] Agent hostname: a0fdaf75194e
I0811 11:36:12.026629  5192 status_update_manager.cpp:177] Pausing sending status updates
I0811 11:36:12.028648  5194 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_C4Ft6o/meta'
I0811 11:36:12.029341  5194 status_update_manager.cpp:203] Recovering status update manager
I0811 11:36:12.029685  5195 containerizer.cpp:598] Recovering containerizer
I0811 11:36:12.032394  5194 provisioner.cpp:416] Provisioner recovery complete
I0811 11:36:12.033007  5190 slave.cpp:6210] Finished recovery
I0811 11:36:12.033819  5190 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0811 11:36:12.034301  5193 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0811 11:36:12.039229  5189 process.cpp:3933] Handling HTTP event for process 'slave(800)' with path: '/slave(800)/monitor/statistics'
I0811 11:36:12.041613  5193 http.cpp:1166] HTTP GET for /slave(800)/monitor/statistics from 172.17.0.4:38106
I0811 11:36:12.041784  5193 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0811 11:36:12.050792  5170 slave.cpp:843] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (79 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0811 11:36:12.099720  5170 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0811 11:36:12.101279  5170 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0811 11:36:12.101698  5170 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0811 11:36:12.101876  5170 provisioner.cpp:255] Using default backend 'copy'
I0811 11:36:12.109643  5189 slave.cpp:250] Mesos agent started on (801)@172.17.0.4:33738
I0811 11:36:12.109853  5189 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Gu9O7g/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_Gu9O7g/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Gu9O7g/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Gu9O7g/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Gu9O7g/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Gu9O7g" --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_TPrUPT"
I0811 11:36:12.110499  5189 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Gu9O7g/credential'
I0811 11:36:12.111246  5189 slave.cpp:283] Agent using credential for: test-principal
I0811 11:36:12.111304  5189 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Gu9O7g/http_credentials'
I0811 11:36:12.111729  5189 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0811 11:36:12.111959  5189 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0811 11:36:12.114521  5189 slave.cpp:565] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0811 11:36:12.115185  5189 slave.cpp:573] Agent attributes: [  ]
I0811 11:36:12.115236  5189 slave.cpp:582] Agent hostname: a0fdaf75194e
I0811 11:36:12.115610  5192 status_update_manager.cpp:177] Pausing sending status updates
I0811 11:36:12.118391  5194 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_TPrUPT/meta'
I0811 11:36:12.118963  5192 status_update_manager.cpp:203] Recovering status update manager
I0811 11:36:12.119555  5189 containerizer.cpp:598] Recovering containerizer
I0811 11:36:12.132654  5191 provisioner.cpp:416] Provisioner recovery complete
I0811 11:36:12.134706  5193 slave.cpp:6210] Finished recovery
I0811 11:36:12.135733  5193 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0811 11:36:12.136478  5191 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0811 11:36:12.141330  5192 process.cpp:3933] Handling HTTP event for process 'slave(801)' with path: '/slave(801)/monitor/statistics.json'
I0811 11:36:12.143420  5191 http.cpp:1166] HTTP GET for /slave(801)/monitor/statistics.json from 172.17.0.4:38110
I0811 11:36:12.143537  5191 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0811 11:36:12.156560  5170 slave.cpp:843] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (121 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0811 11:36:12.224867  5170 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0811 11:36:12.226840  5170 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0811 11:36:12.227478  5170 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0811 11:36:12.227684  5170 provisioner.cpp:255] Using default backend 'copy'
I0811 11:36:12.239363  5193 slave.cpp:250] Mesos agent started on (802)@172.17.0.4:33738
I0811 11:36:12.239425  5193 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_4OVNpN/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_4OVNpN/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_4OVNpN/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_4OVNpN/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_4OVNpN/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_4OVNpN" --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_iaprMp"
I0811 11:36:12.240686  5193 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_4OVNpN/credential'
I0811 11:36:12.241648  5193 slave.cpp:283] Agent using credential for: test-principal
I0811 11:36:12.241690  5193 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_4OVNpN/http_credentials'
I0811 11:36:12.242691  5193 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0811 11:36:12.243254  5193 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0811 11:36:12.246500  5193 slave.cpp:565] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0811 11:36:12.246999  5193 slave.cpp:573] Agent attributes: [  ]
I0811 11:36:12.247251  5193 slave.cpp:582] Agent hostname: a0fdaf75194e
I0811 11:36:12.247859  5195 status_update_manager.cpp:177] Pausing sending status updates
I0811 11:36:12.251746  5196 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_iaprMp/meta'
I0811 11:36:12.252418  5193 status_update_manager.cpp:203] Recovering status update manager
I0811 11:36:12.252965  5189 containerizer.cpp:598] Recovering containerizer
I0811 11:36:12.256758  5191 provisioner.cpp:416] Provisioner recovery complete
I0811 11:36:12.257596  5192 slave.cpp:6210] Finished recovery
I0811 11:36:12.258890  5192 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0811 11:36:12.259639  5194 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0811 11:36:12.264339  5189 process.cpp:3933] Handling HTTP event for process 'slave(802)' with path: '/slave(802)/containers'
I0811 11:36:12.267015  5194 http.cpp:1166] HTTP GET for /slave(802)/containers from 172.17.0.4:38114
I0811 11:36:12.267103  5194 http.cpp:957] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0811 11:36:12.283651  5170 slave.cpp:843] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (118 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0811 11:36:12.336392  5170 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0811 11:36:12.336999  5170 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0811 11:36:12.337157  5170 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0811 11:36:12.337224  5170 provisioner.cpp:255] Using default backend 'copy'
I0811 11:36:12.339597  5170 cluster.cpp:448] Creating default 'local' authorizer
I0811 11:36:12.342232  5195 slave.cpp:250] Mesos agent started on (803)@172.17.0.4:33738
I0811 11:36:12.342278  5195 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_QNlw2k/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_QNlw2k/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_QNlw2k/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_QNlw2k/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_QNlw2k/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_QNlw2k" --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_IA9Y4W"
I0811 11:36:12.343523  5195 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_QNlw2k/credential'
I0811 11:36:12.344139  5195 slave.cpp:283] Agent using credential for: test-principal
I0811 11:36:12.344405  5195 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_QNlw2k/http_credentials'
I0811 11:36:12.345093  5195 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0811 11:36:12.345674  5195 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0811 11:36:12.348332  5195 slave.cpp:565] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0811 11:36:12.348953  5195 slave.cpp:573] Agent attributes: [  ]
I0811 11:36:12.349198  5195 slave.cpp:582] Agent hostname: a0fdaf75194e
I0811 11:36:12.349624  5196 status_update_manager.cpp:177] Pausing sending status updates
I0811 11:36:12.352574  5196 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_IA9Y4W/meta'
I0811 11:36:12.353467  5195 status_update_manager.cpp:203] Recovering status update manager
I0811 11:36:12.353837  5192 containerizer.cpp:598] Recovering containerizer
I0811 11:36:12.355985  5190 provisioner.cpp:416] Provisioner recovery complete
I0811 11:36:12.356593  5192 slave.cpp:6210] Finished recovery
I0811 11:36:12.357341  5192 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0811 11:36:12.357887  5193 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0811 11:36:12.362491  5192 process.cpp:3933] Handling HTTP event for process 'slave(803)' with path: '/slave(803)/monitor/statistics'
I0811 11:36:12.364500  5193 http.cpp:1166] HTTP GET for /slave(803)/monitor/statistics from 172.17.0.4:38118
I0811 11:36:12.364581  5193 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0811 11:36:12.378933  5170 slave.cpp:843] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (59 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0811 11:36:12.394911  5170 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0811 11:36:12.395539  5170 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0811 11:36:12.395843  5170 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0811 11:36:12.395913  5170 provisioner.cpp:255] Using default backend 'copy'
I0811 11:36:12.398232  5170 cluster.cpp:448] Creating default 'local' authorizer
I0811 11:36:12.400506  5191 slave.cpp:250] Mesos agent started on (804)@172.17.0.4:33738
I0811 11:36:12.400534  5191 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_vNE9rT/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_vNE9rT/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_vNE9rT/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_vNE9rT/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_vNE9rT/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_vNE9rT" --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_jZV7jv"
I0811 11:36:12.401363  5191 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_vNE9rT/credential'
I0811 11:36:12.401569  5191 slave.cpp:283] Agent using credential for: test-principal
I0811 11:36:12.401599  5191 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_vNE9rT/http_credentials'
I0811 11:36:12.401852  5191 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0811 11:36:12.402065  5191 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0811 11:36:12.403610  5191 slave.cpp:565] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0811 11:36:12.403867  5191 slave.cpp:573] Agent attributes: [  ]
I0811 11:36:12.403882  5191 slave.cpp:582] Agent hostname: a0fdaf75194e
I0811 11:36:12.404273  5194 status_update_manager.cpp:177] Pausing sending status updates
I0811 11:36:12.416563  5192 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_jZV7jv/meta'
I0811 11:36:12.424923  5190 status_update_manager.cpp:203] Recovering status update manager
I0811 11:36:12.425292  5190 containerizer.cpp:598] Recovering containerizer
I0811 11:36:12.427181  5195 provisioner.cpp:416] Provisioner recovery complete
I0811 11:36:12.427809  5193 slave.cpp:6210] Finished recovery
I0811 11:36:12.428382  5193 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0811 11:36:12.429126  5194 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0811 11:36:12.433296  5189 process.cpp:3933] Handling HTTP event for process 'slave(804)' with path: '/slave(804)/monitor/statistics.json'
I0811 11:36:12.440134  5196 http.cpp:1166] HTTP GET for /slave(804)/monitor/statistics.json from 172.17.0.4:38122
I0811 11:36:12.440234  5196 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0811 11:36:12.444972  5170 slave.cpp:843] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (86 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0811 11:36:12.482925  5170 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0811 11:36:12.483558  5170 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0811 11:36:12.483810  5170 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0811 11:36:12.483860  5170 provisioner.cpp:255] Using default backend 'copy'
I0811 11:36:12.486768  5170 cluster.cpp:448] Creating default 'local' authorizer
I0811 11:36:12.489091  5194 slave.cpp:250] Mesos agent started on (805)@172.17.0.4:33738
I0811 11:36:12.489118  5194 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_VdDfOs/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_VdDfOs/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_VdDfOs/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_VdDfOs/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_VdDfOs/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_VdDfOs" --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_J2JRq4"
I0811 11:36:12.489513  5194 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_VdDfOs/credential'
I0811 11:36:12.489708  5194 slave.cpp:283] Agent using credential for: test-principal
I0811 11:36:12.489730  5194 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_VdDfOs/http_credentials'
I0811 11:36:12.490000  5194 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0811 11:36:12.490195  5194 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0811 11:36:12.496574  5194 slave.cpp:565] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0811 11:36:12.497328  5194 slave.cpp:573] Agent attributes: [  ]
I0811 11:36:12.497993  5194 slave.cpp:582] Agent hostname: a0fdaf75194e
I0811 11:36:12.498395  5196 status_update_manager.cpp:177] Pausing sending status updates
I0811 11:36:12.501021  5196 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_J2JRq4/meta'
I0811 11:36:12.511005  5191 status_update_manager.cpp:203] Recovering status update manager
I0811 11:36:12.511333  5191 containerizer.cpp:598] Recovering containerizer
I0811 11:36:12.513664  5195 provisioner.cpp:416] Provisioner recovery complete
I0811 11:36:12.514310  5195 slave.cpp:6210] Finished recovery
I0811 11:36:12.515120  5195 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0811 11:36:12.515514  5192 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0811 11:36:12.519950  5192 process.cpp:3933] Handling HTTP event for process 'slave(805)' with path: '/slave(805)/containers'
I0811 11:36:12.522230  5194 http.cpp:1166] HTTP GET for /slave(805)/containers from 172.17.0.4:38124
I0811 11:36:12.522357  5194 http.cpp:957] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0811 11:36:12.534816  5195 slave.cpp:843] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (92 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (864 ms total)

[----------] 2 tests from ContainerizerType/DefaultContainerDNSFlagTest
[ RUN      ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/0
[       OK ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/0 (14 ms)
[ RUN      ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/1
[       OK ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/1 (11 ms)
[----------] 2 tests from ContainerizerType/DefaultContainerDNSFlagTest (25 ms total)

[----------] Global test environment tear-down
[==========] 1655 tests from 182 test cases ran. (799064 ms total)
[  PASSED  ] 1650 tests.
[  FAILED  ] 5 tests, listed below:
[  FAILED  ] DefaultExecutorCheckTest.CommandCheckDeliveredAndReconciled
[  FAILED  ] DefaultExecutorCheckTest.CommandCheckStatusChange
[  FAILED  ] DefaultExecutorCheckTest.CommandCheckSeesParentsEnv
[  FAILED  ] DefaultExecutorCheckTest.CommandCheckSharesWorkDirWithTask
[  FAILED  ] ContentType/AgentAPIStreamingTest.AttachInputToNestedContainerSession/0, where GetParam() = application/x-protobuf

 5 FAILED TESTS
  YOU HAVE 20 DISABLED TESTS

I0811 11:36:12.650663  5197 process.cpp:1072] Failed to accept socket: future discarded
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.4.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1502444397-17254
Untagged: mesos-1502444397-17254:latest
Deleted: sha256:da718af5ef541171616db58a99a8a06f2d231953fb78a107d836769942f735e4
Deleted: sha256:43dde091f072537b1686e9c699572100d07d3f3fb79918f59a8f767e6004f74d
Deleted: sha256:04d60fbbda3cc97ec62be941d356a1a4cde0485480d15f971ab8c2b3ad97c896
Deleted: sha256:e5bbe91bbba691de5124eada91c11d6d379b4473821fb812152131273210b5b3
Deleted: sha256:67854a9ad7067c531f7b956a1ff7d2037c702e93f174ec32f0a6370c4417a216
Deleted: sha256:8ba2b115e31f7648e22e8e3649aa785e3cb7a2b63c61e74856a16516301c6770
Deleted: sha256:35c0ec679919d6adb33cd50220d5fd6264bc2a783212ed851276cbe6d7df1d10
Deleted: sha256:c0d0da3adafcf5a2a3b50ade9a5de5decfc2918e0fde963a9dc05a1b606e096f
Deleted: sha256:b8cdba4d9438677fae71d8035dc8c14cc0709c9826e875c612d7d0daa3634123
Deleted: sha256:b8fe6fb2fc112c62841700cec20d180e603deae452e5033e480ccb3eaab49ed8
Deleted: sha256:2fcdc6f39c18b85f72fb6c65ba8f4c0c20f21432c26ada13502a4418e0b6b134
Deleted: sha256:aa4cff954fd88bba6980992e4bf8d07eabd6281458be76e2c438033487ecf381
Deleted: sha256:abe4e5c2965524b487fd6332a2162345d025367671528aa9119a105a41a2a4c5
Deleted: sha256:57ab471e7c3c4d99d5b4ba5918f3689cf25ba1bed5535e9ee9bc99f2f2279287
Deleted: sha256:5374304fd252f3e1e8c187bd8952d240ba4c3e23db833626ba1bbf7a77f66d32
Deleted: sha256:1dd8b0c1d533711a27337ff5141ebbac5f65c49fa6902d9adb9d02fc8e874425
Deleted: sha256:5b1e9405943fb4c702c4f4a4d3522836b80bd131706eac5b47bde7caf1e7319b
Deleted: sha256:0ae45b2eb1bac6bb4fa67c2ffe0bac22d806bc1f3eeef053475c0554a114a430
Deleted: sha256:87edfdf490f80e6be4d519ff61aa0e4a8a7934e5c59a2d5481b8a1e4cca07c18
Deleted: sha256:a8402bfbc3b7092755a3ec2817c2dd03fd3012b4c83600258c8a9b30cb232370
Deleted: sha256:cc0c8c5f65afde2a4f44e949da07c9fa41b566a002dd8d2a81b5ee7323a8439b
Deleted: sha256:9daf42f5c8a6bfde4057850eb82984aa5dbc2026ef5097dea9e616a2af976610
Deleted: sha256:767e4c5b17ed049192f23af132db1b86d5a440fce523deb823051a760ab939a0
Deleted: sha256:de54f0f5a1f5835be16e3fe1131a57a40df8defbe935bddc9051e8c5b1069965
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user yujie.jay@gmail.com