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/07/27 09:29:38 UTC
Build failed in Jenkins: Mesos-Buildbot » cmake,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3963
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3963/display/redirect>
------------------------------------------
[...truncated 26.58 MB...]
I0727 09:29:21.361457 1298 hierarchical.cpp:690] Agent 2236fede-4de9-43d2-b693-8643c42e7011-S0 deactivated
I0727 09:29:21.364053 1292 master.cpp:1160] Master terminating
I0727 09:29:21.365473 1296 hierarchical.cpp:626] Removed agent 2236fede-4de9-43d2-b693-8643c42e7011-S0
[ OK ] ContentType/SchedulerTest.TaskRunning/0 (138 ms)
[ RUN ] ContentType/SchedulerTest.TaskRunning/1
I0727 09:29:21.376950 1292 cluster.cpp:162] Creating default 'local' authorizer
I0727 09:29:21.379830 1300 master.cpp:442] Master d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c (bbbdf99144fe) started on 172.17.0.3:41825
I0727 09:29:21.379853 1300 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/m2tByV/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="/usr/local/share/mesos/webui" --work_dir="/tmp/m2tByV/master" --zk_session_timeout="10secs"
I0727 09:29:21.380095 1300 master.cpp:494] Master only allowing authenticated frameworks to register
I0727 09:29:21.380106 1300 master.cpp:508] Master only allowing authenticated agents to register
I0727 09:29:21.380110 1300 master.cpp:521] Master only allowing authenticated HTTP frameworks to register
I0727 09:29:21.380115 1300 credentials.hpp:37] Loading credentials for authentication from '/tmp/m2tByV/credentials'
I0727 09:29:21.380357 1300 master.cpp:566] Using default 'crammd5' authenticator
I0727 09:29:21.380511 1300 http.cpp:993] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0727 09:29:21.380656 1300 http.cpp:993] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0727 09:29:21.380762 1300 http.cpp:993] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0727 09:29:21.380862 1300 master.cpp:646] Authorization enabled
I0727 09:29:21.381067 1293 whitelist_watcher.cpp:77] No whitelist given
I0727 09:29:21.381188 1297 hierarchical.cpp:171] Initialized hierarchical allocator process
I0727 09:29:21.383569 1298 master.cpp:2163] Elected as the leading master!
I0727 09:29:21.383694 1298 master.cpp:1702] Recovering from registrar
I0727 09:29:21.383972 1296 registrar.cpp:345] Recovering registrar
I0727 09:29:21.384905 1296 registrar.cpp:389] Successfully fetched the registry (0B) in 880896ns
I0727 09:29:21.385206 1296 registrar.cpp:493] Applied 1 operations in 203881ns; attempting to update the registry
I0727 09:29:21.386405 1296 registrar.cpp:550] Successfully updated the registry in 1.108992ms
I0727 09:29:21.386595 1296 registrar.cpp:422] Successfully recovered registrar
I0727 09:29:21.387401 1294 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
I0727 09:29:21.387392 1296 master.cpp:1801] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0727 09:29:21.392019 1292 cluster.cpp:448] Creating default 'local' authorizer
I0727 09:29:21.393806 1300 slave.cpp:250] Mesos agent started on (722)@172.17.0.3:41825
I0727 09:29:21.393822 1300 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/ContentType_SchedulerTest_TaskRunning_1_OW37PJ/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/ContentType_SchedulerTest_TaskRunning_1_OW37PJ/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/ContentType_SchedulerTest_TaskRunning_1_OW37PJ/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/ContentType_SchedulerTest_TaskRunning_1_OW37PJ/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/ContentType_SchedulerTest_TaskRunning_1_OW37PJ/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/ContentType_SchedulerTest_TaskRunning_1_OW37PJ/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/ContentType_SchedulerTest_TaskRunning_1_OW37PJ" --sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true" --systemd_enable_support="true" --systemd_runtime_directory="/run/systemd/system" --version="false" --work_dir="/tmp/ContentType_SchedulerTest_TaskRunning_1_iCXlHP"
I0727 09:29:21.394153 1300 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentType_SchedulerTest_TaskRunning_1_OW37PJ/credential'
I0727 09:29:21.394300 1300 slave.cpp:283] Agent using credential for: test-principal
I0727 09:29:21.394327 1300 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentType_SchedulerTest_TaskRunning_1_OW37PJ/http_credentials'
I0727 09:29:21.394578 1300 http.cpp:993] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0727 09:29:21.394673 1300 http.cpp:1014] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0727 09:29:21.394918 1300 http.cpp:993] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0727 09:29:21.395006 1300 http.cpp:1014] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0727 09:29:21.395150 1300 http.cpp:993] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0727 09:29:21.395231 1300 http.cpp:1014] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0727 09:29:21.397215 1300 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"}]
I0727 09:29:21.397406 1300 slave.cpp:573] Agent attributes: [ ]
I0727 09:29:21.397420 1300 slave.cpp:582] Agent hostname: bbbdf99144fe
I0727 09:29:21.397758 1294 status_update_manager.cpp:177] Pausing sending status updates
I0727 09:29:21.399652 1300 state.cpp:64] Recovering state from '/tmp/ContentType_SchedulerTest_TaskRunning_1_iCXlHP/meta'
I0727 09:29:21.400121 1293 status_update_manager.cpp:203] Recovering status update manager
I0727 09:29:21.400355 1292 scheduler.cpp:184] Version: 1.4.0
I0727 09:29:21.401008 1300 scheduler.cpp:470] New master detected at master@172.17.0.3:41825
I0727 09:29:21.401042 1300 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0727 09:29:21.401554 1299 slave.cpp:6207] Finished recovery
I0727 09:29:21.402422 1299 slave.cpp:6389] Querying resource estimator for oversubscribable resources
I0727 09:29:21.402935 1299 slave.cpp:971] New master detected at master@172.17.0.3:41825
I0727 09:29:21.403013 1299 slave.cpp:1006] Detecting new master
I0727 09:29:21.403183 1297 status_update_manager.cpp:177] Pausing sending status updates
I0727 09:29:21.403250 1299 slave.cpp:6403] Received oversubscribable resources {} from the resource estimator
I0727 09:29:21.405004 1299 scheduler.cpp:361] Connected with the master at http://172.17.0.3:41825/master/api/v1/scheduler
I0727 09:29:21.406797 1294 scheduler.cpp:243] Sending SUBSCRIBE call to http://172.17.0.3:41825/master/api/v1/scheduler
I0727 09:29:21.408848 1298 process.cpp:3837] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0727 09:29:21.410835 1293 http.cpp:1133] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:42274
I0727 09:29:21.411315 1293 master.cpp:2545] Received subscription request for HTTP framework 'default'
I0727 09:29:21.411572 1293 master.cpp:2228] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0727 09:29:21.412294 1296 master.cpp:2681] Subscribing framework 'default' with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
I0727 09:29:21.412622 1299 slave.cpp:1033] Authenticating with master master@172.17.0.3:41825
I0727 09:29:21.412931 1299 slave.cpp:1044] Using default CRAM-MD5 authenticatee
I0727 09:29:21.413228 1298 hierarchical.cpp:303] Added framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000
I0727 09:29:21.413307 1295 authenticatee.cpp:121] Creating new client SASL connection
I0727 09:29:21.413540 1298 hierarchical.cpp:1925] No allocations performed
I0727 09:29:21.413601 1298 hierarchical.cpp:2015] No inverse offers to send out!
I0727 09:29:21.413615 1296 master.cpp:7793] Authenticating slave(722)@172.17.0.3:41825
I0727 09:29:21.413710 1299 master.hpp:2215] Sending heartbeat to d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000
I0727 09:29:21.413728 1298 hierarchical.cpp:1468] Performed allocation for 0 agents in 289819ns
I0727 09:29:21.413825 1296 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1350)@172.17.0.3:41825
I0727 09:29:21.414521 1296 authenticator.cpp:98] Creating new server SASL connection
I0727 09:29:21.414953 1293 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0727 09:29:21.414981 1293 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0727 09:29:21.415163 1293 authenticator.cpp:204] Received SASL authentication start
I0727 09:29:21.415282 1293 authenticator.cpp:326] Authentication requires more steps
I0727 09:29:21.415474 1293 authenticatee.cpp:259] Received SASL authentication step
I0727 09:29:21.415693 1293 authenticator.cpp:232] Received SASL authentication step
I0727 09:29:21.415875 1293 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'bbbdf99144fe' server FQDN: 'bbbdf99144fe' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0727 09:29:21.415895 1293 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0727 09:29:21.416082 1293 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0727 09:29:21.416117 1293 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'bbbdf99144fe' server FQDN: 'bbbdf99144fe' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0727 09:29:21.416409 1293 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0727 09:29:21.416424 1293 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0727 09:29:21.416440 1293 authenticator.cpp:318] Authentication success
I0727 09:29:21.416568 1300 authenticatee.cpp:299] Authentication success
I0727 09:29:21.416829 1300 slave.cpp:1128] Successfully authenticated with master master@172.17.0.3:41825
I0727 09:29:21.417307 1300 slave.cpp:1572] Will retry registration in 2.498959ms if necessary
I0727 09:29:21.417323 1298 master.cpp:7823] Successfully authenticated principal 'test-principal' at slave(722)@172.17.0.3:41825
I0727 09:29:21.417398 1299 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1350)@172.17.0.3:41825
I0727 09:29:21.417776 1298 master.cpp:5677] Received register agent message from slave(722)@172.17.0.3:41825 (bbbdf99144fe)
I0727 09:29:21.418007 1298 master.cpp:3773] Authorizing agent with principal 'test-principal'
I0727 09:29:21.418463 1300 master.cpp:5737] Authorized registration of agent at slave(722)@172.17.0.3:41825 (bbbdf99144fe)
I0727 09:29:21.418658 1300 master.cpp:5830] Registering agent at slave(722)@172.17.0.3:41825 (bbbdf99144fe) with id d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-S0
I0727 09:29:21.418865 1297 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from http://172.17.0.3:41825/master/api/v1/scheduler
I0727 09:29:21.419246 1300 registrar.cpp:493] Applied 1 operations in 53832ns; attempting to update the registry
I0727 09:29:21.419828 1300 registrar.cpp:550] Successfully updated the registry in 524032ns
I0727 09:29:21.420068 1298 master.cpp:5877] Admitted agent d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-S0 at slave(722)@172.17.0.3:41825 (bbbdf99144fe)
I0727 09:29:21.420773 1298 master.cpp:5908] Registered agent d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-S0 at slave(722)@172.17.0.3:41825 (bbbdf99144fe) 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"}]
I0727 09:29:21.421090 1294 scheduler.cpp:676] Enqueuing event HEARTBEAT received from http://172.17.0.3:41825/master/api/v1/scheduler
I0727 09:29:21.421097 1297 slave.cpp:1572] Will retry registration in 31.716203ms if necessary
I0727 09:29:21.421267 1298 master.cpp:5677] Received register agent message from slave(722)@172.17.0.3:41825 (bbbdf99144fe)
I0727 09:29:21.421448 1298 master.cpp:3773] Authorizing agent with principal 'test-principal'
I0727 09:29:21.421566 1295 hierarchical.cpp:593] Added agent d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-S0 (bbbdf99144fe) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0727 09:29:21.422242 1297 slave.cpp:4883] Received ping from slave-observer(656)@172.17.0.3:41825
I0727 09:29:21.422610 1297 slave.cpp:1174] Registered with master master@172.17.0.3:41825; given agent ID d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-S0
I0727 09:29:21.422942 1299 status_update_manager.cpp:184] Resuming sending status updates
I0727 09:29:21.423020 1299 master.cpp:5737] Authorized registration of agent at slave(722)@172.17.0.3:41825 (bbbdf99144fe)
I0727 09:29:21.423308 1299 master.cpp:5808] Agent d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-S0 at slave(722)@172.17.0.3:41825 (bbbdf99144fe) already registered, resending acknowledgement
I0727 09:29:21.423353 1297 slave.cpp:1194] Checkpointing SlaveInfo to '/tmp/ContentType_SchedulerTest_TaskRunning_1_iCXlHP/meta/slaves/d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-S0/slave.info'
I0727 09:29:21.423961 1297 slave.cpp:1232] Forwarding total oversubscribed resources {}
I0727 09:29:21.424002 1295 hierarchical.cpp:2015] No inverse offers to send out!
I0727 09:29:21.424052 1295 hierarchical.cpp:1468] Performed allocation for 1 agents in 1.551796ms
W0727 09:29:21.424377 1297 slave.cpp:1218] Already registered with master master@172.17.0.3:41825
I0727 09:29:21.424399 1297 slave.cpp:1232] Forwarding total oversubscribed resources {}
I0727 09:29:21.424981 1298 master.cpp:7623] Sending 1 offers to framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000 (default)
I0727 09:29:21.426281 1298 master.cpp:6644] Received update of agent d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-S0 at slave(722)@172.17.0.3:41825 (bbbdf99144fe) with total oversubscribed resources {}
I0727 09:29:21.426933 1298 master.cpp:6644] Received update of agent d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-S0 at slave(722)@172.17.0.3:41825 (bbbdf99144fe) with total oversubscribed resources {}
I0727 09:29:21.427124 1299 hierarchical.cpp:660] Agent d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-S0 (bbbdf99144fe) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0727 09:29:21.427884 1299 hierarchical.cpp:660] Agent d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-S0 (bbbdf99144fe) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0727 09:29:21.429011 1293 scheduler.cpp:676] Enqueuing event OFFERS received from http://172.17.0.3:41825/master/api/v1/scheduler
I0727 09:29:21.431905 1300 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.3:41825/master/api/v1/scheduler
I0727 09:29:21.434758 1299 process.cpp:3837] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0727 09:29:21.436444 1297 http.cpp:1133] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:42272
I0727 09:29:21.438827 1297 master.cpp:4123] Processing ACCEPT call for offers: [ d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-O0 ] on agent d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-S0 at slave(722)@172.17.0.3:41825 (bbbdf99144fe) for framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000 (default)
I0727 09:29:21.439091 1297 master.cpp:3500] Authorizing framework principal 'test-principal' to launch task 1
W0727 09:29:21.441532 1297 validation.cpp:1294] Executor 'default' for task '1' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0727 09:29:21.441570 1297 validation.cpp:1306] Executor 'default' for task '1' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0727 09:29:21.442389 1297 master.cpp:9674] Adding task 1 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 d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-S0 at slave(722)@172.17.0.3:41825 (bbbdf99144fe)
I0727 09:29:21.443152 1297 master.cpp:4786] Launching task 1 of framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000 (default) with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] on agent d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-S0 at slave(722)@172.17.0.3:41825 (bbbdf99144fe)
I0727 09:29:21.443845 1295 slave.cpp:1697] Got assigned task '1' for framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000
I0727 09:29:21.444555 1295 slave.cpp:1978] Authorizing task '1' for framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000
I0727 09:29:21.444612 1295 slave.cpp:6706] Authorizing framework principal 'test-principal' to launch task 1
I0727 09:29:21.445726 1297 hierarchical.cpp:887] Updated allocation of framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000 on agent d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-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]
I0727 09:29:21.446743 1294 slave.cpp:2165] Launching task '1' for framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000
I0727 09:29:21.447559 1294 paths.cpp:578] Trying to chown '/tmp/ContentType_SchedulerTest_TaskRunning_1_iCXlHP/slaves/d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-S0/frameworks/d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000/executors/default/runs/6291acb2-b3ee-44da-992e-01f2d88d9b99' to user 'mesos'
I0727 09:29:21.447854 1294 slave.cpp:7162] Launching executor 'default' of framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000 with resources [] in work directory '/tmp/ContentType_SchedulerTest_TaskRunning_1_iCXlHP/slaves/d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-S0/frameworks/d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000/executors/default/runs/6291acb2-b3ee-44da-992e-01f2d88d9b99'
I0727 09:29:21.449079 1294 slave.cpp:2394] Queued task '1' for executor 'default' of framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000
I0727 09:29:21.449163 1294 slave.cpp:924] Successfully attached file '/tmp/ContentType_SchedulerTest_TaskRunning_1_iCXlHP/slaves/d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-S0/frameworks/d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000/executors/default/runs/6291acb2-b3ee-44da-992e-01f2d88d9b99'
I0727 09:29:21.449199 1294 slave.cpp:924] Successfully attached file '/tmp/ContentType_SchedulerTest_TaskRunning_1_iCXlHP/slaves/d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-S0/frameworks/d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000/executors/default/runs/6291acb2-b3ee-44da-992e-01f2d88d9b99'
I0727 09:29:21.449519 1294 slave.cpp:2852] Launching container 6291acb2-b3ee-44da-992e-01f2d88d9b99 for executor 'default' of framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000
I0727 09:29:21.452064 1295 executor.cpp:192] Version: 1.4.0
I0727 09:29:21.454505 1293 executor.cpp:410] Connected with the agent
I0727 09:29:21.455292 1299 executor.cpp:307] Sending SUBSCRIBE call to http://172.17.0.3:41825/slave(722)/api/v1/executor
I0727 09:29:21.456462 1297 process.cpp:3837] Handling HTTP event for process 'slave(722)' with path: '/slave(722)/api/v1/executor'
I0727 09:29:21.459713 1298 http.cpp:1133] HTTP POST for /slave(722)/api/v1/executor from 172.17.0.3:42276
I0727 09:29:21.459961 1298 slave.cpp:3669] Received Subscribe request for HTTP executor 'default' of framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000
I0727 09:29:21.461315 1298 slave.cpp:2599] Sending queued task '1' to executor 'default' of framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000 (via HTTP)
I0727 09:29:21.463925 1298 executor.cpp:725] Enqueuing event SUBSCRIBED received from http://172.17.0.3:41825/slave(722)/api/v1/executor
I0727 09:29:21.465368 1295 executor.cpp:725] Enqueuing event LAUNCH received from http://172.17.0.3:41825/slave(722)/api/v1/executor
I0727 09:29:21.466742 1296 executor.cpp:307] Sending UPDATE call to http://172.17.0.3:41825/slave(722)/api/v1/executor
I0727 09:29:21.468890 1300 process.cpp:3837] Handling HTTP event for process 'slave(722)' with path: '/slave(722)/api/v1/executor'
I0727 09:29:21.473136 1300 http.cpp:1133] HTTP POST for /slave(722)/api/v1/executor from 172.17.0.3:42278
I0727 09:29:21.473608 1300 slave.cpp:4341] Handling status update TASK_RUNNING (UUID: 669a1e10-c16e-453f-8c09-9ee464970743) for task 1 of framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000
I0727 09:29:21.474570 1298 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 669a1e10-c16e-453f-8c09-9ee464970743) for task 1 of framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000
I0727 09:29:21.474692 1298 status_update_manager.cpp:500] Creating StatusUpdate stream for task 1 of framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000
I0727 09:29:21.475401 1298 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 669a1e10-c16e-453f-8c09-9ee464970743) for task 1 of framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000 to the agent
I0727 09:29:21.475703 1296 slave.cpp:4793] Forwarding the update TASK_RUNNING (UUID: 669a1e10-c16e-453f-8c09-9ee464970743) for task 1 of framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000 to master@172.17.0.3:41825
I0727 09:29:21.475924 1296 slave.cpp:4687] Status update manager successfully handled status update TASK_RUNNING (UUID: 669a1e10-c16e-453f-8c09-9ee464970743) for task 1 of framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000
I0727 09:29:21.476472 1297 master.cpp:6802] Status update TASK_RUNNING (UUID: 669a1e10-c16e-453f-8c09-9ee464970743) for task 1 of framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000 from agent d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-S0 at slave(722)@172.17.0.3:41825 (bbbdf99144fe)
I0727 09:29:21.476601 1297 master.cpp:6864] Forwarding status update TASK_RUNNING (UUID: 669a1e10-c16e-453f-8c09-9ee464970743) for task 1 of framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000
I0727 09:29:21.477186 1299 executor.cpp:725] Enqueuing event ACKNOWLEDGED received from http://172.17.0.3:41825/slave(722)/api/v1/executor
I0727 09:29:21.478164 1297 master.cpp:8884] Updating the state of task 1 of framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0727 09:29:21.479540 1298 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.3:41825/master/api/v1/scheduler
I0727 09:29:21.487155 1293 master.cpp:1432] Framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000 (default) disconnected
I0727 09:29:21.487179 1293 master.cpp:3234] Deactivating framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000 (default)
I0727 09:29:21.487509 1299 hierarchical.cpp:412] Deactivated framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000
I0727 09:29:21.487360 1293 master.cpp:3211] Disconnecting framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000 (default)
I0727 09:29:21.487820 1293 master.cpp:1447] Giving framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000 (default) 0ns to failover
I0727 09:29:21.488788 1293 master.cpp:7455] Framework failover timeout, removing framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000 (default)
I0727 09:29:21.488816 1293 master.cpp:8316] Removing framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000 (default)
I0727 09:29:21.489255 1293 master.cpp:8884] Updating the state of task 1 of framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0727 09:29:21.489368 1298 slave.cpp:3155] Asked to shut down framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000 by master@172.17.0.3:41825
I0727 09:29:21.489436 1298 slave.cpp:3180] Shutting down framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000
I0727 09:29:21.489629 1298 slave.cpp:5648] Shutting down executor 'default' of framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000 (via HTTP)
I0727 09:29:21.490962 1293 master.cpp:8978] Removing task 1 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 d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000 on agent d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-S0 at slave(722)@172.17.0.3:41825 (bbbdf99144fe)
I0727 09:29:21.491629 1293 master.cpp:9007] Removing executor 'default' with resources [] of framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000 on agent d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-S0 at slave(722)@172.17.0.3:41825 (bbbdf99144fe)
I0727 09:29:21.492384 1294 hierarchical.cpp:1152] Recovered cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: {}) on agent d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-S0 from framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000
I0727 09:29:21.493149 1294 hierarchical.cpp:355] Removed framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000
I0727 09:29:21.494516 1299 executor.cpp:725] Enqueuing event SHUTDOWN received from http://172.17.0.3:41825/slave(722)/api/v1/executor
I0727 09:29:21.495409 1296 slave.cpp:5326] Executor 'default' of framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000 exited with status 0
I0727 09:29:21.495506 1296 slave.cpp:5426] Cleaning up executor 'default' of framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000 (via HTTP)
I*** Aborted at 1501147761 (unix time) try "date -d @1501147761" if you are using GNU date ***
0727 09:29:21.495956 1294 gc.cpp:59] Scheduling '/tmp/ContentType_SchedulerTest_TaskRunning_1_iCXlHP/slaves/d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-S0/frameworks/d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000/executors/default/runs/6291acb2-b3ee-44da-992e-01f2d88d9b99' for gc 6.99999426283556days in the future
I0727 09:29:21.496016 1296 slave.cpp:5522] Cleaning up framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000
W0727 09:29:21.496157 1293 master.cpp:6919] Ignoring unknown exited executor 'default' of framework d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-0000 on agent d2dfe6ba-76f4-4ace-b8fe-54d8b691fe8c-S0 at slave(722)@172.17.0.3:41825 (bbbdf99144fe)
PC: @ 0x3b25225 testing::internal::UntypedFunctionMockerBase::SetOwnerAndName()
*** SIGSEGV (@0x0) received by PID 1292 (TID 0x2b9006bc9700) from PID 0; stack trace: ***
@ 0x2b8ffd01a330 (unknown)
@ 0x3b25225 testing::internal::UntypedFunctionMockerBase::SetOwnerAndName()
@ 0x2660219 mesos::internal::tests::executor::MockHTTPExecutor<>::shutdown()
@ 0x26554b7 mesos::internal::tests::executor::MockHTTPExecutor<>::event()
@ 0x264a2d4 mesos::internal::tests::executor::TestMesos<>::events()
@ 0x267b4a5 std::_Mem_fn<>::operator()<>()
@ 0x266d2b1 _ZNSt5_BindIFSt7_Mem_fnIMN5mesos8internal5tests8executor9TestMesosINS1_2v18executor5MesosENS7_5EventEEEFvSt5queueIS9_St5dequeIS9_SaIS9_EEEEEPSA_St12_PlaceholderILi1EEEE6__callIvIRKSF_EILm0ELm1EEEET_OSt5tupleIIDpT0_EESt12_Index_tupleIIXspT1_EEE
@ 0x2660617 _ZNSt5_BindIFSt7_Mem_fnIMN5mesos8internal5tests8executor9TestMesosINS1_2v18executor5MesosENS7_5EventEEEFvSt5queueIS9_St5dequeIS9_SaIS9_EEEEEPSA_St12_PlaceholderILi1EEEEclIJRKSF_EvEET0_DpOT_
@ 0x265587d std::_Function_handler<>::_M_invoke()
@ 0x2b8ff8383c7b std::function<>::operator()()
@ 0x2b8ff837dcd1 process::AsyncExecutorProcess::execute<>()
@ 0x2b8ff837de17 _ZZN7process8dispatchI7NothingNS_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v18executor5EventESt5dequeIS8_SaIS8_EEEEESC_SG_SC_EENS_6FutureIT_EERKNS_3PIDIT0_EEMSN_FSK_T1_T2_ET3_T4_ENKUlPNS_11ProcessBaseEE_clESY_
@ 0x2b8ff8389bba _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8dispatchI7NothingNS0_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v18executor5EventESt5dequeISC_SaISC_EEEEESG_SK_SG_EENS0_6FutureIT_EERKNS0_3PIDIT0_EEMSR_FSO_T1_T2_ET3_T4_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_
@ 0x2b8ffa9b8dbf std::function<>::operator()()
@ 0x2b8ffa994d71 process::ProcessBase::visit()
@ 0x2b8ffa9a1c18 process::DispatchEvent::visit()
@ 0x25d26ec process::ProcessBase::serve()
@ 0x2b8ffa9912ad process::ProcessManager::resume()
@ 0x2b8ffa98d53a _ZZN7process14ProcessManager12init_threadsEvENKUlvE_clEv
@ 0x2b8ffa99ff34 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
@ 0x2b8ffa99fe8b _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEclEv
@ 0x2b8ffa99fe24 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEE6_M_runEv
@ 0x2b8ffd2d9a60 (unknown)
@ 0x2b8ffd012184 start_thread
@ 0x2b8ffdb45ffd (unknown)
make[3]: *** [CMakeFiles/check] Segmentation fault (core dumped)
make[3]: Leaving directory `/mesos/build'
make[2]: *** [CMakeFiles/check.dir/all] Error 2
make[2]: Leaving directory `/mesos/build'
make[1]: *** [CMakeFiles/check.dir/rule] Error 2
make[1]: Leaving directory `/mesos/build'
make: *** [check] Error 2
+ docker rmi mesos-1501143275-5834
Untagged: mesos-1501143275-5834:latest
Deleted: sha256:b32d21360d688c88664084e855dfe86fe0fa0d9367eef684d0861aaaf3d9f129
Deleted: sha256:b7d1154c210979046ffffce9fe72fd0d5404098410aacde4e6731aa9fc0caaf5
Deleted: sha256:dc08792a7be8594f8e55265b96fd942370d096bab154eaa5c36c5f0112c4e9e4
Deleted: sha256:8f970a38b2bf12d1cd5a964bfa9d7ec5cbf352790ef6b6052fae3f0981624d74
Deleted: sha256:5a2f3f8dfae8a437ac3630f513774cacf7e323a8caa6c87e0c4332207d3c31b9
Deleted: sha256:e66e729075d7d6a82206c14dd7a6282835130aed88ff3d9aa4fe0d9299e8b62a
Deleted: sha256:ab322db84118fd0dd730fd7a37c4c8c903f50c1383b36757e27ef8034a30ecc0
Deleted: sha256:fb7ba17410d589759467a19a91ace9b57fad3ed552353b3d789aee9f3cc4f8b7
Deleted: sha256:db0c6c038761d490d2d5e75d50cf08e90eb7ddb77a424d9f9ba920f04a05ff66
Deleted: sha256:f34969cbb01e22dbf064af7934b7d5c376f088d473208d972cada1aea7b26048
Deleted: sha256:b09b4489ea95349950d337756f9143f1c791531592bdf241077d42d9e29f9a06
Deleted: sha256:932625b27110c63156a8f725af2bb3dfd187a3fb4c73ac4a621d252bf815ad62
Deleted: sha256:2bb35a278c1700e8578835e04c3ddc0ac8cc20d0e32e41c44b08b8c02ea95965
Deleted: sha256:4176cbbb4c59b34ad62fe92c4495332d4e629cfbc9a1083cab74a8522461a70f
Deleted: sha256:06c5ac0d1f012481119fb2696df0f7ab469f12f91c40cd4cfbc8fff0f8024040
Deleted: sha256:8933b76bbc66d2d157107889ec1f1c983205c043e53160037364761ec592fb39
Deleted: sha256:6c8660ca8af58eea8f3080a5eea28ec4dcf602c33948787672c259ae3e079bd8
Deleted: sha256:8351dcace816ce492d92b4988e488e0e33627e4713d634ac2f4241d3628ef586
Deleted: sha256:c1d9b586a475b7d3209e68664da9e11543d71a4016f88c4399bdac53e4980f30
Deleted: sha256:6b51ea7ba8764412f02a3383b0a4138bf163f59726aafc10915288c4ed45b13d
Deleted: sha256:ff9a46dd9d5cf5e566fe22f3c5e74534f3bbd68a0d0607eb2ee3a79ec97e318b
Deleted: sha256:298daef1ca025f5f6e2ef7be7ab2cf3bef4d4700e1e857601d4b578635ebd19e
Deleted: sha256:cc04a4c0e6718a90c0a3a3feb977aa3be7b707aead499be2889bbd97bca9a463
Deleted: sha256:1f7c64a59bbd4266b1bb15164f60986f1e3a4775da81e512894e8249e339f38d
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user zhq527725@gmail.com
Jenkins build is back to normal : Mesos-Buildbot » cmake,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3964
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3964/display/redirect?page=changes>