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/06/22 15:37:08 UTC
Build failed in Jenkins: Mesos-Buildbot » cmake,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3831
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3831/display/redirect?page=changes>
Changes:
[alexr] Printed the reason why offer is declined in disk full framework.
[alexr] Minor clean up of the balloon framework.
------------------------------------------
[...truncated 24.42 MB...]
I0622 15:37:01.827184 32326 slave.cpp:5303] Executor 'E' of framework 80b4cabc-1884-430c-895f-2b2f93677ab9-0000 terminated with signal Killed
I0622 15:37:01.827469 32326 slave.cpp:5403] Cleaning up executor 'E' of framework 80b4cabc-1884-430c-895f-2b2f93677ab9-0000 (via HTTP)
W0622 15:37:01.827728 32325 master.cpp:6726] Ignoring unknown exited executor 'E' of framework 80b4cabc-1884-430c-895f-2b2f93677ab9-0000 on agent 80b4cabc-1884-430c-895f-2b2f93677ab9-S0 at slave(699)@172.17.0.5:44769 (f9cfac29717d)
I0622 15:37:01.827787 32327 gc.cpp:55] Scheduling '/tmp/ContentType_SchedulerTest_TaskGroupRunning_1_bv4BSc/slaves/80b4cabc-1884-430c-895f-2b2f93677ab9-S0/frameworks/80b4cabc-1884-430c-895f-2b2f93677ab9-0000/executors/E/runs/50e45ecc-7b08-42c9-a09a-8e5b40ce0499' for gc 6.99999042054222days in the future
I0622 15:37:01.828016 32326 slave.cpp:5499] Cleaning up framework 80b4cabc-1884-430c-895f-2b2f93677ab9-0000
I0622 15:37:01.828464 32329 status_update_manager.cpp:285] Closing status update streams for framework 80b4cabc-1884-430c-895f-2b2f93677ab9-0000
I0622 15:37:01.828506 32327 gc.cpp:55] Scheduling '/tmp/ContentType_SchedulerTest_TaskGroupRunning_1_bv4BSc/slaves/80b4cabc-1884-430c-895f-2b2f93677ab9-S0/frameworks/80b4cabc-1884-430c-895f-2b2f93677ab9-0000/executors/E' for gc 6.99999041758222days in the future
I0622 15:37:01.828614 32329 status_update_manager.cpp:531] Cleaning up status update stream for task 2 of framework 80b4cabc-1884-430c-895f-2b2f93677ab9-0000
I0622 15:37:01.829054 32329 status_update_manager.cpp:531] Cleaning up status update stream for task 1 of framework 80b4cabc-1884-430c-895f-2b2f93677ab9-0000
I0622 15:37:01.829535 32327 gc.cpp:55] Scheduling '/tmp/ContentType_SchedulerTest_TaskGroupRunning_1_bv4BSc/slaves/80b4cabc-1884-430c-895f-2b2f93677ab9-S0/frameworks/80b4cabc-1884-430c-895f-2b2f93677ab9-0000' for gc 6.9999904110637days in the future
I0622 15:37:01.829821 32329 slave.cpp:818] Agent terminating
I0622 15:37:01.830102 32329 master.cpp:1316] Agent 80b4cabc-1884-430c-895f-2b2f93677ab9-S0 at slave(699)@172.17.0.5:44769 (f9cfac29717d) disconnected
I0622 15:37:01.830610 32329 master.cpp:3240] Disconnecting agent 80b4cabc-1884-430c-895f-2b2f93677ab9-S0 at slave(699)@172.17.0.5:44769 (f9cfac29717d)
I0622 15:37:01.830778 32329 master.cpp:3259] Deactivating agent 80b4cabc-1884-430c-895f-2b2f93677ab9-S0 at slave(699)@172.17.0.5:44769 (f9cfac29717d)
I0622 15:37:01.831089 32324 hierarchical.cpp:715] Agent 80b4cabc-1884-430c-895f-2b2f93677ab9-S0 deactivated
I0622 15:37:01.847126 32321 master.cpp:1158] Master terminating
I0622 15:37:01.848206 32324 hierarchical.cpp:620] Removed agent 80b4cabc-1884-430c-895f-2b2f93677ab9-S0
[ OK ] ContentType/SchedulerTest.TaskGroupRunning/1 (849 ms)
[ RUN ] ContentType/SchedulerTest.ReconcileTask/0
I0622 15:37:01.888365 32321 cluster.cpp:162] Creating default 'local' authorizer
I0622 15:37:01.892802 32328 master.cpp:438] Master 34599721-4cb4-4124-b702-6569beff8642 (f9cfac29717d) started on 172.17.0.5:44769
I0622 15:37:01.892864 32328 master.cpp:440] 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/xivxdP/credentials" --filter_gpu_resources="true" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --port="5050" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/xivxdP/master" --zk_session_timeout="10secs"
I0622 15:37:01.893436 32328 master.cpp:490] Master only allowing authenticated frameworks to register
I0622 15:37:01.893477 32328 master.cpp:504] Master only allowing authenticated agents to register
I0622 15:37:01.893585 32328 master.cpp:517] Master only allowing authenticated HTTP frameworks to register
I0622 15:37:01.893625 32328 credentials.hpp:37] Loading credentials for authentication from '/tmp/xivxdP/credentials'
I0622 15:37:01.894090 32328 master.cpp:562] Using default 'crammd5' authenticator
I0622 15:37:01.894445 32328 http.cpp:974] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0622 15:37:01.894707 32328 http.cpp:974] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0622 15:37:01.894995 32328 http.cpp:974] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0622 15:37:01.895184 32328 master.cpp:642] Authorization enabled
I0622 15:37:01.895668 32327 whitelist_watcher.cpp:77] No whitelist given
I0622 15:37:01.895851 32323 hierarchical.cpp:169] Initialized hierarchical allocator process
I0622 15:37:01.899598 32328 master.cpp:2161] Elected as the leading master!
I0622 15:37:01.899855 32328 master.cpp:1700] Recovering from registrar
I0622 15:37:01.900363 32328 registrar.cpp:345] Recovering registrar
I0622 15:37:01.902021 32328 registrar.cpp:389] Successfully fetched the registry (0B) in 1.140992ms
I0622 15:37:01.902508 32328 registrar.cpp:493] Applied 1 operations in 35589ns; attempting to update the registry
I0622 15:37:01.903923 32328 registrar.cpp:550] Successfully updated the registry in 1.281024ms
I0622 15:37:01.904260 32328 registrar.cpp:422] Successfully recovered registrar
I0622 15:37:01.905083 32323 hierarchical.cpp:207] Skipping recovery of hierarchical allocator: nothing to recover
I0622 15:37:01.905081 32324 master.cpp:1799] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0622 15:37:01.913116 32321 cluster.cpp:448] Creating default 'local' authorizer
I0622 15:37:01.915881 32325 slave.cpp:249] Mesos agent started on (700)@172.17.0.5:44769
I0622 15:37:01.915910 32325 slave.cpp:250] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/ContentType_SchedulerTest_ReconcileTask_0_T0if3i/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_T0if3i/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/ContentType_SchedulerTest_ReconcileTask_0_T0if3i/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/ContentType_SchedulerTest_ReconcileTask_0_T0if3i/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_T0if3i/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_T0if3i" --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_AjFn83"
I0622 15:37:01.916569 32325 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentType_SchedulerTest_ReconcileTask_0_T0if3i/credential'
I0622 15:37:01.916792 32325 slave.cpp:282] Agent using credential for: test-principal
I0622 15:37:01.916810 32325 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentType_SchedulerTest_ReconcileTask_0_T0if3i/http_credentials'
I0622 15:37:01.916916 32321 scheduler.cpp:184] Version: 1.4.0
I0622 15:37:01.917120 32325 http.cpp:974] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0622 15:37:01.917479 32325 http.cpp:974] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0622 15:37:01.917842 32323 scheduler.cpp:470] New master detected at master@172.17.0.5:44769
I0622 15:37:01.917883 32323 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0622 15:37:01.919430 32325 slave.cpp:553] Agent resources: cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0622 15:37:01.919551 32325 slave.cpp:561] Agent attributes: [ ]
I0622 15:37:01.919565 32325 slave.cpp:566] Agent hostname: f9cfac29717d
I0622 15:37:01.920375 32327 status_update_manager.cpp:177] Pausing sending status updates
I0622 15:37:01.921640 32327 state.cpp:64] Recovering state from '/tmp/ContentType_SchedulerTest_ReconcileTask_0_AjFn83/meta'
I0622 15:37:01.922581 32324 status_update_manager.cpp:203] Recovering status update manager
I0622 15:37:01.923099 32325 slave.cpp:6162] Finished recovery
I0622 15:37:01.923527 32323 scheduler.cpp:361] Connected with the master at http://172.17.0.5:44769/master/api/v1/scheduler
I0622 15:37:01.924635 32325 slave.cpp:6344] Querying resource estimator for oversubscribable resources
I0622 15:37:01.925552 32323 scheduler.cpp:243] Sending SUBSCRIBE call to http://172.17.0.5:44769/master/api/v1/scheduler
I0622 15:37:01.927567 32325 slave.cpp:946] New master detected at master@172.17.0.5:44769
I0622 15:37:01.927837 32327 status_update_manager.cpp:177] Pausing sending status updates
I0622 15:37:01.928350 32325 slave.cpp:981] Detecting new master
I0622 15:37:01.928843 32326 process.cpp:3779] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0622 15:37:01.931046 32324 http.cpp:1114] HTTP POST for /master/api/v1/scheduler from 172.17.0.5:34236
I0622 15:37:01.931409 32324 master.cpp:2514] Received subscription request for HTTP framework 'default'
I0622 15:37:01.931538 32324 master.cpp:2197] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0622 15:37:01.932314 32329 master.cpp:2650] Subscribing framework 'default' with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
I0622 15:37:01.934152 32329 hierarchical.cpp:301] Added framework 34599721-4cb4-4124-b702-6569beff8642-0000
I0622 15:37:01.934154 32324 master.hpp:2216] Sending heartbeat to 34599721-4cb4-4124-b702-6569beff8642-0000
I0622 15:37:01.935446 32327 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from http://172.17.0.5:44769/master/api/v1/scheduler
I0622 15:37:01.936259 32329 hierarchical.cpp:1938] No allocations performed
I0622 15:37:01.937346 32329 hierarchical.cpp:2028] No inverse offers to send out!
I0622 15:37:01.937644 32329 hierarchical.cpp:1493] Performed allocation for 0 agents in 1.45189ms
I0622 15:37:01.938042 32326 scheduler.cpp:676] Enqueuing event HEARTBEAT received from http://172.17.0.5:44769/master/api/v1/scheduler
I0622 15:37:01.939878 32325 slave.cpp:6358] Received oversubscribable resources {} from the resource estimator
I0622 15:37:01.940440 32325 slave.cpp:1008] Authenticating with master master@172.17.0.5:44769
I0622 15:37:01.940876 32325 slave.cpp:1019] Using default CRAM-MD5 authenticatee
I0622 15:37:01.941335 32324 authenticatee.cpp:121] Creating new client SASL connection
I0622 15:37:01.941826 32325 master.cpp:7596] Authenticating slave(700)@172.17.0.5:44769
I0622 15:37:01.942126 32323 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1317)@172.17.0.5:44769
I0622 15:37:01.942607 32326 authenticator.cpp:98] Creating new server SASL connection
I0622 15:37:01.943331 32324 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0622 15:37:01.943367 32324 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0622 15:37:01.943616 32326 authenticator.cpp:204] Received SASL authentication start
I0622 15:37:01.943872 32326 authenticator.cpp:326] Authentication requires more steps
I0622 15:37:01.944285 32326 authenticatee.cpp:259] Received SASL authentication step
I0622 15:37:01.944675 32326 authenticator.cpp:232] Received SASL authentication step
I0622 15:37:01.944876 32326 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f9cfac29717d' server FQDN: 'f9cfac29717d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0622 15:37:01.944953 32326 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0622 15:37:01.945049 32326 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0622 15:37:01.945344 32326 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f9cfac29717d' server FQDN: 'f9cfac29717d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0622 15:37:01.945435 32326 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0622 15:37:01.945626 32326 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0622 15:37:01.945705 32326 authenticator.cpp:318] Authentication success
I0622 15:37:01.946097 32324 authenticatee.cpp:299] Authentication success
I0622 15:37:01.946346 32326 master.cpp:7626] Successfully authenticated principal 'test-principal' at slave(700)@172.17.0.5:44769
I0622 15:37:01.946425 32329 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1317)@172.17.0.5:44769
I0622 15:37:01.946964 32323 slave.cpp:1103] Successfully authenticated with master master@172.17.0.5:44769
I0622 15:37:01.947425 32323 slave.cpp:1539] Will retry registration in 15.475093ms if necessary
I0622 15:37:01.947774 32326 master.cpp:5574] Received register agent message from slave(700)@172.17.0.5:44769 (f9cfac29717d)
I0622 15:37:01.948101 32326 master.cpp:3742] Authorizing agent with principal 'test-principal'
I0622 15:37:01.948920 32326 master.cpp:5634] Authorized registration of agent at slave(700)@172.17.0.5:44769 (f9cfac29717d)
I0622 15:37:01.949162 32326 master.cpp:5713] Registering agent at slave(700)@172.17.0.5:44769 (f9cfac29717d) with id 34599721-4cb4-4124-b702-6569beff8642-S0
I0622 15:37:01.949838 32322 registrar.cpp:493] Applied 1 operations in 92042ns; attempting to update the registry
I0622 15:37:01.950731 32322 registrar.cpp:550] Successfully updated the registry in 766976ns
I0622 15:37:01.957551 32323 master.cpp:5760] Admitted agent 34599721-4cb4-4124-b702-6569beff8642-S0 at slave(700)@172.17.0.5:44769 (f9cfac29717d)
I0622 15:37:01.958745 32322 slave.cpp:4860] Received ping from slave-observer(637)@172.17.0.5:44769
I0622 15:37:01.959002 32322 slave.cpp:1149] Registered with master master@172.17.0.5:44769; given agent ID 34599721-4cb4-4124-b702-6569beff8642-S0
I0622 15:37:01.958765 32323 master.cpp:5791] Registered agent 34599721-4cb4-4124-b702-6569beff8642-S0 at slave(700)@172.17.0.5:44769 (f9cfac29717d) with cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0622 15:37:01.959522 32322 slave.cpp:1169] Checkpointing SlaveInfo to '/tmp/ContentType_SchedulerTest_ReconcileTask_0_AjFn83/meta/slaves/34599721-4cb4-4124-b702-6569beff8642-S0/slave.info'
I0622 15:37:01.960103 32328 status_update_manager.cpp:184] Resuming sending status updates
I0622 15:37:01.960086 32323 hierarchical.cpp:587] Added agent 34599721-4cb4-4124-b702-6569beff8642-S0 (f9cfac29717d) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0622 15:37:01.960351 32322 slave.cpp:1207] Forwarding total oversubscribed resources {}
I0622 15:37:01.960747 32322 master.cpp:6464] Received update of agent 34599721-4cb4-4124-b702-6569beff8642-S0 at slave(700)@172.17.0.5:44769 (f9cfac29717d) with total oversubscribed resources {}
I0622 15:37:01.962620 32323 hierarchical.cpp:2028] No inverse offers to send out!
I0622 15:37:01.962723 32323 hierarchical.cpp:1493] Performed allocation for 1 agents in 1.891077ms
I0622 15:37:01.963547 32328 master.cpp:7426] Sending 1 offers to framework 34599721-4cb4-4124-b702-6569beff8642-0000 (default)
I0622 15:37:01.967159 32326 scheduler.cpp:676] Enqueuing event OFFERS received from http://172.17.0.5:44769/master/api/v1/scheduler
I0622 15:37:01.970947 32323 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.5:44769/master/api/v1/scheduler
I0622 15:37:01.973459 32328 process.cpp:3779] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0622 15:37:01.977895 32324 http.cpp:1114] HTTP POST for /master/api/v1/scheduler from 172.17.0.5:34234
I0622 15:37:01.979547 32324 master.cpp:3957] Processing ACCEPT call for offers: [ 34599721-4cb4-4124-b702-6569beff8642-O0 ] on agent 34599721-4cb4-4124-b702-6569beff8642-S0 at slave(700)@172.17.0.5:44769 (f9cfac29717d) for framework 34599721-4cb4-4124-b702-6569beff8642-0000 (default)
I0622 15:37:01.979704 32324 master.cpp:3469] Authorizing framework principal 'test-principal' to launch task 41a24116-ebd7-4cac-bec8-a379970cb42f
W0622 15:37:01.983264 32329 validation.cpp:1332] Executor 'default' for task '41a24116-ebd7-4cac-bec8-a379970cb42f' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0622 15:37:01.983322 32329 validation.cpp:1344] Executor 'default' for task '41a24116-ebd7-4cac-bec8-a379970cb42f' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0622 15:37:01.984302 32329 master.cpp:9466] Adding task 41a24116-ebd7-4cac-bec8-a379970cb42f with resources cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] on agent 34599721-4cb4-4124-b702-6569beff8642-S0 at slave(700)@172.17.0.5:44769 (f9cfac29717d)
I0622 15:37:01.985039 32329 master.cpp:4670] Launching task 41a24116-ebd7-4cac-bec8-a379970cb42f of framework 34599721-4cb4-4124-b702-6569beff8642-0000 (default) with resources cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] on agent 34599721-4cb4-4124-b702-6569beff8642-S0 at slave(700)@172.17.0.5:44769 (f9cfac29717d)
I0622 15:37:01.985708 32326 slave.cpp:1664] Got assigned task '41a24116-ebd7-4cac-bec8-a379970cb42f' for framework 34599721-4cb4-4124-b702-6569beff8642-0000
I0622 15:37:01.986706 32326 slave.cpp:1945] Authorizing task '41a24116-ebd7-4cac-bec8-a379970cb42f' for framework 34599721-4cb4-4124-b702-6569beff8642-0000
I0622 15:37:01.986781 32326 slave.cpp:6661] Authorizing framework principal 'test-principal' to launch task 41a24116-ebd7-4cac-bec8-a379970cb42f
I0622 15:37:01.988595 32326 slave.cpp:2132] Launching task '41a24116-ebd7-4cac-bec8-a379970cb42f' for framework 34599721-4cb4-4124-b702-6569beff8642-0000
I0622 15:37:01.989464 32326 paths.cpp:577] Trying to chown '/tmp/ContentType_SchedulerTest_ReconcileTask_0_AjFn83/slaves/34599721-4cb4-4124-b702-6569beff8642-S0/frameworks/34599721-4cb4-4124-b702-6569beff8642-0000/executors/default/runs/bd2bc1ba-7774-42da-ac04-1ab216c8cbd0' to user 'mesos'
I0622 15:37:01.989727 32326 slave.cpp:7121] Launching executor 'default' of framework 34599721-4cb4-4124-b702-6569beff8642-0000 with resources {} in work directory '/tmp/ContentType_SchedulerTest_ReconcileTask_0_AjFn83/slaves/34599721-4cb4-4124-b702-6569beff8642-S0/frameworks/34599721-4cb4-4124-b702-6569beff8642-0000/executors/default/runs/bd2bc1ba-7774-42da-ac04-1ab216c8cbd0'
I0622 15:37:01.990016 32323 hierarchical.cpp:912] Updated allocation of framework 34599721-4cb4-4124-b702-6569beff8642-0000 on agent 34599721-4cb4-4124-b702-6569beff8642-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]
I0622 15:37:01.990411 32326 slave.cpp:2827] Launching container bd2bc1ba-7774-42da-ac04-1ab216c8cbd0 for executor 'default' of framework 34599721-4cb4-4124-b702-6569beff8642-0000
I0622 15:37:01.990985 32326 slave.cpp:2361] Queued task '41a24116-ebd7-4cac-bec8-a379970cb42f' for executor 'default' of framework 34599721-4cb4-4124-b702-6569beff8642-0000
I0622 15:37:01.991925 32323 slave.cpp:899] Successfully attached file '/tmp/ContentType_SchedulerTest_ReconcileTask_0_AjFn83/slaves/34599721-4cb4-4124-b702-6569beff8642-S0/frameworks/34599721-4cb4-4124-b702-6569beff8642-0000/executors/default/runs/bd2bc1ba-7774-42da-ac04-1ab216c8cbd0'
I0622 15:37:01.992054 32323 slave.cpp:899] Successfully attached file '/tmp/ContentType_SchedulerTest_ReconcileTask_0_AjFn83/slaves/34599721-4cb4-4124-b702-6569beff8642-S0/frameworks/34599721-4cb4-4124-b702-6569beff8642-0000/executors/default/runs/bd2bc1ba-7774-42da-ac04-1ab216c8cbd0'
I0622 15:37:01.994484 32326 executor.cpp:192] Version: 1.4.0
I0622 15:37:01.998651 32326 executor.cpp:410] Connected with the agent
I0622 15:37:01.999433 32322 executor.cpp:307] Sending SUBSCRIBE call to http://172.17.0.5:44769/slave(700)/api/v1/executor
I0622 15:37:02.001673 32322 process.cpp:3779] Handling HTTP event for process 'slave(700)' with path: '/slave(700)/api/v1/executor'
I0622 15:37:02.003963 32322 http.cpp:1114] HTTP POST for /slave(700)/api/v1/executor from 172.17.0.5:34238
I0622 15:37:02.004297 32322 slave.cpp:3644] Received Subscribe request for HTTP executor 'default' of framework 34599721-4cb4-4124-b702-6569beff8642-0000
I0622 15:37:02.006744 32322 slave.cpp:2574] Sending queued task '41a24116-ebd7-4cac-bec8-a379970cb42f' to executor 'default' of framework 34599721-4cb4-4124-b702-6569beff8642-0000 (via HTTP)
I0622 15:37:02.010596 32322 executor.cpp:725] Enqueuing event SUBSCRIBED received from http://172.17.0.5:44769/slave(700)/api/v1/executor
I0622 15:37:02.013010 32322 executor.cpp:725] Enqueuing event LAUNCH received from http://172.17.0.5:44769/slave(700)/api/v1/executor
I0622 15:37:02.015813 32328 executor.cpp:307] Sending UPDATE call to http://172.17.0.5:44769/slave(700)/api/v1/executor
I0622 15:37:02.018172 32328 process.cpp:3779] Handling HTTP event for process 'slave(700)' with path: '/slave(700)/api/v1/executor'
I0622 15:37:02.020535 32328 http.cpp:1114] HTTP POST for /slave(700)/api/v1/executor from 172.17.0.5:34240
I0622 15:37:02.020808 32328 slave.cpp:4330] Handling status update TASK_RUNNING (UUID: cb129833-4c6a-4431-86be-273f60035ce0) for task 41a24116-ebd7-4cac-bec8-a379970cb42f of framework 34599721-4cb4-4124-b702-6569beff8642-0000
I0622 15:37:02.022299 32328 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: cb129833-4c6a-4431-86be-273f60035ce0) for task 41a24116-ebd7-4cac-bec8-a379970cb42f of framework 34599721-4cb4-4124-b702-6569beff8642-0000
I0622 15:37:02.022372 32328 status_update_manager.cpp:500] Creating StatusUpdate stream for task 41a24116-ebd7-4cac-bec8-a379970cb42f of framework 34599721-4cb4-4124-b702-6569beff8642-0000
I0622 15:37:02.022951 32328 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: cb129833-4c6a-4431-86be-273f60035ce0) for task 41a24116-ebd7-4cac-bec8-a379970cb42f of framework 34599721-4cb4-4124-b702-6569beff8642-0000 to the agent
I0622 15:37:02.024468 32328 slave.cpp:4770] Forwarding the update TASK_RUNNING (UUID: cb129833-4c6a-4431-86be-273f60035ce0) for task 41a24116-ebd7-4cac-bec8-a379970cb42f of framework 34599721-4cb4-4124-b702-6569beff8642-0000 to master@172.17.0.5:44769
I0622 15:37:02.024737 32328 slave.cpp:4664] Status update manager successfully handled status update TASK_RUNNING (UUID: cb129833-4c6a-4431-86be-273f60035ce0) for task 41a24116-ebd7-4cac-bec8-a379970cb42f of framework 34599721-4cb4-4124-b702-6569beff8642-0000
I0622 15:37:02.025318 32328 master.cpp:6609] Status update TASK_RUNNING (UUID: cb129833-4c6a-4431-86be-273f60035ce0) for task 41a24116-ebd7-4cac-bec8-a379970cb42f of framework 34599721-4cb4-4124-b702-6569beff8642-0000 from agent 34599721-4cb4-4124-b702-6569beff8642-S0 at slave(700)@172.17.0.5:44769 (f9cfac29717d)
I0622 15:37:02.025390 32328 master.cpp:6671] Forwarding status update TASK_RUNNING (UUID: cb129833-4c6a-4431-86be-273f60035ce0) for task 41a24116-ebd7-4cac-bec8-a379970cb42f of framework 34599721-4cb4-4124-b702-6569beff8642-0000
I0622 15:37:02.025869 32328 master.cpp:8687] Updating the state of task 41a24116-ebd7-4cac-bec8-a379970cb42f of framework 34599721-4cb4-4124-b702-6569beff8642-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0622 15:37:02.028035 32328 executor.cpp:725] Enqueuing event ACKNOWLEDGED received from http://172.17.0.5:44769/slave(700)/api/v1/executor
I0622 15:37:02.029623 32328 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.5:44769/master/api/v1/scheduler
I0622 15:37:02.031630 32328 scheduler.cpp:243] Sending RECONCILE call to http://172.17.0.5:44769/master/api/v1/scheduler
I0622 15:37:02.033640 32328 process.cpp:3779] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0622 15:37:02.076164 32327 http.cpp:1114] HTTP POST for /master/api/v1/scheduler from 172.17.0.5:34234
I0622 15:37:02.076603 32327 master.cpp:7109] Performing explicit task state reconciliation for 1 tasks of framework 34599721-4cb4-4124-b702-6569beff8642-0000 (default)
I0622 15:37:02.076896 32327 master.cpp:7238] Sending explicit reconciliation state TASK_RUNNING for task 41a24116-ebd7-4cac-bec8-a379970cb42f of framework 34599721-4cb4-4124-b702-6569beff8642-0000 (default)
I0622 15:37:02.080677 32327 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.5:44769/master/api/v1/scheduler
I0622 15:37:02.105422 32326 master.cpp:1430] Framework 34599721-4cb4-4124-b702-6569beff8642-0000 (default) disconnected
I0622 15:37:02.105461 32326 master.cpp:3203] Deactivating framework 34599721-4cb4-4124-b702-6569beff8642-0000 (default)
I0622 15:37:02.105648 32326 master.cpp:3180] Disconnecting framework 34599721-4cb4-4124-b702-6569beff8642-0000 (default)
I0622 15:37:02.105847 32326 master.cpp:1445] Giving framework 34599721-4cb4-4124-b702-6569beff8642-0000 (default) 0ns to failover
I0622 15:37:02.105903 32324 hierarchical.cpp:410] Deactivated framework 34599721-4cb4-4124-b702-6569beff8642-0000
I0622 15:37:02.107553 32329 master.cpp:7262] Framework failover timeout, removing framework 34599721-4cb4-4124-b702-6569beff8642-0000 (default)
I0622 15:37:02.107583 32329 master.cpp:8119] Removing framework 34599721-4cb4-4124-b702-6569beff8642-0000 (default)
I0622 15:37:02.108011 32329 master.cpp:8687] Updating the state of task 41a24116-ebd7-4cac-bec8-a379970cb42f of framework 34599721-4cb4-4124-b702-6569beff8642-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0622 15:37:02.108027 32324 slave.cpp:3130] Asked to shut down framework 34599721-4cb4-4124-b702-6569beff8642-0000 by master@172.17.0.5:44769
I0622 15:37:02.108073 32324 slave.cpp:3155] Shutting down framework 34599721-4cb4-4124-b702-6569beff8642-0000
I0622 15:37:02.108244 32324 slave.cpp:5625] Shutting down executor 'default' of framework 34599721-4cb4-4124-b702-6569beff8642-0000 (via HTTP)
I0622 15:37:02.109423 32329 master.cpp:8781] Removing task 41a24116-ebd7-4cac-bec8-a379970cb42f with resources cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] of framework 34599721-4cb4-4124-b702-6569beff8642-0000 on agent 34599721-4cb4-4124-b702-6569beff8642-S0 at slave(700)@172.17.0.5:44769 (f9cfac29717d)
I0622 15:37:02.110112 32329 master.cpp:8810] Removing executor 'default' with resources {} of framework 34599721-4cb4-4124-b702-6569beff8642-0000 on agent 34599721-4cb4-4124-b702-6569beff8642-S0 at slave(700)@172.17.0.5:44769 (f9cfac29717d)
I0622 15:37:02.110363 32324 hierarchical.cpp:1177] 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 34599721-4cb4-4124-b702-6569beff8642-S0 from framework 34599721-4cb4-4124-b702-6569beff8642-0000
I0622 15:37:02.111260 32326 hierarchical.cpp:353] Removed framework 34599721-4cb4-4124-b702-6569beff8642-0000
I0622 15:37:02.115628 32324 executor.cpp:725] Enqueuing event SHUTDOWN received from http://172.17.0.5:44769/slave(700)/api/v1/executor
*** Aborted at 1498145822 (unix time) try "date -d @1498145822" if you are using GNU date ***
PC: @ 0x39e334d testing::internal::UntypedFunctionMockerBase::SetOwnerAndName()
*** SIGSEGV (@0x358) received by PID 32321 (TID 0x2b5bdbcce700) from PID 856; stack trace: ***
@ 0x2b5bd29da330 (unknown)
@ 0x39e334d testing::internal::UntypedFunctionMockerBase::SetOwnerAndName()
@ 0x25ab87b mesos::internal::tests::executor::MockHTTPExecutor<>::shutdown()
@ 0x25a0e5f mesos::internal::tests::executor::MockHTTPExecutor<>::event()
@ 0x2595d48 mesos::internal::tests::executor::TestMesos<>::events()
@ 0x25c64d9 std::_Mem_fn<>::operator()<>()
@ 0x25b8459 _ZNSt5_BindIFSt7_Mem_fnIMN5mesos8internal5tests8executor9TestMesosINS1_2v18executor5MesosENS7_5EventEEEFvSt5queueIS9_St5dequeIS9_SaIS9_EEEEEPSA_St12_PlaceholderILi1EEEE6__callIvIRKSF_EILm0ELm1EEEET_OSt5tupleIIDpT0_EESt12_Index_tupleIIXspT1_EEE
@ 0x25abc79 _ZNSt5_BindIFSt7_Mem_fnIMN5mesos8internal5tests8executor9TestMesosINS1_2v18executor5MesosENS7_5EventEEEFvSt5queueIS9_St5dequeIS9_SaIS9_EEEEEPSA_St12_PlaceholderILi1EEEEclIJRKSF_EvEET0_DpOT_
@ 0x25a1225 std::_Function_handler<>::_M_invoke()
@ 0x2b5bce37416d std::function<>::operator()()
@ 0x2b5bce36e1c3 process::AsyncExecutorProcess::execute<>()
@ 0x2b5bce36e309 _ZZN7process8dispatchI7NothingNS_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v18executor5EventESt5dequeIS8_SaIS8_EEEEESC_SG_SC_EENS_6FutureIT_EERKNS_3PIDIT0_EEMSN_FSK_T1_T2_ET3_T4_ENKUlPNS_11ProcessBaseEE_clESY_
@ 0x2b5bce37a0ac _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_
@ 0x2b5bd07f2e4b std::function<>::operator()()
@ 0x2b5bd07d14eb process::ProcessBase::visit()
@ 0x2b5bd07dd054 process::DispatchEvent::visit()
@ 0x251ee98 process::ProcessBase::serve()
@ 0x2b5bd07cd7ac process::ProcessManager::resume()
@ 0x2b5bd07c9980 _ZZN7process14ProcessManager12init_threadsEvENKUt_clEv
@ 0x2b5bd07db5d8 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
@ 0x2b5bd07db52f _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEclEv
@ 0x2b5bd07db4c8 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv
@ 0x2b5bd2c99a60 (unknown)
@ 0x2b5bd29d2184 start_thread
@ 0x2b5bd3505ffd (unknown)
make[3]: Leaving directory `/mesos/build'
make[3]: *** [CMakeFiles/check] Segmentation fault (core dumped)
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-1498139241-12033
Untagged: mesos-1498139241-12033:latest
Deleted: sha256:32ddd105f5c5724806b7f8a85e8b3b15e948aa8e995c9893992c8aed567c2508
Deleted: sha256:c5e93a4afdc62033ab3d1bccfcd13e15ad17b1d80983043a95b87e61613be24c
Deleted: sha256:c99e252086ac3e7d1d092d2a0b69c8ced8218fd4def71f7c036db56471fc42d7
Deleted: sha256:25946bcf53b9f75199f3e278d72a16de810605f9872abe67d764d58a59270975
Deleted: sha256:a48cebe466f4fe0d462ba8ca9c25a9c8cd83b4c3e9d4c5a062a7843fa2e12840
Deleted: sha256:cf475808570c12e096058572066aa004979c9dcd49f33a7b0a84011ce4e8c682
Deleted: sha256:41b9dbe770254c7b0c6c1cb55035e1131b0cf7411c3e61827e758e25a0e0bd03
Deleted: sha256:5662c892d95a743365c97f9f9a17fe9aeb1ae02c4f2f73b07e2f1d52c6840cbb
Deleted: sha256:ac50b768001010025ebba47dc08cf5475f1134550a24dba3dc8bc0217807621b
Deleted: sha256:c3d01057dc8e55aa8ed55eda67c7c6fcb1eb23feaf0d0da15866ae5c9d890f94
Deleted: sha256:76cf692e196e1828b4dd741eec704f9b2416dbb7d36319ff158ddfe82d16f607
Deleted: sha256:0757c1b3616d58de7047edaee49b226fc74e09d8830a59aa8c765f489aedc476
Deleted: sha256:72685153b0a4e1554dc4388d9174787530a84b429e2b0f7b370437242034b39d
Deleted: sha256:a146e109661fde21c51a30c53124277f1f4d3b3812d52c56e10496ca476a67e4
Deleted: sha256:707fde2e93970d7f618df84859002dbfd0d639619d8f8ef1557c81b6e0a48719
Deleted: sha256:801b21eac8680d7df05460f5a0e38dd8eac66a915bcef68fee9bb5f0a15abf30
Deleted: sha256:5cc7502e5b54cd25848135ecc1f14044e4b35233c8fe444da9addb51b0f55b53
Deleted: sha256:0209de91886013b0d201def75c9aa7b8f2e2c6f02fb81130b7cb7ea72dbc857e
Deleted: sha256:d799d83a73e6ca402539421adecb0dda86a20bff183358b22d8cd1664040e16b
Deleted: sha256:b285764c8f6d651a4d80ac2e035eb7339029fd66ecb8bc3eac46554997e0517c
Deleted: sha256:fa79179de19ec695254e82b845c09aa908bc9ebd8d04bc469bd0c0e2b40abc9c
Deleted: sha256:7e394ca5858c545808a934a691ed5cebb0e606bf924d5188750f98090d26d144
Deleted: sha256:81817b616b76f2d559244f0d8f6f953b3d27271fea632fd80356d4eac6505d7f
Deleted: sha256:7d884059932a1c90cfa3f3048f4fbba8aa38860b262000ff43a935b9b304c63e
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos-Buildbot » cmake,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3832
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3832/display/redirect?page=changes>