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 2018/01/02 22:19:34 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) #4684

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)/4684/display/redirect?page=changes>

Changes:

[yujie.jay] Fixed CI build failure for `volume_profile.pb.h`.

------------------------------------------
[...truncated 35.95 MB...]
3: I0102 22:19:20.348518 27614 slave.cpp:1137] Authenticating with master master@172.17.0.5:43969
3: I0102 22:19:20.348666 27614 slave.cpp:1146] Using default CRAM-MD5 authenticatee
3: I0102 22:19:20.349056 27621 authenticatee.cpp:121] Creating new client SASL connection
3: I0102 22:19:20.349570 27616 master.cpp:8979] Authenticating slave(1024)@172.17.0.5:43969
3: I0102 22:19:20.349715 27607 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1742)@172.17.0.5:43969
3: I0102 22:19:20.350031 27615 authenticator.cpp:98] Creating new server SASL connection
3: I0102 22:19:20.350275 27626 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I0102 22:19:20.350299 27626 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I0102 22:19:20.350432 27624 authenticator.cpp:204] Received SASL authentication start
3: I0102 22:19:20.350484 27624 authenticator.cpp:326] Authentication requires more steps
3: I0102 22:19:20.350586 27606 authenticatee.cpp:259] Received SASL authentication step
3: I0102 22:19:20.350703 27623 authenticator.cpp:232] Received SASL authentication step
3: I0102 22:19:20.350734 27623 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'b82c42e3dd0d' server FQDN: 'b82c42e3dd0d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
3: I0102 22:19:20.350750 27623 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I0102 22:19:20.350795 27623 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I0102 22:19:20.350821 27623 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'b82c42e3dd0d' server FQDN: 'b82c42e3dd0d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
3: I0102 22:19:20.350832 27623 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I0102 22:19:20.350841 27623 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I0102 22:19:20.350859 27623 authenticator.cpp:318] Authentication success
3: I0102 22:19:20.350944 27617 authenticatee.cpp:299] Authentication success
3: I0102 22:19:20.351029 27620 master.cpp:9009] Successfully authenticated principal 'test-principal' at slave(1024)@172.17.0.5:43969
3: I0102 22:19:20.351085 27613 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1742)@172.17.0.5:43969
3: I0102 22:19:20.351284 27604 slave.cpp:1229] Successfully authenticated with master master@172.17.0.5:43969
3: I0102 22:19:20.351529 27604 slave.cpp:1709] Will retry registration in 13.650425ms if necessary
3: I0102 22:19:20.351677 27619 master.cpp:6078] Received register agent message from slave(1024)@172.17.0.5:43969 (b82c42e3dd0d)
3: I0102 22:19:20.351718 27619 master.cpp:3867] Authorizing agent with principal 'test-principal'
3: I0102 22:19:20.352177 27627 master.cpp:6148] Authorized registration of agent at slave(1024)@172.17.0.5:43969 (b82c42e3dd0d)
3: I0102 22:19:20.352283 27627 master.cpp:6259] Registering agent at slave(1024)@172.17.0.5:43969 (b82c42e3dd0d) with id a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0
3: I0102 22:19:20.352730 27611 registrar.cpp:495] Applied 1 operations in 111355ns; attempting to update the registry
3: I0102 22:19:20.352982 27612 hierarchical.cpp:1517] Performed allocation for 0 agents in 84739ns
3: I0102 22:19:20.353382 27611 registrar.cpp:552] Successfully updated the registry in 591872ns
3: I0102 22:19:20.353524 27616 master.cpp:6307] Admitted agent a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0 at slave(1024)@172.17.0.5:43969 (b82c42e3dd0d)
3: I0102 22:19:20.354200 27616 master.cpp:6356] Registered agent a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0 at slave(1024)@172.17.0.5:43969 (b82c42e3dd0d) with cpus:1; mem:512; disk:367489; ports:[31000-32000]
3: I0102 22:19:20.354269 27615 slave.cpp:1275] Registered with master master@172.17.0.5:43969; given agent ID a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0
3: I0102 22:19:20.354346 27616 task_status_update_manager.cpp:188] Resuming sending task status updates
3: I0102 22:19:20.354560 27626 hierarchical.cpp:574] Added agent a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0 (b82c42e3dd0d) with cpus:1; mem:512; disk:367489; ports:[31000-32000] (allocated: {})
3: I0102 22:19:20.354641 27615 slave.cpp:1295] Checkpointing SlaveInfo to '/tmp/ResourceProviderCapability_ReservationTest_PreventUnreservingAlienResources_1_syjPFe/meta/slaves/a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0/slave.info'
3: I0102 22:19:20.354843 27626 hierarchical.cpp:1517] Performed allocation for 1 agents in 144471ns
3: I0102 22:19:20.355144 27615 slave.cpp:1352] Forwarding agent update {"operations":{},"resource_version_uuid":{"value":"oevzGSGOT56t3SXBCiYnhw=="},"slave_id":{"value":"a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0"},"update_oversubscribed_resources":true}
3: I0102 22:19:20.355653 27623 master.cpp:7319] Received update of agent a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0 at slave(1024)@172.17.0.5:43969 (b82c42e3dd0d) with total oversubscribed resources {}
3: I0102 22:19:20.355924 27623 master.cpp:7413] Ignoring update on agent a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0 at slave(1024)@172.17.0.5:43969 (b82c42e3dd0d) as it reports no changes
3: W0102 22:19:20.356178 18409 process.cpp:2756] Attempted to spawn already running process version@172.17.0.5:43969
3: W0102 22:19:20.356600 18409 process.cpp:2756] Attempted to spawn already running process version@172.17.0.5:43969
3: I0102 22:19:20.357450 18409 sched.cpp:232] Version: 1.5.0
3: I0102 22:19:20.358026 27621 sched.cpp:336] New master detected at master@172.17.0.5:43969
3: I0102 22:19:20.358106 27621 sched.cpp:396] Authenticating with master master@172.17.0.5:43969
3: I0102 22:19:20.358121 27621 sched.cpp:403] Using default CRAM-MD5 authenticatee
3: I0102 22:19:20.358378 27614 authenticatee.cpp:121] Creating new client SASL connection
3: I0102 22:19:20.358682 27611 master.cpp:8979] Authenticating scheduler-3de642b7-8be8-4293-bc03-7c978177c07f@172.17.0.5:43969
3: I0102 22:19:20.358796 27607 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1743)@172.17.0.5:43969
3: I0102 22:19:20.359001 27624 authenticator.cpp:98] Creating new server SASL connection
3: I0102 22:19:20.359220 27606 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I0102 22:19:20.359244 27606 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I0102 22:19:20.359339 27616 authenticator.cpp:204] Received SASL authentication start
3: I0102 22:19:20.359393 27616 authenticator.cpp:326] Authentication requires more steps
3: I0102 22:19:20.359485 27626 authenticatee.cpp:259] Received SASL authentication step
3: I0102 22:19:20.359593 27615 authenticator.cpp:232] Received SASL authentication step
3: I0102 22:19:20.359625 27615 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'b82c42e3dd0d' server FQDN: 'b82c42e3dd0d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
3: I0102 22:19:20.359642 27615 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I0102 22:19:20.359688 27615 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I0102 22:19:20.359714 27615 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'b82c42e3dd0d' server FQDN: 'b82c42e3dd0d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
3: I0102 22:19:20.359726 27615 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I0102 22:19:20.359735 27615 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I0102 22:19:20.359752 27615 authenticator.cpp:318] Authentication success
3: I0102 22:19:20.359827 27610 authenticatee.cpp:299] Authentication success
3: I0102 22:19:20.359903 27617 hierarchical.cpp:1517] Performed allocation for 1 agents in 251388ns
3: I0102 22:19:20.359910 27620 master.cpp:9009] Successfully authenticated principal 'test-principal' at scheduler-3de642b7-8be8-4293-bc03-7c978177c07f@172.17.0.5:43969
3: I0102 22:19:20.359948 27610 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1743)@172.17.0.5:43969
3: I0102 22:19:20.360092 27622 sched.cpp:502] Successfully authenticated with master master@172.17.0.5:43969
3: I0102 22:19:20.360110 27622 sched.cpp:824] Sending SUBSCRIBE call to master@172.17.0.5:43969
3: I0102 22:19:20.360224 27622 sched.cpp:857] Will retry registration in 759.604452ms if necessary
3: I0102 22:19:20.360401 27619 master.cpp:2958] Received SUBSCRIBE call for framework 'framework1' at scheduler-3de642b7-8be8-4293-bc03-7c978177c07f@172.17.0.5:43969
3: I0102 22:19:20.360421 27619 master.cpp:2275] Authorizing framework principal 'test-principal' to receive offers for roles '{ role1 }'
3: I0102 22:19:20.360877 27609 master.cpp:3038] Subscribing framework framework1 with checkpointing disabled and capabilities [ MULTI_ROLE, RESERVATION_REFINEMENT ]
3: I0102 22:19:20.361068 27609 master.cpp:9200] Adding framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000 (framework1) at scheduler-3de642b7-8be8-4293-bc03-7c978177c07f@172.17.0.5:43969 with roles {  } suppressed
3: I0102 22:19:20.361522 27621 sched.cpp:751] Framework registered with a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000
3: I0102 22:19:20.361562 27621 sched.cpp:765] Scheduler::registered took 23505ns
3: I0102 22:19:20.361623 27625 hierarchical.cpp:297] Added framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000
3: I0102 22:19:20.362964 27625 hierarchical.cpp:1517] Performed allocation for 1 agents in 1.210112ms
3: I0102 22:19:20.363428 27611 master.cpp:8809] Sending 1 offers to framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000 (framework1) at scheduler-3de642b7-8be8-4293-bc03-7c978177c07f@172.17.0.5:43969
3: I0102 22:19:20.363922 27607 sched.cpp:921] Scheduler::resourceOffers took 116908ns
3: I0102 22:19:20.365795 27620 master.cpp:10722] Removing offer a64bcfdd-7209-4ffb-a436-83d61d85cfbc-O0
3: I0102 22:19:20.365977 27620 master.cpp:4274] Processing ACCEPT call for offers: [ a64bcfdd-7209-4ffb-a436-83d61d85cfbc-O0 ] on agent a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0 at slave(1024)@172.17.0.5:43969 (b82c42e3dd0d) for framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000 (framework1) at scheduler-3de642b7-8be8-4293-bc03-7c978177c07f@172.17.0.5:43969
3: I0102 22:19:20.366127 27620 master.cpp:3652] 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: I0102 22:19:20.367213 27620 master.cpp:4607] 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 a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000 (framework1) at scheduler-3de642b7-8be8-4293-bc03-7c978177c07f@172.17.0.5:43969 to agent a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0 at slave(1024)@172.17.0.5:43969 (b82c42e3dd0d)
3: I0102 22:19:20.367678 27620 master.cpp:10620] Sending operation '' (uuid: 972dc7f8-83f0-4b14-b162-16da948e4354) to agent a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0 at slave(1024)@172.17.0.5:43969 (b82c42e3dd0d)
3: I0102 22:19:20.368857 27617 slave.cpp:3730] Updated checkpointed resources from {} to mem(reservations: [(DYNAMIC,role1,test-principal)]):256
3: I0102 22:19:20.368959 27617 slave.cpp:7452] Updating the state of operation '' (uuid: 972dc7f8-83f0-4b14-b162-16da948e4354) of framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000 (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED)
3: I0102 22:19:20.369287 27619 master.cpp:10409] Updating the state of operation '' (uuid: 972dc7f8-83f0-4b14-b162-16da948e4354) of framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000 (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED)
3: I0102 22:19:20.370198 27622 hierarchical.cpp:925] Updated allocation of framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000 on agent a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0 from cpus(allocated: role1):1; mem(allocated: role1):512; disk(allocated: role1):367489; ports(allocated: role1):[31000-32000] to cpus(allocated: role1):1; mem(allocated: role1):256; disk(allocated: role1):367489; ports(allocated: role1):[31000-32000]; mem(allocated: role1)(reservations: [(DYNAMIC,role1,test-principal)]):256
3: I0102 22:19:20.371502 27622 hierarchical.cpp:1192] Recovered cpus(allocated: role1):1; mem(allocated: role1):256; disk(allocated: role1):367489; ports(allocated: role1):[31000-32000]; mem(allocated: role1)(reservations: [(DYNAMIC,role1,test-principal)]):256 (total: cpus:1; mem:256; disk:367489; ports:[31000-32000]; mem(reservations: [(DYNAMIC,role1,test-principal)]):256, allocated: {}) on agent a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0 from framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000
3: I0102 22:19:20.373016 27622 hierarchical.cpp:1517] Performed allocation for 1 agents in 1.367246ms
3: I0102 22:19:20.373571 27609 master.cpp:8809] Sending 1 offers to framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000 (framework1) at scheduler-3de642b7-8be8-4293-bc03-7c978177c07f@172.17.0.5:43969
3: I0102 22:19:20.374140 27605 sched.cpp:921] Scheduler::resourceOffers took 122679ns
3: I0102 22:19:20.375068 27606 master.cpp:5484] Processing DECLINE call for offers: [ a64bcfdd-7209-4ffb-a436-83d61d85cfbc-O1 ] for framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000 (framework1) at scheduler-3de642b7-8be8-4293-bc03-7c978177c07f@172.17.0.5:43969
3: I0102 22:19:20.375550 18409 sched.cpp:232] Version: 1.5.0
3: I0102 22:19:20.375708 27606 master.cpp:10722] Removing offer a64bcfdd-7209-4ffb-a436-83d61d85cfbc-O1
3: I0102 22:19:20.376147 27623 sched.cpp:336] New master detected at master@172.17.0.5:43969
3: I0102 22:19:20.376260 27623 sched.cpp:396] Authenticating with master master@172.17.0.5:43969
3: I0102 22:19:20.376273 27623 sched.cpp:403] Using default CRAM-MD5 authenticatee
3: I0102 22:19:20.376420 27607 hierarchical.cpp:1192] Recovered cpus(allocated: role1):1; mem(allocated: role1):256; disk(allocated: role1):367489; ports(allocated: role1):[31000-32000]; mem(allocated: role1)(reservations: [(DYNAMIC,role1,test-principal)]):256 (total: cpus:1; mem:256; disk:367489; ports:[31000-32000]; mem(reservations: [(DYNAMIC,role1,test-principal)]):256, allocated: {}) on agent a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0 from framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000
3: W0102 22:19:20.376495 27607 hierarchical.cpp:1213] Using 365 days to create the refused resources offer filter because the input value is too big
3: I0102 22:19:20.376508 27607 hierarchical.cpp:1238] Framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000 filtered agent a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0 for 365days
3: I0102 22:19:20.376529 27613 authenticatee.cpp:121] Creating new client SASL connection
3: I0102 22:19:20.376830 27604 master.cpp:8979] Authenticating scheduler-bdbe66eb-1704-4548-9bf8-37cb01c216f2@172.17.0.5:43969
3: I0102 22:19:20.376933 27610 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1744)@172.17.0.5:43969
3: I0102 22:19:20.377151 27620 authenticator.cpp:98] Creating new server SASL connection
3: I0102 22:19:20.377336 27617 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I0102 22:19:20.377359 27617 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I0102 22:19:20.377450 27619 authenticator.cpp:204] Received SASL authentication start
3: I0102 22:19:20.377502 27619 authenticator.cpp:326] Authentication requires more steps
3: I0102 22:19:20.377594 27627 authenticatee.cpp:259] Received SASL authentication step
3: I0102 22:19:20.377704 27622 authenticator.cpp:232] Received SASL authentication step
3: I0102 22:19:20.377729 27622 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'b82c42e3dd0d' server FQDN: 'b82c42e3dd0d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
3: I0102 22:19:20.377739 27622 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I0102 22:19:20.377775 27622 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I0102 22:19:20.377790 27622 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'b82c42e3dd0d' server FQDN: 'b82c42e3dd0d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
3: I0102 22:19:20.377799 27622 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I0102 22:19:20.377804 27622 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I0102 22:19:20.377815 27622 authenticator.cpp:318] Authentication success
3: I0102 22:19:20.377882 27609 authenticatee.cpp:299] Authentication success
3: I0102 22:19:20.377959 27605 master.cpp:9009] Successfully authenticated principal 'test-principal' at scheduler-bdbe66eb-1704-4548-9bf8-37cb01c216f2@172.17.0.5:43969
3: I0102 22:19:20.377997 27609 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1744)@172.17.0.5:43969
3: I0102 22:19:20.378141 27621 sched.cpp:502] Successfully authenticated with master master@172.17.0.5:43969
3: I0102 22:19:20.378157 27621 sched.cpp:824] Sending SUBSCRIBE call to master@172.17.0.5:43969
3: I0102 22:19:20.378265 27621 sched.cpp:857] Will retry registration in 291.838938ms if necessary
3: I0102 22:19:20.378434 27626 master.cpp:2958] Received SUBSCRIBE call for framework 'framework2' at scheduler-bdbe66eb-1704-4548-9bf8-37cb01c216f2@172.17.0.5:43969
3: I0102 22:19:20.378453 27626 master.cpp:2275] Authorizing framework principal 'test-principal' to receive offers for roles '{ role2 }'
3: I0102 22:19:20.378918 27606 master.cpp:3038] Subscribing framework framework2 with checkpointing disabled and capabilities [ MULTI_ROLE, RESERVATION_REFINEMENT ]
3: I0102 22:19:20.379132 27606 master.cpp:9200] Adding framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0001 (framework2) at scheduler-bdbe66eb-1704-4548-9bf8-37cb01c216f2@172.17.0.5:43969 with roles {  } suppressed
3: I0102 22:19:20.379528 27608 sched.cpp:751] Framework registered with a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0001
3: I0102 22:19:20.379568 27608 sched.cpp:765] Scheduler::registered took 26724ns
3: I0102 22:19:20.379711 27616 hierarchical.cpp:297] Added framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0001
3: I0102 22:19:20.381212 27616 hierarchical.cpp:2429] Filtered offer with mem(reservations: [(DYNAMIC,role1,test-principal)]):256 on agent a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0 for role role1 of framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000
3: I0102 22:19:20.381400 27616 hierarchical.cpp:1517] Performed allocation for 1 agents in 1.498251ms
3: I0102 22:19:20.381808 27618 master.cpp:8809] Sending 1 offers to framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0001 (framework2) at scheduler-bdbe66eb-1704-4548-9bf8-37cb01c216f2@172.17.0.5:43969
3: I0102 22:19:20.382285 27613 sched.cpp:921] Scheduler::resourceOffers took 114241ns
3: I0102 22:19:20.384063 27614 master.cpp:10722] Removing offer a64bcfdd-7209-4ffb-a436-83d61d85cfbc-O2
3: I0102 22:19:20.384253 27614 master.cpp:4274] Processing ACCEPT call for offers: [ a64bcfdd-7209-4ffb-a436-83d61d85cfbc-O2 ] on agent a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0 at slave(1024)@172.17.0.5:43969 (b82c42e3dd0d) for framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0001 (framework2) at scheduler-bdbe66eb-1704-4548-9bf8-37cb01c216f2@172.17.0.5:43969
3: I0102 22:19:20.384472 27614 master.cpp:3720] 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: W0102 22:19:20.385861 27621 master.cpp:2360] Dropping UNRESERVE operation from framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0001 (framework2) at scheduler-bdbe66eb-1704-4548-9bf8-37cb01c216f2@172.17.0.5:43969: cpus(allocated: role2):1; mem(allocated: role2):256; disk(allocated: role2):367489; ports(allocated: role2):[31000-32000] does not contain mem(allocated: role2)(reservations: [(DYNAMIC,role1,test-principal)]):256
3: I0102 22:19:20.386914 27615 hierarchical.cpp:1192] Recovered cpus(allocated: role2):1; mem(allocated: role2):256; disk(allocated: role2):367489; ports(allocated: role2):[31000-32000] (total: cpus:1; mem:256; disk:367489; ports:[31000-32000]; mem(reservations: [(DYNAMIC,role1,test-principal)]):256, allocated: {}) on agent a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0 from framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0001
3: I0102 22:19:20.390597 27606 hierarchical.cpp:2429] Filtered offer with mem(reservations: [(DYNAMIC,role1,test-principal)]):256 on agent a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0 for role role1 of framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000
3: I0102 22:19:20.390959 27606 hierarchical.cpp:1517] Performed allocation for 1 agents in 2.387274ms
3: I0102 22:19:20.391502 27608 master.cpp:8809] Sending 1 offers to framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0001 (framework2) at scheduler-bdbe66eb-1704-4548-9bf8-37cb01c216f2@172.17.0.5:43969
3: I0102 22:19:20.392141 27623 sched.cpp:921] Scheduler::resourceOffers took 127204ns
3: I0102 22:19:20.392561 18409 sched.cpp:2009] Asked to stop the driver
3: W0102 22:19:20.392616 27613 sched.cpp:1402] Attempting to decline an unknown offer a64bcfdd-7209-4ffb-a436-83d61d85cfbc-O2
3: I0102 22:19:20.392781 27613 sched.cpp:1191] Stopping framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0001
3: I0102 22:19:20.392889 27604 master.cpp:5484] Processing DECLINE call for offers: [ a64bcfdd-7209-4ffb-a436-83d61d85cfbc-O2 ] for framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0001 (framework2) at scheduler-bdbe66eb-1704-4548-9bf8-37cb01c216f2@172.17.0.5:43969
3: W0102 22:19:20.392921 27604 master.cpp:5505] Ignoring decline of offer a64bcfdd-7209-4ffb-a436-83d61d85cfbc-O2 since it is no longer valid
3: I0102 22:19:20.393016 27604 master.cpp:9489] Processing TEARDOWN call for framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0001 (framework2) at scheduler-bdbe66eb-1704-4548-9bf8-37cb01c216f2@172.17.0.5:43969
3: I0102 22:19:20.393038 27604 master.cpp:9501] Removing framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0001 (framework2) at scheduler-bdbe66eb-1704-4548-9bf8-37cb01c216f2@172.17.0.5:43969
3: I0102 22:19:20.393046 27604 master.cpp:3328] Deactivating framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0001 (framework2) at scheduler-bdbe66eb-1704-4548-9bf8-37cb01c216f2@172.17.0.5:43969
3: I0102 22:19:20.393214 27619 hierarchical.cpp:405] Deactivated framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0001
3: I0102 22:19:20.393558 27604 master.cpp:10722] Removing offer a64bcfdd-7209-4ffb-a436-83d61d85cfbc-O3
3: I0102 22:19:20.393734 27605 slave.cpp:3407] Asked to shut down framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0001 by master@172.17.0.5:43969
3: I0102 22:19:20.393764 27605 slave.cpp:3422] Cannot shut down unknown framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0001
3: I0102 22:19:20.393987 27604 master.cpp:5589] Processing REVIVE call for framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000 (framework1) at scheduler-3de642b7-8be8-4293-bc03-7c978177c07f@172.17.0.5:43969
3: I0102 22:19:20.394203 27619 hierarchical.cpp:1192] Recovered cpus(allocated: role2):1; mem(allocated: role2):256; disk(allocated: role2):367489; ports(allocated: role2):[31000-32000] (total: cpus:1; mem:256; disk:367489; ports:[31000-32000]; mem(reservations: [(DYNAMIC,role1,test-principal)]):256, allocated: {}) on agent a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0 from framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0001
3: I0102 22:19:20.394531 27619 hierarchical.cpp:344] Removed framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0001
3: I0102 22:19:20.394608 27619 hierarchical.cpp:1339] Revived offers for roles { role1 } of framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000
3: I0102 22:19:20.396690 27619 hierarchical.cpp:1517] Performed allocation for 1 agents in 1.856535ms
3: I0102 22:19:20.397212 27609 master.cpp:8809] Sending 1 offers to framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000 (framework1) at scheduler-3de642b7-8be8-4293-bc03-7c978177c07f@172.17.0.5:43969
3: I0102 22:19:20.397825 27622 sched.cpp:921] Scheduler::resourceOffers took 127964ns
3: I0102 22:19:20.398286 18409 sched.cpp:2009] Asked to stop the driver
3: I0102 22:19:20.398385 27606 sched.cpp:1191] Stopping framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000
3: I0102 22:19:20.398640 27608 master.cpp:9489] Processing TEARDOWN call for framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000 (framework1) at scheduler-3de642b7-8be8-4293-bc03-7c978177c07f@172.17.0.5:43969
3: I0102 22:19:20.398665 27608 master.cpp:9501] Removing framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000 (framework1) at scheduler-3de642b7-8be8-4293-bc03-7c978177c07f@172.17.0.5:43969
3: I0102 22:19:20.398674 27608 master.cpp:3328] Deactivating framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000 (framework1) at scheduler-3de642b7-8be8-4293-bc03-7c978177c07f@172.17.0.5:43969
3: I0102 22:19:20.398826 27607 hierarchical.cpp:405] Deactivated framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000
3: I0102 22:19:20.399346 27608 master.cpp:10722] Removing offer a64bcfdd-7209-4ffb-a436-83d61d85cfbc-O4
3: I0102 22:19:20.399518 27627 slave.cpp:3407] Asked to shut down framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000 by master@172.17.0.5:43969
3: I0102 22:19:20.399544 27627 slave.cpp:3422] Cannot shut down unknown framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000
3: I0102 22:19:20.399560 27627 slave.cpp:931] Agent terminating
3: I0102 22:19:20.399874 27608 master.cpp:1305] Agent a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0 at slave(1024)@172.17.0.5:43969 (b82c42e3dd0d) disconnected
3: I0102 22:19:20.399891 27608 master.cpp:3365] Disconnecting agent a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0 at slave(1024)@172.17.0.5:43969 (b82c42e3dd0d)
3: I0102 22:19:20.399932 27608 master.cpp:3384] Deactivating agent a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0 at slave(1024)@172.17.0.5:43969 (b82c42e3dd0d)
3: I0102 22:19:20.400120 27610 hierarchical.cpp:1192] Recovered cpus(allocated: role1):1; mem(allocated: role1):256; disk(allocated: role1):367489; ports(allocated: role1):[31000-32000]; mem(allocated: role1)(reservations: [(DYNAMIC,role1,test-principal)]):256 (total: cpus:1; mem:256; disk:367489; ports:[31000-32000]; mem(reservations: [(DYNAMIC,role1,test-principal)]):256, allocated: {}) on agent a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0 from framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000
3: I0102 22:19:20.400478 27610 hierarchical.cpp:344] Removed framework a64bcfdd-7209-4ffb-a436-83d61d85cfbc-0000
3: I0102 22:19:20.400676 27610 hierarchical.cpp:766] Agent a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0 deactivated
3: I0102 22:19:20.400923 27610 hierarchical.cpp:1517] Performed allocation for 1 agents in 174426ns
3: I0102 22:19:20.406365 27604 master.cpp:1147] Master terminating
3: I0102 22:19:20.407364 27609 hierarchical.cpp:609] Removed agent a64bcfdd-7209-4ffb-a436-83d61d85cfbc-S0
3: I0102 22:19:20.407790 27612 hierarchical.cpp:1517] Performed allocation for 0 agents in 104008ns
3: [       OK ] ResourceProviderCapability/ReservationTest.PreventUnreservingAlienResources/1 (105 ms)
3: [----------] 36 tests from ResourceProviderCapability/ReservationTest (4805 ms total)
3: 
3: [----------] Global test environment tear-down
3: [==========] 1857 tests from 187 test cases ran. (518866 ms total)
3: [  PASSED  ] 1855 tests.
3: [  FAILED  ] 2 tests, listed below:
3: [  FAILED  ] SlaveTest.PingTimeoutSomePings
3: [  FAILED  ] DiskQuotaTest.SlaveRecovery
3: 
3:  2 FAILED TESTS
3:   YOU HAVE 22 DISABLED TESTS
3: 
3: I0102 22:19:20.484288 27628 process.cpp:887] Failed to accept socket: future discarded
3/3 Test #3: MesosTests .......................***Failed  524.94 sec

