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/01/30 04:18:58 UTC

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

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

Changes:

[bmahler] Added TODOs to make the master code safer.

[bmahler] Added a safety CHECK when accessing activeRoles in the master.

[bmahler] Added helpers to allocate / unallocate Resources.

[bmahler] Augmented printing of Resources to include AllocationInfo.

[bmahler] Updated resources quantity stripping to strip AllocationInfo.

[anand] Improved executor, scheduler v1 API docs.

------------------------------------------
[...truncated 64311 lines...]
I0130 04:18:50.934765 30208 master.cpp:5377] Registered agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S0 at slave(152)@172.17.0.3:53042 (maintenance-host) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0130 04:18:50.935106 30205 slave.cpp:1132] Registered with master master@172.17.0.3:53042; given agent ID 62aa0ac2-0647-4808-81ea-4459ec53efdc-S0
I0130 04:18:50.935133 30205 fetcher.cpp:90] Clearing fetcher cache
I0130 04:18:50.935119 30210 hierarchical.cpp:478] Added agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S0 (maintenance-host) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0130 04:18:50.935348 30210 hierarchical.cpp:1675] No allocations performed
I0130 04:18:50.935508 30210 hierarchical.cpp:1302] Performed allocation for agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S0 in 311018ns
I0130 04:18:50.935837 30200 status_update_manager.cpp:184] Resuming sending status updates
I0130 04:18:50.936077 30205 slave.cpp:1160] Checkpointing SlaveInfo to '/tmp/MasterMaintenanceTest_InverseOffersFilters_X9J6fl/meta/slaves/62aa0ac2-0647-4808-81ea-4459ec53efdc-S0/slave.info'
I0130 04:18:50.936457 30205 slave.cpp:1198] Forwarding total oversubscribed resources {}
I0130 04:18:50.936662 30210 master.cpp:5876] Received update of agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S0 at slave(152)@172.17.0.3:53042 (maintenance-host) with total oversubscribed resources {}
I0130 04:18:50.936906 30205 hierarchical.cpp:548] Agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S0 (maintenance-host) updated with oversubscribed resources {} (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: {})
I0130 04:18:50.937058 30205 hierarchical.cpp:1675] No allocations performed
I0130 04:18:50.937129 30205 hierarchical.cpp:1302] Performed allocation for agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S0 in 180519ns
I0130 04:18:50.941769 30178 cluster.cpp:446] Creating default 'local' authorizer
I0130 04:18:50.943411 30209 slave.cpp:209] Mesos agent started on (153)@172.17.0.3:53042
I0130 04:18:50.943454 30209 slave.cpp:210] 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/MasterMaintenanceTest_InverseOffersFilters_Fbtgj4/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/MasterMaintenanceTest_InverseOffersFilters_Fbtgj4/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname="maintenance-host-2" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/MasterMaintenanceTest_InverseOffersFilters_Fbtgj4/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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/MasterMaintenanceTest_InverseOffersFilters_Fbtgj4" --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/MasterMaintenanceTest_InverseOffersFilters_nEZnhV"
I0130 04:18:50.944093 30209 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterMaintenanceTest_InverseOffersFilters_Fbtgj4/credential'
I0130 04:18:50.944335 30209 slave.cpp:352] Agent using credential for: test-principal
I0130 04:18:50.944366 30209 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterMaintenanceTest_InverseOffersFilters_Fbtgj4/http_credentials'
I0130 04:18:50.944685 30209 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0130 04:18:50.944887 30209 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0130 04:18:50.946432 30209 slave.cpp:539] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0130 04:18:50.946512 30209 slave.cpp:547] Agent attributes: [  ]
I0130 04:18:50.946527 30209 slave.cpp:552] Agent hostname: maintenance-host-2
I0130 04:18:50.946705 30203 status_update_manager.cpp:177] Pausing sending status updates
I0130 04:18:50.948176 30203 state.cpp:60] Recovering state from '/tmp/MasterMaintenanceTest_InverseOffersFilters_nEZnhV/meta'
I0130 04:18:50.948462 30205 status_update_manager.cpp:203] Recovering status update manager
I0130 04:18:50.948839 30208 slave.cpp:5422] Finished recovery
I0130 04:18:50.949328 30208 slave.cpp:5596] Querying resource estimator for oversubscribable resources
I0130 04:18:50.949676 30201 slave.cpp:929] New master detected at master@172.17.0.3:53042
I0130 04:18:50.949695 30207 status_update_manager.cpp:177] Pausing sending status updates
I0130 04:18:50.949751 30201 slave.cpp:964] Detecting new master
I0130 04:18:50.949904 30201 slave.cpp:5610] Received oversubscribable resources {} from the resource estimator
I0130 04:18:50.960595 30200 slave.cpp:991] Authenticating with master master@172.17.0.3:53042
I0130 04:18:50.960765 30200 slave.cpp:1002] Using default CRAM-MD5 authenticatee
I0130 04:18:50.961112 30198 authenticatee.cpp:121] Creating new client SASL connection
I0130 04:18:50.961493 30206 master.cpp:7018] Authenticating slave(153)@172.17.0.3:53042
I0130 04:18:50.961647 30204 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(358)@172.17.0.3:53042
I0130 04:18:50.961930 30199 authenticator.cpp:98] Creating new server SASL connection
I0130 04:18:50.962173 30202 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0130 04:18:50.962208 30202 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0130 04:18:50.962334 30202 authenticator.cpp:204] Received SASL authentication start
I0130 04:18:50.962412 30202 authenticator.cpp:326] Authentication requires more steps
I0130 04:18:50.962537 30198 authenticatee.cpp:259] Received SASL authentication step
I0130 04:18:50.962673 30208 authenticator.cpp:232] Received SASL authentication step
I0130 04:18:50.962710 30208 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '8c5804de8a42' server FQDN: '8c5804de8a42' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0130 04:18:50.962734 30208 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0130 04:18:50.962796 30208 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0130 04:18:50.962827 30208 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '8c5804de8a42' server FQDN: '8c5804de8a42' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0130 04:18:50.962851 30208 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0130 04:18:50.962868 30208 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0130 04:18:50.962888 30208 authenticator.cpp:318] Authentication success
I0130 04:18:50.962985 30210 authenticatee.cpp:299] Authentication success
I0130 04:18:50.963022 30201 master.cpp:7048] Successfully authenticated principal 'test-principal' at slave(153)@172.17.0.3:53042
I0130 04:18:50.963065 30212 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(358)@172.17.0.3:53042
I0130 04:18:50.963521 30200 slave.cpp:1086] Successfully authenticated with master master@172.17.0.3:53042
I0130 04:18:50.963719 30200 slave.cpp:1508] Will retry registration in 10.565936ms if necessary
I0130 04:18:50.964117 30201 master.cpp:5303] Registering agent at slave(153)@172.17.0.3:53042 (maintenance-host-2) with id 62aa0ac2-0647-4808-81ea-4459ec53efdc-S1
I0130 04:18:50.964753 30203 registrar.cpp:461] Applied 1 operations in 100225ns; attempting to update the registry
I0130 04:18:50.966675 30203 registrar.cpp:506] Successfully updated the registry in 1.830912ms
I0130 04:18:50.967564 30198 slave.cpp:4286] Received ping from slave-observer(152)@172.17.0.3:53042
I0130 04:18:50.967607 30199 master.cpp:5377] Registered agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S1 at slave(153)@172.17.0.3:53042 (maintenance-host-2) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0130 04:18:50.967962 30198 slave.cpp:1132] Registered with master master@172.17.0.3:53042; given agent ID 62aa0ac2-0647-4808-81ea-4459ec53efdc-S1
I0130 04:18:50.968035 30198 fetcher.cpp:90] Clearing fetcher cache
I0130 04:18:50.968070 30210 hierarchical.cpp:478] Added agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S1 (maintenance-host-2) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0130 04:18:50.968319 30209 status_update_manager.cpp:184] Resuming sending status updates
I0130 04:18:50.968333 30210 hierarchical.cpp:1675] No allocations performed
I0130 04:18:50.968538 30210 hierarchical.cpp:1302] Performed allocation for agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S1 in 407080ns
I0130 04:18:50.968786 30198 slave.cpp:1160] Checkpointing SlaveInfo to '/tmp/MasterMaintenanceTest_InverseOffersFilters_nEZnhV/meta/slaves/62aa0ac2-0647-4808-81ea-4459ec53efdc-S1/slave.info'
I0130 04:18:50.969254 30198 slave.cpp:1198] Forwarding total oversubscribed resources {}
I0130 04:18:50.969463 30198 master.cpp:5876] Received update of agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S1 at slave(153)@172.17.0.3:53042 (maintenance-host-2) with total oversubscribed resources {}
I0130 04:18:50.969837 30198 hierarchical.cpp:548] Agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S1 (maintenance-host-2) updated with oversubscribed resources {} (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: {})
I0130 04:18:50.970013 30198 hierarchical.cpp:1675] No allocations performed
I0130 04:18:50.970096 30198 hierarchical.cpp:1302] Performed allocation for agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S1 in 208999ns
I0130 04:18:50.972077 30199 process.cpp:3697] Handling HTTP event for process 'master' with path: '/master/maintenance/schedule'
I0130 04:18:50.974099 30208 http.cpp:420] HTTP POST for /master/maintenance/schedule from 172.17.0.3:50929
I0130 04:18:50.975147 30205 registrar.cpp:461] Applied 1 operations in 191475ns; attempting to update the registry
I0130 04:18:50.978415 30205 registrar.cpp:506] Successfully updated the registry in 3.166976ms
I0130 04:18:50.979032 30209 master.cpp:5938] Updating unavailability of agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S0 at slave(152)@172.17.0.3:53042 (maintenance-host), starting at 2461.59787704777weeks
I0130 04:18:50.979223 30209 master.cpp:5938] Updating unavailability of agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S1 at slave(153)@172.17.0.3:53042 (maintenance-host-2), starting at 2461.59787704777weeks
I0130 04:18:50.979451 30198 hierarchical.cpp:1675] No allocations performed
I0130 04:18:50.979542 30198 hierarchical.cpp:1302] Performed allocation for agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S0 in 273203ns
I0130 04:18:50.979830 30198 hierarchical.cpp:1675] No allocations performed
I0130 04:18:50.979910 30198 hierarchical.cpp:1302] Performed allocation for agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S1 in 224787ns
I0130 04:18:50.982291 30178 scheduler.cpp:184] Version: 1.2.0
I0130 04:18:50.983140 30203 scheduler.cpp:470] New master detected at master@172.17.0.3:53042
I0130 04:18:50.983188 30203 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0130 04:18:50.987387 30204 scheduler.cpp:361] Connected with the master at http://172.17.0.3:53042/master/api/v1/scheduler
I0130 04:18:50.989115 30207 scheduler.cpp:243] Sending SUBSCRIBE call to http://172.17.0.3:53042/master/api/v1/scheduler
I0130 04:18:50.990653 30197 process.cpp:3697] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0130 04:18:50.992236 30198 http.cpp:420] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:50931
I0130 04:18:50.992473 30198 master.cpp:2422] Received subscription request for HTTP framework 'default'
I0130 04:18:50.992560 30198 master.cpp:2159] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0130 04:18:50.993130 30206 master.cpp:2536] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I0130 04:18:50.993955 30200 hierarchical.cpp:271] Added framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000
I0130 04:18:50.993968 30209 master.hpp:2114] Sending heartbeat to 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000
I0130 04:18:50.995146 30210 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from http://172.17.0.3:53042/master/api/v1/scheduler
I0130 04:18:50.995815 30210 scheduler.cpp:676] Enqueuing event HEARTBEAT received from http://172.17.0.3:53042/master/api/v1/scheduler
I0130 04:18:50.996328 30200 hierarchical.cpp:1279] Performed allocation for 2 agents in 2.163612ms
I0130 04:18:50.996915 30197 master.cpp:6847] Sending 2 offers to framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000 (default)
I0130 04:18:50.997802 30197 master.cpp:6937] Sending 2 inverse offers to framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000 (default)
I0130 04:18:50.999416 30212 scheduler.cpp:676] Enqueuing event OFFERS received from http://172.17.0.3:53042/master/api/v1/scheduler
I0130 04:18:51.000358 30212 scheduler.cpp:676] Enqueuing event INVERSE_OFFERS received from http://172.17.0.3:53042/master/api/v1/scheduler
I0130 04:18:51.001914 30197 hierarchical.cpp:1675] No allocations performed
I0130 04:18:51.002238 30197 hierarchical.cpp:1279] Performed allocation for 2 agents in 585083ns
I0130 04:18:51.003959 30204 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.3:53042/master/api/v1/scheduler
I0130 04:18:51.005061 30204 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.3:53042/master/api/v1/scheduler
I0130 04:18:51.006161 30208 process.cpp:3697] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0130 04:18:51.008314 30202 http.cpp:420] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:50930
I0130 04:18:51.009452 30202 master.cpp:3730] Processing ACCEPT call for offers: [ 62aa0ac2-0647-4808-81ea-4459ec53efdc-O0 ] on agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S1 at slave(153)@172.17.0.3:53042 (maintenance-host-2) for framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000 (default)
I0130 04:18:51.009585 30202 master.cpp:3318] Authorizing framework principal 'test-principal' to launch task 36e5c190-1ce9-4e12-9375-02dd96f1f386
I0130 04:18:51.010967 30202 process.cpp:3697] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
W0130 04:18:51.012850 30202 validation.cpp:1018] Executor 'executor-1' for task '36e5c190-1ce9-4e12-9375-02dd96f1f386' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0130 04:18:51.012887 30202 validation.cpp:1030] Executor 'executor-1' for task '36e5c190-1ce9-4e12-9375-02dd96f1f386' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0130 04:18:51.013365 30202 master.cpp:8902] Adding task 36e5c190-1ce9-4e12-9375-02dd96f1f386 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S1 at slave(153)@172.17.0.3:53042 (maintenance-host-2)
I0130 04:18:51.013695 30202 master.cpp:4380] Launching task 36e5c190-1ce9-4e12-9375-02dd96f1f386 of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000 (default) with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S1 at slave(153)@172.17.0.3:53042 (maintenance-host-2)
I0130 04:18:51.014185 30205 slave.cpp:1576] Got assigned task '36e5c190-1ce9-4e12-9375-02dd96f1f386' for framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000
I0130 04:18:51.014794 30205 slave.cpp:1736] Launching task '36e5c190-1ce9-4e12-9375-02dd96f1f386' for framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000
I0130 04:18:51.014889 30211 http.cpp:420] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:50930
I0130 04:18:51.015439 30205 paths.cpp:547] Trying to chown '/tmp/MasterMaintenanceTest_InverseOffersFilters_nEZnhV/slaves/62aa0ac2-0647-4808-81ea-4459ec53efdc-S1/frameworks/62aa0ac2-0647-4808-81ea-4459ec53efdc-0000/executors/executor-1/runs/f7bc3de2-2607-4bbf-a1e6-cae7819d783f' to user 'mesos'
I0130 04:18:51.015569 30211 master.cpp:3730] Processing ACCEPT call for offers: [ 62aa0ac2-0647-4808-81ea-4459ec53efdc-O1 ] on agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S0 at slave(152)@172.17.0.3:53042 (maintenance-host) for framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000 (default)
I0130 04:18:51.015661 30211 master.cpp:3318] Authorizing framework principal 'test-principal' to launch task 1e92a627-d336-4202-8a7d-84c5c736015e
I0130 04:18:51.015763 30205 slave.cpp:6331] Launching executor 'executor-1' of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000 with resources {} in work directory '/tmp/MasterMaintenanceTest_InverseOffersFilters_nEZnhV/slaves/62aa0ac2-0647-4808-81ea-4459ec53efdc-S1/frameworks/62aa0ac2-0647-4808-81ea-4459ec53efdc-0000/executors/executor-1/runs/f7bc3de2-2607-4bbf-a1e6-cae7819d783f'
I0130 04:18:51.016362 30205 slave.cpp:2058] Queued task '36e5c190-1ce9-4e12-9375-02dd96f1f386' for executor 'executor-1' of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000
I0130 04:18:51.016434 30205 slave.cpp:882] Successfully attached file '/tmp/MasterMaintenanceTest_InverseOffersFilters_nEZnhV/slaves/62aa0ac2-0647-4808-81ea-4459ec53efdc-S1/frameworks/62aa0ac2-0647-4808-81ea-4459ec53efdc-0000/executors/executor-1/runs/f7bc3de2-2607-4bbf-a1e6-cae7819d783f'
*** Aborted at 1485749931 (unix time) try "date -d @1485749931" if you are using GNU date ***
PC: @     0x2b44cd73982d (unknown)
I0130 04:18:51.018461 30207 exec.cpp:162] Version: 1.2.0
W0130 04:18:51.018440 30198 validation.cpp:1018] Executor 'executor-2' for task '1e92a627-d336-4202-8a7d-84c5c736015e' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W*** SIGSEGV (@0xb0) received by PID 30178 (TID 0x2b44d716d700) from PID 176; stack trace: ***
0130 04:18:51.018538 30198 validation.cpp:1030] Executor 'executor-2' for task '1e92a627-d336-4202-8a7d-84c5c736015e' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0130 04:18:51.018790 30211 exec.cpp:212] Executor started at: executor(61)@172.17.0.3:53042 with pid 30178
I0130 04:18:51.019201 30198 master.cpp:8902] Adding task 1e92a627-d336-4202-8a7d-84c5c736015e with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S0 at slave(152)@172.17.0.3:53042 (maintenance-host)
I0130 04:18:51.019282 30199 slave.cpp:3325] Got registration for executor 'executor-1' of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000 from executor(61)@172.17.0.3:53042
    @     0x2b450adbb197 (unknown)
