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/11/28 00:25:31 UTC

Build failed in Jenkins: Mesos-Buildbot » cmake,clang,--verbose --disable-libtool-wrappers --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4503

See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,CONFIGURATION=--verbose%20--disable-libtool-wrappers%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4503/display/redirect?page=changes>

Changes:

[andrew] Added Andrew Schwartzmeyer to the list of committers.

[andrew] Added Windows to "don't break the build" note in `committing.md`.

[andrew] Windows: Fixed variable casing in `windows/os.hpp`.

------------------------------------------
[...truncated 35.06 MB...]
3: I1128 00:25:16.470875 24435 master.cpp:8312] Authenticating slave(951)@172.17.0.5:54461
3: I1128 00:25:16.471031 24441 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1706)@172.17.0.5:54461
3: I1128 00:25:16.471459 24441 authenticator.cpp:98] Creating new server SASL connection
3: I1128 00:25:16.471704 24441 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1128 00:25:16.471725 24441 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1128 00:25:16.471856 24431 authenticator.cpp:204] Received SASL authentication start
3: I1128 00:25:16.471923 24431 authenticator.cpp:326] Authentication requires more steps
3: I1128 00:25:16.472026 24436 authenticatee.cpp:259] Received SASL authentication step
3: I1128 00:25:16.472139 24431 authenticator.cpp:232] Received SASL authentication step
3: I1128 00:25:16.472168 24431 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '1892248cd782' server FQDN: '1892248cd782' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
3: I1128 00:25:16.472183 24431 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1128 00:25:16.472245 24431 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1128 00:25:16.472280 24431 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '1892248cd782' server FQDN: '1892248cd782' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
3: I1128 00:25:16.472295 24431 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1128 00:25:16.472302 24431 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1128 00:25:16.472319 24431 authenticator.cpp:318] Authentication success
3: I1128 00:25:16.472405 24429 authenticatee.cpp:299] Authentication success
3: I1128 00:25:16.472514 24438 master.cpp:8342] Successfully authenticated principal 'test-principal' at slave(951)@172.17.0.5:54461
3: I1128 00:25:16.472739 24432 slave.cpp:1161] Successfully authenticated with master master@172.17.0.5:54461
3: I1128 00:25:16.472977 24432 slave.cpp:1685] Will retry registration in 1.495038ms if necessary
3: I1128 00:25:16.473088 24431 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1706)@172.17.0.5:54461
3: I1128 00:25:16.473294 24428 master.cpp:6036] Received register agent message from slave(951)@172.17.0.5:54461 (1892248cd782)
3: I1128 00:25:16.473331 24428 master.cpp:3872] Authorizing agent with principal 'test-principal'
3: I1128 00:25:16.473759 24441 master.cpp:6098] Authorized registration of agent at slave(951)@172.17.0.5:54461 (1892248cd782)
3: I1128 00:25:16.473873 24441 master.cpp:6191] Registering agent at slave(951)@172.17.0.5:54461 (1892248cd782) with id 78fac9e7-529b-4a69-a093-ce47559ea193-S0
3: I1128 00:25:16.474279 24434 registrar.cpp:495] Applied 1 operations in 76193ns; attempting to update the registry
3: I1128 00:25:16.474753 24436 hierarchical.cpp:1457] Performed allocation for 0 agents in 63533ns
3: I1128 00:25:16.474889 24434 registrar.cpp:552] Successfully updated the registry in 560128ns
3: I1128 00:25:16.475088 24430 master.cpp:6240] Admitted agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 at slave(951)@172.17.0.5:54461 (1892248cd782)
3: I1128 00:25:16.475729 24430 master.cpp:6276] Registered agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 at slave(951)@172.17.0.5:54461 (1892248cd782) with cpus:1; mem:512; disk:3701220; ports:[31000-32000]
3: I1128 00:25:16.475842 24443 slave.cpp:1207] Registered with master master@172.17.0.5:54461; given agent ID 78fac9e7-529b-4a69-a093-ce47559ea193-S0
3: I1128 00:25:16.475977 24440 task_status_update_manager.cpp:188] Resuming sending task status updates
3: I1128 00:25:16.476161 24432 hierarchical.cpp:600] Added agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 (1892248cd782) with cpus:1; mem:512; disk:3701220; ports:[31000-32000] (allocated: {})
3: I1128 00:25:16.476275 24443 slave.cpp:1227] Checkpointing SlaveInfo to '/tmp/ResourceProviderCapability_ReservationTest_PreventUnreservingAlienResources_1_hSrgYI/meta/slaves/78fac9e7-529b-4a69-a093-ce47559ea193-S0/slave.info'
3: I1128 00:25:16.476436 24432 hierarchical.cpp:1457] Performed allocation for 1 agents in 147194ns
3: I1128 00:25:16.476868 24443 slave.cpp:1288] Forwarding total resources cpus:1; mem:512; disk:3701220; ports:[31000-32000]
3: I1128 00:25:16.476991 24443 slave.cpp:1298] Forwarding total oversubscribed resources {}
3: I1128 00:25:16.477630 24443 master.cpp:7078] Received update of agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 at slave(951)@172.17.0.5:54461 (1892248cd782) with total resources cpus:1; mem:512; disk:3701220; ports:[31000-32000]
3: I1128 00:25:16.477733 24443 master.cpp:7091] Received update of agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 at slave(951)@172.17.0.5:54461 (1892248cd782) with total oversubscribed resources {}
3: I1128 00:25:16.478052 24443 master.cpp:7109] Ignoring update on agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 at slave(951)@172.17.0.5:54461 (1892248cd782) as it reports no changes
3: W1128 00:25:16.478118 17607 process.cpp:2756] Attempted to spawn already running process version@172.17.0.5:54461
3: W1128 00:25:16.478622 17607 process.cpp:2756] Attempted to spawn already running process version@172.17.0.5:54461
3: I1128 00:25:16.479565 17607 sched.cpp:232] Version: 1.5.0
3: I1128 00:25:16.480106 24432 sched.cpp:336] New master detected at master@172.17.0.5:54461
3: I1128 00:25:16.480183 24432 sched.cpp:396] Authenticating with master master@172.17.0.5:54461
3: I1128 00:25:16.480199 24432 sched.cpp:403] Using default CRAM-MD5 authenticatee
3: I1128 00:25:16.480512 24428 authenticatee.cpp:121] Creating new client SASL connection
3: I1128 00:25:16.480741 24441 master.cpp:8312] Authenticating scheduler-c1b266fc-1cac-471d-a8b7-4aa30d5cf058@172.17.0.5:54461
3: I1128 00:25:16.480836 24435 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1707)@172.17.0.5:54461
3: I1128 00:25:16.481123 24442 authenticator.cpp:98] Creating new server SASL connection
3: I1128 00:25:16.481302 24437 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1128 00:25:16.481323 24437 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1128 00:25:16.481434 24443 authenticator.cpp:204] Received SASL authentication start
3: I1128 00:25:16.481739 24443 authenticator.cpp:326] Authentication requires more steps
3: I1128 00:25:16.481997 24443 authenticatee.cpp:259] Received SASL authentication step
3: I1128 00:25:16.482269 24438 authenticator.cpp:232] Received SASL authentication step
3: I1128 00:25:16.482300 24438 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '1892248cd782' server FQDN: '1892248cd782' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
3: I1128 00:25:16.482313 24438 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1128 00:25:16.482355 24438 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1128 00:25:16.482375 24438 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '1892248cd782' server FQDN: '1892248cd782' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
3: I1128 00:25:16.482386 24438 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1128 00:25:16.482394 24438 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1128 00:25:16.482409 24438 authenticator.cpp:318] Authentication success
3: I1128 00:25:16.482609 24438 master.cpp:8342] Successfully authenticated principal 'test-principal' at scheduler-c1b266fc-1cac-471d-a8b7-4aa30d5cf058@172.17.0.5:54461
3: I1128 00:25:16.482702 24438 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1707)@172.17.0.5:54461
3: I1128 00:25:16.485539 24430 hierarchical.cpp:1457] Performed allocation for 1 agents in 179451ns
3: I1128 00:25:16.485826 24443 authenticatee.cpp:299] Authentication success
3: I1128 00:25:16.489270 24443 sched.cpp:502] Successfully authenticated with master master@172.17.0.5:54461
3: I1128 00:25:16.489291 24443 sched.cpp:824] Sending SUBSCRIBE call to master@172.17.0.5:54461
3: I1128 00:25:16.489452 24443 sched.cpp:857] Will retry registration in 826.175449ms if necessary
3: I1128 00:25:16.489650 24428 master.cpp:2963] Received SUBSCRIBE call for framework 'framework1' at scheduler-c1b266fc-1cac-471d-a8b7-4aa30d5cf058@172.17.0.5:54461
3: I1128 00:25:16.489673 24428 master.cpp:2280] Authorizing framework principal 'test-principal' to receive offers for roles '{ role1 }'
3: I1128 00:25:16.490103 24441 master.cpp:3043] Subscribing framework framework1 with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1128 00:25:16.490665 24437 sched.cpp:751] Framework registered with 78fac9e7-529b-4a69-a093-ce47559ea193-0000
3: I1128 00:25:16.490710 24437 sched.cpp:765] Scheduler::registered took 28864ns
3: I1128 00:25:16.490845 24442 hierarchical.cpp:306] Added framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000
3: I1128 00:25:16.491856 24442 hierarchical.cpp:1457] Performed allocation for 1 agents in 900458ns
3: I1128 00:25:16.492292 24433 master.cpp:8142] Sending 1 offers to framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000 (framework1) at scheduler-c1b266fc-1cac-471d-a8b7-4aa30d5cf058@172.17.0.5:54461
3: I1128 00:25:16.492935 24430 sched.cpp:921] Scheduler::resourceOffers took 157636ns
3: I1128 00:25:16.494331 24435 hierarchical.cpp:1457] Performed allocation for 1 agents in 142346ns
3: I1128 00:25:16.495050 24429 master.cpp:10063] Removing offer 78fac9e7-529b-4a69-a093-ce47559ea193-O0
3: I1128 00:25:16.495282 24429 master.cpp:4230] Processing ACCEPT call for offers: [ 78fac9e7-529b-4a69-a093-ce47559ea193-O0 ] on agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 at slave(951)@172.17.0.5:54461 (1892248cd782) for framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000 (framework1) at scheduler-c1b266fc-1cac-471d-a8b7-4aa30d5cf058@172.17.0.5:54461
3: I1128 00:25:16.495522 24429 master.cpp:3657] Authorizing principal 'test-principal' to reserve resources '[{"allocation_info":{"role":"role1"},"name":"mem","reservations":[{"principal":"test-principal","role":"role1","type":"DYNAMIC"}],"scalar":{"value":256.0},"type":"SCALAR"}]'
3: I1128 00:25:16.496894 24429 master.cpp:4563] Applying RESERVE operation for resources [{"allocation_info":{"role":"role1"},"name":"mem","reservations":[{"principal":"test-principal","role":"role1","type":"DYNAMIC"}],"scalar":{"value":256.0},"type":"SCALAR"}] from framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000 (framework1) at scheduler-c1b266fc-1cac-471d-a8b7-4aa30d5cf058@172.17.0.5:54461 to agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 at slave(951)@172.17.0.5:54461 (1892248cd782)
3: I1128 00:25:16.497619 24429 master.cpp:9945] Sending offer operation '' (uuid: e3b3c7b6-9069-447c-ad42-3a8443449412) to agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 at slave(951)@172.17.0.5:54461 (1892248cd782)
3: I1128 00:25:16.498672 24433 slave.cpp:3594] Updated checkpointed resources from {} to mem(reservations: [(DYNAMIC,role1,test-principal)]):256
3: I1128 00:25:16.498764 24433 slave.cpp:6988] Updating the state of offer operation '' (uuid: e3b3c7b6-9069-447c-ad42-3a8443449412) of framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000 (latest state: OFFER_OPERATION_FINISHED, status update state: OFFER_OPERATION_FINISHED)
3: I1128 00:25:16.499045 24430 master.cpp:9731] Updating the state of offer operation '' (uuid: e3b3c7b6-9069-447c-ad42-3a8443449412) of framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000 (latest state: OFFER_OPERATION_FINISHED, status update state: OFFER_OPERATION_FINISHED)
3: I1128 00:25:16.500768 24438 hierarchical.cpp:856] Updated allocation of framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000 on agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 from cpus(allocated: role1):1; mem(allocated: role1):512; disk(allocated: role1):3701220; ports(allocated: role1):[31000-32000] to cpus(allocated: role1):1; mem(allocated: role1):256; disk(allocated: role1):3701220; ports(allocated: role1):[31000-32000]; mem(allocated: role1)(reservations: [(DYNAMIC,role1,test-principal)]):256
3: I1128 00:25:16.502202 24438 hierarchical.cpp:1132] Recovered cpus(allocated: role1):1; mem(allocated: role1):256; disk(allocated: role1):3701220; ports(allocated: role1):[31000-32000]; mem(allocated: role1)(reservations: [(DYNAMIC,role1,test-principal)]):256 (total: cpus:1; mem:256; disk:3701220; ports:[31000-32000]; mem(reservations: [(DYNAMIC,role1,test-principal)]):256, allocated: {}) on agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 from framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000
3: I1128 00:25:16.503952 24438 hierarchical.cpp:1457] Performed allocation for 1 agents in 1.50631ms
3: I1128 00:25:16.504601 24434 master.cpp:8142] Sending 1 offers to framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000 (framework1) at scheduler-c1b266fc-1cac-471d-a8b7-4aa30d5cf058@172.17.0.5:54461
3: I1128 00:25:16.505280 24431 sched.cpp:921] Scheduler::resourceOffers took 154102ns
3: I1128 00:25:16.506132 24437 master.cpp:5434] Processing DECLINE call for offers: [ 78fac9e7-529b-4a69-a093-ce47559ea193-O1 ] for framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000 (framework1) at scheduler-c1b266fc-1cac-471d-a8b7-4aa30d5cf058@172.17.0.5:54461
3: I1128 00:25:16.506409 17607 sched.cpp:232] Version: 1.5.0
3: I1128 00:25:16.506999 24437 master.cpp:10063] Removing offer 78fac9e7-529b-4a69-a093-ce47559ea193-O1
3: I1128 00:25:16.507087 24438 sched.cpp:336] New master detected at master@172.17.0.5:54461
3: I1128 00:25:16.507289 24438 sched.cpp:396] Authenticating with master master@172.17.0.5:54461
3: I1128 00:25:16.507371 24438 sched.cpp:403] Using default CRAM-MD5 authenticatee
3: I1128 00:25:16.507730 24434 authenticatee.cpp:121] Creating new client SASL connection
3: I1128 00:25:16.507809 24436 hierarchical.cpp:1132] Recovered cpus(allocated: role1):1; mem(allocated: role1):256; disk(allocated: role1):3701220; ports(allocated: role1):[31000-32000]; mem(allocated: role1)(reservations: [(DYNAMIC,role1,test-principal)]):256 (total: cpus:1; mem:256; disk:3701220; ports:[31000-32000]; mem(reservations: [(DYNAMIC,role1,test-principal)]):256, allocated: {}) on agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 from framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000
3: W1128 00:25:16.507902 24436 hierarchical.cpp:1153] Using 365 days to create the refused resources offer filter because the input value is too big
3: I1128 00:25:16.507920 24436 hierarchical.cpp:1178] Framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000 filtered agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 for 365days
3: I1128 00:25:16.508075 24443 master.cpp:8312] Authenticating scheduler-277e12ab-9fd0-4314-b389-f90a398959d1@172.17.0.5:54461
3: I1128 00:25:16.508188 24440 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1708)@172.17.0.5:54461
3: I1128 00:25:16.508422 24428 authenticator.cpp:98] Creating new server SASL connection
3: I1128 00:25:16.508671 24432 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1128 00:25:16.508738 24432 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1128 00:25:16.508889 24435 authenticator.cpp:204] Received SASL authentication start
3: I1128 00:25:16.508963 24435 authenticator.cpp:326] Authentication requires more steps
3: I1128 00:25:16.509124 24435 authenticatee.cpp:259] Received SASL authentication step
3: I1128 00:25:16.509268 24429 authenticator.cpp:232] Received SASL authentication step
3: I1128 00:25:16.509299 24429 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '1892248cd782' server FQDN: '1892248cd782' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
3: I1128 00:25:16.509315 24429 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1128 00:25:16.509356 24429 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1128 00:25:16.509379 24429 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '1892248cd782' server FQDN: '1892248cd782' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
3: I1128 00:25:16.509389 24429 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1128 00:25:16.509397 24429 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1128 00:25:16.509413 24429 authenticator.cpp:318] Authentication success
3: I1128 00:25:16.509500 24442 authenticatee.cpp:299] Authentication success
3: I1128 00:25:16.509552 24439 master.cpp:8342] Successfully authenticated principal 'test-principal' at scheduler-277e12ab-9fd0-4314-b389-f90a398959d1@172.17.0.5:54461
3: I1128 00:25:16.509603 24429 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1708)@172.17.0.5:54461
3: I1128 00:25:16.509838 24430 sched.cpp:502] Successfully authenticated with master master@172.17.0.5:54461
3: I1128 00:25:16.509896 24430 sched.cpp:824] Sending SUBSCRIBE call to master@172.17.0.5:54461
3: I1128 00:25:16.510776 24434 hierarchical.cpp:2175] Filtered offer with cpus:1; mem:256; disk:3701220; ports:[31000-32000]; mem(reservations: [(DYNAMIC,role1,test-principal)]):256 on agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 for role role1 of framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000
3: I1128 00:25:16.511008 24434 hierarchical.cpp:1457] Performed allocation for 1 agents in 744127ns
3: I1128 00:25:16.511044 24436 master.cpp:2963] Received SUBSCRIBE call for framework 'framework2' at scheduler-277e12ab-9fd0-4314-b389-f90a398959d1@172.17.0.5:54461
3: I1128 00:25:16.511075 24436 master.cpp:2280] Authorizing framework principal 'test-principal' to receive offers for roles '{ role2 }'
3: I1128 00:25:16.510885 24430 sched.cpp:857] Will retry registration in 66.289071ms if necessary
3: I1128 00:25:16.511518 24440 master.cpp:3043] Subscribing framework framework2 with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1128 00:25:16.512042 24432 sched.cpp:751] Framework registered with 78fac9e7-529b-4a69-a093-ce47559ea193-0001
3: I1128 00:25:16.512128 24432 sched.cpp:765] Scheduler::registered took 30672ns
3: I1128 00:25:16.512264 24428 hierarchical.cpp:306] Added framework 78fac9e7-529b-4a69-a093-ce47559ea193-0001
3: I1128 00:25:16.513834 24428 hierarchical.cpp:2175] Filtered offer with mem(reservations: [(DYNAMIC,role1,test-principal)]):256 on agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 for role role1 of framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000
3: I1128 00:25:16.514032 24428 hierarchical.cpp:1457] Performed allocation for 1 agents in 1.629454ms
3: I1128 00:25:16.514431 24442 master.cpp:8142] Sending 1 offers to framework 78fac9e7-529b-4a69-a093-ce47559ea193-0001 (framework2) at scheduler-277e12ab-9fd0-4314-b389-f90a398959d1@172.17.0.5:54461
3: I1128 00:25:16.514889 24437 sched.cpp:921] Scheduler::resourceOffers took 111723ns
3: I1128 00:25:16.516242 24436 master.cpp:10063] Removing offer 78fac9e7-529b-4a69-a093-ce47559ea193-O2
3: I1128 00:25:16.516346 24436 master.cpp:4230] Processing ACCEPT call for offers: [ 78fac9e7-529b-4a69-a093-ce47559ea193-O2 ] on agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 at slave(951)@172.17.0.5:54461 (1892248cd782) for framework 78fac9e7-529b-4a69-a093-ce47559ea193-0001 (framework2) at scheduler-277e12ab-9fd0-4314-b389-f90a398959d1@172.17.0.5:54461
3: I1128 00:25:16.516464 24436 master.cpp:3725] Authorizing principal 'test-principal' to unreserve resources '[{"allocation_info":{"role":"role2"},"name":"mem","reservations":[{"principal":"test-principal","role":"role1","type":"DYNAMIC"}],"scalar":{"value":256.0},"type":"SCALAR"}]'
3: W1128 00:25:16.517464 24436 master.cpp:2365] Dropping UNRESERVE offer operation from framework 78fac9e7-529b-4a69-a093-ce47559ea193-0001 (framework2) at scheduler-277e12ab-9fd0-4314-b389-f90a398959d1@172.17.0.5:54461: cpus(allocated: role2):1; mem(allocated: role2):256; disk(allocated: role2):3701220; ports(allocated: role2):[31000-32000] does not contain mem(allocated: role2)(reservations: [(DYNAMIC,role1,test-principal)]):256
3: I1128 00:25:16.517959 24428 hierarchical.cpp:2175] Filtered offer with mem(reservations: [(DYNAMIC,role1,test-principal)]):256 on agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 for role role1 of framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000
3: I1128 00:25:16.518237 24428 hierarchical.cpp:1457] Performed allocation for 1 agents in 681305ns
3: I1128 00:25:16.519461 24428 hierarchical.cpp:1132] Recovered cpus(allocated: role2):1; mem(allocated: role2):256; disk(allocated: role2):3701220; ports(allocated: role2):[31000-32000] (total: cpus:1; mem:256; disk:3701220; ports:[31000-32000]; mem(reservations: [(DYNAMIC,role1,test-principal)]):256, allocated: {}) on agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 from framework 78fac9e7-529b-4a69-a093-ce47559ea193-0001
3: I1128 00:25:16.527511 24442 hierarchical.cpp:2175] Filtered offer with mem(reservations: [(DYNAMIC,role1,test-principal)]):256 on agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 for role role1 of framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000
3: I1128 00:25:16.527799 24442 hierarchical.cpp:1457] Performed allocation for 1 agents in 1.65553ms
3: I1128 00:25:16.528311 24433 master.cpp:8142] Sending 1 offers to framework 78fac9e7-529b-4a69-a093-ce47559ea193-0001 (framework2) at scheduler-277e12ab-9fd0-4314-b389-f90a398959d1@172.17.0.5:54461
3: I1128 00:25:16.528805 24437 sched.cpp:921] Scheduler::resourceOffers took 96209ns
3: I1128 00:25:16.529178 17607 sched.cpp:2009] Asked to stop the driver
3: W1128 00:25:16.529224 24430 sched.cpp:1402] Attempting to decline an unknown offer 78fac9e7-529b-4a69-a093-ce47559ea193-O2
3: I1128 00:25:16.529454 24430 sched.cpp:1191] Stopping framework 78fac9e7-529b-4a69-a093-ce47559ea193-0001
3: I1128 00:25:16.529600 24429 master.cpp:5434] Processing DECLINE call for offers: [ 78fac9e7-529b-4a69-a093-ce47559ea193-O2 ] for framework 78fac9e7-529b-4a69-a093-ce47559ea193-0001 (framework2) at scheduler-277e12ab-9fd0-4314-b389-f90a398959d1@172.17.0.5:54461
3: W1128 00:25:16.529680 24429 master.cpp:5455] Ignoring decline of offer 78fac9e7-529b-4a69-a093-ce47559ea193-O2 since it is no longer valid
3: I1128 00:25:16.529844 24429 master.cpp:8819] Processing TEARDOWN call for framework 78fac9e7-529b-4a69-a093-ce47559ea193-0001 (framework2) at scheduler-277e12ab-9fd0-4314-b389-f90a398959d1@172.17.0.5:54461
3: I1128 00:25:16.529960 24429 master.cpp:8831] Removing framework 78fac9e7-529b-4a69-a093-ce47559ea193-0001 (framework2) at scheduler-277e12ab-9fd0-4314-b389-f90a398959d1@172.17.0.5:54461
3: I1128 00:25:16.530025 24429 master.cpp:3333] Deactivating framework 78fac9e7-529b-4a69-a093-ce47559ea193-0001 (framework2) at scheduler-277e12ab-9fd0-4314-b389-f90a398959d1@172.17.0.5:54461
3: I1128 00:25:16.530166 24428 hierarchical.cpp:419] Deactivated framework 78fac9e7-529b-4a69-a093-ce47559ea193-0001
3: I1128 00:25:16.530647 24429 master.cpp:10063] Removing offer 78fac9e7-529b-4a69-a093-ce47559ea193-O3
3: I1128 00:25:16.530827 24433 slave.cpp:3270] Asked to shut down framework 78fac9e7-529b-4a69-a093-ce47559ea193-0001 by master@172.17.0.5:54461
3: I1128 00:25:16.530854 24433 slave.cpp:3285] Cannot shut down unknown framework 78fac9e7-529b-4a69-a093-ce47559ea193-0001
3: I1128 00:25:16.531096 24429 master.cpp:5539] Processing REVIVE call for framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000 (framework1) at scheduler-c1b266fc-1cac-471d-a8b7-4aa30d5cf058@172.17.0.5:54461
3: I1128 00:25:16.531091 24442 hierarchical.cpp:1132] Recovered cpus(allocated: role2):1; mem(allocated: role2):256; disk(allocated: role2):3701220; ports(allocated: role2):[31000-32000] (total: cpus:1; mem:256; disk:3701220; ports:[31000-32000]; mem(reservations: [(DYNAMIC,role1,test-principal)]):256, allocated: {}) on agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 from framework 78fac9e7-529b-4a69-a093-ce47559ea193-0001
3: I1128 00:25:16.531378 24442 hierarchical.cpp:358] Removed framework 78fac9e7-529b-4a69-a093-ce47559ea193-0001
3: I1128 00:25:16.531455 24442 hierarchical.cpp:1279] Revived offers for roles { role1 } of framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000
3: I1128 00:25:16.532699 24442 hierarchical.cpp:1457] Performed allocation for 1 agents in 1.117267ms
3: I1128 00:25:16.533188 24439 master.cpp:8142] Sending 1 offers to framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000 (framework1) at scheduler-c1b266fc-1cac-471d-a8b7-4aa30d5cf058@172.17.0.5:54461
3: I1128 00:25:16.533639 24439 sched.cpp:921] Scheduler::resourceOffers took 101290ns
3: I1128 00:25:16.534060 17607 sched.cpp:2009] Asked to stop the driver
3: I1128 00:25:16.534154 24443 sched.cpp:1191] Stopping framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000
3: I1128 00:25:16.534433 24440 master.cpp:8819] Processing TEARDOWN call for framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000 (framework1) at scheduler-c1b266fc-1cac-471d-a8b7-4aa30d5cf058@172.17.0.5:54461
3: I1128 00:25:16.534461 24440 master.cpp:8831] Removing framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000 (framework1) at scheduler-c1b266fc-1cac-471d-a8b7-4aa30d5cf058@172.17.0.5:54461
3: I1128 00:25:16.534477 24440 master.cpp:3333] Deactivating framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000 (framework1) at scheduler-c1b266fc-1cac-471d-a8b7-4aa30d5cf058@172.17.0.5:54461
3: I1128 00:25:16.534502 24432 hierarchical.cpp:1457] Performed allocation for 1 agents in 162769ns
3: I1128 00:25:16.534730 24432 hierarchical.cpp:419] Deactivated framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000
3: I1128 00:25:16.535193 24440 master.cpp:10063] Removing offer 78fac9e7-529b-4a69-a093-ce47559ea193-O4
3: I1128 00:25:16.535383 24439 slave.cpp:3270] Asked to shut down framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000 by master@172.17.0.5:54461
3: I1128 00:25:16.535413 24439 slave.cpp:3285] Cannot shut down unknown framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000
3: I1128 00:25:16.535924 17607 slave.cpp:883] Agent terminating
3: I1128 00:25:16.536078 24439 master.cpp:1311] Agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 at slave(951)@172.17.0.5:54461 (1892248cd782) disconnected
3: I1128 00:25:16.536104 24439 master.cpp:3370] Disconnecting agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 at slave(951)@172.17.0.5:54461 (1892248cd782)
3: I1128 00:25:16.536196 24439 master.cpp:3389] Deactivating agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 at slave(951)@172.17.0.5:54461 (1892248cd782)
3: I1128 00:25:16.536222 24432 hierarchical.cpp:1132] Recovered cpus(allocated: role1):1; mem(allocated: role1):256; disk(allocated: role1):3701220; ports(allocated: role1):[31000-32000]; mem(allocated: role1)(reservations: [(DYNAMIC,role1,test-principal)]):256 (total: cpus:1; mem:256; disk:3701220; ports:[31000-32000]; mem(reservations: [(DYNAMIC,role1,test-principal)]):256, allocated: {}) on agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 from framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000
3: I1128 00:25:16.536597 24432 hierarchical.cpp:358] Removed framework 78fac9e7-529b-4a69-a093-ce47559ea193-0000
3: I1128 00:25:16.536720 24432 hierarchical.cpp:697] Agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0 deactivated
3: I1128 00:25:16.542158 24439 hierarchical.cpp:1457] Performed allocation for 1 agents in 109368ns
3: I1128 00:25:16.542829 17607 master.cpp:1153] Master terminating
3: I1128 00:25:16.543759 24437 hierarchical.cpp:633] Removed agent 78fac9e7-529b-4a69-a093-ce47559ea193-S0
3: [       OK ] ResourceProviderCapability/ReservationTest.PreventUnreservingAlienResources/1 (126 ms)
3: [----------] 36 tests from ResourceProviderCapability/ReservationTest (3139 ms total)
3: 
3: [----------] Global test environment tear-down
3: [==========] 1771 tests from 183 test cases ran. (585550 ms total)
3: [  PASSED  ] 1770 tests.
3: [  FAILED  ] 1 test, listed below:
3: [  FAILED  ] ContentType/AgentAPIStreamingTest.AttachInputToNestedContainerSession/0, where GetParam() = application/x-protobuf
3: 
3:  1 FAILED TEST
3:   YOU HAVE 23 DISABLED TESTS
3: 
3: I1128 00:25:16.628543 24444 process.cpp:887] Failed to accept socket: future discarded
3/3 Test #3: MesosTests .......................***Failed  590.91 sec