67% tests passed, 1 tests failed out of 3

Total Test time (real) = 570.85 sec

The following tests FAILED:
	  3 - MesosTests (Failed)
Errors while running CTest
make[3]: Leaving directory `/mesos/build'
make[3]: *** [CMakeFiles/check] Error 8
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-1514928825-24616
Untagged: mesos-1514928825-24616:latest
Deleted: sha256:82f819953bc42bdb5931b6d9a500d63a84883cd0b6029682b0a7d1d44f47da96
Deleted: sha256:e83de90e3890154080e0126d927397fb2a79d799cc6836d16b13c09d87d0c638
Deleted: sha256:0c36c7fe0054052739af438f1b601095441c292de9cc86f83f25930585aa4d4e
Deleted: sha256:0ac9b2f1f5f074f245ddc5dd81c19b10629f648fe4ef73a013aebac298234140
Deleted: sha256:1d4c02c8da937f1220eb91def4887298850bb6d55c2e52f6512209e5219442b0
Deleted: sha256:337c94225d462dc9fef56848267a03fcb57f2e1015834df83d7da7d7a1790871
Deleted: sha256:a17b09c40adeaf3f54bc1bb2df49282b31acc5241d5d112ab4381773ea777c07
Deleted: sha256:be89685fb8c698117adaf56c07a2907b5f74d1d97c7719dbcb521d70e8b2ac28
Deleted: sha256:9fad8eebb8cf0a9a2df9b6d94f62f27c19f1d37075e87d06dd13e30e9d2003c2
Deleted: sha256:7177f91264a5d86f5192f3937789cd4599969e662a6541ee2cb9059971efbe36
Deleted: sha256:b704c94e93c0fe6fbe25ab695a888acf7ac3b169631430cf1285fe5edd3a33fe
Deleted: sha256:6e5de5c51962ca63631ed40ed22f485dd84d64156d37c06932d7deca06a56aab
Deleted: sha256:e69525756de4a7d6bb1dbbadd6c3085a8971b3c4918cf1608294b5125a78e005
Deleted: sha256:c87e677306549c0740bc3635fac6335093f900d85ab5989860fdfab428eef915
Deleted: sha256:8da2d09bc33cff303b48d67a598d4e73868fa125e4e65594d5461ee07107539f
Deleted: sha256:45a88fb77b90a626caadd5add9455aaaaf6ab4f28ffe76f39813a0479e3b5bdd
Deleted: sha256:45bab1c191fa0cca4f58e673ff53c8a698501df6fa671b51025282cb36435bec
Deleted: sha256:7dd987ecd531206b45fdf36a944d7920b2394c181610764161658145b0821919
Deleted: sha256:b0d39dcf48befa7761654df2623ead58b08523a0e034f98d5bbe8a51972a7ec4
Deleted: sha256:1a582b6eb165fe55d0a96a656678baf2f1d2bcd3ebb4849e423fefc1e81b963a
Deleted: sha256:da9a67be9874472d6cad4c732d1e61b44829a06aab6314d624c04b516ba33548
Deleted: sha256:38d60125fab0f9d7d62c9cc73eafaa25c68d6889d95295fbad169072eca37746
Deleted: sha256:4f2ee77cb88519034c95da9b03f98aa694ed65ecebb49eb5f5376364c8eb9c62
Deleted: sha256:db4c61b4ad78eabe6ad7aeaadae1f5fb74b8ad7546f9afc4f12faaaa0c5971ae
Deleted: sha256:02aa70d30dc5d40a8599307f4fa70db94e0ff3effae77f40d4b8a58a8c4e7f94
Deleted: sha256:1eedf5430ea4bfcffbb29932f0fdcdfbdb5a173e402b9a80fe4bc4a5849b9f0c
Deleted: sha256:57e66c5469bf2f6ab35f351b1748e9ddfd5767a521676444f589e57bc9012e85
Deleted: sha256:77b67450ace48e283186a324e46dbe6cf8db18aa918f0e31eb34dcdc3538e6bc
Deleted: sha256:7e22354500ca62ddd43428f009206893a8c8ed4411aa53c845e663d373610edd
Deleted: sha256:30932fc98e1f5203b350c73090ce4c674539070e1e29fdd0266b32dc6bc42205
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user yujie.jay@gmail.com