I0130 04:18:51.019570 30198 master.cpp:4380] Launching task 1e92a627-d336-4202-8a7d-84c5c736015e of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000 (default) with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S0 at slave(152)@172.17.0.3:53042 (maintenance-host)
I0130 04:18:51.019704 30210 exec.cpp:237] Executor registered on agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S1
I0130 04:18:51.019744 30210 exec.cpp:249] Executor::registered took 20658ns
I0130 04:18:51.020232 30206 slave.cpp:1576] Got assigned task '1e92a627-d336-4202-8a7d-84c5c736015e' for framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000
    @     0x2b450adbf479 (unknown)
I0130 04:18:51.020438 30199 slave.cpp:2271] Sending queued task '36e5c190-1ce9-4e12-9375-02dd96f1f386' to executor 'executor-1' of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000 at executor(61)@172.17.0.3:53042
    @     0x2b44cd4f0330 (unknown)
I0130 04:18:51.020743 30200 exec.cpp:320] Executor asked to run task '36e5c190-1ce9-4e12-9375-02dd96f1f386'
I0130 04:18:51.020824 30200 exec.cpp:329] Executor::launchTask took 56059ns
I0130 04:18:51.020905 30200 exec.cpp:546] Executor sending status update TASK_RUNNING (UUID: 0ce4eab0-860b-44e7-863e-6ed6fb3b6967) for task 36e5c190-1ce9-4e12-9375-02dd96f1f386 of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000
    @     0x2b44cd73982d (unknown)
    @     0x2b44cd72f6f1 (unknown)
