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/05/04 22:10:05 UTC

Build failed in Jenkins: Mesos-Buildbot » cmake,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3609

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

Changes:

[mpark] Fixed a minor bug in setting the agent's `totalResources`.

------------------------------------------
[...truncated 4.22 MB...]
I0504 22:09:55.639618 24431 master.cpp:490] Master allowing unauthenticated frameworks to register
I0504 22:09:55.639631 24431 master.cpp:502] Master only allowing authenticated agents to register
I0504 22:09:55.639637 24431 master.cpp:515] Master only allowing authenticated HTTP frameworks to register
I0504 22:09:55.639644 24431 credentials.hpp:37] Loading credentials for authentication from '/tmp/KV8Goj/credentials'
I0504 22:09:55.639801 24431 master.cpp:560] Using default 'crammd5' authenticator
I0504 22:09:55.639852 24431 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0504 22:09:55.639896 24431 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0504 22:09:55.639935 24431 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0504 22:09:55.639962 24431 master.cpp:640] Authorization enabled
I0504 22:09:55.640141 24418 hierarchical.cpp:158] Initialized hierarchical allocator process
I0504 22:09:55.640168 24418 whitelist_watcher.cpp:77] No whitelist given
I0504 22:09:55.641695 24431 master.cpp:2161] Elected as the leading master!
I0504 22:09:55.641716 24431 master.cpp:1700] Recovering from registrar
I0504 22:09:55.641779 24431 registrar.cpp:345] Recovering registrar
I0504 22:09:55.642088 24431 registrar.cpp:389] Successfully fetched the registry (0B) in 287232ns
I0504 22:09:55.642132 24431 registrar.cpp:493] Applied 1 operations in 6032ns; attempting to update the registry
I0504 22:09:55.642333 24431 registrar.cpp:550] Successfully updated the registry in 177920ns
I0504 22:09:55.642383 24431 registrar.cpp:422] Successfully recovered registrar
I0504 22:09:55.642525 24431 master.cpp:1799] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0504 22:09:55.642594 24431 hierarchical.cpp:185] Skipping recovery of hierarchical allocator: nothing to recover
I0504 22:09:55.643342 24417 scheduler.cpp:184] Version: 1.4.0
I0504 22:09:55.643651 24425 scheduler.cpp:470] New master detected at master@172.17.0.2:48067
I0504 22:09:55.643673 24425 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0504 22:09:55.646188 24421 scheduler.cpp:361] Connected with the master at http://172.17.0.2:48067/master/api/v1/scheduler
I0504 22:09:55.646888 24429 scheduler.cpp:243] Sending SUBSCRIBE call to http://172.17.0.2:48067/master/api/v1/scheduler
I0504 22:09:55.647495 24429 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0504 22:09:55.647888 24429 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:42181
I0504 22:09:55.647982 24429 master.cpp:2513] Received subscription request for HTTP framework 'default'
I0504 22:09:55.648022 24429 master.cpp:2197] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0504 22:09:55.648260 24429 master.cpp:2628] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I0504 22:09:55.648524 24429 hierarchical.cpp:273] Added framework 2b5ec1bf-8406-44e7-90ad-3a42d583b8c6-0000
I0504 22:09:55.648574 24429 hierarchical.cpp:1850] No allocations performed
I0504 22:09:55.648593 24429 hierarchical.cpp:1940] No inverse offers to send out!
I0504 22:09:55.648608 24429 hierarchical.cpp:1434] Performed allocation for 0 agents in 42785ns
I0504 22:09:55.648707 24429 master.hpp:2194] Sending heartbeat to 2b5ec1bf-8406-44e7-90ad-3a42d583b8c6-0000
I0504 22:09:55.649379 24431 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from http://172.17.0.2:48067/master/api/v1/scheduler
I0504 22:09:55.649605 24431 scheduler.cpp:676] Enqueuing event HEARTBEAT received from http://172.17.0.2:48067/master/api/v1/scheduler
I0504 22:09:55.664949 24427 scheduler.cpp:243] Sending TEARDOWN call to http://172.17.0.2:48067/master/api/v1/scheduler
I0504 22:09:55.665730 24427 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0504 22:09:55.666148 24427 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:42180
I0504 22:09:55.666199 24427 master.cpp:8000] Removing framework 2b5ec1bf-8406-44e7-90ad-3a42d583b8c6-0000 (default)
I0504 22:09:55.666220 24427 master.cpp:3160] Deactivating framework 2b5ec1bf-8406-44e7-90ad-3a42d583b8c6-0000 (default)
I0504 22:09:55.666353 24427 hierarchical.cpp:374] Deactivated framework 2b5ec1bf-8406-44e7-90ad-3a42d583b8c6-0000
I0504 22:09:55.666424 24427 hierarchical.cpp:325] Removed framework 2b5ec1bf-8406-44e7-90ad-3a42d583b8c6-0000
E0504 22:09:55.667038 24429 scheduler.cpp:649] End-Of-File received from master. The master closed the event stream
I0504 22:09:55.667136 24429 scheduler.cpp:444] Re-detecting master
I0504 22:09:55.667472 24429 scheduler.cpp:395] Ignoring disconnection attempt from stale connection
I0504 22:09:55.667500 24429 scheduler.cpp:395] Ignoring disconnection attempt from stale connection
I0504 22:09:55.667551 24429 scheduler.cpp:470] New master detected at master@172.17.0.2:48067
I0504 22:09:55.667568 24429 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0504 22:09:55.668756 24424 scheduler.cpp:361] Connected with the master at http://172.17.0.2:48067/master/api/v1/scheduler
I0504 22:09:55.750659 24417 scheduler.cpp:184] Version: 1.4.0
I0504 22:09:55.751102 24418 scheduler.cpp:470] New master detected at master@172.17.0.2:48067
I0504 22:09:55.752204 24418 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0504 22:09:55.758790 24418 scheduler.cpp:361] Connected with the master at http://172.17.0.2:48067/master/api/v1/scheduler
I0504 22:09:55.759609 24425 scheduler.cpp:243] Sending SUBSCRIBE call to http://172.17.0.2:48067/master/api/v1/scheduler
I0504 22:09:55.760388 24418 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0504 22:09:55.761270 24418 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:42185
I0504 22:09:55.762099 24418 master.cpp:2513] Received subscription request for HTTP framework 'default'
I0504 22:09:55.762534 24418 master.cpp:2568] Refusing subscription of framework 'default': Framework has been removed
I0504 22:09:55.763844 24425 scheduler.cpp:676] Enqueuing event ERROR received from http://172.17.0.2:48067/master/api/v1/scheduler
E0504 22:09:55.764555 24425 scheduler.cpp:649] End-Of-File received from master. The master closed the event stream
I0504 22:09:55.765159 24425 scheduler.cpp:444] Re-detecting master
I0504 22:09:55.766304 24425 scheduler.cpp:395] Ignoring disconnection attempt from stale connection
I0504 22:09:55.766916 24425 scheduler.cpp:395] Ignoring disconnection attempt from stale connection
I0504 22:09:55.767370 24425 scheduler.cpp:470] New master detected at master@172.17.0.2:48067
I0504 22:09:55.767786 24425 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0504 22:09:55.794823 24418 scheduler.cpp:361] Connected with the master at http://172.17.0.2:48067/master/api/v1/scheduler
I0504 22:09:55.798257 24417 master.cpp:1155] Master terminating
W0504 22:09:55.800863 24417 master.hpp:2677] Failed to close HTTP pipe for 2b5ec1bf-8406-44e7-90ad-3a42d583b8c6-0000 (default)
[       OK ] HttpFaultToleranceTest.SchedulerSubscribeAfterTeardown (166 ms)
[ RUN      ] HttpFaultToleranceTest.SchedulerFailoverStatusUpdate
I0504 22:09:55.806702 24417 cluster.cpp:162] Creating default 'local' authorizer
I0504 22:09:55.808821 24425 master.cpp:436] Master fa8c1b71-f844-4d48-bcb0-1298c860a61b (8709b3ef1efa) started on 172.17.0.2:48067
I0504 22:09:55.809582 24425 master.cpp:438] Flags at startup: --acls="" --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate_agents="true" --authenticate_frameworks="false" --authenticate_http_frameworks="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/PvJaKv/credentials" --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/PvJaKv/master" --zk_session_timeout="10secs"
I0504 22:09:55.810258 24425 master.cpp:490] Master allowing unauthenticated frameworks to register
I0504 22:09:55.811553 24425 master.cpp:502] Master only allowing authenticated agents to register
I0504 22:09:55.811961 24425 master.cpp:515] Master only allowing authenticated HTTP frameworks to register
I0504 22:09:55.812460 24425 credentials.hpp:37] Loading credentials for authentication from '/tmp/PvJaKv/credentials'
I0504 22:09:55.813050 24425 master.cpp:560] Using default 'crammd5' authenticator
I0504 22:09:55.813501 24425 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0504 22:09:55.813966 24425 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0504 22:09:55.814422 24425 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0504 22:09:55.814857 24425 master.cpp:640] Authorization enabled
I0504 22:09:55.816195 24425 hierarchical.cpp:158] Initialized hierarchical allocator process
I0504 22:09:55.817229 24419 whitelist_watcher.cpp:77] No whitelist given
I0504 22:09:55.817816 24427 master.cpp:2161] Elected as the leading master!
I0504 22:09:55.819413 24427 master.cpp:1700] Recovering from registrar
I0504 22:09:55.819985 24427 registrar.cpp:345] Recovering registrar
I0504 22:09:55.820724 24427 registrar.cpp:389] Successfully fetched the registry (0B) in 226048ns
I0504 22:09:55.821168 24427 registrar.cpp:493] Applied 1 operations in 6991ns; attempting to update the registry
I0504 22:09:55.821810 24427 registrar.cpp:550] Successfully updated the registry in 208896ns
I0504 22:09:55.822451 24427 registrar.cpp:422] Successfully recovered registrar
I0504 22:09:55.823284 24427 master.cpp:1799] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0504 22:09:55.824000 24427 hierarchical.cpp:185] Skipping recovery of hierarchical allocator: nothing to recover
I0504 22:09:55.828392 24417 cluster.cpp:448] Creating default 'local' authorizer
I0504 22:09:55.836907 24418 slave.cpp:225] Mesos agent started on (79)@172.17.0.2:48067
I0504 22:09:55.837868 24418 slave.cpp:226] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/HttpFaultToleranceTest_SchedulerFailoverStatusUpdate_vcI9xU/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/HttpFaultToleranceTest_SchedulerFailoverStatusUpdate_vcI9xU/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/HttpFaultToleranceTest_SchedulerFailoverStatusUpdate_vcI9xU/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/HttpFaultToleranceTest_SchedulerFailoverStatusUpdate_vcI9xU" --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/HttpFaultToleranceTest_SchedulerFailoverStatusUpdate_jam98H"
I0504 22:09:55.838119 24418 credentials.hpp:86] Loading credential for authentication from '/tmp/HttpFaultToleranceTest_SchedulerFailoverStatusUpdate_vcI9xU/credential'
I0504 22:09:55.838263 24418 slave.cpp:258] Agent using credential for: test-principal
I0504 22:09:55.838294 24418 credentials.hpp:37] Loading credentials for authentication from '/tmp/HttpFaultToleranceTest_SchedulerFailoverStatusUpdate_vcI9xU/http_credentials'
I0504 22:09:55.838438 24418 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0504 22:09:55.838624 24418 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0504 22:09:55.839393 24418 slave.cpp:525] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0504 22:09:55.839572 24418 slave.cpp:533] Agent attributes: [  ]
I0504 22:09:55.839709 24418 slave.cpp:538] Agent hostname: 8709b3ef1efa
I0504 22:09:55.840046 24417 scheduler.cpp:184] Version: 1.4.0
I0504 22:09:55.840230 24431 status_update_manager.cpp:177] Pausing sending status updates
I0504 22:09:55.841408 24418 state.cpp:62] Recovering state from '/tmp/HttpFaultToleranceTest_SchedulerFailoverStatusUpdate_jam98H/meta'
I0504 22:09:55.842183 24433 status_update_manager.cpp:203] Recovering status update manager
I0504 22:09:55.842594 24418 slave.cpp:5963] Finished recovery
I0504 22:09:55.843273 24418 slave.cpp:6145] Querying resource estimator for oversubscribable resources
I0504 22:09:55.843580 24418 slave.cpp:918] New master detected at master@172.17.0.2:48067
I0504 22:09:55.843699 24431 status_update_manager.cpp:177] Pausing sending status updates
I0504 22:09:55.844022 24418 slave.cpp:953] Detecting new master
I0504 22:09:55.844277 24418 slave.cpp:6159] Received oversubscribable resources {} from the resource estimator
I0504 22:09:55.840603 24428 scheduler.cpp:470] New master detected at master@172.17.0.2:48067
I0504 22:09:55.844569 24428 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0504 22:09:55.846653 24429 scheduler.cpp:361] Connected with the master at http://172.17.0.2:48067/master/api/v1/scheduler
I0504 22:09:55.847826 24431 scheduler.cpp:243] Sending SUBSCRIBE call to http://172.17.0.2:48067/master/api/v1/scheduler
I0504 22:09:55.848755 24427 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0504 22:09:55.849740 24427 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:42189
I0504 22:09:55.850000 24427 master.cpp:2513] Received subscription request for HTTP framework 'default'
I0504 22:09:55.850042 24427 master.cpp:2197] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0504 22:09:55.851425 24427 master.cpp:2628] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I0504 22:09:55.851933 24427 hierarchical.cpp:273] Added framework fa8c1b71-f844-4d48-bcb0-1298c860a61b-0000
I0504 22:09:55.851979 24427 hierarchical.cpp:1850] No allocations performed
I0504 22:09:55.851994 24427 hierarchical.cpp:1940] No inverse offers to send out!
I0504 22:09:55.852005 24427 hierarchical.cpp:1434] Performed allocation for 0 agents in 33584ns
I0504 22:09:55.852291 24427 master.hpp:2194] Sending heartbeat to fa8c1b71-f844-4d48-bcb0-1298c860a61b-0000
I0504 22:09:55.853096 24427 slave.cpp:980] Authenticating with master master@172.17.0.2:48067
I0504 22:09:55.853123 24427 slave.cpp:991] Using default CRAM-MD5 authenticatee
I0504 22:09:55.853790 24427 authenticatee.cpp:121] Creating new client SASL connection
I0504 22:09:55.854396 24427 master.cpp:7475] Authenticating slave(79)@172.17.0.2:48067
I0504 22:09:55.855075 24427 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(172)@172.17.0.2:48067
I0504 22:09:55.855772 24427 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from http://172.17.0.2:48067/master/api/v1/scheduler
I0504 22:09:55.856062 24427 authenticator.cpp:98] Creating new server SASL connection
I0504 22:09:55.856451 24427 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0504 22:09:55.856477 24427 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0504 22:09:55.856525 24427 scheduler.cpp:676] Enqueuing event HEARTBEAT received from http://172.17.0.2:48067/master/api/v1/scheduler
I0504 22:09:55.857039 24427 authenticator.cpp:204] Received SASL authentication start
I0504 22:09:55.857101 24427 authenticator.cpp:326] Authentication requires more steps
I0504 22:09:55.857558 24427 authenticatee.cpp:259] Received SASL authentication step
I0504 22:09:55.857782 24427 authenticator.cpp:232] Received SASL authentication step
I0504 22:09:55.857810 24427 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '8709b3ef1efa' server FQDN: '8709b3ef1efa' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0504 22:09:55.857841 24427 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0504 22:09:55.857859 24427 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0504 22:09:55.857872 24427 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '8709b3ef1efa' server FQDN: '8709b3ef1efa' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0504 22:09:55.858125 24427 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0504 22:09:55.858139 24427 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0504 22:09:55.858155 24427 authenticator.cpp:318] Authentication success
I0504 22:09:55.858546 24427 authenticatee.cpp:299] Authentication success
I0504 22:09:55.858600 24419 master.cpp:7505] Successfully authenticated principal 'test-principal' at slave(79)@172.17.0.2:48067
I0504 22:09:55.858846 24423 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(172)@172.17.0.2:48067
I0504 22:09:55.859480 24419 slave.cpp:1075] Successfully authenticated with master master@172.17.0.2:48067
I0504 22:09:55.859782 24419 slave.cpp:1503] Will retry registration in 9.650263ms if necessary
I0504 22:09:55.860060 24427 master.cpp:5429] Received register agent message from slave(79)@172.17.0.2:48067 (8709b3ef1efa)
I0504 22:09:55.860110 24427 master.cpp:3659] Authorizing agent with principal 'test-principal'
I0504 22:09:55.860862 24427 master.cpp:5564] Registering agent at slave(79)@172.17.0.2:48067 (8709b3ef1efa) with id fa8c1b71-f844-4d48-bcb0-1298c860a61b-S0
I0504 22:09:55.861299 24420 registrar.cpp:493] Applied 1 operations in 23280ns; attempting to update the registry
I0504 22:09:55.861677 24420 registrar.cpp:550] Successfully updated the registry in 349184ns
I0504 22:09:55.862272 24427 master.cpp:5639] Registered agent fa8c1b71-f844-4d48-bcb0-1298c860a61b-S0 at slave(79)@172.17.0.2:48067 (8709b3ef1efa) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0504 22:09:55.862887 24429 slave.cpp:1121] Registered with master master@172.17.0.2:48067; given agent ID fa8c1b71-f844-4d48-bcb0-1298c860a61b-S0
I0504 22:09:55.862911 24429 fetcher.cpp:94] Clearing fetcher cache
I0504 22:09:55.863164 24430 status_update_manager.cpp:184] Resuming sending status updates
I0504 22:09:55.864387 24429 slave.cpp:1149] Checkpointing SlaveInfo to '/tmp/HttpFaultToleranceTest_SchedulerFailoverStatusUpdate_jam98H/meta/slaves/fa8c1b71-f844-4d48-bcb0-1298c860a61b-S0/slave.info'
I0504 22:09:55.864990 24429 slave.cpp:1187] Forwarding total oversubscribed resources {}
I0504 22:09:55.865051 24429 slave.cpp:4745] Received ping from slave-observer(79)@172.17.0.2:48067
I0504 22:09:55.865314 24430 master.cpp:6324] Received update of agent fa8c1b71-f844-4d48-bcb0-1298c860a61b-S0 at slave(79)@172.17.0.2:48067 (8709b3ef1efa) with total oversubscribed resources {}
I0504 22:09:55.865803 24427 hierarchical.cpp:525] Added agent fa8c1b71-f844-4d48-bcb0-1298c860a61b-S0 (8709b3ef1efa) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0504 22:09:55.866832 24426 master.cpp:7305] Sending 1 offers to framework fa8c1b71-f844-4d48-bcb0-1298c860a61b-0000 (default)
I0504 22:09:55.868870 24426 scheduler.cpp:676] Enqueuing event OFFERS received from http://172.17.0.2:48067/master/api/v1/scheduler
I0504 22:09:55.869756 24427 hierarchical.cpp:1940] No inverse offers to send out!
I0504 22:09:55.869781 24427 hierarchical.cpp:1434] Performed allocation for 1 agents in 3.88353ms
I0504 22:09:55.890828 24425 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.2:48067/master/api/v1/scheduler
I0504 22:09:55.891758 24425 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0504 22:09:55.892187 24425 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:42188
I0504 22:09:55.892503 24425 master.cpp:3875] Processing ACCEPT call for offers: [ fa8c1b71-f844-4d48-bcb0-1298c860a61b-O0 ] on agent fa8c1b71-f844-4d48-bcb0-1298c860a61b-S0 at slave(79)@172.17.0.2:48067 (8709b3ef1efa) for framework fa8c1b71-f844-4d48-bcb0-1298c860a61b-0000 (default)
I0504 22:09:55.892560 24425 master.cpp:3426] Authorizing framework principal 'test-principal' to launch task 69540824-61e0-4e7c-8c23-055180abe8dd
W0504 22:09:55.893537 24425 validation.cpp:1284] Executor 'default' for task '69540824-61e0-4e7c-8c23-055180abe8dd' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0504 22:09:55.893571 24425 validation.cpp:1296] Executor 'default' for task '69540824-61e0-4e7c-8c23-055180abe8dd' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0504 22:09:55.893739 24425 master.cpp:9326] Adding task 69540824-61e0-4e7c-8c23-055180abe8dd with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent fa8c1b71-f844-4d48-bcb0-1298c860a61b-S0 at slave(79)@172.17.0.2:48067 (8709b3ef1efa)
I0504 22:09:55.894086 24425 master.cpp:4531] Launching task 69540824-61e0-4e7c-8c23-055180abe8dd of framework fa8c1b71-f844-4d48-bcb0-1298c860a61b-0000 (default) with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent fa8c1b71-f844-4d48-bcb0-1298c860a61b-S0 at slave(79)@172.17.0.2:48067 (8709b3ef1efa)
I0504 22:09:55.894862 24427 slave.cpp:1613] Got assigned task '69540824-61e0-4e7c-8c23-055180abe8dd' for framework fa8c1b71-f844-4d48-bcb0-1298c860a61b-0000
I0504 22:09:55.895239 24427 slave.cpp:1894] Authorizing task '69540824-61e0-4e7c-8c23-055180abe8dd' for framework fa8c1b71-f844-4d48-bcb0-1298c860a61b-0000
I0504 22:09:55.895272 24427 slave.cpp:6582] Authorizing framework principal 'test-principal' to launch task 69540824-61e0-4e7c-8c23-055180abe8dd
I0504 22:09:55.895817 24427 slave.cpp:2081] Launching task '69540824-61e0-4e7c-8c23-055180abe8dd' for framework fa8c1b71-f844-4d48-bcb0-1298c860a61b-0000
I0504 22:09:55.896494 24427 paths.cpp:573] Trying to chown '/tmp/HttpFaultToleranceTest_SchedulerFailoverStatusUpdate_jam98H/slaves/fa8c1b71-f844-4d48-bcb0-1298c860a61b-S0/frameworks/fa8c1b71-f844-4d48-bcb0-1298c860a61b-0000/executors/default/runs/7963097a-a2fb-46e4-8355-7d306306041a' to user 'mesos'
I0504 22:09:55.896716 24427 slave.cpp:6922] Launching executor 'default' of framework fa8c1b71-f844-4d48-bcb0-1298c860a61b-0000 with resources {} in work directory '/tmp/HttpFaultToleranceTest_SchedulerFailoverStatusUpdate_jam98H/slaves/fa8c1b71-f844-4d48-bcb0-1298c860a61b-S0/frameworks/fa8c1b71-f844-4d48-bcb0-1298c860a61b-0000/executors/default/runs/7963097a-a2fb-46e4-8355-7d306306041a'
I0504 22:09:55.896987 24427 slave.cpp:2310] Queued task '69540824-61e0-4e7c-8c23-055180abe8dd' for executor 'default' of framework fa8c1b71-f844-4d48-bcb0-1298c860a61b-0000
I0504 22:09:55.897878 24429 slave.cpp:871] Successfully attached file '/tmp/HttpFaultToleranceTest_SchedulerFailoverStatusUpdate_jam98H/slaves/fa8c1b71-f844-4d48-bcb0-1298c860a61b-S0/frameworks/fa8c1b71-f844-4d48-bcb0-1298c860a61b-0000/executors/default/runs/7963097a-a2fb-46e4-8355-7d306306041a'
I0504 22:09:55.898603 24423 hierarchical.cpp:850] Updated allocation of framework fa8c1b71-f844-4d48-bcb0-1298c860a61b-0000 on agent fa8c1b71-f844-4d48-bcb0-1298c860a61b-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]
I0504 22:09:55.899282 24427 executor.cpp:192] Version: 1.4.0
I0504 22:09:55.900274 24424 executor.cpp:410] Connected with the agent
I0504 22:09:55.900538 24424 executor.cpp:307] Sending SUBSCRIBE call to http://172.17.0.2:48067/slave(79)/api/v1/executor
I0504 22:09:55.901237 24424 process.cpp:3730] Handling HTTP event for process 'slave(79)' with path: '/slave(79)/api/v1/executor'
I0504 22:09:55.901589 24424 http.cpp:1115] HTTP POST for /slave(79)/api/v1/executor from 172.17.0.2:42190
I0504 22:09:55.901692 24424 slave.cpp:3568] Received Subscribe request for HTTP executor 'default' of framework fa8c1b71-f844-4d48-bcb0-1298c860a61b-0000
I0504 22:09:55.903286 24424 executor.cpp:725] Enqueuing event SUBSCRIBED received from http://172.17.0.2:48067/slave(79)/api/v1/executor
*** Aborted at 1493935795 (unix time) try "date -d @1493935795" if you are using GNU date ***
PC: @          0x1cf326f testing::internal::UntypedFunctionMockerBase::SetOwnerAndName()
*** SIGSEGV (@0x109) received by PID 24417 (TID 0x7f70854f4700) from PID 265; stack trace: ***
    @     0x7f708ee25370 (unknown)
    @          0x1cf326f testing::internal::UntypedFunctionMockerBase::SetOwnerAndName()
    @           0xdee34b mesos::internal::tests::executor::MockHTTPExecutor<>::event()
    @           0xe11dd7 mesos::internal::tests::executor::TestMesos<>::events()
    @           0xdfdccd std::_Function_handler<>::_M_invoke()
    @     0x7f7092db2e95 process::AsyncExecutorProcess::execute<>()
    @     0x7f7092dbc895 _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_
    @     0x7f7091ccfd31 process::ProcessManager::resume()
    @     0x7f7091cd8a57 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv
    @     0x7f708ebc2230 (unknown)
    @     0x7f708ee1ddc5 start_thread
    @     0x7f708e32b73d __clone
