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/09/01 16:21:33 UTC

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

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

Changes:

[songzihao1990] Added unit test for killing the default executor process.

[alexr] Ensured JAVA HTTP adapter propagates a subscription error.

[alexr] Extracted JNI code into a protected function for clarity.

[alexr] Added several logs to the C++ part of the v1-v0 adapter.

[alexr] Added MESOS-7872 to 1.4.1 CHANGELOG.

[alexr] Added MESOS-7872 to 1.3.2 CHANGELOG.

[alexr] Added MESOS-7872 to 1.2.3 CHANGELOG.

------------------------------------------
[...truncated 7.76 MB...]
I0901 16:21:18.236912 32651 slave.cpp:581] 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"}]
I0901 16:21:18.237107 32651 slave.cpp:589] Agent attributes: [  ]
I0901 16:21:18.237144 32651 slave.cpp:598] Agent hostname: ede302bdbd2c
I0901 16:21:18.237320 32647 status_update_manager.cpp:177] Pausing sending status updates
I0901 16:21:18.238750 32663 state.cpp:64] Recovering state from '/tmp/SlaveTest_ContainersEndpointNoExecutor_4Z97Uj/meta'
I0901 16:21:18.238793 32651 process.cpp:3956] Handling HTTP event for process 'slave(167)' with path: '/slave(167)/containers'
I0901 16:21:18.239384 32653 status_update_manager.cpp:203] Recovering status update manager
I0901 16:21:18.239651 32654 containerizer.cpp:646] Recovering containerizer
I0901 16:21:18.240159 32664 http.cpp:1185] HTTP GET for /slave(167)/containers from 172.17.0.11:50060
I0901 16:21:18.240428 32664 http.cpp:976] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0901 16:21:18.241288 32655 provisioner.cpp:416] Provisioner recovery complete
I0901 16:21:18.242692 32653 slave.cpp:6296] Finished recovery
I0901 16:21:18.243154 32653 slave.cpp:6478] Querying resource estimator for oversubscribable resources
I0901 16:21:18.243449 32661 status_update_manager.cpp:177] Pausing sending status updates
I0901 16:21:18.243471 32646 slave.cpp:987] New master detected at master@172.17.0.11:36525
I0901 16:21:18.243573 32646 slave.cpp:1022] Detecting new master
I0901 16:21:18.243690 32646 slave.cpp:6492] Received oversubscribable resources {} from the resource estimator
I0901 16:21:18.244837 32659 slave.cpp:859] Agent terminating
I0901 16:21:18.250949 32642 master.cpp:1163] Master terminating
[       OK ] SlaveTest.ContainersEndpointNoExecutor (44 ms)
[ RUN      ] SlaveTest.ContainersEndpoint
I0901 16:21:18.256873 32642 cluster.cpp:162] Creating default 'local' authorizer
I0901 16:21:18.259739 32648 master.cpp:445] Master eabb8a7c-fe8f-4751-a53e-76ec29161e53 (ede302bdbd2c) started on 172.17.0.11:36525
I0901 16:21:18.259760 32648 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/kNjyL2/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/kNjyL2/master" --zk_session_timeout="10secs"
I0901 16:21:18.260026 32648 master.cpp:497] Master only allowing authenticated frameworks to register
I0901 16:21:18.260035 32648 master.cpp:511] Master only allowing authenticated agents to register
I0901 16:21:18.260042 32648 master.cpp:524] Master only allowing authenticated HTTP frameworks to register
I0901 16:21:18.260053 32648 credentials.hpp:37] Loading credentials for authentication from '/tmp/kNjyL2/credentials'
I0901 16:21:18.260293 32648 master.cpp:569] Using default 'crammd5' authenticator
I0901 16:21:18.260437 32648 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0901 16:21:18.260577 32648 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0901 16:21:18.260715 32648 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0901 16:21:18.260828 32648 master.cpp:649] Authorization enabled
I0901 16:21:18.260960 32666 hierarchical.cpp:171] Initialized hierarchical allocator process
I0901 16:21:18.261015 32650 whitelist_watcher.cpp:77] No whitelist given
I0901 16:21:18.263550 32662 master.cpp:2166] Elected as the leading master!
I0901 16:21:18.263577 32662 master.cpp:1705] Recovering from registrar
I0901 16:21:18.263705 32656 registrar.cpp:347] Recovering registrar
I0901 16:21:18.264230 32656 registrar.cpp:391] Successfully fetched the registry (0B) in 492032ns
I0901 16:21:18.264331 32656 registrar.cpp:495] Applied 1 operations in 26960ns; attempting to update the registry
I0901 16:21:18.264885 32656 registrar.cpp:552] Successfully updated the registry in 504064ns
I0901 16:21:18.264991 32656 registrar.cpp:424] Successfully recovered registrar
I0901 16:21:18.265344 32664 master.cpp:1804] Recovered 0 agents from the registry (132B); allowing 10mins for agents to re-register
I0901 16:21:18.265373 32649 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
W0901 16:21:18.269737 32642 process.cpp:3240] Attempted to spawn already running process files@172.17.0.11:36525
I0901 16:21:18.270001 32642 cluster.cpp:448] Creating default 'local' authorizer
I0901 16:21:18.271976 32645 slave.cpp:252] Mesos agent started on (168)@172.17.0.11:36525
W0901 16:21:18.272281 32642 process.cpp:3240] Attempted to spawn already running process version@172.17.0.11:36525
I0901 16:21:18.272020 32645 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/SlaveTest_ContainersEndpoint_wtMJ7b/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/SlaveTest_ContainersEndpoint_wtMJ7b/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/SlaveTest_ContainersEndpoint_wtMJ7b/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/SlaveTest_ContainersEndpoint_wtMJ7b/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/SlaveTest_ContainersEndpoint_wtMJ7b/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/SlaveTest_ContainersEndpoint_wtMJ7b" --sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true" --systemd_enable_support="true" --systemd_runtime_directory="/run/systemd/system" --version="false" --work_dir="/tmp/SlaveTest_ContainersEndpoint_4fzDrC" --zk_session_timeout="10secs"
I0901 16:21:18.272784 32645 credentials.hpp:86] Loading credential for authentication from '/tmp/SlaveTest_ContainersEndpoint_wtMJ7b/credential'
I0901 16:21:18.273092 32645 slave.cpp:285] Agent using credential for: test-principal
I0901 16:21:18.273147 32645 credentials.hpp:37] Loading credentials for authentication from '/tmp/SlaveTest_ContainersEndpoint_wtMJ7b/http_credentials'
I0901 16:21:18.273231 32642 sched.cpp:232] Version: 1.5.0
I0901 16:21:18.273506 32645 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0901 16:21:18.273736 32666 sched.cpp:336] New master detected at master@172.17.0.11:36525
I0901 16:21:18.273828 32645 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0901 16:21:18.273838 32666 sched.cpp:407] Authenticating with master master@172.17.0.11:36525
I0901 16:21:18.273851 32666 sched.cpp:414] Using default CRAM-MD5 authenticatee
I0901 16:21:18.274138 32644 authenticatee.cpp:121] Creating new client SASL connection
I0901 16:21:18.274510 32651 master.cpp:7834] Authenticating scheduler-4fa2f792-6bff-4224-ad38-1671d1fb496e@172.17.0.11:36525
I0901 16:21:18.274613 32661 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(352)@172.17.0.11:36525
I0901 16:21:18.274852 32659 authenticator.cpp:98] Creating new server SASL connection
I0901 16:21:18.275048 32660 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0901 16:21:18.275077 32660 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0901 16:21:18.275166 32647 authenticator.cpp:204] Received SASL authentication start
I0901 16:21:18.275221 32647 authenticator.cpp:326] Authentication requires more steps
I0901 16:21:18.275346 32653 authenticatee.cpp:259] Received SASL authentication step
I0901 16:21:18.275487 32658 authenticator.cpp:232] Received SASL authentication step
I0901 16:21:18.275523 32658 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'ede302bdbd2c' server FQDN: 'ede302bdbd2c' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0901 16:21:18.275544 32658 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0901 16:21:18.275588 32658 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0901 16:21:18.275611 32658 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'ede302bdbd2c' server FQDN: 'ede302bdbd2c' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0901 16:21:18.275626 32658 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0901 16:21:18.275640 32658 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0901 16:21:18.275672 32658 authenticator.cpp:318] Authentication success
I0901 16:21:18.275774 32652 authenticatee.cpp:299] Authentication success
I0901 16:21:18.275840 32656 master.cpp:7864] Successfully authenticated principal 'test-principal' at scheduler-4fa2f792-6bff-4224-ad38-1671d1fb496e@172.17.0.11:36525
I0901 16:21:18.275890 32652 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(352)@172.17.0.11:36525
I0901 16:21:18.276031 32643 sched.cpp:513] Successfully authenticated with master master@172.17.0.11:36525
I0901 16:21:18.276049 32643 sched.cpp:836] Sending SUBSCRIBE call to master@172.17.0.11:36525
I0901 16:21:18.276167 32643 sched.cpp:869] Will retry registration in 699.125492ms if necessary
I0901 16:21:18.276518 32649 master.cpp:2897] Received SUBSCRIBE call for framework 'default' at scheduler-4fa2f792-6bff-4224-ad38-1671d1fb496e@172.17.0.11:36525
I0901 16:21:18.276229 32645 slave.cpp:581] 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"}]
I0901 16:21:18.276623 32645 slave.cpp:589] Agent attributes: [  ]
I0901 16:21:18.276635 32645 slave.cpp:598] Agent hostname: ede302bdbd2c
I0901 16:21:18.276666 32649 master.cpp:2231] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0901 16:21:18.276799 32648 status_update_manager.cpp:177] Pausing sending status updates
I0901 16:21:18.277199 32646 master.cpp:2977] Subscribing framework default with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
I0901 16:21:18.278187 32644 sched.cpp:759] Framework registered with eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000
I0901 16:21:18.278257 32644 sched.cpp:773] Scheduler::registered took 37295ns
I0901 16:21:18.278437 32657 hierarchical.cpp:303] Added framework eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000
I0901 16:21:18.278684 32657 hierarchical.cpp:1943] No allocations performed
I0901 16:21:18.278754 32657 hierarchical.cpp:2033] No inverse offers to send out!
I0901 16:21:18.278785 32657 hierarchical.cpp:1486] Performed allocation for 0 agents in 158687ns
I0901 16:21:18.279033 32647 state.cpp:64] Recovering state from '/tmp/SlaveTest_ContainersEndpoint_4fzDrC/meta'
I0901 16:21:18.279320 32647 status_update_manager.cpp:203] Recovering status update manager
I0901 16:21:18.279608 32664 slave.cpp:6296] Finished recovery
I0901 16:21:18.280006 32664 slave.cpp:6478] Querying resource estimator for oversubscribable resources
I0901 16:21:18.280212 32648 status_update_manager.cpp:177] Pausing sending status updates
I0901 16:21:18.280253 32643 slave.cpp:987] New master detected at master@172.17.0.11:36525
I0901 16:21:18.280335 32643 slave.cpp:1022] Detecting new master
I0901 16:21:18.280439 32643 slave.cpp:6492] Received oversubscribable resources {} from the resource estimator
I0901 16:21:18.287691 32666 slave.cpp:1049] Authenticating with master master@172.17.0.11:36525
I0901 16:21:18.287775 32666 slave.cpp:1060] Using default CRAM-MD5 authenticatee
I0901 16:21:18.288132 32655 authenticatee.cpp:121] Creating new client SASL connection
I0901 16:21:18.288601 32646 master.cpp:7834] Authenticating slave(168)@172.17.0.11:36525
I0901 16:21:18.288823 32662 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(353)@172.17.0.11:36525
I0901 16:21:18.289084 32644 authenticator.cpp:98] Creating new server SASL connection
I0901 16:21:18.289348 32661 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0901 16:21:18.289396 32661 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0901 16:21:18.289541 32661 authenticator.cpp:204] Received SASL authentication start
I0901 16:21:18.289623 32661 authenticator.cpp:326] Authentication requires more steps
I0901 16:21:18.289749 32659 authenticatee.cpp:259] Received SASL authentication step
I0901 16:21:18.289911 32660 authenticator.cpp:232] Received SASL authentication step
I0901 16:21:18.289945 32660 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'ede302bdbd2c' server FQDN: 'ede302bdbd2c' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0901 16:21:18.289958 32660 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0901 16:21:18.289996 32660 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0901 16:21:18.290024 32660 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'ede302bdbd2c' server FQDN: 'ede302bdbd2c' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0901 16:21:18.290035 32660 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0901 16:21:18.290040 32660 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0901 16:21:18.290055 32660 authenticator.cpp:318] Authentication success
I0901 16:21:18.290143 32651 authenticatee.cpp:299] Authentication success
I0901 16:21:18.290216 32645 master.cpp:7864] Successfully authenticated principal 'test-principal' at slave(168)@172.17.0.11:36525
I0901 16:21:18.290294 32663 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(353)@172.17.0.11:36525
I0901 16:21:18.290599 32651 slave.cpp:1144] Successfully authenticated with master master@172.17.0.11:36525
I0901 16:21:18.290937 32651 slave.cpp:1623] Will retry registration in 1.543494ms if necessary
I0901 16:21:18.291157 32654 master.cpp:5717] Received register agent message from slave(168)@172.17.0.11:36525 (ede302bdbd2c)
I0901 16:21:18.291327 32654 master.cpp:3806] Authorizing agent with principal 'test-principal'
I0901 16:21:18.291798 32652 master.cpp:5777] Authorized registration of agent at slave(168)@172.17.0.11:36525 (ede302bdbd2c)
I0901 16:21:18.291899 32652 master.cpp:5870] Registering agent at slave(168)@172.17.0.11:36525 (ede302bdbd2c) with id eabb8a7c-fe8f-4751-a53e-76ec29161e53-S0
I0901 16:21:18.292297 32665 registrar.cpp:495] Applied 1 operations in 48867ns; attempting to update the registry
I0901 16:21:18.292822 32665 registrar.cpp:552] Successfully updated the registry in 474112ns
I0901 16:21:18.293021 32662 master.cpp:5917] Admitted agent eabb8a7c-fe8f-4751-a53e-76ec29161e53-S0 at slave(168)@172.17.0.11:36525 (ede302bdbd2c)
I0901 16:21:18.293735 32657 slave.cpp:1623] Will retry registration in 39.005473ms if necessary
I0901 16:21:18.293643 32662 master.cpp:5948] Registered agent eabb8a7c-fe8f-4751-a53e-76ec29161e53-S0 at slave(168)@172.17.0.11:36525 (ede302bdbd2c) 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"}]
I0901 16:21:18.293851 32657 slave.cpp:4963] Received ping from slave-observer(162)@172.17.0.11:36525
I0901 16:21:18.293994 32657 slave.cpp:1190] Registered with master master@172.17.0.11:36525; given agent ID eabb8a7c-fe8f-4751-a53e-76ec29161e53-S0
I0901 16:21:18.294013 32662 master.cpp:5717] Received register agent message from slave(168)@172.17.0.11:36525 (ede302bdbd2c)
I0901 16:21:18.294054 32661 hierarchical.cpp:593] Added agent eabb8a7c-fe8f-4751-a53e-76ec29161e53-S0 (ede302bdbd2c) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0901 16:21:18.294108 32662 master.cpp:3806] Authorizing agent with principal 'test-principal'
I0901 16:21:18.294113 32660 status_update_manager.cpp:184] Resuming sending status updates
I0901 16:21:18.294354 32657 slave.cpp:1210] Checkpointing SlaveInfo to '/tmp/SlaveTest_ContainersEndpoint_4fzDrC/meta/slaves/eabb8a7c-fe8f-4751-a53e-76ec29161e53-S0/slave.info'
I0901 16:21:18.294486 32645 master.cpp:5777] Authorized registration of agent at slave(168)@172.17.0.11:36525 (ede302bdbd2c)
I0901 16:21:18.294560 32645 master.cpp:5848] Agent eabb8a7c-fe8f-4751-a53e-76ec29161e53-S0 at slave(168)@172.17.0.11:36525 (ede302bdbd2c) already registered, resending acknowledgement
I0901 16:21:18.294759 32657 slave.cpp:1259] Forwarding total oversubscribed resources {}
W0901 16:21:18.294900 32657 slave.cpp:1245] Already registered with master master@172.17.0.11:36525
I0901 16:21:18.294946 32657 slave.cpp:1259] Forwarding total oversubscribed resources {}
I0901 16:21:18.295012 32656 master.cpp:6685] Received update of agent eabb8a7c-fe8f-4751-a53e-76ec29161e53-S0 at slave(168)@172.17.0.11:36525 (ede302bdbd2c) with total oversubscribed resources {}
I0901 16:21:18.295274 32661 hierarchical.cpp:2033] No inverse offers to send out!
I0901 16:21:18.295280 32656 master.cpp:6685] Received update of agent eabb8a7c-fe8f-4751-a53e-76ec29161e53-S0 at slave(168)@172.17.0.11:36525 (ede302bdbd2c) with total oversubscribed resources {}
I0901 16:21:18.295325 32661 hierarchical.cpp:1486] Performed allocation for 1 agents in 1.105449ms
I0901 16:21:18.295486 32661 hierarchical.cpp:660] Agent eabb8a7c-fe8f-4751-a53e-76ec29161e53-S0 (ede302bdbd2c) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0901 16:21:18.295648 32661 hierarchical.cpp:660] Agent eabb8a7c-fe8f-4751-a53e-76ec29161e53-S0 (ede302bdbd2c) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0901 16:21:18.296205 32656 master.cpp:7664] Sending 1 offers to framework eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000 (default) at scheduler-4fa2f792-6bff-4224-ad38-1671d1fb496e@172.17.0.11:36525
I0901 16:21:18.297005 32653 sched.cpp:933] Scheduler::resourceOffers took 191923ns
I0901 16:21:18.299433 32643 master.cpp:9162] Removing offer eabb8a7c-fe8f-4751-a53e-76ec29161e53-O0
I0901 16:21:18.299582 32643 master.cpp:4156] Processing ACCEPT call for offers: [ eabb8a7c-fe8f-4751-a53e-76ec29161e53-O0 ] on agent eabb8a7c-fe8f-4751-a53e-76ec29161e53-S0 at slave(168)@172.17.0.11:36525 (ede302bdbd2c) for framework eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000 (default) at scheduler-4fa2f792-6bff-4224-ad38-1671d1fb496e@172.17.0.11:36525
I0901 16:21:18.299670 32643 master.cpp:3533] Authorizing framework principal 'test-principal' to launch task 1
I0901 16:21:18.299868 32643 master.cpp:3533] Authorizing framework principal 'test-principal' to launch task 2
W0901 16:21:18.301467 32665 validation.cpp:1332] Executor 'executor-1' 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.
W0901 16:21:18.301496 32665 validation.cpp:1344] Executor 'executor-1' for task '1' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0901 16:21:18.301846 32665 master.cpp:9908] Adding task 1 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}] on agent eabb8a7c-fe8f-4751-a53e-76ec29161e53-S0 at slave(168)@172.17.0.11:36525 (ede302bdbd2c)
I0901 16:21:18.302148 32665 master.cpp:4819] Launching task 1 of framework eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000 (default) at scheduler-4fa2f792-6bff-4224-ad38-1671d1fb496e@172.17.0.11:36525 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}] on agent eabb8a7c-fe8f-4751-a53e-76ec29161e53-S0 at slave(168)@172.17.0.11:36525 (ede302bdbd2c)
I0901 16:21:18.302608 32660 slave.cpp:1744] Got assigned task '1' for framework eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000
W0901 16:21:18.303059 32665 validation.cpp:1332] Executor 'executor-2' for task '2' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0901 16:21:18.303083 32665 validation.cpp:1344] Executor 'executor-2' for task '2' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0901 16:21:18.303220 32660 slave.cpp:2012] Authorizing task '1' for framework eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000
I0901 16:21:18.303267 32660 slave.cpp:6795] Authorizing framework principal 'test-principal' to launch task 1
I0901 16:21:18.303401 32665 master.cpp:9908] Adding task 2 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}] on agent eabb8a7c-fe8f-4751-a53e-76ec29161e53-S0 at slave(168)@172.17.0.11:36525 (ede302bdbd2c)
I0901 16:21:18.303669 32665 master.cpp:4819] Launching task 2 of framework eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000 (default) at scheduler-4fa2f792-6bff-4224-ad38-1671d1fb496e@172.17.0.11:36525 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}] on agent eabb8a7c-fe8f-4751-a53e-76ec29161e53-S0 at slave(168)@172.17.0.11:36525 (ede302bdbd2c)
I0901 16:21:18.303985 32661 slave.cpp:2180] Launching task '1' for framework eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000
I0901 16:21:18.304600 32661 paths.cpp:578] Trying to chown '/tmp/SlaveTest_ContainersEndpoint_4fzDrC/slaves/eabb8a7c-fe8f-4751-a53e-76ec29161e53-S0/frameworks/eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000/executors/executor-1/runs/d1917dea-5462-4d54-af05-6cbe3f1c5b93' to user 'mesos'
I0901 16:21:18.304853 32661 slave.cpp:7257] Launching executor 'executor-1' of framework eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000 with resources [] in work directory '/tmp/SlaveTest_ContainersEndpoint_4fzDrC/slaves/eabb8a7c-fe8f-4751-a53e-76ec29161e53-S0/frameworks/eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000/executors/executor-1/runs/d1917dea-5462-4d54-af05-6cbe3f1c5b93'
I0901 16:21:18.305308 32661 slave.cpp:2871] Launching container d1917dea-5462-4d54-af05-6cbe3f1c5b93 for executor 'executor-1' of framework eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000
I0901 16:21:18.305476 32647 hierarchical.cpp:887] Updated allocation of framework eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000 on agent eabb8a7c-fe8f-4751-a53e-76ec29161e53-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]
I0901 16:21:18.305644 32661 slave.cpp:2408] Queued task '1' for executor 'executor-1' of framework eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000
I0901 16:21:18.305920 32661 slave.cpp:1744] Got assigned task '2' for framework eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000
I0901 16:21:18.306128 32647 hierarchical.cpp:1161] Recovered ports(allocated: *):[31000-32000]; disk(allocated: *):1024 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: cpus(allocated: *):2; mem(allocated: *):1024) on agent eabb8a7c-fe8f-4751-a53e-76ec29161e53-S0 from framework eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000
I0901 16:21:18.306182 32647 hierarchical.cpp:1207] Framework eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000 filtered agent eabb8a7c-fe8f-4751-a53e-76ec29161e53-S0 for 5secs
I0901 16:21:18.306489 32661 slave.cpp:940] Successfully attached file '/tmp/SlaveTest_ContainersEndpoint_4fzDrC/slaves/eabb8a7c-fe8f-4751-a53e-76ec29161e53-S0/frameworks/eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000/executors/executor-1/runs/d1917dea-5462-4d54-af05-6cbe3f1c5b93'
I0901 16:21:18.306533 32661 slave.cpp:940] Successfully attached file '/tmp/SlaveTest_ContainersEndpoint_4fzDrC/slaves/eabb8a7c-fe8f-4751-a53e-76ec29161e53-S0/frameworks/eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000/executors/executor-1/runs/d1917dea-5462-4d54-af05-6cbe3f1c5b93'
I0901 16:21:18.306607 32661 slave.cpp:2012] Authorizing task '2' for framework eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000
I0901 16:21:18.306648 32661 slave.cpp:6795] Authorizing framework principal 'test-principal' to launch task 2
I0901 16:21:18.307446 32652 slave.cpp:2180] Launching task '2' for framework eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000
I0901 16:21:18.307847 32652 paths.cpp:578] Trying to chown '/tmp/SlaveTest_ContainersEndpoint_4fzDrC/slaves/eabb8a7c-fe8f-4751-a53e-76ec29161e53-S0/frameworks/eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000/executors/executor-2/runs/fd6619cc-01f1-456d-8c7d-a6584e487c31' to user 'mesos'
I0901 16:21:18.308076 32652 slave.cpp:7257] Launching executor 'executor-2' of framework eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000 with resources [] in work directory '/tmp/SlaveTest_ContainersEndpoint_4fzDrC/slaves/eabb8a7c-fe8f-4751-a53e-76ec29161e53-S0/frameworks/eabb8a7c-fe8f-4751-a53e-76ec29161e53-0000/executors/executor-2/runs/fd6619cc-01f1-456d-8c7d-a6584e487c31'
*** Aborted at 1504282878 (unix time) try "date -d @1504282878" if you are using GNU date ***
PC: @     0x2b511296c82d (unknown)
*** SIGSEGV (@0x31) received by PID 32642 (TID 0x2b511c2c1700) from PID 49; stack trace: ***
W    @     0x2b5111f03330 (unknown)
0901 16:21:18.308887 32654 process.cpp:3240] Attempted to spawn already running process version@172.17.0.11:36525
    @     0x2b511296c82d (unknown)