I0130 04:18:51.021131 30200 slave.cpp:3756] Handling status update TASK_RUNNING (UUID: 0ce4eab0-860b-44e7-863e-6ed6fb3b6967) for task 36e5c190-1ce9-4e12-9375-02dd96f1f386 of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000 from executor(61)@172.17.0.3:53042
I0130 04:18:51.021165 30206 slave.cpp:1736] Launching task '1e92a627-d336-4202-8a7d-84c5c736015e' for framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000
    @     0x2b44cd78687e (unknown)
I0130 04:18:51.021754 30200 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 0ce4eab0-860b-44e7-863e-6ed6fb3b6967) for task 36e5c190-1ce9-4e12-9375-02dd96f1f386 of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000
I0130 04:18:51.021801 30200 status_update_manager.cpp:500] Creating StatusUpdate stream for task 36e5c190-1ce9-4e12-9375-02dd96f1f386 of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000
I0130 04:18:51.021811 30206 paths.cpp:547] Trying to chown '/tmp/MasterMaintenanceTest_InverseOffersFilters_X9J6fl/slaves/62aa0ac2-0647-4808-81ea-4459ec53efdc-S0/frameworks/62aa0ac2-0647-4808-81ea-4459ec53efdc-0000/executors/executor-2/runs/f7884c59-22b1-4e1b-87c1-0eaa785df550' to user 'mesos'
I0130 04:18:51.022063 30206 slave.cpp:6331] Launching executor 'executor-2' of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000 with resources {} in work directory '/tmp/MasterMaintenanceTest_InverseOffersFilters_X9J6fl/slaves/62aa0ac2-0647-4808-81ea-4459ec53efdc-S0/frameworks/62aa0ac2-0647-4808-81ea-4459ec53efdc-0000/executors/executor-2/runs/f7884c59-22b1-4e1b-87c1-0eaa785df550'
I0130 04:18:51.022212 30200 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 0ce4eab0-860b-44e7-863e-6ed6fb3b6967) for task 36e5c190-1ce9-4e12-9375-02dd96f1f386 of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000 to the agent
I0130 04:18:51.022480 30204 slave.cpp:4196] Forwarding the update TASK_RUNNING (UUID: 0ce4eab0-860b-44e7-863e-6ed6fb3b6967) for task 36e5c190-1ce9-4e12-9375-02dd96f1f386 of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000 to master@172.17.0.3:53042
I0130 04:18:51.022697 30206 slave.cpp:2058] Queued task '1e92a627-d336-4202-8a7d-84c5c736015e' for executor 'executor-2' of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000
I0130 04:18:51.022686 30204 slave.cpp:4090] Status update manager successfully handled status update TASK_RUNNING (UUID: 0ce4eab0-860b-44e7-863e-6ed6fb3b6967) for task 36e5c190-1ce9-4e12-9375-02dd96f1f386 of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000
I0130 04:18:51.022768 30206 slave.cpp:882] Successfully attached file '/tmp/MasterMaintenanceTest_InverseOffersFilters_X9J6fl/slaves/62aa0ac2-0647-4808-81ea-4459ec53efdc-S0/frameworks/62aa0ac2-0647-4808-81ea-4459ec53efdc-0000/executors/executor-2/runs/f7884c59-22b1-4e1b-87c1-0eaa785df550'
I0130 04:18:51.022754 30204 slave.cpp:4106] Sending acknowledgement for status update TASK_RUNNING (UUID: 0ce4eab0-860b-44e7-863e-6ed6fb3b6967) for task 36e5c190-1ce9-4e12-9375-02dd96f1f386 of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000 to executor(61)@172.17.0.3:53042
I0130 04:18:51.022775 30199 master.cpp:6021] Status update TASK_RUNNING (UUID: 0ce4eab0-860b-44e7-863e-6ed6fb3b6967) for task 36e5c190-1ce9-4e12-9375-02dd96f1f386 of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000 from agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S1 at slave(153)@172.17.0.3:53042 (maintenance-host-2)
I0130 04:18:51.022840 30199 master.cpp:6089] Forwarding status update TASK_RUNNING (UUID: 0ce4eab0-860b-44e7-863e-6ed6fb3b6967) for task 36e5c190-1ce9-4e12-9375-02dd96f1f386 of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000
I0130 04:18:51.022975 30207 exec.cpp:369] Executor received status update acknowledgement 0ce4eab0-860b-44e7-863e-6ed6fb3b6967 for task 36e5c190-1ce9-4e12-9375-02dd96f1f386 of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000
I0130 04:18:51.023262 30199 master.cpp:8157] Updating the state of task 36e5c190-1ce9-4e12-9375-02dd96f1f386 of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0130 04:18:51.024235 30207 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.3:53042/master/api/v1/scheduler
I0130 04:18:51.024283 30202 exec.cpp:162] Version: 1.2.0
I0130 04:18:51.024454 30210 exec.cpp:212] Executor started at: executor(62)@172.17.0.3:53042 with pid 30178
I0130 04:18:51.024670 30197 slave.cpp:3325] Got registration for executor 'executor-2' of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000 from executor(62)@172.17.0.3:53042
I0130 04:18:51.025138 30203 exec.cpp:237] Executor registered on agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S0
I0130 04:18:51.025177 30203 exec.cpp:249] Executor::registered took 15676ns
    @     0x2b44c35c4881 os::strerror()
