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/07/25 05:01:13 UTC
Build failed in Jenkins: Mesos-Buildbot » cmake,clang,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3951
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3951/display/redirect>
------------------------------------------
[...truncated 5.35 MB...]
I0725 05:01:09.753991 717 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterMaintenanceTest_InverseOffersFilters_Mlq4vw/credential'
I0725 05:01:09.754115 717 slave.cpp:283] Agent using credential for: test-principal
I0725 05:01:09.754137 717 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterMaintenanceTest_InverseOffersFilters_Mlq4vw/http_credentials'
I0725 05:01:09.754369 717 http.cpp:993] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0725 05:01:09.754472 717 http.cpp:1014] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0725 05:01:09.754616 717 http.cpp:993] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0725 05:01:09.754695 717 http.cpp:1014] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0725 05:01:09.754869 717 http.cpp:993] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0725 05:01:09.754933 717 http.cpp:1014] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0725 05:01:09.756250 717 slave.cpp:565] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0725 05:01:09.756433 717 slave.cpp:573] Agent attributes: [ ]
I0725 05:01:09.756444 717 slave.cpp:582] Agent hostname: maintenance-host-2
I0725 05:01:09.756575 727 status_update_manager.cpp:177] Pausing sending status updates
I0725 05:01:09.758086 725 state.cpp:64] Recovering state from '/tmp/MasterMaintenanceTest_InverseOffersFilters_uo20E2/meta'
I0725 05:01:09.758339 710 status_update_manager.cpp:203] Recovering status update manager
I0725 05:01:09.758658 715 slave.cpp:6207] Finished recovery
I0725 05:01:09.759201 715 slave.cpp:6389] Querying resource estimator for oversubscribable resources
I0725 05:01:09.759390 716 status_update_manager.cpp:177] Pausing sending status updates
I0725 05:01:09.759393 715 slave.cpp:971] New master detected at master@172.17.0.5:34725
I0725 05:01:09.759443 715 slave.cpp:1006] Detecting new master
I0725 05:01:09.759551 715 slave.cpp:6403] Received oversubscribable resources {} from the resource estimator
I0725 05:01:09.769136 719 slave.cpp:1033] Authenticating with master master@172.17.0.5:34725
I0725 05:01:09.769187 719 slave.cpp:1044] Using default CRAM-MD5 authenticatee
I0725 05:01:09.769330 711 authenticatee.cpp:121] Creating new client SASL connection
I0725 05:01:09.769523 713 master.cpp:7793] Authenticating slave(95)@172.17.0.5:34725
I0725 05:01:09.769598 724 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(185)@172.17.0.5:34725
I0725 05:01:09.769764 721 authenticator.cpp:98] Creating new server SASL connection
I0725 05:01:09.770020 727 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0725 05:01:09.770069 727 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0725 05:01:09.770232 712 authenticator.cpp:204] Received SASL authentication start
I0725 05:01:09.770290 712 authenticator.cpp:326] Authentication requires more steps
I0725 05:01:09.770364 720 authenticatee.cpp:259] Received SASL authentication step
I0725 05:01:09.770452 709 authenticator.cpp:232] Received SASL authentication step
I0725 05:01:09.770472 709 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '00b09e7b2fc9' server FQDN: '00b09e7b2fc9' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0725 05:01:09.770480 709 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0725 05:01:09.770504 709 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0725 05:01:09.770519 709 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '00b09e7b2fc9' server FQDN: '00b09e7b2fc9' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0725 05:01:09.770525 709 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0725 05:01:09.770531 709 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0725 05:01:09.770545 709 authenticator.cpp:318] Authentication success
I0725 05:01:09.770602 728 authenticatee.cpp:299] Authentication success
I0725 05:01:09.770630 706 master.cpp:7823] Successfully authenticated principal 'test-principal' at slave(95)@172.17.0.5:34725
I0725 05:01:09.770658 725 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(185)@172.17.0.5:34725
I0725 05:01:09.770824 726 slave.cpp:1128] Successfully authenticated with master master@172.17.0.5:34725
I0725 05:01:09.770968 726 slave.cpp:1572] Will retry registration in 18.068172ms if necessary
I0725 05:01:09.771090 708 master.cpp:5677] Received register agent message from slave(95)@172.17.0.5:34725 (maintenance-host-2)
I0725 05:01:09.771119 708 master.cpp:3773] Authorizing agent with principal 'test-principal'
I0725 05:01:09.771618 705 master.cpp:5737] Authorized registration of agent at slave(95)@172.17.0.5:34725 (maintenance-host-2)
I0725 05:01:09.771737 705 master.cpp:5830] Registering agent at slave(95)@172.17.0.5:34725 (maintenance-host-2) with id 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S1
I0725 05:01:09.772138 723 registrar.cpp:493] Applied 1 operations in 109914ns; attempting to update the registry
I0725 05:01:09.772847 723 registrar.cpp:550] Successfully updated the registry in 632832ns
I0725 05:01:09.773006 713 master.cpp:5877] Admitted agent 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S1 at slave(95)@172.17.0.5:34725 (maintenance-host-2)
I0725 05:01:09.773533 721 slave.cpp:4883] Received ping from slave-observer(89)@172.17.0.5:34725
I0725 05:01:09.773754 721 slave.cpp:1174] Registered with master master@172.17.0.5:34725; given agent ID 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S1
I0725 05:01:09.773605 713 master.cpp:5908] Registered agent 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S1 at slave(95)@172.17.0.5:34725 (maintenance-host-2) with [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0725 05:01:09.773843 727 hierarchical.cpp:593] Added agent 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S1 (maintenance-host-2) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0725 05:01:09.773890 713 status_update_manager.cpp:184] Resuming sending status updates
I0725 05:01:09.774093 727 hierarchical.cpp:1925] No allocations performed
I0725 05:01:09.774137 727 hierarchical.cpp:1468] Performed allocation for 1 agents in 156552ns
I0725 05:01:09.774158 721 slave.cpp:1194] Checkpointing SlaveInfo to '/tmp/MasterMaintenanceTest_InverseOffersFilters_uo20E2/meta/slaves/4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S1/slave.info'
I0725 05:01:09.774497 721 slave.cpp:1232] Forwarding total oversubscribed resources {}
I0725 05:01:09.774637 722 master.cpp:6644] Received update of agent 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S1 at slave(95)@172.17.0.5:34725 (maintenance-host-2) with total oversubscribed resources {}
I0725 05:01:09.774883 714 hierarchical.cpp:660] Agent 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S1 (maintenance-host-2) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0725 05:01:09.776113 718 process.cpp:3837] Handling HTTP event for process 'master' with path: '/master/maintenance/schedule'
I0725 05:01:09.777333 717 http.cpp:1133] HTTP POST for /master/maintenance/schedule from 172.17.0.5:36986
I0725 05:01:09.778470 706 registrar.cpp:493] Applied 1 operations in 238794ns; attempting to update the registry
I0725 05:01:09.779130 706 registrar.cpp:550] Successfully updated the registry in 593920ns
I0725 05:01:09.779402 714 master.cpp:6719] Updating unavailability of agent 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S0 at slave(94)@172.17.0.5:34725 (maintenance-host), starting at 2486.74469374014weeks
I0725 05:01:09.779515 714 master.cpp:6719] Updating unavailability of agent 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S1 at slave(95)@172.17.0.5:34725 (maintenance-host-2), starting at 2486.74469374014weeks
I0725 05:01:09.779682 705 hierarchical.cpp:1925] No allocations performed
I0725 05:01:09.779722 705 hierarchical.cpp:1468] Performed allocation for 1 agents in 129548ns
I0725 05:01:09.779933 705 hierarchical.cpp:1925] No allocations performed
I0725 05:01:09.779969 705 hierarchical.cpp:1468] Performed allocation for 1 agents in 120369ns
I0725 05:01:09.781208 704 scheduler.cpp:184] Version: 1.4.0
I0725 05:01:09.781740 722 scheduler.cpp:470] New master detected at master@172.17.0.5:34725
I0725 05:01:09.781761 722 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0725 05:01:09.782927 716 scheduler.cpp:361] Connected with the master at http://172.17.0.5:34725/master/api/v1/scheduler
I0725 05:01:09.783867 710 scheduler.cpp:243] Sending SUBSCRIBE call to http://172.17.0.5:34725/master/api/v1/scheduler
I0725 05:01:09.784629 714 process.cpp:3837] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0725 05:01:09.785805 724 http.cpp:1133] HTTP POST for /master/api/v1/scheduler from 172.17.0.5:36988
I0725 05:01:09.786005 724 master.cpp:2545] Received subscription request for HTTP framework 'default'
I0725 05:01:09.786041 724 master.cpp:2228] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0725 05:01:09.786408 728 master.cpp:2681] Subscribing framework 'default' with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
I0725 05:01:09.786900 721 master.hpp:2215] Sending heartbeat to 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
I0725 05:01:09.787015 716 hierarchical.cpp:303] Added framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
I0725 05:01:09.787428 708 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from http://172.17.0.5:34725/master/api/v1/scheduler
I0725 05:01:09.787762 708 scheduler.cpp:676] Enqueuing event HEARTBEAT received from http://172.17.0.5:34725/master/api/v1/scheduler
I0725 05:01:09.788653 716 hierarchical.cpp:1468] Performed allocation for 2 agents in 1.474642ms
I0725 05:01:09.789095 726 master.cpp:7623] Sending 2 offers to framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 (default)
I0725 05:01:09.789741 726 master.cpp:7712] Sending 2 inverse offers to framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 (default)
I0725 05:01:09.791074 727 scheduler.cpp:676] Enqueuing event OFFERS received from http://172.17.0.5:34725/master/api/v1/scheduler
I0725 05:01:09.791726 727 scheduler.cpp:676] Enqueuing event INVERSE_OFFERS received from http://172.17.0.5:34725/master/api/v1/scheduler
I0725 05:01:09.795301 724 hierarchical.cpp:1925] No allocations performed
I0725 05:01:09.795467 724 hierarchical.cpp:1468] Performed allocation for 2 agents in 249657ns
I0725 05:01:09.796851 723 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.5:34725/master/api/v1/scheduler
I0725 05:01:09.797382 723 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.5:34725/master/api/v1/scheduler
I0725 05:01:09.797921 706 process.cpp:3837] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0725 05:01:09.799201 710 process.cpp:3837] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0725 05:01:09.799821 715 http.cpp:1133] HTTP POST for /master/api/v1/scheduler from 172.17.0.5:36990
I0725 05:01:09.800956 715 master.cpp:4123] Processing ACCEPT call for offers: [ 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-O0 ] on agent 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S1 at slave(95)@172.17.0.5:34725 (maintenance-host-2) for framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 (default)
I0725 05:01:09.801080 715 master.cpp:3500] Authorizing framework principal 'test-principal' to launch task 049494e8-d652-4221-b2d1-8f71d0844027
W0725 05:01:09.803234 715 validation.cpp:1294] Executor 'executor-1' for task '049494e8-d652-4221-b2d1-8f71d0844027' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0725 05:01:09.803263 715 validation.cpp:1306] Executor 'executor-1' for task '049494e8-d652-4221-b2d1-8f71d0844027' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0725 05:01:09.803719 715 master.cpp:9674] Adding task 049494e8-d652-4221-b2d1-8f71d0844027 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] on agent 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S1 at slave(95)@172.17.0.5:34725 (maintenance-host-2)
I0725 05:01:09.804282 715 master.cpp:4786] Launching task 049494e8-d652-4221-b2d1-8f71d0844027 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 (default) with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] on agent 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S1 at slave(95)@172.17.0.5:34725 (maintenance-host-2)
I0725 05:01:09.804760 726 slave.cpp:1697] Got assigned task '049494e8-d652-4221-b2d1-8f71d0844027' for framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
I0725 05:01:09.804802 715 http.cpp:1133] HTTP POST for /master/api/v1/scheduler from 172.17.0.5:36990
I0725 05:01:09.805287 726 slave.cpp:1978] Authorizing task '049494e8-d652-4221-b2d1-8f71d0844027' for framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
I0725 05:01:09.805335 726 slave.cpp:6706] Authorizing framework principal 'test-principal' to launch task 049494e8-d652-4221-b2d1-8f71d0844027
I0725 05:01:09.805721 715 master.cpp:4123] Processing ACCEPT call for offers: [ 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-O1 ] on agent 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S0 at slave(94)@172.17.0.5:34725 (maintenance-host) for framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 (default)
I0725 05:01:09.805804 715 master.cpp:3500] Authorizing framework principal 'test-principal' to launch task bde0e339-ad48-4d89-89fe-efef27e52ba6
I0725 05:01:09.806025 728 hierarchical.cpp:887] Updated allocation of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 on agent 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-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]
I0725 05:01:09.806094 721 slave.cpp:2165] Launching task '049494e8-d652-4221-b2d1-8f71d0844027' for framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
I0725 05:01:09.806665 721 paths.cpp:578] Trying to chown '/tmp/MasterMaintenanceTest_InverseOffersFilters_uo20E2/slaves/4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S1/frameworks/4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000/executors/executor-1/runs/76dfe16b-3131-4f4a-89bb-3b9befc71aa8' to user 'mesos'
I0725 05:01:09.806891 721 slave.cpp:7162] Launching executor 'executor-1' of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 with resources [] in work directory '/tmp/MasterMaintenanceTest_InverseOffersFilters_uo20E2/slaves/4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S1/frameworks/4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000/executors/executor-1/runs/76dfe16b-3131-4f4a-89bb-3b9befc71aa8'
W0725 05:01:09.807461 715 validation.cpp:1294] Executor 'executor-2' for task 'bde0e339-ad48-4d89-89fe-efef27e52ba6' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0725 05:01:09.807484 715 validation.cpp:1306] Executor 'executor-2' for task 'bde0e339-ad48-4d89-89fe-efef27e52ba6' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0725 05:01:09.807536 721 slave.cpp:2394] Queued task '049494e8-d652-4221-b2d1-8f71d0844027' for executor 'executor-1' of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
I0725 05:01:09.807605 721 slave.cpp:924] Successfully attached file '/tmp/MasterMaintenanceTest_InverseOffersFilters_uo20E2/slaves/4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S1/frameworks/4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000/executors/executor-1/runs/76dfe16b-3131-4f4a-89bb-3b9befc71aa8'
I0725 05:01:09.807629 721 slave.cpp:924] Successfully attached file '/tmp/MasterMaintenanceTest_InverseOffersFilters_uo20E2/slaves/4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S1/frameworks/4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000/executors/executor-1/runs/76dfe16b-3131-4f4a-89bb-3b9befc71aa8'
I0725 05:01:09.807835 721 slave.cpp:2852] Launching container 76dfe16b-3131-4f4a-89bb-3b9befc71aa8 for executor 'executor-1' of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
I0725 05:01:09.807857 715 master.cpp:9674] Adding task bde0e339-ad48-4d89-89fe-efef27e52ba6 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] on agent 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S0 at slave(94)@172.17.0.5:34725 (maintenance-host)
I0725 05:01:09.808285 715 master.cpp:4786] Launching task bde0e339-ad48-4d89-89fe-efef27e52ba6 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 (default) with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] on agent 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S0 at slave(94)@172.17.0.5:34725 (maintenance-host)
I0725 05:01:09.808984 723 slave.cpp:1697] Got assigned task 'bde0e339-ad48-4d89-89fe-efef27e52ba6' for framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
I0725 05:01:09.809759 723 slave.cpp:1978] Authorizing task 'bde0e339-ad48-4d89-89fe-efef27e52ba6' for framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
I0725 05:01:09.809823 723 slave.cpp:6706] Authorizing framework principal 'test-principal' to launch task bde0e339-ad48-4d89-89fe-efef27e52ba6
I0725 05:01:09.809952 708 exec.cpp:162] Version: 1.4.0
I0725 05:01:09.810181 726 exec.cpp:212] Executor started at: executor(28)@172.17.0.5:34725 with pid 704
I0725 05:01:09.810163 716 hierarchical.cpp:887] Updated allocation of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 on agent 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-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]
I0725 05:01:09.810406 725 slave.cpp:3877] Got registration for executor 'executor-1' of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 from executor(28)@172.17.0.5:34725
I0725 05:01:09.810842 728 slave.cpp:2165] Launching task 'bde0e339-ad48-4d89-89fe-efef27e52ba6' for framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
I0725 05:01:09.810914 719 exec.cpp:237] Executor registered on agent 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S1
I0725 05:01:09.810967 719 exec.cpp:249] Executor::registered took 27720ns
I0725 05:01:09.811499 728 paths.cpp:578] Trying to chown '/tmp/MasterMaintenanceTest_InverseOffersFilters_zDb1k7/slaves/4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S0/frameworks/4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000/executors/executor-2/runs/e4267539-c2fd-44b0-8fe1-cbec982cb161' to user 'mesos'
I0725 05:01:09.811602 725 slave.cpp:2599] Sending queued task '049494e8-d652-4221-b2d1-8f71d0844027' to executor 'executor-1' of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 at executor(28)@172.17.0.5:34725
I0725 05:01:09.811761 728 slave.cpp:7162] Launching executor 'executor-2' of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 with resources [] in work directory '/tmp/MasterMaintenanceTest_InverseOffersFilters_zDb1k7/slaves/4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S0/frameworks/4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000/executors/executor-2/runs/e4267539-c2fd-44b0-8fe1-cbec982cb161'
I0725 05:01:09.811929 712 exec.cpp:331] Executor asked to run task '049494e8-d652-4221-b2d1-8f71d0844027'
I0725 05:01:09.812014 712 exec.cpp:340] Executor::launchTask took 69652ns
I0725 05:01:09.812120 712 exec.cpp:571] Executor sending status update TASK_RUNNING (UUID: e0e09cc4-9a8c-45ab-bbbb-a6992d3ed3eb) for task 049494e8-d652-4221-b2d1-8f71d0844027 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
I0725 05:01:09.812357 717 slave.cpp:4341] Handling status update TASK_RUNNING (UUID: e0e09cc4-9a8c-45ab-bbbb-a6992d3ed3eb) for task 049494e8-d652-4221-b2d1-8f71d0844027 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 from executor(28)@172.17.0.5:34725
I0725 05:01:09.812731 728 slave.cpp:2394] Queued task 'bde0e339-ad48-4d89-89fe-efef27e52ba6' for executor 'executor-2' of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
I0725 05:01:09.812865 728 slave.cpp:924] Successfully attached file '/tmp/MasterMaintenanceTest_InverseOffersFilters_zDb1k7/slaves/4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S0/frameworks/4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000/executors/executor-2/runs/e4267539-c2fd-44b0-8fe1-cbec982cb161'
I0725 05:01:09.812902 728 slave.cpp:924] Successfully attached file '/tmp/MasterMaintenanceTest_InverseOffersFilters_zDb1k7/slaves/4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S0/frameworks/4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000/executors/executor-2/runs/e4267539-c2fd-44b0-8fe1-cbec982cb161'
I0725 05:01:09.812970 717 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: e0e09cc4-9a8c-45ab-bbbb-a6992d3ed3eb) for task 049494e8-d652-4221-b2d1-8f71d0844027 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
I0725 05:01:09.813014 717 status_update_manager.cpp:500] Creating StatusUpdate stream for task 049494e8-d652-4221-b2d1-8f71d0844027 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
I0725 05:01:09.813292 728 slave.cpp:2852] Launching container e4267539-c2fd-44b0-8fe1-cbec982cb161 for executor 'executor-2' of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
I0725 05:01:09.813477 717 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: e0e09cc4-9a8c-45ab-bbbb-a6992d3ed3eb) for task 049494e8-d652-4221-b2d1-8f71d0844027 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 to the agent
I0725 05:01:09.813727 715 slave.cpp:4793] Forwarding the update TASK_RUNNING (UUID: e0e09cc4-9a8c-45ab-bbbb-a6992d3ed3eb) for task 049494e8-d652-4221-b2d1-8f71d0844027 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 to master@172.17.0.5:34725
I0725 05:01:09.814041 715 slave.cpp:4687] Status update manager successfully handled status update TASK_RUNNING (UUID: e0e09cc4-9a8c-45ab-bbbb-a6992d3ed3eb) for task 049494e8-d652-4221-b2d1-8f71d0844027 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
I0725 05:01:09.814081 715 slave.cpp:4703] Sending acknowledgement for status update TASK_RUNNING (UUID: e0e09cc4-9a8c-45ab-bbbb-a6992d3ed3eb) for task 049494e8-d652-4221-b2d1-8f71d0844027 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 to executor(28)@172.17.0.5:34725
I0725 05:01:09.814261 715 exec.cpp:388] Executor received status update acknowledgement e0e09cc4-9a8c-45ab-bbbb-a6992d3ed3eb for task 049494e8-d652-4221-b2d1-8f71d0844027 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
I0725 05:01:09.814388 722 master.cpp:6802] Status update TASK_RUNNING (UUID: e0e09cc4-9a8c-45ab-bbbb-a6992d3ed3eb) for task 049494e8-d652-4221-b2d1-8f71d0844027 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 from agent 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S1 at slave(95)@172.17.0.5:34725 (maintenance-host-2)
I0725 05:01:09.814446 722 master.cpp:6864] Forwarding status update TASK_RUNNING (UUID: e0e09cc4-9a8c-45ab-bbbb-a6992d3ed3eb) for task 049494e8-d652-4221-b2d1-8f71d0844027 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
I0725 05:01:09.814846 722 master.cpp:8884] Updating the state of task 049494e8-d652-4221-b2d1-8f71d0844027 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
*** Aborted at 1500958869 (unix time) try "date -d @1500958869" if you are using GNU date ***
PC: @ 0x2b4afb0c682d (unknown)
I0725 05:01:09.816159 721 exec.cpp:162] Version: 1.4.0
I0725 05:01:09.816176 723 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.5:34725/master/api/v1/scheduler
*** SIGSEGV (@0xb0) received by PID 704 (TID 0x2b4b04e5c700) from PID 176; stack trace: ***
I0725 05:01:09.816418 720 exec.cpp:212] Executor started at: executor(29)@172.17.0.5:34725 with pid 704
@ 0x2b4afa65d330 (unknown)
I0725 05:01:09.816721 720 slave.cpp:3877] Got registration for executor 'executor-2' of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 from executor(29)@172.17.0.5:34725
@ 0x2b4afb0c682d (unknown)
@ 0x2b4afb0bc6f1 (unknown)
I0725 05:01:09.817386 711 exec.cpp:237] Executor registered on agent 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S0
I0725 05:01:09.817432 711 exec.cpp:249] Executor::registered took 28285ns
@ 0x2b4afb113c9e (unknown)
I0725 05:01:09.818495 720 slave.cpp:2599] Sending queued task 'bde0e339-ad48-4d89-89fe-efef27e52ba6' to executor 'executor-2' of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 at executor(29)@172.17.0.5:34725
I0725 05:01:09.818634 724 scheduler.cpp:243] Sending ACKNOWLEDGE call to http://172.17.0.5:34725/master/api/v1/scheduler
I0725 05:01:09.818985 709 exec.cpp:331] Executor asked to run task 'bde0e339-ad48-4d89-89fe-efef27e52ba6'
I0725 05:01:09.819070 709 exec.cpp:340] Executor::launchTask took 74978ns
I0725 05:01:09.819167 709 exec.cpp:571] Executor sending status update TASK_RUNNING (UUID: 4ff21136-5ee3-4eeb-872e-4806a2b3a411) for task bde0e339-ad48-4d89-89fe-efef27e52ba6 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
I0725 05:01:09.819402 709 slave.cpp:4341] Handling status update TASK_RUNNING (UUID: 4ff21136-5ee3-4eeb-872e-4806a2b3a411) for task bde0e339-ad48-4d89-89fe-efef27e52ba6 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 from executor(29)@172.17.0.5:34725
I0725 05:01:09.820044 709 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 4ff21136-5ee3-4eeb-872e-4806a2b3a411) for task bde0e339-ad48-4d89-89fe-efef27e52ba6 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
I0725 05:01:09.820075 709 status_update_manager.cpp:500] Creating StatusUpdate stream for task bde0e339-ad48-4d89-89fe-efef27e52ba6 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
I0725 05:01:09.820363 706 process.cpp:3837] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0725 05:01:09.820567 709 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 4ff21136-5ee3-4eeb-872e-4806a2b3a411) for task bde0e339-ad48-4d89-89fe-efef27e52ba6 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 to the agent
I0725 05:01:09.820789 716 slave.cpp:4793] Forwarding the update TASK_RUNNING (UUID: 4ff21136-5ee3-4eeb-872e-4806a2b3a411) for task bde0e339-ad48-4d89-89fe-efef27e52ba6 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 to master@172.17.0.5:34725
I0725 05:01:09.820976 716 slave.cpp:4687] Status update manager successfully handled status update TASK_RUNNING (UUID: 4ff21136-5ee3-4eeb-872e-4806a2b3a411) for task bde0e339-ad48-4d89-89fe-efef27e52ba6 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
I0725 05:01:09.821014 716 slave.cpp:4703] Sending acknowledgement for status update TASK_RUNNING (UUID: 4ff21136-5ee3-4eeb-872e-4806a2b3a411) for task bde0e339-ad48-4d89-89fe-efef27e52ba6 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 to executor(29)@172.17.0.5:34725
I0725 05:01:09.821147 707 exec.cpp:388] Executor received status update acknowledgement 4ff21136-5ee3-4eeb-872e-4806a2b3a411 for task bde0e339-ad48-4d89-89fe-efef27e52ba6 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
I0725 05:01:09.821140 708 master.cpp:6802] Status update TASK_RUNNING (UUID: 4ff21136-5ee3-4eeb-872e-4806a2b3a411) for task bde0e339-ad48-4d89-89fe-efef27e52ba6 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 from agent 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S0 at slave(94)@172.17.0.5:34725 (maintenance-host)
I0725 05:01:09.821193 708 master.cpp:6864] Forwarding status update TASK_RUNNING (UUID: 4ff21136-5ee3-4eeb-872e-4806a2b3a411) for task bde0e339-ad48-4d89-89fe-efef27e52ba6 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
I0725 05:01:09.821557 708 master.cpp:8884] Updating the state of task bde0e339-ad48-4d89-89fe-efef27e52ba6 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
@ 0x1afb217 os::strerror()
@ 0x1afb197 ErrnoError::ErrnoError()
@ 0x1afb164 ErrnoError::ErrnoError()
@ 0x2b4af6157e62 process::io::internal::read()::$_3::operator()()
@ 0x2b4af6157157 process::internal::Loop<>::start()
@ 0x2b4af6136910 process::loop<>()
@ 0x2b4af613684b process::io::internal::read()
@ 0x2b4af6136e11 process::io::read()
@ 0x2b4af61cd67e process::network::internal::PollSocketImpl::recv()
@ 0x2b4af62eeffa process::network::internal::SocketImpl::recv()
@ 0x2b4af60faa1e process::network::internal::Socket<>::recv()
@ 0x2b4af60fa8b2 process::http::internal::ConnectionProcess::read()
@ 0x2b4af60fb9a2 process::http::internal::ConnectionProcess::_read()
@ 0x2b4af60ff476 _ZZN7process8dispatchINS_4http8internal17ConnectionProcessERKNS_6FutureISsEES5_EEvRKNS_3PIDIT_EEMS9_FvT0_ET1_ENKUlPNS_11ProcessBaseEE_clESI_
@ 0x2b4af60ff0c2 _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8dispatchINS0_4http8internal17ConnectionProcessERKNS0_6FutureISsEES9_EEvRKNS0_3PIDIT_EEMSD_FvT0_ET1_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_
@ 0x2b4af62290d8 std::function<>::operator()()
@ 0x2b4af620de84 process::ProcessBase::visit()
I0725 05:01:09.860810 718 http.cpp:1133] HTTP POST for /master/api/v1/scheduler from 172.17.0.5:36990
I0725 05:01:09.861068 718 master.cpp:5442] Processing ACKNOWLEDGE call e0e09cc4-9a8c-45ab-bbbb-a6992d3ed3eb for task 049494e8-d652-4221-b2d1-8f71d0844027 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000 (default) on agent 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-S1
I0725 05:01:09.861639 718 status_update_manager.cpp:395] Received status update acknowledgement (UUID: e0e09cc4-9a8c-45ab-bbbb-a6992d3ed3eb) for task 049494e8-d652-4221-b2d1-8f71d0844027 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
@ 0x2b4af629e77e process::DispatchEvent::visit()
I0725 05:01:09.861918 718 slave.cpp:3605] Status update manager successfully handled status update acknowledgement (UUID: e0e09cc4-9a8c-45ab-bbbb-a6992d3ed3eb) for task 049494e8-d652-4221-b2d1-8f71d0844027 of framework 4b5af6ce-de17-4ce2-a6b6-635f8f70cf08-0000
@ 0x1b3f941 process::ProcessBase::serve()
@ 0x2b4af620bdda process::ProcessManager::resume()
@ 0x2b4af6219a31 process::ProcessManager::init_threads()::$_7::operator()()
@ 0x2b4af6219975 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvE3$_7vEE9_M_invokeIJEEEvSt12_Index_tupleIJXspT_EEE
@ 0x2b4af6219945 std::_Bind_simple<>::operator()()
@ 0x2b4af621991c std::thread::_Impl<>::_M_run()
@ 0x2b4afa91ca60 (unknown)
@ 0x2b4afa655184 start_thread
@ 0x2b4afb188ffd (unknown)
make[3]: Leaving directory `/mesos/build'
make[3]: *** [CMakeFiles/check] Segmentation fault (core dumped)
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-1500956907-5405
Untagged: mesos-1500956907-5405:latest
Deleted: sha256:1e89c81ed7db3608397e23e9b48a5b2b2be3eae4d56de6a49adfb739a209a1c8
Deleted: sha256:3b24a2ef07701dcd578796c57e1ce66ad75b2aef14bb20995927161f34c9dcb2
Deleted: sha256:20ee53dbc55368b74bb4f0ba348bcd660cea592de6b00ea76998627f5cb24974
Deleted: sha256:f88ae92ab5b0cb5162929a9c9428a69e1ffb50ab4431d21543faa656957a95af
Deleted: sha256:3e24fc8246f8b6874afc2e785af27bd5d3e0bfc34a802f1e2f07091ae3c2e60e
Deleted: sha256:2c32a9eb7a824f8a1ff56c571c152bbcca0c8fde854171321e8e11bdf3e4163d
Deleted: sha256:9c20fb11149728b7ed4e4124bda9e33f98f774b98ce41cc30dcd48d6b88e11bc
Deleted: sha256:53e113320f8eddc1a7960960f43723b7bc897f7a2026d6d12f4ff3f55a31d41e
Deleted: sha256:88c4dc973e8eb542fb5eea7219c60fb088331d82eed6b237441896f8cd64da9d
Deleted: sha256:4e69f9cf0c6dd9b7902ed76cebe3ea0afe6330bb30f3c7721ce3ba6d05eec7c8
Deleted: sha256:f26b0ec6b25ffee9d6fd360407297cd40e6c2a4b9e225ec3869d6b08da75fba1
Deleted: sha256:cba9e4abbde2f8df6ddeada3b200a6948361f6d1ea2e2ed05205af3c542ade13
Deleted: sha256:35adb29f44f700d95cbddcaee6e36b9947794680ac947d921624bd63edf40139
Deleted: sha256:75ec665dbe69aebd5a9a92dafba22ec2f558be3d8f9aee9998669f98727fc52b
Deleted: sha256:c0a2323c2cd3fc8f1b415a0fbff651b89a84f3e65a9c0aaf206570c03addbdc0
Deleted: sha256:9f71a281cf1374d734f96b80d191f40b850e1130480373397c0d7dec314b73c7
Deleted: sha256:e8558494857c33b0c995170f636fa017bc701df651bbfaab2a1e5c2609892895
Deleted: sha256:4de2ee6fc6361e0133ca94d59e8108927887398368617a0940e28a3f54b630c2
Deleted: sha256:236ab809a09ecc7aa89a93379146d44cec15c506bc989129f009eea79a7c6fa3
Deleted: sha256:9b9468945a6681bf18cf21c2ea8fff500b4ef58bf25fe8bd3c2b237e50082c93
Deleted: sha256:9702bd7bb77bfca63383b461e41fd8cbdd4fbf45a7ca7f0a57eec4be0648952b
Deleted: sha256:85f51b7cc12e42efff83c402bbf134fe4846316919a25df75b689484a3cbdf1a
Deleted: sha256:d69602f5c71e0795c23ac134d8593c3ace6542ab2c38df8ca47485fecdea9ed7
Deleted: sha256:b5e621367ebb1a9dd3aa7845fefe43f4555570ddb7c48a6f41194508d337f98f
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos-Buildbot » cmake,clang,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3952
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3952/display/redirect?page=changes>