I0901 16:21:18.309162 32654 exec.cpp:162] Version: 1.5.0
I0901 16:21:18.309532 32644 exec.cpp:212] Executor started at: executor(47)@172.17.0.11:36525 with pid 32642
    @          0x27e477c os::getenv()
    @     0x2b510cd51386 mesos::internal::slave::executorEnvironment()
    @     0x2b510cd26b35 mesos::internal::slave::Slave::launchExecutor()
    @     0x2b510cd220de mesos::internal::slave::Slave::__run()
    @     0x2b510cd9f3a2 _ZZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS_6FutureISt4listIbSaIbEEEERKNS1_13FrameworkInfoERKNS1_12ExecutorInfoERK6OptionINS1_8TaskInfoEERKSI_INS1_13TaskGroupInfoEESB_SE_SH_SM_SQ_EEvRKNS_3PIDIT_EEMSS_FvT0_T1_T2_T3_T4_EOT5_OT6_OT7_OT8_OT9_ENKUlRS9_RSC_RSF_RSK_RSO_PNS_11ProcessBaseEE_clES1D_S1E_S1F_S1G_S1H_S1J_
    @     0x2b510ce265cb _ZNSt5_BindIFZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS0_6FutureISt4listIbSaIbEEEERKNS2_13FrameworkInfoERKNS2_12ExecutorInfoERK6OptionINS2_8TaskInfoEERKSJ_INS2_13TaskGroupInfoEESC_SF_SI_SN_SR_EEvRKNS0_3PIDIT_EEMST_FvT0_T1_T2_T3_T4_EOT5_OT6_OT7_OT8_OT9_EUlRSA_RSD_RSG_RSL_RSP_PNS0_11ProcessBaseEE_SA_SD_SG_SL_SP_St12_PlaceholderILi1EEEE6__callIvJOS1K_EJLm0ELm1ELm2ELm3ELm4ELm5EEEET_OSt5tupleIJDpT0_EESt12_Index_tupleIJXspT1_EEE
    @     0x2b510ce0de11 _ZNSt5_BindIFZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS0_6FutureISt4listIbSaIbEEEERKNS2_13FrameworkInfoERKNS2_12ExecutorInfoERK6OptionINS2_8TaskInfoEERKSJ_INS2_13TaskGroupInfoEESC_SF_SI_SN_SR_EEvRKNS0_3PIDIT_EEMST_FvT0_T1_T2_T3_T4_EOT5_OT6_OT7_OT8_OT9_EUlRSA_RSD_RSG_RSL_RSP_PNS0_11ProcessBaseEE_SA_SD_SG_SL_SP_St12_PlaceholderILi1EEEEclIIS1K_EvEET0_DpOT_
    @     0x2b510cdef6bd _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEESt5_BindIFZNS0_8dispatchIN5mesos8internal5slave5SlaveERKNS0_6FutureISt4listIbSaIbEEEERKNS6_13FrameworkInfoERKNS6_12ExecutorInfoERK6OptionINS6_8TaskInfoEERKSN_INS6_13TaskGroupInfoEESG_SJ_SM_SR_SV_EEvRKNS0_3PIDIT_EEMSX_FvT0_T1_T2_T3_T4_EOT5_OT6_OT7_OT8_OT9_EUlRSE_RSH_RSK_RSP_RST_S2_E_SE_SH_SK_SP_ST_St12_PlaceholderILi1EEEEE9_M_invokeERKSt9_Any_dataS2_
    @     0x2b510fc20443 std::function<>::operator()()
    @     0x2b510fbf990d process::ProcessBase::visit()
    @     0x2b510fc06d1e process::DispatchEvent::visit()
    @          0x26fee02 process::ProcessBase::serve()
    @     0x2b510fbf702d process::ProcessManager::resume()
    @     0x2b510fbf33a4 _ZZN7process14ProcessManager12init_threadsEvENKUlvE_clEv
    @     0x2b510fc04c46 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
    @     0x2b510fc04b9d _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEclEv
    @     0x2b510fc04b36 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEE6_M_runEv
    @     0x2b51121c2a60 (unknown)
    @     0x2b5111efb184 start_thread
    @     0x2b5112a2effd (unknown)
