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/13 02:08:41 UTC
Build failed in Jenkins: Mesos-Buildbot » cmake,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3675
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)/3675/display/redirect?page=changes>
Changes:
[vinodkone] Fixed a fd-related build on Windows.
[neil.conway] Added missing `constexpr` to Days constructors in stout.
------------------------------------------
[...truncated 23.24 MB...]
I0513 02:08:28.217921 24451 slave.cpp:5172] Executor 'E' of framework 884c687b-e30c-4c30-8ba8-c06d89fee798-0000 terminated with signal Killed
I0513 02:08:28.217993 24451 slave.cpp:5272] Cleaning up executor 'E' of framework 884c687b-e30c-4c30-8ba8-c06d89fee798-0000 (via HTTP)
W0513 02:08:28.218101 24450 master.cpp:6592] Ignoring unknown exited executor 'E' of framework 884c687b-e30c-4c30-8ba8-c06d89fee798-0000 on agent 884c687b-e30c-4c30-8ba8-c06d89fee798-S0 at slave(686)@172.17.0.2:34673 (4f846f2193c3)
I0513 02:08:28.218175 24445 gc.cpp:55] Scheduling '/tmp/ContentType_SchedulerTest_TaskGroupRunning_1_YbVUKA/slaves/884c687b-e30c-4c30-8ba8-c06d89fee798-S0/frameworks/884c687b-e30c-4c30-8ba8-c06d89fee798-0000/executors/E/runs/d93b698e-cdb4-4c91-a01a-cab08738af52' for gc 6.9999974756237days in the future
I0513 02:08:28.218224 24451 slave.cpp:5360] Cleaning up framework 884c687b-e30c-4c30-8ba8-c06d89fee798-0000
I0513 02:08:28.218238 24445 gc.cpp:55] Scheduling '/tmp/ContentType_SchedulerTest_TaskGroupRunning_1_YbVUKA/slaves/884c687b-e30c-4c30-8ba8-c06d89fee798-S0/frameworks/884c687b-e30c-4c30-8ba8-c06d89fee798-0000/executors/E' for gc 6.9999974744563days in the future
I0513 02:08:28.218447 24454 status_update_manager.cpp:285] Closing status update streams for framework 884c687b-e30c-4c30-8ba8-c06d89fee798-0000
I0513 02:08:28.218479 24454 status_update_manager.cpp:531] Cleaning up status update stream for task 2 of framework 884c687b-e30c-4c30-8ba8-c06d89fee798-0000
I0513 02:08:28.218582 24454 status_update_manager.cpp:531] Cleaning up status update stream for task 1 of framework 884c687b-e30c-4c30-8ba8-c06d89fee798-0000
I0513 02:08:28.219089 24448 gc.cpp:55] Scheduling '/tmp/ContentType_SchedulerTest_TaskGroupRunning_1_YbVUKA/slaves/884c687b-e30c-4c30-8ba8-c06d89fee798-S0/frameworks/884c687b-e30c-4c30-8ba8-c06d89fee798-0000' for gc 6.99999747244148days in the future
I0513 02:08:28.219239 24438 slave.cpp:794] Agent terminating
I0513 02:08:28.219395 24446 master.cpp:1313] Agent 884c687b-e30c-4c30-8ba8-c06d89fee798-S0 at slave(686)@172.17.0.2:34673 (4f846f2193c3) disconnected
I0513 02:08:28.219413 24446 master.cpp:3197] Disconnecting agent 884c687b-e30c-4c30-8ba8-c06d89fee798-S0 at slave(686)@172.17.0.2:34673 (4f846f2193c3)
I0513 02:08:28.219435 24446 master.cpp:3216] Deactivating agent 884c687b-e30c-4c30-8ba8-c06d89fee798-S0 at slave(686)@172.17.0.2:34673 (4f846f2193c3)
I0513 02:08:28.219506 24451 hierarchical.cpp:653] Agent 884c687b-e30c-4c30-8ba8-c06d89fee798-S0 deactivated
I0513 02:08:28.222036 24438 master.cpp:1155] Master terminating
I0513 02:08:28.222280 24451 hierarchical.cpp:558] Removed agent 884c687b-e30c-4c30-8ba8-c06d89fee798-S0
[ OK ] ContentType/SchedulerTest.TaskGroupRunning/1 (400 ms)
[ RUN ] ContentType/SchedulerTest.ReconcileTask/0
I0513 02:08:28.227272 24438 cluster.cpp:162] Creating default 'local' authorizer
I0513 02:08:28.228962 24439 master.cpp:436] Master 3000801d-b601-4e0d-93d5-b27412b09f70 (4f846f2193c3) started on 172.17.0.2:34673
I0513 02:08:28.228987 24439 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="true" --authenticate_http_frameworks="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/wgsQym/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/wgsQym/master" --zk_session_timeout="10secs"
I0513 02:08:28.229172 24439 master.cpp:488] Master only allowing authenticated frameworks to register
I0513 02:08:28.229187 24439 master.cpp:502] Master only allowing authenticated agents to register
I0513 02:08:28.229192 24439 master.cpp:515] Master only allowing authenticated HTTP frameworks to register
I0513 02:08:28.229199 24439 credentials.hpp:37] Loading credentials for authentication from '/tmp/wgsQym/credentials'
I0513 02:08:28.229359 24439 master.cpp:560] Using default 'crammd5' authenticator
I0513 02:08:28.229429 24439 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0513 02:08:28.229517 24439 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0513 02:08:28.229562 24439 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0513 02:08:28.229619 24439 master.cpp:640] Authorization enabled
I0513 02:08:28.229698 24451 whitelist_watcher.cpp:77] No whitelist given
I0513 02:08:28.229725 24441 hierarchical.cpp:158] Initialized hierarchical allocator process
I0513 02:08:28.230562 24444 master.cpp:2161] Elected as the leading master!
I0513 02:08:28.230578 24444 master.cpp:1700] Recovering from registrar
I0513 02:08:28.230659 24444 registrar.cpp:345] Recovering registrar
I0513 02:08:28.230948 24441 registrar.cpp:389] Successfully fetched the registry (0B) in 250112ns
I0513 02:08:28.231020 24441 registrar.cpp:493] Applied 1 operations in 7354ns; attempting to update the registry
I0513 02:08:28.231744 24441 registrar.cpp:550] Successfully updated the registry in 694016ns
I0513 02:08:28.231791 24441 registrar.cpp:422] Successfully recovered registrar
I0513 02:08:28.232136 24453 hierarchical.cpp:185] Skipping recovery of hierarchical allocator: nothing to recover
I0513 02:08:28.232131 24440 master.cpp:1799] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0513 02:08:28.234931 24438 cluster.cpp:448] Creating default 'local' authorizer
I0513 02:08:28.235652 24448 slave.cpp:225] Mesos agent started on (687)@172.17.0.2:34673
I0513 02:08:28.235676 24448 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/ContentType_SchedulerTest_ReconcileTask_0_IsOABl/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/ContentType_SchedulerTest_ReconcileTask_0_IsOABl/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/ContentType_SchedulerTest_ReconcileTask_0_IsOABl/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/ContentType_SchedulerTest_ReconcileTask_0_IsOABl" --sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true" --systemd_enable_support="true" --systemd_runtime_directory="/run/systemd/system" --version="false" --work_dir="/tmp/ContentType_SchedulerTest_ReconcileTask_0_ScPc5l"
I0513 02:08:28.235918 24448 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentType_SchedulerTest_ReconcileTask_0_IsOABl/credential'
I0513 02:08:28.235942 24438 scheduler.cpp:184] Version: 1.4.0
I0513 02:08:28.236021 24448 slave.cpp:258] Agent using credential for: test-principal
I0513 02:08:28.236049 24448 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentType_SchedulerTest_ReconcileTask_0_IsOABl/http_credentials'
I0513 02:08:28.236183 24448 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0513 02:08:28.236249 24448 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0513 02:08:28.236712 24439 scheduler.cpp:470] New master detected at master@172.17.0.2:34673
I0513 02:08:28.236732 24439 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0513 02:08:28.236995 24448 slave.cpp:529] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0513 02:08:28.237030 24448 slave.cpp:537] Agent attributes: [ ]
I0513 02:08:28.237038 24448 slave.cpp:542] Agent hostname: 4f846f2193c3
I0513 02:08:28.237139 24452 status_update_manager.cpp:177] Pausing sending status updates
I0513 02:08:28.237535 24454 state.cpp:62] Recovering state from '/tmp/ContentType_SchedulerTest_ReconcileTask_0_ScPc5l/meta'
I0513 02:08:28.237730 24444 status_update_manager.cpp:203] Recovering status update manager
I0513 02:08:28.237855 24454 slave.cpp:5974] Finished recovery
I0513 02:08:28.238296 24454 slave.cpp:6156] Querying resource estimator for oversubscribable resources
I0513 02:08:28.238422 24452 scheduler.cpp:361] Connected with the master at http://172.17.0.2:34673/master/api/v1/scheduler
I0513 02:08:28.238456 24454 status_update_manager.cpp:177] Pausing sending status updates
I0513 02:08:28.238466 24442 slave.cpp:922] New master detected at master@172.17.0.2:34673
I0513 02:08:28.238523 24442 slave.cpp:957] Detecting new master
I0513 02:08:28.238641 24442 slave.cpp:6170] Received oversubscribable resources {} from the resource estimator
I0513 02:08:28.239097 24446 scheduler.cpp:243] Sending SUBSCRIBE call to http://172.17.0.2:34673/master/api/v1/scheduler
I0513 02:08:28.239559 24441 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0513 02:08:28.240067 24440 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:49169
I0513 02:08:28.240141 24440 master.cpp:2513] Received subscription request for HTTP framework 'default'
I0513 02:08:28.240165 24440 master.cpp:2197] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0513 02:08:28.240396 24452 master.cpp:2628] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I0513 02:08:28.240659 24451 hierarchical.cpp:273] Added framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000
I0513 02:08:28.240705 24451 hierarchical.cpp:1850] No allocations performed
I0513 02:08:28.240723 24451 hierarchical.cpp:1940] No inverse offers to send out!
I0513 02:08:28.240738 24451 hierarchical.cpp:1434] Performed allocation for 0 agents in 39956ns
I0513 02:08:28.240949 24450 master.hpp:2194] Sending heartbeat to 3000801d-b601-4e0d-93d5-b27412b09f70-0000
I0513 02:08:28.241241 24444 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from http://172.17.0.2:34673/master/api/v1/scheduler
I0513 02:08:28.241435 24444 scheduler.cpp:676] Enqueuing event HEARTBEAT received from http://172.17.0.2:34673/master/api/v1/scheduler
I0513 02:08:28.243455 24443 slave.cpp:984] Authenticating with master master@172.17.0.2:34673
I0513 02:08:28.243484 24443 slave.cpp:995] Using default CRAM-MD5 authenticatee
I0513 02:08:28.243571 24453 authenticatee.cpp:121] Creating new client SASL connection
I0513 02:08:28.243839 24452 master.cpp:7475] Authenticating slave(687)@172.17.0.2:34673
I0513 02:08:28.243901 24453 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1284)@172.17.0.2:34673
I0513 02:08:28.244082 24452 authenticator.cpp:98] Creating new server SASL connection
I0513 02:08:28.244272 24445 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0513 02:08:28.244328 24445 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0513 02:08:28.244467 24439 authenticator.cpp:204] Received SASL authentication start
I0513 02:08:28.244580 24439 authenticator.cpp:326] Authentication requires more steps
I0513 02:08:28.244634 24439 authenticatee.cpp:259] Received SASL authentication step
I0513 02:08:28.244698 24439 authenticator.cpp:232] Received SASL authentication step
I0513 02:08:28.244724 24439 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '4f846f2193c3' server FQDN: '4f846f2193c3' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0513 02:08:28.244740 24439 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0513 02:08:28.244758 24439 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0513 02:08:28.244776 24439 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '4f846f2193c3' server FQDN: '4f846f2193c3' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0513 02:08:28.244787 24439 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0513 02:08:28.244796 24439 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0513 02:08:28.244812 24439 authenticator.cpp:318] Authentication success
I0513 02:08:28.244899 24439 authenticatee.cpp:299] Authentication success
I0513 02:08:28.244940 24439 master.cpp:7505] Successfully authenticated principal 'test-principal' at slave(687)@172.17.0.2:34673
I0513 02:08:28.245043 24449 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1284)@172.17.0.2:34673
I0513 02:08:28.245052 24439 slave.cpp:1079] Successfully authenticated with master master@172.17.0.2:34673
I0513 02:08:28.245198 24439 slave.cpp:1507] Will retry registration in 19.215959ms if necessary
I0513 02:08:28.245261 24441 master.cpp:5429] Received register agent message from slave(687)@172.17.0.2:34673 (4f846f2193c3)
I0513 02:08:28.245306 24441 master.cpp:3659] Authorizing agent with principal 'test-principal'
I0513 02:08:28.245501 24441 master.cpp:5564] Registering agent at slave(687)@172.17.0.2:34673 (4f846f2193c3) with id 3000801d-b601-4e0d-93d5-b27412b09f70-S0
I0513 02:08:28.245636 24442 registrar.cpp:493] Applied 1 operations in 19281ns; attempting to update the registry
I0513 02:08:28.245867 24442 registrar.cpp:550] Successfully updated the registry in 205056ns
I0513 02:08:28.246120 24442 slave.cpp:4749] Received ping from slave-observer(619)@172.17.0.2:34673
I0513 02:08:28.246306 24450 slave.cpp:1125] Registered with master master@172.17.0.2:34673; given agent ID 3000801d-b601-4e0d-93d5-b27412b09f70-S0
I0513 02:08:28.246327 24450 fetcher.cpp:94] Clearing fetcher cache
I0513 02:08:28.246320 24442 hierarchical.cpp:525] Added agent 3000801d-b601-4e0d-93d5-b27412b09f70-S0 (4f846f2193c3) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0513 02:08:28.246455 24453 status_update_manager.cpp:184] Resuming sending status updates
I0513 02:08:28.246284 24445 master.cpp:5639] Registered agent 3000801d-b601-4e0d-93d5-b27412b09f70-S0 at slave(687)@172.17.0.2:34673 (4f846f2193c3) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0513 02:08:28.246757 24450 slave.cpp:1153] Checkpointing SlaveInfo to '/tmp/ContentType_SchedulerTest_ReconcileTask_0_ScPc5l/meta/slaves/3000801d-b601-4e0d-93d5-b27412b09f70-S0/slave.info'
I0513 02:08:28.246819 24442 hierarchical.cpp:1940] No inverse offers to send out!
I0513 02:08:28.247117 24444 master.cpp:7305] Sending 1 offers to framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 (default)
I0513 02:08:28.247145 24450 slave.cpp:1191] Forwarding total oversubscribed resources {}
I0513 02:08:28.247397 24444 master.cpp:6324] Received update of agent 3000801d-b601-4e0d-93d5-b27412b09f70-S0 at slave(687)@172.17.0.2:34673 (4f846f2193c3) with total oversubscribed resources {}
I0513 02:08:28.247668 24442 hierarchical.cpp:1434] Performed allocation for 1 agents in 456487ns
I0513 02:08:28.247835 24451 scheduler.cpp:676] Enqueuing event OFFERS received from http://172.17.0.2:34673/master/api/v1/scheduler
I0513 02:08:28.248816 24448 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.2:34673/master/api/v1/scheduler
I0513 02:08:28.249225 24449 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0513 02:08:28.249733 24439 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:49168
I0513 02:08:28.250025 24439 master.cpp:3875] Processing ACCEPT call for offers: [ 3000801d-b601-4e0d-93d5-b27412b09f70-O0 ] on agent 3000801d-b601-4e0d-93d5-b27412b09f70-S0 at slave(687)@172.17.0.2:34673 (4f846f2193c3) for framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 (default)
I0513 02:08:28.250072 24439 master.cpp:3426] Authorizing framework principal 'test-principal' to launch task b446eb87-bf68-4cae-9040-92fdbc3c0971
W0513 02:08:28.250849 24451 validation.cpp:1284] Executor 'default' for task 'b446eb87-bf68-4cae-9040-92fdbc3c0971' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0513 02:08:28.250876 24451 validation.cpp:1296] Executor 'default' for task 'b446eb87-bf68-4cae-9040-92fdbc3c0971' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0513 02:08:28.251013 24451 master.cpp:9326] Adding task b446eb87-bf68-4cae-9040-92fdbc3c0971 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 3000801d-b601-4e0d-93d5-b27412b09f70-S0 at slave(687)@172.17.0.2:34673 (4f846f2193c3)
I0513 02:08:28.251111 24451 master.cpp:4531] Launching task b446eb87-bf68-4cae-9040-92fdbc3c0971 of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 (default) with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 3000801d-b601-4e0d-93d5-b27412b09f70-S0 at slave(687)@172.17.0.2:34673 (4f846f2193c3)
I0513 02:08:28.251305 24453 slave.cpp:1617] Got assigned task 'b446eb87-bf68-4cae-9040-92fdbc3c0971' for framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000
I0513 02:08:28.251663 24453 slave.cpp:1898] Authorizing task 'b446eb87-bf68-4cae-9040-92fdbc3c0971' for framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000
I0513 02:08:28.251690 24453 slave.cpp:6593] Authorizing framework principal 'test-principal' to launch task b446eb87-bf68-4cae-9040-92fdbc3c0971
I0513 02:08:28.251946 24451 hierarchical.cpp:850] Updated allocation of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 on agent 3000801d-b601-4e0d-93d5-b27412b09f70-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]
I0513 02:08:28.252063 24451 slave.cpp:2085] Launching task 'b446eb87-bf68-4cae-9040-92fdbc3c0971' for framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000
I0513 02:08:28.252540 24451 paths.cpp:573] Trying to chown '/tmp/ContentType_SchedulerTest_ReconcileTask_0_ScPc5l/slaves/3000801d-b601-4e0d-93d5-b27412b09f70-S0/frameworks/3000801d-b601-4e0d-93d5-b27412b09f70-0000/executors/default/runs/24d6ba11-87d6-4887-92f3-997cd87a1e54' to user 'mesos'
I0513 02:08:28.252720 24451 slave.cpp:6933] Launching executor 'default' of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 with resources {} in work directory '/tmp/ContentType_SchedulerTest_ReconcileTask_0_ScPc5l/slaves/3000801d-b601-4e0d-93d5-b27412b09f70-S0/frameworks/3000801d-b601-4e0d-93d5-b27412b09f70-0000/executors/default/runs/24d6ba11-87d6-4887-92f3-997cd87a1e54'
I0513 02:08:28.252996 24451 slave.cpp:2314] Queued task 'b446eb87-bf68-4cae-9040-92fdbc3c0971' for executor 'default' of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000
I0513 02:08:28.253044 24451 slave.cpp:875] Successfully attached file '/tmp/ContentType_SchedulerTest_ReconcileTask_0_ScPc5l/slaves/3000801d-b601-4e0d-93d5-b27412b09f70-S0/frameworks/3000801d-b601-4e0d-93d5-b27412b09f70-0000/executors/default/runs/24d6ba11-87d6-4887-92f3-997cd87a1e54'
I0513 02:08:28.253811 24453 executor.cpp:192] Version: 1.4.0
I0513 02:08:28.254464 24453 executor.cpp:410] Connected with the agent
I0513 02:08:28.254822 24440 executor.cpp:307] Sending SUBSCRIBE call to http://172.17.0.2:34673/slave(687)/api/v1/executor
I0513 02:08:28.255332 24450 process.cpp:3730] Handling HTTP event for process 'slave(687)' with path: '/slave(687)/api/v1/executor'
I0513 02:08:28.255707 24450 http.cpp:1115] HTTP POST for /slave(687)/api/v1/executor from 172.17.0.2:49170
I0513 02:08:28.255782 24450 slave.cpp:3572] Received Subscribe request for HTTP executor 'default' of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000
I0513 02:08:28.256203 24453 slave.cpp:2527] Sending queued task 'b446eb87-bf68-4cae-9040-92fdbc3c0971' to executor 'default' of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 (via HTTP)
I0513 02:08:28.256784 24440 executor.cpp:725] Enqueuing event SUBSCRIBED received from http://172.17.0.2:34673/slave(687)/api/v1/executor
I0513 02:08:28.257256 24453 executor.cpp:725] Enqueuing event LAUNCH received from http://172.17.0.2:34673/slave(687)/api/v1/executor
I0513 02:08:28.257647 24450 executor.cpp:307] Sending UPDATE call to http://172.17.0.2:34673/slave(687)/api/v1/executor
I0513 02:08:28.258014 24451 process.cpp:3730] Handling HTTP event for process 'slave(687)' with path: '/slave(687)/api/v1/executor'
I0513 02:08:28.258352 24450 http.cpp:1115] HTTP POST for /slave(687)/api/v1/executor from 172.17.0.2:49171
I0513 02:08:28.258412 24450 slave.cpp:4219] Handling status update TASK_RUNNING (UUID: d4b740f6-6d8b-402f-9f3e-9f6d49b97653) for task b446eb87-bf68-4cae-9040-92fdbc3c0971 of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000
I0513 02:08:28.258730 24449 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: d4b740f6-6d8b-402f-9f3e-9f6d49b97653) for task b446eb87-bf68-4cae-9040-92fdbc3c0971 of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000
I0513 02:08:28.258760 24449 status_update_manager.cpp:500] Creating StatusUpdate stream for task b446eb87-bf68-4cae-9040-92fdbc3c0971 of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000
I0513 02:08:28.258976 24449 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: d4b740f6-6d8b-402f-9f3e-9f6d49b97653) for task b446eb87-bf68-4cae-9040-92fdbc3c0971 of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 to the agent
I0513 02:08:28.259066 24446 slave.cpp:4659] Forwarding the update TASK_RUNNING (UUID: d4b740f6-6d8b-402f-9f3e-9f6d49b97653) for task b446eb87-bf68-4cae-9040-92fdbc3c0971 of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 to master@172.17.0.2:34673
I0513 02:08:28.259153 24446 slave.cpp:4553] Status update manager successfully handled status update TASK_RUNNING (UUID: d4b740f6-6d8b-402f-9f3e-9f6d49b97653) for task b446eb87-bf68-4cae-9040-92fdbc3c0971 of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000
I0513 02:08:28.259228 24449 master.cpp:6469] Status update TASK_RUNNING (UUID: d4b740f6-6d8b-402f-9f3e-9f6d49b97653) for task b446eb87-bf68-4cae-9040-92fdbc3c0971 of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 from agent 3000801d-b601-4e0d-93d5-b27412b09f70-S0 at slave(687)@172.17.0.2:34673 (4f846f2193c3)
I0513 02:08:28.259260 24449 master.cpp:6537] Forwarding status update TASK_RUNNING (UUID: d4b740f6-6d8b-402f-9f3e-9f6d49b97653) for task b446eb87-bf68-4cae-9040-92fdbc3c0971 of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000
I0513 02:08:28.259392 24449 master.cpp:8568] Updating the state of task b446eb87-bf68-4cae-9040-92fdbc3c0971 of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0513 02:08:28.259572 24442 executor.cpp:725] Enqueuing event ACKNOWLEDGED received from http://172.17.0.2:34673/slave(687)/api/v1/executor
I0513 02:08:28.259835 24453 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.2:34673/master/api/v1/scheduler
I0513 02:08:28.260601 24453 scheduler.cpp:243] Sending RECONCILE call to http://172.17.0.2:34673/master/api/v1/scheduler
I0513 02:08:28.260941 24444 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0513 02:08:28.299609 24445 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:49168
I0513 02:08:28.299763 24445 master.cpp:6990] Performing explicit task state reconciliation for 1 tasks of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 (default)
I0513 02:08:28.299823 24445 master.cpp:7122] Sending explicit reconciliation state TASK_RUNNING for task b446eb87-bf68-4cae-9040-92fdbc3c0971 of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 (default)
I0513 02:08:28.300420 24441 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.2:34673/master/api/v1/scheduler
I0513 02:08:28.301406 24441 master.cpp:1430] Framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 (default) disconnected
I0513 02:08:28.301429 24441 master.cpp:3160] Deactivating framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 (default)
I0513 02:08:28.301467 24441 master.cpp:3137] Disconnecting framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 (default)
I0513 02:08:28.301484 24441 master.cpp:1445] Giving framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 (default) 0ns to failover
I0513 02:08:28.301501 24451 hierarchical.cpp:374] Deactivated framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000
I0513 02:08:28.302939 24441 master.cpp:7146] Framework failover timeout, removing framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 (default)
I0513 02:08:28.302965 24441 master.cpp:8000] Removing framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 (default)
I0513 02:08:28.303045 24441 master.cpp:8568] Updating the state of task b446eb87-bf68-4cae-9040-92fdbc3c0971 of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0513 02:08:28.303109 24439 slave.cpp:3061] Asked to shut down framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 by master@172.17.0.2:34673
I0513 02:08:28.303134 24439 slave.cpp:3086] Shutting down framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000
I0513 02:08:28.303148 24439 slave.cpp:5486] Shutting down executor 'default' of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 (via HTTP)
I0513 02:08:28.303325 24441 master.cpp:8662] Removing task b446eb87-bf68-4cae-9040-92fdbc3c0971 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 on agent 3000801d-b601-4e0d-93d5-b27412b09f70-S0 at slave(687)@172.17.0.2:34673 (4f846f2193c3)
I0513 02:08:28.303478 24441 master.cpp:8691] Removing executor 'default' with resources {} of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 on agent 3000801d-b601-4e0d-93d5-b27412b09f70-S0 at slave(687)@172.17.0.2:34673 (4f846f2193c3)
I0513 02:08:28.303683 24448 hierarchical.cpp:1114] Recovered cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: {}) on agent 3000801d-b601-4e0d-93d5-b27412b09f70-S0 from framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000
I0513 02:08:28.303799 24448 hierarchical.cpp:325] Removed framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000
I0513 02:08:28.304198 24449 executor.cpp:725] Enqueuing event SHUTDOWN received from http://172.17.0.2:34673/slave(687)/api/v1/executor
I0513 02:08:28.304589 24450 slave.cpp:5172] Executor 'default' of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 exited with status 0
I0513 02:08:28.304632 24450 slave.cpp:5272] Cleaning up executor 'default' of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 (via HTTP)
W0513 02:08:28.304767 24449 master.cpp:6592] Ignoring unknown exited executor 'default' of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000 on agent 3000801d-b601-4e0d-93d5-b27412b09f70-S0 at slave(687)@172.17.0.2:34673 (4f846f2193c3)
I0513 02:08:28.304865 24450 slave.cpp:5360] Cleaning up framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000
I0513 02:08:28.305018 24439 gc.cpp:55] Scheduling '/tmp/ContentType_SchedulerTest_ReconcileTask_0_ScPc5l/slaves/3000801d-b601-4e0d-93d5-b27412b09f70-S0/frameworks/3000801d-b601-4e0d-93d5-b27412b09f70-0000/executors/default/runs/24d6ba11-87d6-4887-92f3-997cd87a1e54' for gc 6.99999647259259days in the future
I0513 02:08:28.305055 24454 status_update_manager.cpp:285] Closing status update streams for framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000
I0513 02:08:28.305078 24454 status_update_manager.cpp:531] Cleaning up status update stream for task b446eb87-bf68-4cae-9040-92fdbc3c0971 of framework 3000801d-b601-4e0d-93d5-b27412b09f70-0000
I0513 02:08:28.305088 24439 gc.cpp:55] Scheduling '/tmp/ContentType_SchedulerTest_ReconcileTask_0_ScPc5l/slaves/3000801d-b601-4e0d-93d5-b27412b09f70-S0/frameworks/3000801d-b601-4e0d-93d5-b27412b09f70-0000/executors/default' for gc 6.99999647164148days in the future
I0513 02:08:28.305204 24438 slave.cpp:794] Agent terminating
I0513 02:08:28.305941 24450 master.cpp:1313] Agent 3000801d-b601-4e0d-93d5-b27412b09f70-S0 at slave(687)@172.17.0.2:34673 (4f846f2193c3) disconnected
I0513 02:08:28.305963 24450 master.cpp:3197] Disconnecting agent 3000801d-b601-4e0d-93d5-b27412b09f70-S0 at slave(687)@172.17.0.2:34673 (4f846f2193c3)
I0513 02:08:28.305990 24450 master.cpp:3216] Deactivating agent 3000801d-b601-4e0d-93d5-b27412b09f70-S0 at slave(687)@172.17.0.2:34673 (4f846f2193c3)
I0513 02:08:28.306044 24442 hierarchical.cpp:653] Agent 3000801d-b601-4e0d-93d5-b27412b09f70-S0 deactivated
I0513 02:08:28.305220 24439 gc.cpp:55] Scheduling '/tmp/ContentType_SchedulerTest_ReconcileTask_0_ScPc5l/slaves/3000801d-b601-4e0d-93d5-b27412b09f70-S0/frameworks/3000801d-b601-4e0d-93d5-b27412b09f70-0000' for gc 6.99999647061333days in the future
*** Aborted at 1494641308 (unix time) try "date -d @1494641308" if you are using GNU date ***
PC: @ 0x1d0c6cf testing::internal::UntypedFunctionMockerBase::SetOwnerAndName()
*** SIGSEGV (@0x0) received by PID 24438 (TID 0x7fb39ab54700) from PID 0; stack trace: ***
@ 0x7fb3a5484370 (unknown)
@ 0x1d0c6cf testing::internal::UntypedFunctionMockerBase::SetOwnerAndName()
@ 0xdf2e31 mesos::internal::tests::executor::MockHTTPExecutor<>::event()
@ 0xe16807 mesos::internal::tests::executor::TestMesos<>::events()
@ 0xe026dd std::_Function_handler<>::_M_invoke()
@ 0x7fb3a944a0d5 process::AsyncExecutorProcess::execute<>()
@ 0x7fb3a9453d15 _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_
@ 0x7fb3a835b001 process::ProcessManager::resume()
@ 0x7fb3a83640b7 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv
@ 0x7fb3a5221230 (unknown)
@ 0x7fb3a547cdc5 start_thread
@ 0x7fb3a498a73d __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-1494638367-5225
Untagged: mesos-1494638367-5225:latest
Deleted: sha256:05e7c78d7a4f554f7abe33944cec07058f5ac5edf6352ba10b5bb25b69d74fda
Deleted: sha256:8ef593976e8ccbd14db1ef905db306176401e277237fb38843cc9f7b9fc72751
Deleted: sha256:eccfe69ff8f80257cd36555dd25bfd9f8144e6dbbbe2969316a18958c5659d0f
Deleted: sha256:2d7983f105136bcd20275440b3236a88135699552505a632c5ed3c4266454aa3
Deleted: sha256:4035509b6ae8a09d91222209dc6550dca2ae14b20ee288d58e311343aeb613cc
Deleted: sha256:1133c8e1cf4e159a3af39fa0c3898285733e65c8a067f019681bb55c30a62688
Deleted: sha256:0636bf6fec882bf4d973bf67776e529d7ecaa5f57c3bd61ad0a2f60741b3d560
Deleted: sha256:63bfaed151d715ed0083e0c0e6d5b8954b9fd0093c4bd7e307ca72c693330e28
Deleted: sha256:88a33c233089f2e9e615d57346abe01f79f2aed8ba2cc53ce0b17e808b3e726b
Deleted: sha256:46c36836fca1f6d0a565587678f0da1ab6038cb74d9af6d40f8423369daea266
Deleted: sha256:0796f0e213cf178481d365dab1d9515a5816391346ddf3fbf26323f53af413c4
Deleted: sha256:e35dd25b6e688998db6b2ac913c7ed0111a96abc2016923100f8f6ff1d7e4d97
Deleted: sha256:116ecfbe14d1b874ee1de07e2d3e4b2bf1eb4bb4ba77900a47a873d51bb467d3
Deleted: sha256:8067b58aa9dd6980f2247b1228ddc52e2d80e12c5735ea21c2cb826a6cf9ae68
Deleted: sha256:ec46641b7742c4234ac3c4bdd30137673f8ccefab9efe517fa127a701add261e
Deleted: sha256:e002731cd86b2b16feba5d4a5aa94f0724a956442c686ce552cdebe70dd1f40a
Deleted: sha256:da5e9f3f5763195e8b7508ac031f5ddc1ff092028acecb20915642a7ce6d3e04
Deleted: sha256:5256e0c8398eefe23d3491327faed4ed3e4b5a2ac2656c64a3f3e597812478a0
Deleted: sha256:47720c53343521c6895389d801ead00fdbf096938dad95aed3def5c6189c0d24
Deleted: sha256:ce6e79c06f56f68eb90dbdb70ae497960f61135ddc74d4f31212f3e99338a9ad
Deleted: sha256:9b7f3fe4f463bc58c140311904a663fe8b440450d8b598ce908d25c622ace5f7
Deleted: sha256:2926d67a67762155202c4c2e2a5f620852a1c70fa15e4296a8d68e425500e545
Deleted: sha256:b794732e4dc394e5bb8564bd179745135bdf040fee2c8b483e85c82e9bd5ed75
Deleted: sha256:17ef921ed09bc4405a894f34c4da836b773b22c7ee191c2ad7d835a3840b7c2e
Deleted: sha256:03fb1b8416d22850ca9ea5dbb39c8e1a22c0876319c834e82b15866a509555d3
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user neil.conway@gmail.com
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) #3676
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)/3676/display/redirect>