I0130 04:18:51.025871 30197 slave.cpp:2271] Sending queued task '1e92a627-d336-4202-8a7d-84c5c736015e' to executor 'executor-2' of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000 at executor(62)@172.17.0.3:53042
I0130 04:18:51.026017 30201 scheduler.cpp:243] Sending ACKNOWLEDGE call to http://172.17.0.3:53042/master/api/v1/scheduler
I0130 04:18:51.026181 30199 exec.cpp:320] Executor asked to run task '1e92a627-d336-4202-8a7d-84c5c736015e'
I0130 04:18:51.026263 30199 exec.cpp:329] Executor::launchTask took 56829ns
I0130 04:18:51.026355 30199 exec.cpp:546] Executor sending status update TASK_RUNNING (UUID: 4f855895-4994-4b04-89c2-5b8ab79ab9f3) for task 1e92a627-d336-4202-8a7d-84c5c736015e of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000
I0130 04:18:51.026613 30198 slave.cpp:3756] Handling status update TASK_RUNNING (UUID: 4f855895-4994-4b04-89c2-5b8ab79ab9f3) for task 1e92a627-d336-4202-8a7d-84c5c736015e of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000 from executor(62)@172.17.0.3:53042
I0130 04:18:51.027377 30206 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 4f855895-4994-4b04-89c2-5b8ab79ab9f3) for task 1e92a627-d336-4202-8a7d-84c5c736015e of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000
I0130 04:18:51.027426 30206 status_update_manager.cpp:500] Creating StatusUpdate stream for task 1e92a627-d336-4202-8a7d-84c5c736015e of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000
I0130 04:18:51.027781 30206 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 4f855895-4994-4b04-89c2-5b8ab79ab9f3) for task 1e92a627-d336-4202-8a7d-84c5c736015e of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000 to the agent
I0130 04:18:51.028043 30198 slave.cpp:4196] Forwarding the update TASK_RUNNING (UUID: 4f855895-4994-4b04-89c2-5b8ab79ab9f3) for task 1e92a627-d336-4202-8a7d-84c5c736015e of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000 to master@172.17.0.3:53042
I0130 04:18:51.028246 30198 slave.cpp:4090] Status update manager successfully handled status update TASK_RUNNING (UUID: 4f855895-4994-4b04-89c2-5b8ab79ab9f3) for task 1e92a627-d336-4202-8a7d-84c5c736015e of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000
I0130 04:18:51.028287 30198 slave.cpp:4106] Sending acknowledgement for status update TASK_RUNNING (UUID: 4f855895-4994-4b04-89c2-5b8ab79ab9f3) for task 1e92a627-d336-4202-8a7d-84c5c736015e of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000 to executor(62)@172.17.0.3:53042
I0130 04:18:51.028357 30208 master.cpp:6021] Status update TASK_RUNNING (UUID: 4f855895-4994-4b04-89c2-5b8ab79ab9f3) for task 1e92a627-d336-4202-8a7d-84c5c736015e of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000 from agent 62aa0ac2-0647-4808-81ea-4459ec53efdc-S0 at slave(152)@172.17.0.3:53042 (maintenance-host)
I0130 04:18:51.028419 30208 master.cpp:6089] Forwarding status update TASK_RUNNING (UUID: 4f855895-4994-4b04-89c2-5b8ab79ab9f3) for task 1e92a627-d336-4202-8a7d-84c5c736015e of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000
I0130 04:18:51.028427 30207 exec.cpp:369] Executor received status update acknowledgement 4f855895-4994-4b04-89c2-5b8ab79ab9f3 for task 1e92a627-d336-4202-8a7d-84c5c736015e of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000
I0130 04:18:51.028878 30208 master.cpp:8157] Updating the state of task 1e92a627-d336-4202-8a7d-84c5c736015e of framework 62aa0ac2-0647-4808-81ea-4459ec53efdc-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0130 04:18:51.030025 30212 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.3:53042/master/api/v1/scheduler
    @     0x2b44c35de811 ErrnoError::ErrnoError()
    @     0x2b44c35de7ed ErrnoError::ErrnoError()
    @     0x2b44cb1cefa6 _ZZN7process2io8internal4readEiPvmENKUlvE_clEv
    @     0x2b44cb1d2b09 _ZN7process8internal4LoopIZNS_2io8internal4readEiPvmEUlvE_ZNS3_4readEiS4_mEUlRK6OptionImEE0_S7_mE5startEv
    @     0x2b44cb1d1e1e _ZN7process4loopIZNS_2io8internal4readEiPvmEUlvE_ZNS2_4readEiS3_mEUlRK6OptionImEE0_S6_NS_11ControlFlowImEEmEENS_6FutureIT3_EERKS5_INS_4UPIDEEOT_OT0_
    @     0x2b44cb1cf299 process::io::internal::read()
    @     0x2b44cb1cf819 process::io::read()
    @     0x2b44cb228cc8 process::network::internal::PollSocketImpl::recv()
    @     0x2b44cb2cb7d4 process::network::internal::SocketImpl::recv()
    @     0x2b44cb1a4e1b process::network::internal::Socket<>::recv()
    @     0x2b44cb1a1628 process::http::internal::ConnectionProcess::read()
    @     0x2b44cb1a1feb process::http::internal::ConnectionProcess::_read()
    @     0x2b44cb1a9b27 _ZZN7process8dispatchINS_4http8internal17ConnectionProcessERKNS_6FutureISsEES5_EEvRKNS_3PIDIT_EEMS9_FvT0_ET1_ENKUlPNS_11ProcessBaseEE_clESI_
    @     0x2b44cb1b17e0 _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8dispatchINS0_4http8internal17ConnectionProcessERKNS0_6FutureISsEES9_EEvRKNS0_3PIDIT_EEMSD_FvT0_ET1_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_
    @     0x2b44cb26835d std::function<>::operator()()
    @     0x2b44cb24e15f process::ProcessBase::visit()
    @     0x2b44cb2589de process::DispatchEvent::visit()
    @     0x2b44c35c592c process::ProcessBase::serve()
    @     0x2b44cb24a44c process::ProcessManager::resume()
    @     0x2b44cb246c90 _ZZN7process14ProcessManager12init_threadsEvENKUt_clEv
    @     0x2b44cb258118 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
    @     0x2b44cb25806f _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEclEv
    @     0x2b44cb258008 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv
    @     0x2b44ccd71a60 (unknown)
    @     0x2b44cd4e8184 start_thread
