You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2017/10/25 01:13:35 UTC

Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose --disable-libtool-wrappers --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4364

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

Changes:

[songzihao1990] Added Meng Zhu to contributors list.

------------------------------------------
[...truncated 29.93 MB...]
I1025 01:13:00.076396  6858 containerizer.cpp:2690] Container 675f5be6-a63e-4261-905e-7540b3dcd372 has reached its limit for resource [{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":20.0},"type":"SCALAR"}] and will be terminated
I1025 01:13:00.076815  6858 containerizer.cpp:2220] Destroying container 675f5be6-a63e-4261-905e-7540b3dcd372 in RUNNING state
I1025 01:13:00.076992  6858 containerizer.cpp:2784] Transitioning the state of container 675f5be6-a63e-4261-905e-7540b3dcd372 from RUNNING to DESTROYING
I1025 01:13:00.077262  6858 containerizer.cpp:2220] Destroying container 675f5be6-a63e-4261-905e-7540b3dcd372.d218690d-51e2-4535-8794-a6f7821c7388 in RUNNING state
I1025 01:13:00.077497  6858 containerizer.cpp:2784] Transitioning the state of container 675f5be6-a63e-4261-905e-7540b3dcd372.d218690d-51e2-4535-8794-a6f7821c7388 from RUNNING to DESTROYING
I1025 01:13:00.078433  6858 launcher.cpp:156] Asked to destroy container 675f5be6-a63e-4261-905e-7540b3dcd372.d218690d-51e2-4535-8794-a6f7821c7388
I1025 01:13:00.157955  6860 hierarchical.cpp:2194] Filtered offer with cpus:1.8; mem:960; disk:1004; ports:[31000-32000] on agent c10d6ed7-13aa-435c-99ee-9b643727e7aa-S0 for role * of framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000
I1025 01:13:00.158429  6860 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.260671ms
I1025 01:13:00.176779  6857 containerizer.cpp:2671] Container 675f5be6-a63e-4261-905e-7540b3dcd372.d218690d-51e2-4535-8794-a6f7821c7388 has exited
I1025 01:13:00.180639  6861 provisioner.cpp:490] Ignoring destroy request for unknown container 675f5be6-a63e-4261-905e-7540b3dcd372.d218690d-51e2-4535-8794-a6f7821c7388
I1025 01:13:00.180924  6861 containerizer.cpp:2509] Checkpointing termination state to nested container's runtime directory '/tmp/MesosContainerizer_DefaultExecutorTest_ResourceLimitation_0_smNniO/containers/675f5be6-a63e-4261-905e-7540b3dcd372/containers/d218690d-51e2-4535-8794-a6f7821c7388/termination'
I1025 01:13:00.183737  6861 launcher.cpp:156] Asked to destroy container 675f5be6-a63e-4261-905e-7540b3dcd372
I1025 01:13:00.226585  6860 process.cpp:3938] Handling HTTP event for process 'slave(728)' with path: '/slave(728)/api/v1/executor'
I1025 01:13:00.248086  6863 http.cpp:1185] HTTP POST for /slave(728)/api/v1/executor from 172.17.0.3:43522
I1025 01:13:00.248900  6863 slave.cpp:4395] Handling status update TASK_FAILED (UUID: 03433eeb-09e1-4192-8019-043d45b6dd88) for task 1a8e5dfd-a81d-463f-9e90-bd2cae9f4edb of framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000
W1025 01:13:00.255699  6864 containerizer.cpp:2036] Ignoring update for currently being destroyed container 675f5be6-a63e-4261-905e-7540b3dcd372
I1025 01:13:00.256467  6865 process.cpp:954] Decode failure: Connection reset by peer
E1025 01:13:00.256611  6865 process.cpp:2576] Failed to shutdown socket with fd 32, address 172.17.0.3:32792: Transport endpoint is not connected
I1025 01:13:00.259526  6859 status_update_manager.cpp:323] Received status update TASK_FAILED (UUID: 03433eeb-09e1-4192-8019-043d45b6dd88) for task 1a8e5dfd-a81d-463f-9e90-bd2cae9f4edb of framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000
I1025 01:13:00.268275  6859 status_update_manager.cpp:377] Forwarding update TASK_FAILED (UUID: 03433eeb-09e1-4192-8019-043d45b6dd88) for task 1a8e5dfd-a81d-463f-9e90-bd2cae9f4edb of framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000 to the agent
I1025 01:13:00.268791  6857 slave.cpp:4876] Forwarding the update TASK_FAILED (UUID: 03433eeb-09e1-4192-8019-043d45b6dd88) for task 1a8e5dfd-a81d-463f-9e90-bd2cae9f4edb of framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000 to master@172.17.0.3:32792
I1025 01:13:00.269176  6857 slave.cpp:4770] Status update manager successfully handled status update TASK_FAILED (UUID: 03433eeb-09e1-4192-8019-043d45b6dd88) for task 1a8e5dfd-a81d-463f-9e90-bd2cae9f4edb of framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000
W1025 01:13:00.269367  6857 slave.hpp:745] Unable to send event to executor 'default' of framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000 (via HTTP): connection closed
I1025 01:13:00.269866  6857 master.cpp:7004] Status update TASK_FAILED (UUID: 03433eeb-09e1-4192-8019-043d45b6dd88) for task 1a8e5dfd-a81d-463f-9e90-bd2cae9f4edb of framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000 from agent c10d6ed7-13aa-435c-99ee-9b643727e7aa-S0 at slave(728)@172.17.0.3:32792 (4185f70d4718)
I1025 01:13:00.269965  6857 master.cpp:7066] Forwarding status update TASK_FAILED (UUID: 03433eeb-09e1-4192-8019-043d45b6dd88) for task 1a8e5dfd-a81d-463f-9e90-bd2cae9f4edb of framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000
I1025 01:13:00.270699  6857 master.cpp:9168] Updating the state of task 1a8e5dfd-a81d-463f-9e90-bd2cae9f4edb of framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000 (latest state: TASK_FAILED, status update state: TASK_FAILED)
I1025 01:13:00.271617  6861 hierarchical.cpp:1163] Recovered cpus(allocated: *):0.1; mem(allocated: *):32; disk(allocated: *):10 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: cpus(allocated: *):0.1; mem(allocated: *):32; disk(allocated: *):10) on agent c10d6ed7-13aa-435c-99ee-9b643727e7aa-S0 from framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000
I1025 01:13:00.273221  6863 scheduler.cpp:738] Enqueuing event UPDATE received from http://172.17.0.3:32792/master/api/v1/scheduler
I1025 01:13:00.277129  6861 scheduler.cpp:249] Sending ACKNOWLEDGE call to http://172.17.0.3:32792/master/api/v1/scheduler
I1025 01:13:00.280062  6864 master.cpp:1417] Framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000 (default) disconnected
I1025 01:13:00.280098  6864 master.cpp:3299] Deactivating framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000 (default)
I1025 01:13:00.280298  6864 master.cpp:3276] Disconnecting framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000 (default)
I1025 01:13:00.280342  6864 master.cpp:1432] Giving framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000 (default) 0ns to failover
I1025 01:13:00.280563  6864 hierarchical.cpp:412] Deactivated framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000
I1025 01:13:00.281057  6862 master.cpp:7609] Framework failover timeout, removing framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000 (default)
I1025 01:13:00.281090  6862 master.cpp:8470] Removing framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000 (default)
I1025 01:13:00.281384  6862 master.cpp:9168] Updating the state of task 1a8e5dfd-a81d-463f-9e90-bd2cae9f4edb of framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000 (latest state: TASK_FAILED, status update state: TASK_KILLED)
I1025 01:13:00.281512  6864 containerizer.cpp:2671] Container 675f5be6-a63e-4261-905e-7540b3dcd372 has exited
I1025 01:13:00.281431  6862 master.cpp:9262] Removing task 1a8e5dfd-a81d-463f-9e90-bd2cae9f4edb with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":0.1},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":32.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":10.0},"type":"SCALAR"}] of framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000 on agent c10d6ed7-13aa-435c-99ee-9b643727e7aa-S0 at slave(728)@172.17.0.3:32792 (4185f70d4718)
I1025 01:13:00.282327  6862 master.cpp:9291] Removing executor 'default' with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":0.1},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":32.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":10.0},"type":"SCALAR"}] of framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000 on agent c10d6ed7-13aa-435c-99ee-9b643727e7aa-S0 at slave(728)@172.17.0.3:32792 (4185f70d4718)
I1025 01:13:00.283018  6857 slave.cpp:3211] Asked to shut down framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000 by master@172.17.0.3:32792
I1025 01:13:00.284008  6857 slave.cpp:3236] Shutting down framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000
I1025 01:13:00.284191  6857 slave.cpp:5743] Shutting down executor 'default' of framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000 (via HTTP)
W1025 01:13:00.284325  6857 slave.hpp:745] Unable to send event to executor 'default' of framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000 (via HTTP): connection closed
I1025 01:13:00.285073  6859 hierarchical.cpp:1163] Recovered cpus(allocated: *):0.1; mem(allocated: *):32; disk(allocated: *):10 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: {}) on agent c10d6ed7-13aa-435c-99ee-9b643727e7aa-S0 from framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000
I1025 01:13:00.288621  6861 provisioner.cpp:490] Ignoring destroy request for unknown container 675f5be6-a63e-4261-905e-7540b3dcd372
I1025 01:13:00.289662  6862 hierarchical.cpp:355] Removed framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000
I1025 01:13:00.290349  6860 slave.cpp:5408] Executor 'default' of framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000 terminated with signal Killed
I1025 01:13:00.290498  6860 slave.cpp:5512] Cleaning up executor 'default' of framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000 (via HTTP)
W1025 01:13:00.290657  6861 master.cpp:7121] Ignoring unknown exited executor 'default' of framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000 on agent c10d6ed7-13aa-435c-99ee-9b643727e7aa-S0 at slave(728)@172.17.0.3:32792 (4185f70d4718)
I1025 01:13:00.290762  6861 gc.cpp:90] Scheduling '/tmp/MesosContainerizer_DefaultExecutorTest_ResourceLimitation_0_GnQCc4/slaves/c10d6ed7-13aa-435c-99ee-9b643727e7aa-S0/frameworks/c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000/executors/default/runs/675f5be6-a63e-4261-905e-7540b3dcd372' for gc 6.99999664420148days in the future
I1025 01:13:00.290956  6861 gc.cpp:90] Scheduling '/tmp/MesosContainerizer_DefaultExecutorTest_ResourceLimitation_0_GnQCc4/slaves/c10d6ed7-13aa-435c-99ee-9b643727e7aa-S0/frameworks/c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000/executors/default' for gc 6.99999664420148days in the future
I1025 01:13:00.290961  6860 slave.cpp:5619] Cleaning up framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000
I1025 01:13:00.291537  6860 status_update_manager.cpp:285] Closing status update streams for framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000
I1025 01:13:00.291609  6860 status_update_manager.cpp:531] Cleaning up status update stream for task 1a8e5dfd-a81d-463f-9e90-bd2cae9f4edb of framework c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000
I1025 01:13:00.292120  6864 gc.cpp:90] Scheduling '/tmp/MesosContainerizer_DefaultExecutorTest_ResourceLimitation_0_GnQCc4/slaves/c10d6ed7-13aa-435c-99ee-9b643727e7aa-S0/frameworks/c10d6ed7-13aa-435c-99ee-9b643727e7aa-0000' for gc 6.99999664420148days in the future
I1025 01:13:00.306252  6859 slave.cpp:869] Agent terminating
I1025 01:13:00.308509  6857 master.cpp:1303] Agent c10d6ed7-13aa-435c-99ee-9b643727e7aa-S0 at slave(728)@172.17.0.3:32792 (4185f70d4718) disconnected
I1025 01:13:00.308553  6857 master.cpp:3336] Disconnecting agent c10d6ed7-13aa-435c-99ee-9b643727e7aa-S0 at slave(728)@172.17.0.3:32792 (4185f70d4718)
I1025 01:13:00.309077  6857 master.cpp:3355] Deactivating agent c10d6ed7-13aa-435c-99ee-9b643727e7aa-S0 at slave(728)@172.17.0.3:32792 (4185f70d4718)
I1025 01:13:00.309509  6857 hierarchical.cpp:690] Agent c10d6ed7-13aa-435c-99ee-9b643727e7aa-S0 deactivated
I1025 01:13:00.339349  6856 master.cpp:1145] Master terminating
I1025 01:13:00.340333  6859 hierarchical.cpp:626] Removed agent c10d6ed7-13aa-435c-99ee-9b643727e7aa-S0
[       OK ] MesosContainerizer/DefaultExecutorTest.ResourceLimitation/0 (1254 ms)
[ RUN      ] MesosContainerizer/DefaultExecutorTest.TaskWithFileURI/0
I1025 01:13:00.418269  6856 cluster.cpp:162] Creating default 'local' authorizer
I1025 01:13:00.422355  6857 master.cpp:445] Master aa6540b6-c6d4-41f1-b21b-03b395aad1bd (4185f70d4718) started on 172.17.0.3:32792
I1025 01:13:00.422390  6857 master.cpp:447] Flags at startup: --acls="" --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate_agents="true" --authenticate_frameworks="true" --authenticate_http_frameworks="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/0pFITU/credentials" --filter_gpu_resources="true" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --port="5050" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-1.5.0/_inst/share/mesos/webui" --work_dir="/tmp/0pFITU/master" --zk_session_timeout="10secs"
I1025 01:13:00.423408  6857 master.cpp:496] Master only allowing authenticated frameworks to register
I1025 01:13:00.423457  6857 master.cpp:502] Master only allowing authenticated agents to register
I1025 01:13:00.423471  6857 master.cpp:508] Master only allowing authenticated HTTP frameworks to register
I1025 01:13:00.423491  6857 credentials.hpp:37] Loading credentials for authentication from '/tmp/0pFITU/credentials'
I1025 01:13:00.424186  6857 master.cpp:552] Using default 'crammd5' authenticator
I1025 01:13:00.424691  6857 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I1025 01:13:00.425189  6857 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I1025 01:13:00.425621  6857 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I1025 01:13:00.426549  6857 master.cpp:631] Authorization enabled
I1025 01:13:00.427467  6862 hierarchical.cpp:171] Initialized hierarchical allocator process
I1025 01:13:00.427567  6861 whitelist_watcher.cpp:77] No whitelist given
I1025 01:13:00.431756  6857 master.cpp:2198] Elected as the leading master!
I1025 01:13:00.431805  6857 master.cpp:1687] Recovering from registrar
I1025 01:13:00.432335  6859 registrar.cpp:347] Recovering registrar
I1025 01:13:00.433126  6859 registrar.cpp:391] Successfully fetched the registry (0B) in 542976ns
I1025 01:13:00.433310  6859 registrar.cpp:495] Applied 1 operations in 45846ns; attempting to update the registry
I1025 01:13:00.434109  6864 registrar.cpp:552] Successfully updated the registry in 677888ns
I1025 01:13:00.434530  6864 registrar.cpp:424] Successfully recovered registrar
I1025 01:13:00.435513  6862 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
I1025 01:13:00.435499  6857 master.cpp:1791] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
W1025 01:13:00.442792  6856 process.cpp:3193] Attempted to spawn already running process files@172.17.0.3:32792
I1025 01:13:00.443944  6856 containerizer.cpp:301] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W1025 01:13:00.444571  6856 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W1025 01:13:00.444778  6856 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I1025 01:13:00.444850  6856 provisioner.cpp:255] Using default backend 'copy'
I1025 01:13:00.447051  6856 cluster.cpp:448] Creating default 'local' authorizer
I1025 01:13:00.449609  6863 slave.cpp:254] Mesos agent started on (729)@172.17.0.3:32792
I1025 01:13:00.449666  6863 slave.cpp:255] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/MesosContainerizer_DefaultExecutorTest_TaskWithFileURI_0_Vfs1gw/store/appc" --authenticate_http_executors="true" --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/MesosContainerizer_DefaultExecutorTest_TaskWithFileURI_0_Vfs1gw/credential" --default_role="*" --disallow_sharing_agent_pid_namespace="false" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/MesosContainerizer_DefaultExecutorTest_TaskWithFileURI_0_Vfs1gw/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_secret_key="/tmp/MesosContainerizer_DefaultExecutorTest_TaskWithFileURI_0_Vfs1gw/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/MesosContainerizer_DefaultExecutorTest_TaskWithFileURI_0_Vfs1gw/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/MesosContainerizer_DefaultExecutorTest_TaskWithFileURI_0_Vfs1gw/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/MesosContainerizer_DefaultExecutorTest_TaskWithFileURI_0_Vfs1gw" --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/MesosContainerizer_DefaultExecutorTest_TaskWithFileURI_0_3QalAI" --zk_session_timeout="10secs"
I1025 01:13:00.450436  6863 credentials.hpp:86] Loading credential for authentication from '/tmp/MesosContainerizer_DefaultExecutorTest_TaskWithFileURI_0_Vfs1gw/credential'
I1025 01:13:00.450664  6863 slave.cpp:287] Agent using credential for: test-principal
I1025 01:13:00.450716  6863 credentials.hpp:37] Loading credentials for authentication from '/tmp/MesosContainerizer_DefaultExecutorTest_TaskWithFileURI_0_Vfs1gw/http_credentials'
I1025 01:13:00.451020  6863 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I1025 01:13:00.451225  6863 http.cpp:1066] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I1025 01:13:00.451555  6863 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1025 01:13:00.451815  6863 http.cpp:1066] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I1025 01:13:00.452111  6863 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1025 01:13:00.452347  6863 http.cpp:1066] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I1025 01:13:00.453964  6863 slave.cpp:585] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I1025 01:13:00.454227  6863 slave.cpp:593] Agent attributes: [  ]
I1025 01:13:00.454269  6863 slave.cpp:602] Agent hostname: 4185f70d4718
I1025 01:13:00.454741  6864 status_update_manager.cpp:177] Pausing sending status updates
I1025 01:13:00.456450  6863 state.cpp:64] Recovering state from '/tmp/MesosContainerizer_DefaultExecutorTest_TaskWithFileURI_0_3QalAI/meta'
I1025 01:13:00.456974  6862 status_update_manager.cpp:203] Recovering status update manager
I1025 01:13:00.457418  6861 containerizer.cpp:662] Recovering containerizer
I1025 01:13:00.459564  6860 provisioner.cpp:416] Provisioner recovery complete
I1025 01:13:00.460258  6859 slave.cpp:6310] Finished recovery
I1025 01:13:00.461464  6858 status_update_manager.cpp:177] Pausing sending status updates
I1025 01:13:00.461463  6859 slave.cpp:993] New master detected at master@172.17.0.3:32792
I1025 01:13:00.461632  6859 slave.cpp:1028] Detecting new master
I1025 01:13:00.462920  6856 scheduler.cpp:190] Version: 1.5.0
I1025 01:13:00.463523  6860 scheduler.cpp:313] Using default 'basic' HTTP authenticatee
I1025 01:13:00.464246  6860 scheduler.cpp:496] New master detected at master@172.17.0.3:32792
I1025 01:13:00.464284  6860 scheduler.cpp:505] Waiting for 0ns before initiating a re-(connection) attempt with the master
I1025 01:13:00.468308  6862 slave.cpp:1055] Authenticating with master master@172.17.0.3:32792
I1025 01:13:00.468471  6862 slave.cpp:1064] Using default CRAM-MD5 authenticatee
I1025 01:13:00.468930  6862 authenticatee.cpp:121] Creating new client SASL connection
I1025 01:13:00.469316  6862 master.cpp:7947] Authenticating slave(729)@172.17.0.3:32792
I1025 01:13:00.469569  6862 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1379)@172.17.0.3:32792
I1025 01:13:00.470019  6860 scheduler.cpp:387] Connected with the master at http://172.17.0.3:32792/master/api/v1/scheduler
I1025 01:13:00.470047  6862 authenticator.cpp:98] Creating new server SASL connection
I1025 01:13:00.470345  6862 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I1025 01:13:00.470408  6862 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I1025 01:13:00.470553  6862 authenticator.cpp:204] Received SASL authentication start
I1025 01:13:00.470649  6862 authenticator.cpp:326] Authentication requires more steps
I1025 01:13:00.470787  6862 authenticatee.cpp:259] Received SASL authentication step
I1025 01:13:00.470927  6862 authenticator.cpp:232] Received SASL authentication step
I1025 01:13:00.470985  6862 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '4185f70d4718' server FQDN: '4185f70d4718' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I1025 01:13:00.471029  6862 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I1025 01:13:00.471102  6862 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I1025 01:13:00.471164  6862 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '4185f70d4718' server FQDN: '4185f70d4718' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I1025 01:13:00.471205  6862 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I1025 01:13:00.471240  6862 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I1025 01:13:00.471276  6862 authenticator.cpp:318] Authentication success
I1025 01:13:00.471524  6862 authenticatee.cpp:299] Authentication success
I1025 01:13:00.471621  6861 master.cpp:7977] Successfully authenticated principal 'test-principal' at slave(729)@172.17.0.3:32792
I1025 01:13:00.471681  6859 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1379)@172.17.0.3:32792
I1025 01:13:00.472337  6862 slave.cpp:1147] Successfully authenticated with master master@172.17.0.3:32792
I1025 01:13:00.472654  6862 slave.cpp:1626] Will retry registration in 8.437871ms if necessary
I1025 01:13:00.473189  6858 master.cpp:5801] Received register agent message from slave(729)@172.17.0.3:32792 (4185f70d4718)
I1025 01:13:00.473598  6858 master.cpp:3838] Authorizing agent with principal 'test-principal'
I1025 01:13:00.474720  6859 master.cpp:5861] Authorized registration of agent at slave(729)@172.17.0.3:32792 (4185f70d4718)
I1025 01:13:00.475288  6859 master.cpp:5954] Registering agent at slave(729)@172.17.0.3:32792 (4185f70d4718) with id aa6540b6-c6d4-41f1-b21b-03b395aad1bd-S0
I1025 01:13:00.475623  6864 scheduler.cpp:249] Sending SUBSCRIBE call to http://172.17.0.3:32792/master/api/v1/scheduler
I1025 01:13:00.475890  6859 registrar.cpp:495] Applied 1 operations in 67969ns; attempting to update the registry
I1025 01:13:00.476982  6859 registrar.cpp:552] Successfully updated the registry in 988160ns
I1025 01:13:00.477358  6859 master.cpp:6001] Admitted agent aa6540b6-c6d4-41f1-b21b-03b395aad1bd-S0 at slave(729)@172.17.0.3:32792 (4185f70d4718)
I1025 01:13:00.478420  6859 master.cpp:6032] Registered agent aa6540b6-c6d4-41f1-b21b-03b395aad1bd-S0 at slave(729)@172.17.0.3:32792 (4185f70d4718) 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"}]
I1025 01:13:00.478790  6861 slave.cpp:1193] Registered with master master@172.17.0.3:32792; given agent ID aa6540b6-c6d4-41f1-b21b-03b395aad1bd-S0
I1025 01:13:00.479275  6861 slave.cpp:1213] Checkpointing SlaveInfo to '/tmp/MesosContainerizer_DefaultExecutorTest_TaskWithFileURI_0_3QalAI/meta/slaves/aa6540b6-c6d4-41f1-b21b-03b395aad1bd-S0/slave.info'
I1025 01:13:00.479758  6861 slave.cpp:1262] Forwarding total oversubscribed resources {}
I1025 01:13:00.480063  6861 status_update_manager.cpp:184] Resuming sending status updates
I1025 01:13:00.480345  6859 master.cpp:6828] Received update of agent aa6540b6-c6d4-41f1-b21b-03b395aad1bd-S0 at slave(729)@172.17.0.3:32792 (4185f70d4718) with total oversubscribed resources {}
I1025 01:13:00.480552  6859 master.cpp:6839] Ignoring update on agent aa6540b6-c6d4-41f1-b21b-03b395aad1bd-S0 at slave(729)@172.17.0.3:32792 (4185f70d4718) as it reports no changes
I1025 01:13:00.481508  6862 process.cpp:3938] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1025 01:13:00.483253  6864 hierarchical.cpp:593] Added agent aa6540b6-c6d4-41f1-b21b-03b395aad1bd-S0 (4185f70d4718) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I1025 01:13:00.484045  6862 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:43530
I1025 01:13:00.484386  6862 master.cpp:2580] Received subscription request for HTTP framework 'default'
I1025 01:13:00.484539  6862 master.cpp:2263] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I1025 01:13:00.485286  6858 master.cpp:2716] Subscribing framework 'default' with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
I1025 01:13:00.486119  6864 hierarchical.cpp:1488] Performed allocation for 1 agents in 2.162651ms
I1025 01:13:00.487782  6864 hierarchical.cpp:303] Added framework aa6540b6-c6d4-41f1-b21b-03b395aad1bd-0000
I1025 01:13:00.489251  6864 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.034228ms
I1025 01:13:00.489645  6860 scheduler.cpp:738] Enqueuing event SUBSCRIBED received from http://172.17.0.3:32792/master/api/v1/scheduler
I1025 01:13:00.490602  6858 master.cpp:7777] Sending 1 offers to framework aa6540b6-c6d4-41f1-b21b-03b395aad1bd-0000 (default)
*** Aborted at 1508893980 (unix time) try "date -d @1508893980" if you are using GNU date ***
I1025 01:13:00.491554  6859 scheduler.cpp:738] Enqueuing event HEARTBEAT received from http://172.17.0.3:32792/master/api/v1/scheduler
I1025 01:13:00.497264  6864 scheduler.cpp:738] Enqueuing event OFFERS received from http://172.17.0.3:32792/master/api/v1/scheduler
PC: @     0x55e30fba306a testing::internal::UntypedFunctionMockerBase::UntypedInvokeWith()
*** SIGSEGV (@0x10000002f) received by PID 6856 (TID 0x2afb86a4d700) from PID 47; stack trace: ***
    @     0x2afbad9adaf7 (unknown)
    @     0x2afbad9b2449 (unknown)
    @     0x2afb7d410330 (unknown)
    @     0x55e30fba306a testing::internal::UntypedFunctionMockerBase::UntypedInvokeWith()
    @     0x55e30e6dc1e9 testing::internal::FunctionMockerBase<>::InvokeWith()
    @     0x55e30e6c14a2 testing::internal::FunctionMocker<>::Invoke()
    @     0x55e30e6a24d7 mesos::internal::tests::scheduler::MockHTTPScheduler<>::subscribed()
    @     0x55e30e679f00 mesos::internal::tests::scheduler::MockHTTPScheduler<>::event()
    @     0x55e30e64725d mesos::internal::tests::scheduler::TestMesos<>::events()
    @     0x55e30e6dc759 std::_Mem_fn<>::operator()<>()
    @     0x55e30e6c211f _ZNSt5_BindIFSt7_Mem_fnIMN5mesos8internal5tests9scheduler9TestMesosINS1_2v19scheduler5MesosENS7_5EventEEEFvSt5queueIS9_St5dequeIS9_SaIS9_EEEEEPSA_St12_PlaceholderILi1EEEE6__callIvJRKSF_EJLm0ELm1EEEET_OSt5tupleIJDpT0_EESt12_Index_tupleIJXspT1_EEE
    @     0x55e30e6a2a47 _ZNSt5_BindIFSt7_Mem_fnIMN5mesos8internal5tests9scheduler9TestMesosINS1_2v19scheduler5MesosENS7_5EventEEEFvSt5queueIS9_St5dequeIS9_SaIS9_EEEEEPSA_St12_PlaceholderILi1EEEEclIJRKSF_EvEET0_DpOT_
    @     0x55e30e67a3b0 std::_Function_handler<>::_M_invoke()
    @     0x2afb79668033 std::function<>::operator()()
    @     0x2afb7966130a process::AsyncExecutorProcess::execute<>()
    @     0x2afb79661465 _ZZN7process8dispatchI7NothingNS_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v19scheduler5EventESt5dequeIS8_SaIS8_EEEEESC_SI_RSC_EENS_6FutureIT_EERKNS_3PIDIT0_EEMSO_FSL_T1_T2_EOT3_OT4_ENKUlRSG_SJ_PNS_11ProcessBaseEE_clES10_SJ_S12_
    @     0x2afb7967877a _ZNSt5_BindIFZN7process8dispatchI7NothingNS0_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v19scheduler5EventESt5dequeIS9_SaIS9_EEEEESD_SJ_RSD_EENS0_6FutureIT_EERKNS0_3PIDIT0_EEMSP_FSM_T1_T2_EOT3_OT4_EUlRSH_SK_PNS0_11ProcessBaseEE_SH_SD_St12_PlaceholderILi1EEEE6__callIvIOS13_EILm0ELm1ELm2EEEET_OSt5tupleIIDpT0_EESt12_Index_tupleIIXspT1_EEE
    @     0x2afb79675619 _ZNSt5_BindIFZN7process8dispatchI7NothingNS0_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v19scheduler5EventESt5dequeIS9_SaIS9_EEEEESD_SJ_RSD_EENS0_6FutureIT_EERKNS0_3PIDIT0_EEMSP_FSM_T1_T2_EOT3_OT4_EUlRSH_SK_PNS0_11ProcessBaseEE_SH_SD_St12_PlaceholderILi1EEEEclIIS13_EvEET0_DpOT_
    @     0x2afb7966f08a _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEESt5_BindIFZNS0_8dispatchI7NothingNS0_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v19scheduler5EventESt5dequeISD_SaISD_EEEEESH_SN_RSH_EENS0_6FutureIT_EERKNS0_3PIDIT0_EEMST_FSQ_T1_T2_EOT3_OT4_EUlRSL_SO_S2_E_SL_SH_St12_PlaceholderILi1EEEEE9_M_invokeERKSt9_Any_dataS2_
    @     0x2afb7a863d09 std::function<>::operator()()
    @     0x2afb7a844611 process::ProcessBase::visit()
    @     0x2afb7a8511da process::DispatchEvent::visit()
    @     0x55e30e4ff9e6 process::ProcessBase::serve()
    @     0x2afb7a841b53 process::ProcessManager::resume()
    @     0x2afb7a83dfb2 _ZZN7process14ProcessManager12init_threadsEvENKUlvE_clEv
    @     0x2afb7a8501e4 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
    @     0x2afb7a85013b _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEclEv
    @     0x2afb7a8500d4 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEE6_M_runEv
    @     0x2afb7cc91a60 (unknown)
    @     0x2afb7d408184 start_thread
    @     0x2afb7d71bffd (unknown)