make[3]: Leaving directory `/mesos/build'
make[3]: *** [CMakeFiles/check] Segmentation fault (core dumped)
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-1504279760-23369
Untagged: mesos-1504279760-23369:latest
Deleted: sha256:f78add8f0569788e3d38c9a5d2b819500b7212077e57491eef480ecb9f3a80ee
Deleted: sha256:5897a5084af2d182d9cf7a3ca64524ccd01c6f992dbcc5cb8cbba881a46ee857
Deleted: sha256:780dc166741077c67cbbccb64f1b9e070d6f844f2fbe774061b5d285670ec68f
Deleted: sha256:31212bddc2212b636715efb3f6bbd11380739f7e48a3f944909783eb3097d09f
Deleted: sha256:fab93b0a1cf594fef6fd3263f6b96ef851a3bcf209085fe8a676f87bebfb0953
Deleted: sha256:589da08931e3b33734e1e053d30e7b82b934f957bdc0ad19bdb4e9531157e0bd
Deleted: sha256:09a707f8b2a6402d837328ec8b0db4a0364d8aed7c88b63b0534fbb35cab5071
Deleted: sha256:dbda903a21e45ce8a374b2a7f2351f168d82af7cfa3dfd447acf0c1330f53198
Deleted: sha256:2af17c35c655fdbcf029ce035d7a55fa8863d01a4839fa996cd5df568b7eff8a
Deleted: sha256:1e5f14cf05f734b9ea6f58ea39b7b2ba31a0f7cc4e49115c5c2dbcea08ecfae6
Deleted: sha256:7c29714cab5ee07f148e668d2a7c671f540485a87da296ea38a2922c6dc78e62
Deleted: sha256:b66ed62ce84b8afcaf3c45b882d01f64263b8866a205382c83caa69b0476eb00
Deleted: sha256:f05b0dff2edf5bb73f8bc288f191e23cdd98179ceefa86fe63d924ed422a3274
Deleted: sha256:05936a57d3d58dea4b7de8cba772ec99783280154bd646b224d2f2648d83bf58
Deleted: sha256:efd6fc93ce8df67ca5be016687c8d96e90b326a9f5e5865eb17d5466685a983c
Deleted: sha256:ba59895af127e49db64c42bdd5bde5cb03408a72e564c1b52daa0f9fa30319b7
Deleted: sha256:53c9cae98889fb4396b905f7081a2ea9cceacb611305af6fc17352a3eebf6a99
Deleted: sha256:5eb60f3676030d4a5b61b2b9e853ee9a2cea35639c4429c1eb8303980d39f78c
Deleted: sha256:d0bdaca09131b9c9ab4caf1fcc4694dae40c1f14a2942896f7e095a9a0291424
Deleted: sha256:95b1770b9ea1787bdad6b99e47c4ab75dbc6ad2ab5cac5364890a3ee23f02170
Deleted: sha256:c4f59ee1a54eb6fde1bdd07d7d53c25e32bb3a03f969e4ee260c08819e261296
Deleted: sha256:36f664e5b851d9d0e678d4e6464dd5a5072d0b13ab2049979e5057618aadb6dd
Deleted: sha256:30f2360dc2e368d8119ca62caa38419b6dfe74c0ab25f8790b16684c6af38fbb
Deleted: sha256:c37a8936724064ee47128cbfab0cdaff1d4d7f47d2c5d95490d4cc5f8fd5a374
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 » cmake,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #4185

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