make[4]: *** [check-local] Segmentation fault
make[4]: Leaving directory `/mesos/mesos-1.2.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.2.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.2.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.2.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1485747021-28478
Untagged: mesos-1485747021-28478:latest
Deleted: sha256:0872439bc1278401c6ab73794202dcfe115c0a12046031816271df06e033db0b
Deleted: sha256:926930a3030b936b393a87cfb19ce4a836522715b58dd07e6c3c28fdb6b2cf3b
Deleted: sha256:b288442dd380a4d3aeed3bfcd82ba4bb4657f8206fd5d5173d138c0653de276b
Deleted: sha256:55490f91ed587b88d9bf465925008200ef7925a60d1057a8862c2020c594c362
Deleted: sha256:a8a5745fda1fbf41da5bedaebd2a34f4ee73fd632c6c982387d04c15c3571d46
Deleted: sha256:bdc275f07d41c1ef283966428601e55f20b4ff19ab667c1834b019ca4c6f9b75
Deleted: sha256:165236ee846ecf503c00bf930d038da8f1810b1b360e2419ba7c26731b3ed303
Deleted: sha256:c532f0fb473cbe0614357e44fde8846da21e6a189e778ac7f95d72248ab2e231
Deleted: sha256:ecceb83321ba676c6024da39f6f3f2832169a725d727388d3f0d356060d45a3d
Deleted: sha256:c619b187f1d80ebdeefb8607d5a05893398f1d2fb257227e5e6a547cf86134c9
Deleted: sha256:7fa4f4abb9a14c68df1c71cc47813e5765c428d268f21a387b2e8049d8a5bc5a
Deleted: sha256:7ac891b9aec5becfd5d5d2d004a8cf682dcb83107f2268825b08c44e001e5307
Deleted: sha256:5242deca68398c9e938e038e295e78b5c7485dddc2c69e6a253f75afcd2c3c6b
Deleted: sha256:fbfb52bb843f8468c3ee43a3b92bc2207a699c9990a4ff20a67f7af7e1365bc2
Deleted: sha256:b3280805deff5f2a17557621cd9a07e117e64dfd183ccf688ae64b902a999ab6
Deleted: sha256:87c786d3418bc18bf9d829034c60dea402549bb151b3b61b3453f6103ffbe968
Deleted: sha256:fe352fb170912d56a88059ea7a2e61b8c834e6eb7929e8614751c33f5a7422e0
Deleted: sha256:c6b15663549c5a31cf33ae344e824b59a328cfc899a6871035b687126f457532
Deleted: sha256:f2c08c96d65890cc29d76cbfc6d92441ebe7e2c60ef733a252de75582ddaa668
Deleted: sha256:1a02685ae804167ec2b62e4318ef9bf8e5f51f9be29f8f8024c3703097e2d2c7
Deleted: sha256:b42a186aa0e7cd84f772df4598ec468fac8ab0369ab3b2c802d29b516adb7378
Deleted: sha256:6f460fb4c710fd84945f35da438db5b370d982ea10b3e4d1d8b0374928bd947d
Deleted: sha256:93148136f70b8b0e7827c802152f4b23d5f26f591d05af09674b2ef966fa5bfc
Deleted: sha256:f7fbd0f56888bd50db2a4544471aef07df0c0bb09f42430db9b24b268687babe
Build step 'Execute shell' marked build as failure

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

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