make[4]: *** [check-local] Segmentation fault (core dumped)
make[4]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.5.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1508885577-30245
Untagged: mesos-1508885577-30245:latest
Deleted: sha256:5061b93174e6fed3941465ef92d46354ee7301973716299f0b7957cfb473400a
Deleted: sha256:11110586e2519c1cdba5ddc70063972f9889900d007f2d15e9588503ebd0e095
Deleted: sha256:e777a5aba32ffcfd96b26ab2f9c5e8620593e54d95e2498b2e27639dbc0d6a4a
Deleted: sha256:2b17473122d2c936a8e3a297b69644b2a6f88fb90b161d6039c1e9806cd483ab
Deleted: sha256:87442129c696156f9757a215d16616ee67cfd3e5e7bf76dda40301cdd5aaa0f3
Deleted: sha256:f5e3f6b33d3ee278440285ea61a1174dd6b4d0beeb088bd7cce6a9aa0777e2c5
Deleted: sha256:e44cb5a125a700e38be0b775e70220e9b48570242b526a0ddb2a4081b69a9869
Deleted: sha256:90f892d666fb4777f627c09061a2b0b4fa6e02321fcbb424b57a4371ff806211
Deleted: sha256:0e17d01e32c5244b2c267d50c25e43ad9247d98f2182d15a1e6e358a450ed9f2
Deleted: sha256:28d744cca25633e840f1663e773d604f29581b16fab906086c1d6ce9967a18dc
Deleted: sha256:82efff76e7ce4e66125354de0bfbba53fa9f0f14684fcacd36ed9abd2b130dad
Deleted: sha256:08da67b002c72892b72ccca019f302de4fd869ddaa19e12774165eaa91f0a3b3
Deleted: sha256:3dff453f1ad65f2aaa269611b21098ce6158e66a58d98c07bc0c95301db3a5ae
Deleted: sha256:8d7f15d35520f0049896cda3970abe8bc12611010c3339e6a3715a671fc532f2
Deleted: sha256:4ac0f2d6b6c1c20fd4d2eaa5424515d06d5d9cb40f8ad13544e4b7b489493c6c
Deleted: sha256:87691d611fb5be32b610dddde787a44af8ecbd96439e522ddcaeeb636d0a7f0d
Deleted: sha256:ca3ea1fd6aae6af0d24626516b0a729865b00e21594c7882ff132e9d7e88a315
Deleted: sha256:7758bbc2676617106a9a55418288cb860f845b3a864aec85e519192343766cf7
Deleted: sha256:d04fa0029e9c11bf342f60176c0e2f261ff914235dfbacf0633fb669f614d57b
Deleted: sha256:018f1df2df6d915baeae317dde172d3fdfa999a89c93cb07521267d406755764
Deleted: sha256:dc93090935b05fb357a6fbd892d07ac048933c97084b16334e880ac53269a1b5
Deleted: sha256:b283882c1541a23eabfe441c0246e2db0a394f4fc89956b48cfcf944fadaf77a
Deleted: sha256:00626849e695799b958ff87e1552b72f3ee57c8bb55b1d7311a825b401850e34
Deleted: sha256:a72352a9933d8b81bbd0158eae5aecb0ba3cacfa4873161b3a3a4e7bd1ee1bac
Deleted: sha256:5fea3e88005dd8976604180d0046e9ee8461c5df1f5a3a4f2011acda0c26aba1
Deleted: sha256:5caa5223704c0eaddb9cfa9461cfaf424a987eade6a597fce6ad7b9d8386a795
Deleted: sha256:d76e038232c4e077b9c2e6e90c7a0a17ffeb9e88bfb73605bd3138f6e95769ee
Deleted: sha256:42a4362db30777a63d1fb8e5742a9e39c40ebce547af0e96b6c6ffa2a7d8c383
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user songzihao1990@gmail.com

Jenkins build is back to normal : Mesos-Buildbot » autotools,gcc,--verbose --disable-libtool-wrappers --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4365

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose%20--disable-libtool-wrappers%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4365/display/redirect?page=changes>