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/26 15:43:44 UTC
Build failed in Jenkins: Mesos-Buildbot » cmake,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3729
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3729/display/redirect?page=changes>
Changes:
[vinodkone] Introduced executor reconnect retries on the agent.
------------------------------------------
[...truncated 4.92 MB...]
I0526 15:43:37.656433 27846 slave.cpp:6073] Finished recovery
I0526 15:43:37.656733 27846 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 15:43:37.656826 27853 slave.cpp:929] New master detected at master@172.17.0.4:53067
I0526 15:43:37.656862 27853 slave.cpp:964] Detecting new master
I0526 15:43:37.656872 27842 status_update_manager.cpp:177] Pausing sending status updates
I0526 15:43:37.656941 27853 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 15:43:37.663091 27851 slave.cpp:991] Authenticating with master master@172.17.0.4:53067
I0526 15:43:37.663131 27851 slave.cpp:1002] Using default CRAM-MD5 authenticatee
I0526 15:43:37.663236 27840 authenticatee.cpp:121] Creating new client SASL connection
I0526 15:43:37.663471 27854 master.cpp:7487] Authenticating slave(93)@172.17.0.4:53067
I0526 15:43:37.663548 27848 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(182)@172.17.0.4:53067
I0526 15:43:37.663636 27854 authenticator.cpp:98] Creating new server SASL connection
I0526 15:43:37.663769 27854 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0526 15:43:37.663792 27854 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0526 15:43:37.663861 27854 authenticator.cpp:204] Received SASL authentication start
I0526 15:43:37.663915 27854 authenticator.cpp:326] Authentication requires more steps
I0526 15:43:37.663960 27854 authenticatee.cpp:259] Received SASL authentication step
I0526 15:43:37.664017 27854 authenticator.cpp:232] Received SASL authentication step
I0526 15:43:37.664038 27854 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '601c6ca174d8' server FQDN: '601c6ca174d8' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0526 15:43:37.664127 27854 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0526 15:43:37.664147 27854 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0526 15:43:37.664165 27854 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '601c6ca174d8' server FQDN: '601c6ca174d8' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0526 15:43:37.664181 27854 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0526 15:43:37.664189 27854 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0526 15:43:37.664232 27854 authenticator.cpp:318] Authentication success
I0526 15:43:37.664355 27839 authenticatee.cpp:299] Authentication success
I0526 15:43:37.664366 27854 master.cpp:7517] Successfully authenticated principal 'test-principal' at slave(93)@172.17.0.4:53067
I0526 15:43:37.664413 27844 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(182)@172.17.0.4:53067
I0526 15:43:37.664566 27839 slave.cpp:1086] Successfully authenticated with master master@172.17.0.4:53067
I0526 15:43:37.664726 27839 slave.cpp:1506] Will retry registration in 716485ns if necessary
I0526 15:43:37.664804 27842 master.cpp:5429] Received register agent message from slave(93)@172.17.0.4:53067 (maintenance-host)
I0526 15:43:37.664855 27842 master.cpp:3659] Authorizing agent with principal 'test-principal'
I0526 15:43:37.665035 27848 master.cpp:5489] Authorized registration of agent at slave(93)@172.17.0.4:53067 (maintenance-host)
I0526 15:43:37.665081 27848 master.cpp:5568] Registering agent at slave(93)@172.17.0.4:53067 (maintenance-host) with id 08412d5a-d452-40e0-af2c-5f188b58c317-S0
I0526 15:43:37.665201 27843 registrar.cpp:493] Applied 1 operations in 17368ns; attempting to update the registry
I0526 15:43:37.665380 27848 registrar.cpp:550] Successfully updated the registry in 153088ns
I0526 15:43:37.665447 27853 master.cpp:5615] Admitted agent 08412d5a-d452-40e0-af2c-5f188b58c317-S0 at slave(93)@172.17.0.4:53067 (maintenance-host)
I0526 15:43:37.665603 27846 slave.cpp:4799] Received ping from slave-observer(86)@172.17.0.4:53067
I0526 15:43:37.665632 27853 master.cpp:5646] Registered agent 08412d5a-d452-40e0-af2c-5f188b58c317-S0 at slave(93)@172.17.0.4:53067 (maintenance-host) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 15:43:37.665733 27846 slave.cpp:1132] Registered with master master@172.17.0.4:53067; given agent ID 08412d5a-d452-40e0-af2c-5f188b58c317-S0
I0526 15:43:37.665746 27842 hierarchical.cpp:525] Added agent 08412d5a-d452-40e0-af2c-5f188b58c317-S0 (maintenance-host) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0526 15:43:37.665774 27839 status_update_manager.cpp:184] Resuming sending status updates
I0526 15:43:37.665863 27842 hierarchical.cpp:1854] No allocations performed
I0526 15:43:37.665885 27842 hierarchical.cpp:1438] Performed allocation for 1 agents in 49846ns
I0526 15:43:37.665993 27846 slave.cpp:1152] Checkpointing SlaveInfo to '/tmp/MasterMaintenanceTest_InverseOffersFilters_Il1gZp/meta/slaves/08412d5a-d452-40e0-af2c-5f188b58c317-S0/slave.info'
I0526 15:43:37.666288 27846 slave.cpp:1190] Forwarding total oversubscribed resources {}
I0526 15:43:37.666347 27846 master.cpp:6336] Received update of agent 08412d5a-d452-40e0-af2c-5f188b58c317-S0 at slave(93)@172.17.0.4:53067 (maintenance-host) with total oversubscribed resources {}
I0526 15:43:37.667557 27838 cluster.cpp:448] Creating default 'local' authorizer
I0526 15:43:37.668045 27842 slave.cpp:232] Mesos agent started on (94)@172.17.0.4:53067
I0526 15:43:37.668066 27842 slave.cpp:233] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_executors="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/MasterMaintenanceTest_InverseOffersFilters_GLOMr1/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_reregistration_timeout="2secs" --executor_secret_key="/tmp/MasterMaintenanceTest_InverseOffersFilters_GLOMr1/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/MasterMaintenanceTest_InverseOffersFilters_GLOMr1/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_command_executor="false" --http_credentials="/tmp/MasterMaintenanceTest_InverseOffersFilters_GLOMr1/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/MasterMaintenanceTest_InverseOffersFilters_GLOMr1" --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_UMgGxH"
I0526 15:43:37.668339 27842 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterMaintenanceTest_InverseOffersFilters_GLOMr1/credential'
I0526 15:43:37.668416 27842 slave.cpp:265] Agent using credential for: test-principal
I0526 15:43:37.668427 27842 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterMaintenanceTest_InverseOffersFilters_GLOMr1/http_credentials'
I0526 15:43:37.668530 27842 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0526 15:43:37.668565 27842 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0526 15:43:37.668625 27842 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 15:43:37.668658 27842 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 15:43:37.668733 27842 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 15:43:37.668917 27842 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 15:43:37.669512 27842 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 15:43:37.669546 27842 slave.cpp:544] Agent attributes: [ ]
I0526 15:43:37.669551 27842 slave.cpp:549] Agent hostname: maintenance-host-2
I0526 15:43:37.669615 27844 status_update_manager.cpp:177] Pausing sending status updates
I0526 15:43:37.669936 27854 state.cpp:62] Recovering state from '/tmp/MasterMaintenanceTest_InverseOffersFilters_UMgGxH/meta'
I0526 15:43:37.670085 27849 status_update_manager.cpp:203] Recovering status update manager
I0526 15:43:37.670277 27854 slave.cpp:6073] Finished recovery
I0526 15:43:37.670639 27854 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 15:43:37.670745 27839 status_update_manager.cpp:177] Pausing sending status updates
I0526 15:43:37.670745 27854 slave.cpp:929] New master detected at master@172.17.0.4:53067
I0526 15:43:37.670791 27854 slave.cpp:964] Detecting new master
I0526 15:43:37.670861 27854 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 15:43:37.679078 27851 slave.cpp:991] Authenticating with master master@172.17.0.4:53067
I0526 15:43:37.679106 27851 slave.cpp:1002] Using default CRAM-MD5 authenticatee
I0526 15:43:37.679186 27846 authenticatee.cpp:121] Creating new client SASL connection
I0526 15:43:37.679378 27851 master.cpp:7487] Authenticating slave(94)@172.17.0.4:53067
I0526 15:43:37.679432 27839 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(183)@172.17.0.4:53067
I0526 15:43:37.679532 27852 authenticator.cpp:98] Creating new server SASL connection
I0526 15:43:37.679661 27840 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0526 15:43:37.679683 27840 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0526 15:43:37.679725 27840 authenticator.cpp:204] Received SASL authentication start
I0526 15:43:37.679776 27840 authenticator.cpp:326] Authentication requires more steps
I0526 15:43:37.679823 27840 authenticatee.cpp:259] Received SASL authentication step
I0526 15:43:37.679901 27845 authenticator.cpp:232] Received SASL authentication step
I0526 15:43:37.679924 27845 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '601c6ca174d8' server FQDN: '601c6ca174d8' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0526 15:43:37.679939 27845 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0526 15:43:37.679955 27845 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0526 15:43:37.679970 27845 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '601c6ca174d8' server FQDN: '601c6ca174d8' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0526 15:43:37.679982 27845 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0526 15:43:37.679992 27845 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0526 15:43:37.680011 27845 authenticator.cpp:318] Authentication success
I0526 15:43:37.680064 27841 authenticatee.cpp:299] Authentication success
I0526 15:43:37.680079 27840 master.cpp:7517] Successfully authenticated principal 'test-principal' at slave(94)@172.17.0.4:53067
I0526 15:43:37.680126 27843 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(183)@172.17.0.4:53067
I0526 15:43:37.680208 27841 slave.cpp:1086] Successfully authenticated with master master@172.17.0.4:53067
I0526 15:43:37.680274 27841 slave.cpp:1506] Will retry registration in 3.472396ms if necessary
I0526 15:43:37.680325 27849 master.cpp:5429] Received register agent message from slave(94)@172.17.0.4:53067 (maintenance-host-2)
I0526 15:43:37.680371 27849 master.cpp:3659] Authorizing agent with principal 'test-principal'
I0526 15:43:37.680541 27850 master.cpp:5489] Authorized registration of agent at slave(94)@172.17.0.4:53067 (maintenance-host-2)
I0526 15:43:37.680593 27850 master.cpp:5568] Registering agent at slave(94)@172.17.0.4:53067 (maintenance-host-2) with id 08412d5a-d452-40e0-af2c-5f188b58c317-S1
I0526 15:43:37.680716 27854 registrar.cpp:493] Applied 1 operations in 20835ns; attempting to update the registry
I0526 15:43:37.680913 27854 registrar.cpp:550] Successfully updated the registry in 176896ns
I0526 15:43:37.680969 27841 master.cpp:5615] Admitted agent 08412d5a-d452-40e0-af2c-5f188b58c317-S1 at slave(94)@172.17.0.4:53067 (maintenance-host-2)
I0526 15:43:37.681128 27842 slave.cpp:4799] Received ping from slave-observer(87)@172.17.0.4:53067
I0526 15:43:37.681135 27841 master.cpp:5646] Registered agent 08412d5a-d452-40e0-af2c-5f188b58c317-S1 at slave(94)@172.17.0.4:53067 (maintenance-host-2) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 15:43:37.681247 27842 slave.cpp:1132] Registered with master master@172.17.0.4:53067; given agent ID 08412d5a-d452-40e0-af2c-5f188b58c317-S1
I0526 15:43:37.681319 27844 status_update_manager.cpp:184] Resuming sending status updates
I0526 15:43:37.681329 27839 hierarchical.cpp:525] Added agent 08412d5a-d452-40e0-af2c-5f188b58c317-S1 (maintenance-host-2) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0526 15:43:37.681423 27839 hierarchical.cpp:1854] No allocations performed
I0526 15:43:37.681447 27839 hierarchical.cpp:1438] Performed allocation for 1 agents in 48995ns
I0526 15:43:37.681556 27842 slave.cpp:1152] Checkpointing SlaveInfo to '/tmp/MasterMaintenanceTest_InverseOffersFilters_UMgGxH/meta/slaves/08412d5a-d452-40e0-af2c-5f188b58c317-S1/slave.info'
I0526 15:43:37.681789 27842 slave.cpp:1190] Forwarding total oversubscribed resources {}
I0526 15:43:37.681845 27842 master.cpp:6336] Received update of agent 08412d5a-d452-40e0-af2c-5f188b58c317-S1 at slave(94)@172.17.0.4:53067 (maintenance-host-2) with total oversubscribed resources {}
I0526 15:43:37.682363 27854 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/maintenance/schedule'
I0526 15:43:37.682787 27844 http.cpp:1115] HTTP POST for /master/maintenance/schedule from 172.17.0.4:53031
I0526 15:43:37.683033 27840 registrar.cpp:493] Applied 1 operations in 41564ns; attempting to update the registry
I0526 15:43:37.683226 27845 registrar.cpp:550] Successfully updated the registry in 167936ns
I0526 15:43:37.683346 27844 master.cpp:6398] Updating unavailability of agent 08412d5a-d452-40e0-af2c-5f188b58c317-S0 at slave(93)@172.17.0.4:53067 (maintenance-host), starting at 2478.23700013484weeks
I0526 15:43:37.683413 27844 master.cpp:6398] Updating unavailability of agent 08412d5a-d452-40e0-af2c-5f188b58c317-S1 at slave(94)@172.17.0.4:53067 (maintenance-host-2), starting at 2478.23700013484weeks
I0526 15:43:37.683477 27853 hierarchical.cpp:1854] No allocations performed
I0526 15:43:37.683502 27853 hierarchical.cpp:1438] Performed allocation for 1 agents in 47524ns
I0526 15:43:37.683590 27853 hierarchical.cpp:1854] No allocations performed
I0526 15:43:37.683607 27853 hierarchical.cpp:1438] Performed allocation for 1 agents in 35954ns
I0526 15:43:37.684201 27838 scheduler.cpp:184] Version: 1.4.0
I0526 15:43:37.684465 27853 scheduler.cpp:470] New master detected at master@172.17.0.4:53067
I0526 15:43:37.684481 27853 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0526 15:43:37.684934 27852 scheduler.cpp:361] Connected with the master at http://172.17.0.4:53067/master/api/v1/scheduler
I0526 15:43:37.685575 27845 scheduler.cpp:243] Sending SUBSCRIBE call to http://172.17.0.4:53067/master/api/v1/scheduler
I0526 15:43:37.685946 27845 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0526 15:43:37.686316 27839 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:53033
I0526 15:43:37.686398 27839 master.cpp:2513] Received subscription request for HTTP framework 'default'
I0526 15:43:37.686432 27839 master.cpp:2197] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0526 15:43:37.686599 27843 master.cpp:2628] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I0526 15:43:37.686818 27853 master.hpp:2194] Sending heartbeat to 08412d5a-d452-40e0-af2c-5f188b58c317-0000
I0526 15:43:37.686836 27852 hierarchical.cpp:273] Added framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000
I0526 15:43:37.687247 27840 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from http://172.17.0.4:53067/master/api/v1/scheduler
I0526 15:43:37.687335 27852 hierarchical.cpp:1438] Performed allocation for 2 agents in 432410ns
I0526 15:43:37.687474 27840 scheduler.cpp:676] Enqueuing event HEARTBEAT received from http://172.17.0.4:53067/master/api/v1/scheduler
I0526 15:43:37.687593 27853 master.cpp:7317] Sending 2 offers to framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000 (default)
I0526 15:43:37.687896 27853 master.cpp:7406] Sending 2 inverse offers to framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000 (default)
I0526 15:43:37.688379 27853 scheduler.cpp:676] Enqueuing event OFFERS received from http://172.17.0.4:53067/master/api/v1/scheduler
I0526 15:43:37.688618 27853 scheduler.cpp:676] Enqueuing event INVERSE_OFFERS received from http://172.17.0.4:53067/master/api/v1/scheduler
I0526 15:43:37.695966 27848 hierarchical.cpp:1854] No allocations performed
I0526 15:43:37.696027 27848 hierarchical.cpp:1438] Performed allocation for 2 agents in 95889ns
I0526 15:43:37.696528 27852 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.4:53067/master/api/v1/scheduler
I0526 15:43:37.696738 27852 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.4:53067/master/api/v1/scheduler
I0526 15:43:37.697013 27840 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0526 15:43:37.697355 27847 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0526 15:43:37.697430 27847 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:53032
I0526 15:43:37.697680 27847 master.cpp:3875] Processing ACCEPT call for offers: [ 08412d5a-d452-40e0-af2c-5f188b58c317-O0 ] on agent 08412d5a-d452-40e0-af2c-5f188b58c317-S1 at slave(94)@172.17.0.4:53067 (maintenance-host-2) for framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000 (default)
I0526 15:43:37.697717 27847 master.cpp:3426] Authorizing framework principal 'test-principal' to launch task 7c15dcea-0f46-43b1-b70d-ed24b2336045
W0526 15:43:37.698623 27847 validation.cpp:1284] Executor 'executor-1' for task '7c15dcea-0f46-43b1-b70d-ed24b2336045' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0526 15:43:37.698649 27847 validation.cpp:1296] Executor 'executor-1' for task '7c15dcea-0f46-43b1-b70d-ed24b2336045' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0526 15:43:37.698776 27847 master.cpp:9338] Adding task 7c15dcea-0f46-43b1-b70d-ed24b2336045 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 08412d5a-d452-40e0-af2c-5f188b58c317-S1 at slave(94)@172.17.0.4:53067 (maintenance-host-2)
I0526 15:43:37.698925 27847 master.cpp:4531] Launching task 7c15dcea-0f46-43b1-b70d-ed24b2336045 of framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000 (default) with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 08412d5a-d452-40e0-af2c-5f188b58c317-S1 at slave(94)@172.17.0.4:53067 (maintenance-host-2)
I0526 15:43:37.699125 27851 slave.cpp:1616] Got assigned task '7c15dcea-0f46-43b1-b70d-ed24b2336045' for framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000
I0526 15:43:37.699209 27848 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:53032
I0526 15:43:37.699470 27851 slave.cpp:1897] Authorizing task '7c15dcea-0f46-43b1-b70d-ed24b2336045' for framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000
I0526 15:43:37.699470 27848 master.cpp:3875] Processing ACCEPT call for offers: [ 08412d5a-d452-40e0-af2c-5f188b58c317-O1 ] on agent 08412d5a-d452-40e0-af2c-5f188b58c317-S0 at slave(93)@172.17.0.4:53067 (maintenance-host) for framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000 (default)
I0526 15:43:37.699496 27851 slave.cpp:6692] Authorizing framework principal 'test-principal' to launch task 7c15dcea-0f46-43b1-b70d-ed24b2336045
I0526 15:43:37.699501 27848 master.cpp:3426] Authorizing framework principal 'test-principal' to launch task a542dfee-9394-42c1-9055-421cb1956c25
I0526 15:43:37.699704 27846 hierarchical.cpp:850] Updated allocation of framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000 on agent 08412d5a-d452-40e0-af2c-5f188b58c317-S1 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]
I0526 15:43:37.700093 27840 slave.cpp:2084] Launching task '7c15dcea-0f46-43b1-b70d-ed24b2336045' for framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000
W0526 15:43:37.700186 27842 validation.cpp:1284] Executor 'executor-2' for task 'a542dfee-9394-42c1-9055-421cb1956c25' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0526 15:43:37.700217 27842 validation.cpp:1296] Executor 'executor-2' for task 'a542dfee-9394-42c1-9055-421cb1956c25' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0526 15:43:37.700376 27842 master.cpp:9338] Adding task a542dfee-9394-42c1-9055-421cb1956c25 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 08412d5a-d452-40e0-af2c-5f188b58c317-S0 at slave(93)@172.17.0.4:53067 (maintenance-host)
I0526 15:43:37.700500 27842 master.cpp:4531] Launching task a542dfee-9394-42c1-9055-421cb1956c25 of framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000 (default) with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 08412d5a-d452-40e0-af2c-5f188b58c317-S0 at slave(93)@172.17.0.4:53067 (maintenance-host)
I0526 15:43:37.700685 27850 slave.cpp:1616] Got assigned task 'a542dfee-9394-42c1-9055-421cb1956c25' for framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000
I0526 15:43:37.700726 27840 paths.cpp:573] Trying to chown '/tmp/MasterMaintenanceTest_InverseOffersFilters_UMgGxH/slaves/08412d5a-d452-40e0-af2c-5f188b58c317-S1/frameworks/08412d5a-d452-40e0-af2c-5f188b58c317-0000/executors/executor-1/runs/bf694ffc-7783-4305-b5af-5e4532682a68' to user 'mesos'
I0526 15:43:37.700901 27840 slave.cpp:7032] Launching executor 'executor-1' of framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000 with resources {} in work directory '/tmp/MasterMaintenanceTest_InverseOffersFilters_UMgGxH/slaves/08412d5a-d452-40e0-af2c-5f188b58c317-S1/frameworks/08412d5a-d452-40e0-af2c-5f188b58c317-0000/executors/executor-1/runs/bf694ffc-7783-4305-b5af-5e4532682a68'
I0526 15:43:37.700976 27850 slave.cpp:1897] Authorizing task 'a542dfee-9394-42c1-9055-421cb1956c25' for framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000
I0526 15:43:37.701025 27850 slave.cpp:6692] Authorizing framework principal 'test-principal' to launch task a542dfee-9394-42c1-9055-421cb1956c25
I0526 15:43:37.701103 27839 hierarchical.cpp:850] Updated allocation of framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000 on agent 08412d5a-d452-40e0-af2c-5f188b58c317-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]
I0526 15:43:37.701201 27840 slave.cpp:2313] Queued task '7c15dcea-0f46-43b1-b70d-ed24b2336045' for executor 'executor-1' of framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000
I0526 15:43:37.701248 27840 slave.cpp:882] Successfully attached file '/tmp/MasterMaintenanceTest_InverseOffersFilters_UMgGxH/slaves/08412d5a-d452-40e0-af2c-5f188b58c317-S1/frameworks/08412d5a-d452-40e0-af2c-5f188b58c317-0000/executors/executor-1/runs/bf694ffc-7783-4305-b5af-5e4532682a68'
I0526 15:43:37.701333 27845 slave.cpp:2084] Launching task 'a542dfee-9394-42c1-9055-421cb1956c25' for framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000
I0526 15:43:37.701367 27840 slave.cpp:2779] Launching container bf694ffc-7783-4305-b5af-5e4532682a68 for executor 'executor-1' of framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000
I0526 15:43:37.701756 27845 paths.cpp:573] Trying to chown '/tmp/MasterMaintenanceTest_InverseOffersFilters_Il1gZp/slaves/08412d5a-d452-40e0-af2c-5f188b58c317-S0/frameworks/08412d5a-d452-40e0-af2c-5f188b58c317-0000/executors/executor-2/runs/3d4398b2-b654-42be-9ab1-9fc0c83bbe57' to user 'mesos'
I0526 15:43:37.701890 27845 slave.cpp:7032] Launching executor 'executor-2' of framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000 with resources {} in work directory '/tmp/MasterMaintenanceTest_InverseOffersFilters_Il1gZp/slaves/08412d5a-d452-40e0-af2c-5f188b58c317-S0/frameworks/08412d5a-d452-40e0-af2c-5f188b58c317-0000/executors/executor-2/runs/3d4398b2-b654-42be-9ab1-9fc0c83bbe57'
I0526 15:43:37.702085 27845 slave.cpp:2313] Queued task 'a542dfee-9394-42c1-9055-421cb1956c25' for executor 'executor-2' of framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000
I0526 15:43:37.702121 27845 slave.cpp:882] Successfully attached file '/tmp/MasterMaintenanceTest_InverseOffersFilters_Il1gZp/slaves/08412d5a-d452-40e0-af2c-5f188b58c317-S0/frameworks/08412d5a-d452-40e0-af2c-5f188b58c317-0000/executors/executor-2/runs/3d4398b2-b654-42be-9ab1-9fc0c83bbe57'
*** Aborted at 1495813417 (unix time) try "date -d @1495813417" if you are using GNU date ***
I0526 15:43:37.702374 27850 exec.cpp:162] Version: 1.4.0
I0526 15:43:37.702438 27846 exec.cpp:212] Executor started at: executor(28)@172.17.0.4:53067 with pid 27838
PC: @ 0x2b8d39d5b82d (unknown)
I0526 15:43:37.702512 27846 slave.cpp:3809] Got registration for executor 'executor-1' of framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000 from executor(28)@172.17.0.4:53067
*** SIGSEGV (@0xa0) received by PID 27838 (TID 0x2b8d42b02700) from PID 160; stack trace: ***
I0526 15:43:37.702635 27848 exec.cpp:237] Executor registered on agent 08412d5a-d452-40e0-af2c-5f188b58c317-S1
I0526 15:43:37.702677 27848 exec.cpp:249] Executor::registered took 30172ns
@ 0x2b8d392f2330 (unknown)
I0526 15:43:37.702864 27846 slave.cpp:2526] Sending queued task '7c15dcea-0f46-43b1-b70d-ed24b2336045' to executor 'executor-1' of framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000 at executor(28)@172.17.0.4:53067
I0526 15:43:37.702996 27843 exec.cpp:325] Executor asked to run task '7c15dcea-0f46-43b1-b70d-ed24b2336045'
@ 0x2b8d39d5b82d (unknown)
I0526 15:43:37.703037 27843 exec.cpp:334] Executor::launchTask took 26676ns
I0526 15:43:37.703114 27843 exec.cpp:551] Executor sending status update TASK_RUNNING (UUID: df17974f-5b21-4565-a614-aed593835c5b) for task 7c15dcea-0f46-43b1-b70d-ed24b2336045 of framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000
I0526 15:43:37.703225 27852 slave.cpp:4269] Handling status update TASK_RUNNING (UUID: df17974f-5b21-4565-a614-aed593835c5b) for task 7c15dcea-0f46-43b1-b70d-ed24b2336045 of framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000 from executor(28)@172.17.0.4:53067
I0526 15:43:37.703477 27854 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: df17974f-5b21-4565-a614-aed593835c5b) for task 7c15dcea-0f46-43b1-b70d-ed24b2336045 of framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000
I0526 15:43:37.703505 27854 status_update_manager.cpp:500] Creating StatusUpdate stream for task 7c15dcea-0f46-43b1-b70d-ed24b2336045 of framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000
I0526 15:43:37.703640 27854 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: df17974f-5b21-4565-a614-aed593835c5b) for task 7c15dcea-0f46-43b1-b70d-ed24b2336045 of framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000 to the agent
I0526 15:43:37.703722 27843 slave.cpp:4709] Forwarding the update TASK_RUNNING (UUID: df17974f-5b21-4565-a614-aed593835c5b) for task 7c15dcea-0f46-43b1-b70d-ed24b2336045 of framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000 to master@172.17.0.4:53067
I0526 15:43:37.703794 27843 slave.cpp:4603] Status update manager successfully handled status update TASK_RUNNING (UUID: df17974f-5b21-4565-a614-aed593835c5b) for task 7c15dcea-0f46-43b1-b70d-ed24b2336045 of framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000
I0526 15:43:37.703819 27843 slave.cpp:4619] Sending acknowledgement for status update TASK_RUNNING (UUID: df17974f-5b21-4565-a614-aed593835c5b) for task 7c15dcea-0f46-43b1-b70d-ed24b2336045 of framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000 to executor(28)@172.17.0.4:53067
I0526 15:43:37.703855 27852 master.cpp:6481] Status update TASK_RUNNING (UUID: df17974f-5b21-4565-a614-aed593835c5b) for task 7c15dcea-0f46-43b1-b70d-ed24b2336045 of framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000 from agent 08412d5a-d452-40e0-af2c-5f188b58c317-S1 at slave(94)@172.17.0.4:53067 (maintenance-host-2)
I0526 15:43:37.703886 27852 master.cpp:6549] Forwarding status update TASK_RUNNING (UUID: df17974f-5b21-4565-a614-aed593835c5b) for task 7c15dcea-0f46-43b1-b70d-ed24b2336045 of framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000
I0526 15:43:37.703889 27846 exec.cpp:374] Executor received status update acknowledgement df17974f-5b21-4565-a614-aed593835c5b for task 7c15dcea-0f46-43b1-b70d-ed24b2336045 of framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000
I0526 15:43:37.704005 27852 master.cpp:8580] Updating the state of task 7c15dcea-0f46-43b1-b70d-ed24b2336045 of framework 08412d5a-d452-40e0-af2c-5f188b58c317-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0526 15:43:37.704308 27848 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.4:53067/master/api/v1/scheduler
@ 0x2b8d3629c394 mesos::internal::slave::executorEnvironment()
@ 0x2b8d362c33ba mesos::internal::slave::Slave::launchExecutor()
@ 0x2b8d3766ea01 process::ProcessManager::resume()
@ 0x2b8d37677de7 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv
@ 0x2b8d395b1a60 (unknown)
I0526 15:43:37.707036 27843 scheduler.cpp:243] Sending ACKNOWLEDGE call to http://172.17.0.4:53067/master/api/v1/scheduler
@ 0x2b8d392ea184 start_thread
@ 0x2b8d39e1dbed (unknown)
I0526 15:43:37.707449 27848 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
make[3]: *** [CMakeFiles/check] Segmentation fault
make[3]: Leaving directory `/mesos/build'
make[2]: Leaving directory `/mesos/build'
make[2]: *** [CMakeFiles/check.dir/all] Error 2
make[1]: *** [CMakeFiles/check.dir/rule] Error 2
make[1]: Leaving directory `/mesos/build'
make: *** [check] Error 2
+ docker rmi mesos-1495810228-29905
Untagged: mesos-1495810228-29905:latest
Deleted: sha256:bcc5403cbc7e1cda91951b90e6070e5eb0762216c1fd56a2d48555c15de7147a
Deleted: sha256:8debbe3ed28c470b2082a5f150af85a2c5fbd5321afdd3b3ec7819b73c854e60
Deleted: sha256:a7dbbd9f3abc159bea82c5c6eaa3b0dbcde5cd2aaefd452752698ad283cbb63f
Deleted: sha256:4301a1dde841289d3e7b4c310ff8598674a85b6564e8ee35bb6465efb7bd3d9e
Deleted: sha256:edf13df1df9a662c56279bf0cec9a202b20e6c39b7f9ee92bdb6633ebc3aa3be
Deleted: sha256:df9e2fec9c2fa2d9214c7fbbd8129ba55b775031f4b773f0adf3ff4c078dabd1
Deleted: sha256:e95df5f50c729f50e885f8cf5a269d1b22f560237f4d58964b568f934b322d30
Deleted: sha256:1abd744cdea2ceee899347139c95425a7754864a03e3c36eef830709d7488c9e
Deleted: sha256:f1699a2618248427fd36a4039e0dc711702e02c9cfcee7df1a9cb606dcb933ad
Deleted: sha256:afb9dab8370542e6c00c1f900c62e8f19ff2eb9f326a2dcc91ec343c9d119f61
Deleted: sha256:823ddb5f08b2d3301be89faa034b4dc1c5157e10c8fbf0ceaac037449bcee324
Deleted: sha256:960d8069b3097b04979ab873e172f7ace0b517844653b6a2b8f25c7ac80e3693
Deleted: sha256:25c6a2a7caca71ae2188496d573fc76ffb0986616614a79fb6d592195c709093
Deleted: sha256:2a7626531892bfcbb7606628240b949ed34abb1fd81555ad3064ec80988ff153
Deleted: sha256:cfc875000fd4e773a21cafa89d8c57eacd10872e391a9dff33398ad4b2baefbd
Deleted: sha256:ffd191691c68645b64b3ae9bebcd8dcddeb9fec6be2331dcaddac85198ea1364
Deleted: sha256:8d92ecb4db87dc07be1d9ec18e807fbad42e5691633d71a48d8ae629b66000fe
Deleted: sha256:d2a51f11eab836e6f0eeb364c03749b92f40c5f77f3ae7cdebe367f6b11a817b
Deleted: sha256:08abd27b6949f7cf438f9b1f304a25d5c33f1e5b2eb08bd421daec8d6e6be8bf
Deleted: sha256:e9845fa5b06145ec16e51a4fec01645c36954aecb436783bc34662d084befa8f
Deleted: sha256:0071ee2cad1e7103af8402f36de2be97725dc58c3594cf01d6ca62a8cabeb794
Deleted: sha256:534c01b5a94ab843e20380395f484ed7b58e0842cbfbb9fcd5b6af322681ab24
Deleted: sha256:96e880cdb5f67812097215b94084f9a26f665ee5bb7c184ab5d3bb72928325c5
Deleted: sha256:814675951764776d692cf4f44ba5b456d94dcb3d1540bba82dd6ea025bd5679e
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos-Buildbot » cmake,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3730
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3730/display/redirect?page=changes>