make[3]: *** [CMakeFiles/check] Segmentation fault
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-1493933068-24669
Untagged: mesos-1493933068-24669:latest
Deleted: sha256:159803361340281d42bb1c111ff568c8a282f7e47f632a4e6f953e7c87e9c73d
Deleted: sha256:1cd4a9b541098649d7cb57676cb3df959a8d64e323404ef72dbd75f23707dd1a
Deleted: sha256:914ff1dc2882c036feb8069d3a463fb444a7d1d06201bbc4229ac8b5e5b8a0ac
Deleted: sha256:5c4371f2392662ba7744c0288f6d2bab3552ac21994d6acc7be4b1a9145e58b6
Deleted: sha256:44e746caaa403e5ec0efc8d02ca6fdde1a9c39db43753223189320214207d49f
Deleted: sha256:e3cfe4a26d56d219dc8d968ba5033cc3e45426f0501cf96b49d771cacef62b6f
Deleted: sha256:9ab5482675f88dafa4b9d514c516dde5661f7804f463066e22ee0644e0997512
Deleted: sha256:6d0381611a35e2fe5886ea948aaeb9d9c18dd75700d7521cf58ccbf00fc79a80
Deleted: sha256:97b61a8334618cc3c5722daeed5631712e9832302b3158ac89d609a19d9aec32
Deleted: sha256:513220ecb14fdc00c7cf97c3e91937cbc08031e92228887870a300be84e11d80
Deleted: sha256:2b015324d3068acc7d325c972b05cf6f9350d27569ac2bc5349c1ef8538b057d
Deleted: sha256:f1e0a00bf40bbc85387862ae816eae666ca8fa4fb952b239f616b6c941af6d5f
Deleted: sha256:0bc54cc1ef9eb1dde0fea0da224394a69ec3b29d2005cac232b14c843883bc79
Deleted: sha256:401ee45bd75fd0c45ab82ad462fc5be01f410a03d326a0e26792e45aa5444df9
Deleted: sha256:b9c7f534f5448028873050101dd1041d8d4985ab57f128e1520e97bcf19f1365
Deleted: sha256:15e2b8420eaeac9b87e29b79bf59838d06b7ab10062a074c4a30fa6a02be966f
Deleted: sha256:ecdce930f53b0fbd9159bbe75889c45518c723eb42b6436d17160f2ca5c4b6c5
Deleted: sha256:0d2a8aa92221cd9a0c6c8960eaf861e417e59659e7ac8c42aefefd1e8f48a945
Deleted: sha256:a5ead9fafef35739c1194db29ac8deec766e9abe2f505340599d34fac08fa525
Deleted: sha256:00939fc3ffd981f63020753da2710cc117bfce7dddb049180136cb83ea14da3e
Deleted: sha256:26527630a46033487a0e62c429cb2fd74a61e4d831ce922e1136c7f94a3f27ee
Deleted: sha256:60f01dcc59d8843599f9cad03e8b02adbe24c7a17bde8c001a12409b7ecc299d
Deleted: sha256:4a14ecdf789a6adbb5caea51cf7fa55a4d17b0e2a9de3f7f272751f1efde25c9
Deleted: sha256:b23d0629f78765e84a611c092f6acc918504fa28b1696c1fad50a0e399f8a5d9
Deleted: sha256:06239360bf63cda9e6d841f8aa4b93303368df60b0cc3218f02766b244ebdd4c
Build step 'Execute shell' marked build as failure

Jenkins build is back to normal : Mesos-Buildbot » cmake,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3610

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=centos%3A7,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3610/display/redirect?page=changes>