67% tests passed, 1 tests failed out of 3

Total Test time (real) = 630.67 sec

The following tests FAILED:
	  3 - MesosTests (Failed)
Errors while running CTest
make[3]: *** [CMakeFiles/check] Error 8
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-1511825543-16315
Untagged: mesos-1511825543-16315:latest
Deleted: sha256:101c30aa7d5e7b71d92bc6e8ba27e2a58529a3211da92fe58bde51a4a352b204
Deleted: sha256:83e2716a2ce881f751d06587994a25093aca46f34582e964cdfcc2bcc4122327
Deleted: sha256:839dfffe1ceae6abc07afba51497e3b7bc36878c04f0d0da9877e45a9a8aeb9a
Deleted: sha256:435e5caee3852f07fefa492d55bf276d321d898dff584b0bd1641cb1f12d09d7
Deleted: sha256:13d19fcc931cc3720f665d8b0f745e16345d70d142f3fdcbaeaae8e2802f4904
Deleted: sha256:ec8f70271ebbabcfe9828ebe836ed6f9a53c8f42b8f7c367f5e050f3e8eeefc0
Deleted: sha256:558f491890984e1bb28da0d7690919c004e507db5b7639e67000d18cc94be5bb
Deleted: sha256:7d6ea5d33c37d5b4afa07ae31b17b4e53726e6797a58a445b5b861d7adede302
Deleted: sha256:37e3c47a13afb8a6bafc2a832941037183036ebcb5dd76ad870cf9fdd9a8954f
Deleted: sha256:28b36072ab7c6f3e834dde1ec3a1388a1bcfdee5c9cd3d265f44795ff8dfd5b6
Deleted: sha256:f38d64917f0ec996c9ddca56df35708391a3391f7742c4f507851e1c30578742
Deleted: sha256:8ce27b88fb2c290285db786968f594f259774c6fcb297d937d8c937fa4af4f3a
Deleted: sha256:aa2e0ccd33776604670f24fede971674a70dee7672dbc0c9f2121bb959526763
Deleted: sha256:8c427e14c8fbb684494e9123b6ead4c8bc8e099f0635402e5f31f4df2987884c
Deleted: sha256:37c9846cf8b60d9aa8ab0ecc941415f6d4e157ba51bd43d328d940b927f187ee
Deleted: sha256:1ee326e11508378787f98bb341f353a7d45257441886f8e5daf2b8168f63fee4
Deleted: sha256:7b7c2396595e54755e75e9f8cbb4493961cf487ecc67c00fbbdd568eb282e757
Deleted: sha256:150c624fa3423827cd935332d0926b3198db1839f3ba6d929eff9056b88fa173
Deleted: sha256:a6446b306f84cb0561b43cb41693251e4ad875694bbed76f75ddd92bdab8fc80
Deleted: sha256:77bcce5bed25a9fc4ce113d0eb7c697fa867bd0dbba39885554c1c06b96833be
Deleted: sha256:372fe2f80d7917e9655e717eacf2cb6686b6c26a378371f5417f8fc5fe1bcae6
Deleted: sha256:fb83f9af5a3d1a7bdb4adef91587e1d6489f97c7ca71e629a15faa16462384bf
Deleted: sha256:7d5e87c18bdcb76f425174d54a1b13e7e61ac07b9dd9f59d84ccc977a51076da
Deleted: sha256:d6c68b562ff9809a496f257f98b973be66f6c5daca957d45aae0fb225a45b9df
Deleted: sha256:f9645941fafd7f4758154a599cdb03f52fc99e8b8038ca9be930b6b90665812f
Deleted: sha256:7c894f125f335f08e5807352582f374742441b0eb1943eee0aef7d5775450daf
Deleted: sha256:e18f499b2741e977f4410a9a542fc53e76dd8fae98ed26a6d66f570c44979825
Deleted: sha256:7ccafbdf0c95c246c8a75860305a73a23973356a7a70a14555c1a67022175fd1
Deleted: sha256:f74403d507ade4bd3f3f041e04090df507a6ccacb83d760b071f8def2e326bbd
Deleted: sha256:126eb677c893d1716cf1da0a8e98916225294ab107997e6e7c612a32c0611608
Build step 'Execute shell' marked build as failure

Jenkins build is back to normal : Mesos-Buildbot » cmake,clang,--verbose --disable-libtool-wrappers --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4504

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,CONFIGURATION=--verbose%20--disable-libtool-wrappers%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4504/display/redirect>