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/23 08:07:11 UTC
Build failed in Jenkins: Mesos-Buildbot » cmake,gcc,--verbose --disable-libtool-wrappers --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4494
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,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)/4494/display/redirect>
------------------------------------------
[...truncated 34.86 MB...]
3: I1123 08:07:02.086238 29061 hierarchical.cpp:1457] Performed allocation for 0 agents in 36401ns
3: I1123 08:07:02.086483 29062 authenticatee.cpp:121] Creating new client SASL connection
3: I1123 08:07:02.086899 29045 master.cpp:8312] Authenticating slave(951)@172.17.0.2:33553
3: I1123 08:07:02.087051 29041 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1701)@172.17.0.2:33553
3: I1123 08:07:02.087285 29043 authenticator.cpp:98] Creating new server SASL connection
3: I1123 08:07:02.087599 29053 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1123 08:07:02.087630 29053 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1123 08:07:02.087726 29053 authenticator.cpp:204] Received SASL authentication start
3: I1123 08:07:02.087776 29053 authenticator.cpp:326] Authentication requires more steps
3: I1123 08:07:02.087870 29053 authenticatee.cpp:259] Received SASL authentication step
3: I1123 08:07:02.087963 29053 authenticator.cpp:232] Received SASL authentication step
3: I1123 08:07:02.087986 29053 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'dce3e4c418cb' server FQDN: 'dce3e4c418cb' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
3: I1123 08:07:02.088006 29053 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1123 08:07:02.088032 29053 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1123 08:07:02.088048 29053 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'dce3e4c418cb' server FQDN: 'dce3e4c418cb' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
3: I1123 08:07:02.088057 29053 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1123 08:07:02.088063 29053 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1123 08:07:02.088075 29053 authenticator.cpp:318] Authentication success
3: I1123 08:07:02.088181 29063 authenticatee.cpp:299] Authentication success
3: I1123 08:07:02.088214 29050 master.cpp:8342] Successfully authenticated principal 'test-principal' at slave(951)@172.17.0.2:33553
3: I1123 08:07:02.088246 29064 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1701)@172.17.0.2:33553
3: I1123 08:07:02.088433 29063 slave.cpp:1161] Successfully authenticated with master master@172.17.0.2:33553
3: I1123 08:07:02.088634 29063 slave.cpp:1685] Will retry registration in 9.979907ms if necessary
3: I1123 08:07:02.088858 29052 master.cpp:6036] Received register agent message from slave(951)@172.17.0.2:33553 (dce3e4c418cb)
3: I1123 08:07:02.089020 29052 master.cpp:3872] Authorizing agent with principal 'test-principal'
3: I1123 08:07:02.089542 29055 master.cpp:6098] Authorized registration of agent at slave(951)@172.17.0.2:33553 (dce3e4c418cb)
3: I1123 08:07:02.089643 29055 master.cpp:6191] Registering agent at slave(951)@172.17.0.2:33553 (dce3e4c418cb) with id 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0
3: I1123 08:07:02.090153 29059 registrar.cpp:495] Applied 1 operations in 69881ns; attempting to update the registry
3: I1123 08:07:02.090759 29059 registrar.cpp:552] Successfully updated the registry in 542976ns
3: I1123 08:07:02.091032 29061 master.cpp:6240] Admitted agent 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0 at slave(951)@172.17.0.2:33553 (dce3e4c418cb)
3: I1123 08:07:02.092270 29061 master.cpp:6276] Registered agent 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0 at slave(951)@172.17.0.2:33553 (dce3e4c418cb) with cpus:1; mem:512; disk:367489; ports:[31000-32000]
3: I1123 08:07:02.092344 29046 slave.cpp:1207] Registered with master master@172.17.0.2:33553; given agent ID 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0
3: I1123 08:07:02.092448 29054 task_status_update_manager.cpp:188] Resuming sending task status updates
3: I1123 08:07:02.092473 29045 hierarchical.cpp:600] Added agent 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0 (dce3e4c418cb) with cpus:1; mem:512; disk:367489; ports:[31000-32000] (allocated: {})
3: I1123 08:07:02.092697 29046 slave.cpp:1227] Checkpointing SlaveInfo to '/tmp/ResourceProviderCapability_ReservationTest_PreventUnreservingAlienResources_1_GRVqo8/meta/slaves/04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0/slave.info'
3: I1123 08:07:02.092749 29045 hierarchical.cpp:1457] Performed allocation for 1 agents in 122523ns
3: I1123 08:07:02.093232 29046 slave.cpp:1288] Forwarding total resources cpus:1; mem:512; disk:367489; ports:[31000-32000]
3: I1123 08:07:02.093317 29046 slave.cpp:1298] Forwarding total oversubscribed resources {}
3: I1123 08:07:02.093912 29053 master.cpp:7078] Received update of agent 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0 at slave(951)@172.17.0.2:33553 (dce3e4c418cb) with total resources cpus:1; mem:512; disk:367489; ports:[31000-32000]
3: I1123 08:07:02.093973 29053 master.cpp:7091] Received update of agent 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0 at slave(951)@172.17.0.2:33553 (dce3e4c418cb) with total oversubscribed resources {}
3: I1123 08:07:02.094030 29056 hierarchical.cpp:1457] Performed allocation for 1 agents in 112853ns
3: I1123 08:07:02.094146 29053 master.cpp:7109] Ignoring update on agent 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0 at slave(951)@172.17.0.2:33553 (dce3e4c418cb) as it reports no changes
3: W1123 08:07:02.094509 20036 process.cpp:2756] Attempted to spawn already running process version@172.17.0.2:33553
3: W1123 08:07:02.094951 20036 process.cpp:2756] Attempted to spawn already running process version@172.17.0.2:33553
3: I1123 08:07:02.095805 20036 sched.cpp:232] Version: 1.5.0
3: I1123 08:07:02.096349 29060 sched.cpp:336] New master detected at master@172.17.0.2:33553
3: I1123 08:07:02.096437 29060 sched.cpp:396] Authenticating with master master@172.17.0.2:33553
3: I1123 08:07:02.096451 29060 sched.cpp:403] Using default CRAM-MD5 authenticatee
3: I1123 08:07:02.096842 29059 authenticatee.cpp:121] Creating new client SASL connection
3: I1123 08:07:02.097152 29041 master.cpp:8312] Authenticating scheduler-45420782-bd4d-4881-9009-bad29a7608c1@172.17.0.2:33553
3: I1123 08:07:02.097272 29043 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1702)@172.17.0.2:33553
3: I1123 08:07:02.097611 29061 authenticator.cpp:98] Creating new server SASL connection
3: I1123 08:07:02.097946 29054 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1123 08:07:02.097997 29054 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1123 08:07:02.098146 29054 authenticator.cpp:204] Received SASL authentication start
3: I1123 08:07:02.098249 29054 authenticator.cpp:326] Authentication requires more steps
3: I1123 08:07:02.098387 29044 authenticatee.cpp:259] Received SASL authentication step
3: I1123 08:07:02.098512 29046 authenticator.cpp:232] Received SASL authentication step
3: I1123 08:07:02.098549 29046 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'dce3e4c418cb' server FQDN: 'dce3e4c418cb' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
3: I1123 08:07:02.098567 29046 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1123 08:07:02.098599 29046 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1123 08:07:02.098618 29046 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'dce3e4c418cb' server FQDN: 'dce3e4c418cb' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
3: I1123 08:07:02.098626 29046 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1123 08:07:02.098631 29046 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1123 08:07:02.098644 29046 authenticator.cpp:318] Authentication success
3: I1123 08:07:02.098724 29050 authenticatee.cpp:299] Authentication success
3: I1123 08:07:02.098786 29042 master.cpp:8342] Successfully authenticated principal 'test-principal' at scheduler-45420782-bd4d-4881-9009-bad29a7608c1@172.17.0.2:33553
3: I1123 08:07:02.098876 29051 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1702)@172.17.0.2:33553
3: I1123 08:07:02.098983 29050 sched.cpp:502] Successfully authenticated with master master@172.17.0.2:33553
3: I1123 08:07:02.099000 29050 sched.cpp:824] Sending SUBSCRIBE call to master@172.17.0.2:33553
3: I1123 08:07:02.099112 29050 sched.cpp:857] Will retry registration in 353.471407ms if necessary
3: I1123 08:07:02.099325 29052 master.cpp:2963] Received SUBSCRIBE call for framework 'framework1' at scheduler-45420782-bd4d-4881-9009-bad29a7608c1@172.17.0.2:33553
3: I1123 08:07:02.099400 29052 master.cpp:2280] Authorizing framework principal 'test-principal' to receive offers for roles '{ role1 }'
3: I1123 08:07:02.099865 29057 master.cpp:3043] Subscribing framework framework1 with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1123 08:07:02.100549 29057 sched.cpp:751] Framework registered with 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000
3: I1123 08:07:02.100591 29057 sched.cpp:765] Scheduler::registered took 16255ns
3: I1123 08:07:02.100668 29049 hierarchical.cpp:306] Added framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000
3: I1123 08:07:02.101745 29049 hierarchical.cpp:1457] Performed allocation for 1 agents in 957973ns
3: I1123 08:07:02.102000 29049 hierarchical.cpp:1457] Performed allocation for 1 agents in 112278ns
3: I1123 08:07:02.102156 29060 master.cpp:8142] Sending 1 offers to framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000 (framework1) at scheduler-45420782-bd4d-4881-9009-bad29a7608c1@172.17.0.2:33553
3: I1123 08:07:02.102614 29060 sched.cpp:921] Scheduler::resourceOffers took 95753ns
3: I1123 08:07:02.104498 29046 master.cpp:10063] Removing offer 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-O0
3: I1123 08:07:02.104629 29046 master.cpp:4230] Processing ACCEPT call for offers: [ 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-O0 ] on agent 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0 at slave(951)@172.17.0.2:33553 (dce3e4c418cb) for framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000 (framework1) at scheduler-45420782-bd4d-4881-9009-bad29a7608c1@172.17.0.2:33553
3: I1123 08:07:02.104811 29046 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: I1123 08:07:02.106252 29051 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 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000 (framework1) at scheduler-45420782-bd4d-4881-9009-bad29a7608c1@172.17.0.2:33553 to agent 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0 at slave(951)@172.17.0.2:33553 (dce3e4c418cb)
3: I1123 08:07:02.107183 29051 master.cpp:9945] Sending offer operation '' (uuid: e4bbf33a-edd0-4b43-9807-6fb69ef35fd9) to agent 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0 at slave(951)@172.17.0.2:33553 (dce3e4c418cb)
3: I1123 08:07:02.108247 29050 slave.cpp:3594] Updated checkpointed resources from {} to mem(reservations: [(DYNAMIC,role1,test-principal)]):256
3: I1123 08:07:02.108335 29050 slave.cpp:6989] Updating the state of offer operation '' (uuid: e4bbf33a-edd0-4b43-9807-6fb69ef35fd9) of framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000 (latest state: OFFER_OPERATION_FINISHED, status update state: OFFER_OPERATION_FINISHED)
3: I1123 08:07:02.108585 29047 master.cpp:9731] Updating the state of offer operation '' (uuid: e4bbf33a-edd0-4b43-9807-6fb69ef35fd9) of framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000 (latest state: OFFER_OPERATION_FINISHED, status update state: OFFER_OPERATION_FINISHED)
3: I1123 08:07:02.110074 29052 hierarchical.cpp:856] Updated allocation of framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000 on agent 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-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: I1123 08:07:02.111292 29052 hierarchical.cpp:1132] 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 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0 from framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000
3: I1123 08:07:02.112908 29052 hierarchical.cpp:1457] Performed allocation for 1 agents in 1.3771ms
3: I1123 08:07:02.113917 29055 master.cpp:8142] Sending 1 offers to framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000 (framework1) at scheduler-45420782-bd4d-4881-9009-bad29a7608c1@172.17.0.2:33553
3: I1123 08:07:02.114468 29058 sched.cpp:921] Scheduler::resourceOffers took 107483ns
3: I1123 08:07:02.115414 29060 master.cpp:5434] Processing DECLINE call for offers: [ 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-O1 ] for framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000 (framework1) at scheduler-45420782-bd4d-4881-9009-bad29a7608c1@172.17.0.2:33553
3: I1123 08:07:02.115634 20036 sched.cpp:232] Version: 1.5.0
3: I1123 08:07:02.116161 29042 sched.cpp:336] New master detected at master@172.17.0.2:33553
3: I1123 08:07:02.116248 29042 sched.cpp:396] Authenticating with master master@172.17.0.2:33553
3: I1123 08:07:02.116262 29042 sched.cpp:403] Using default CRAM-MD5 authenticatee
3: I1123 08:07:02.116283 29060 master.cpp:10063] Removing offer 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-O1
3: I1123 08:07:02.116464 29064 authenticatee.cpp:121] Creating new client SASL connection
3: I1123 08:07:02.116739 29046 master.cpp:8312] Authenticating scheduler-8717cad6-6f3e-44d5-8b11-4ab9727c4a66@172.17.0.2:33553
3: I1123 08:07:02.116834 29063 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1703)@172.17.0.2:33553
3: I1123 08:07:02.116961 29061 hierarchical.cpp:1132] 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 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0 from framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000
3: W1123 08:07:02.117055 29061 hierarchical.cpp:1153] Using 365 days to create the refused resources offer filter because the input value is too big
3: I1123 08:07:02.117070 29061 hierarchical.cpp:1178] Framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000 filtered agent 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0 for 365days
3: I1123 08:07:02.117110 29053 authenticator.cpp:98] Creating new server SASL connection
3: I1123 08:07:02.117400 29051 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1123 08:07:02.117424 29051 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1123 08:07:02.117506 29051 authenticator.cpp:204] Received SASL authentication start
3: I1123 08:07:02.117547 29051 authenticator.cpp:326] Authentication requires more steps
3: I1123 08:07:02.117677 29047 authenticatee.cpp:259] Received SASL authentication step
3: I1123 08:07:02.117825 29052 authenticator.cpp:232] Received SASL authentication step
3: I1123 08:07:02.117854 29052 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'dce3e4c418cb' server FQDN: 'dce3e4c418cb' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
3: I1123 08:07:02.117864 29052 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1123 08:07:02.117887 29052 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1123 08:07:02.117909 29052 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'dce3e4c418cb' server FQDN: 'dce3e4c418cb' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
3: I1123 08:07:02.117924 29052 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1123 08:07:02.117938 29052 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1123 08:07:02.117956 29052 authenticator.cpp:318] Authentication success
3: I1123 08:07:02.118129 29055 authenticatee.cpp:299] Authentication success
3: I1123 08:07:02.118171 29058 master.cpp:8342] Successfully authenticated principal 'test-principal' at scheduler-8717cad6-6f3e-44d5-8b11-4ab9727c4a66@172.17.0.2:33553
3: I1123 08:07:02.118221 29052 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1703)@172.17.0.2:33553
3: I1123 08:07:02.118366 29062 sched.cpp:502] Successfully authenticated with master master@172.17.0.2:33553
3: I1123 08:07:02.118389 29062 sched.cpp:824] Sending SUBSCRIBE call to master@172.17.0.2:33553
3: I1123 08:07:02.118492 29062 sched.cpp:857] Will retry registration in 867.237435ms if necessary
3: I1123 08:07:02.118654 29052 master.cpp:2963] Received SUBSCRIBE call for framework 'framework2' at scheduler-8717cad6-6f3e-44d5-8b11-4ab9727c4a66@172.17.0.2:33553
3: I1123 08:07:02.118731 29052 master.cpp:2280] Authorizing framework principal 'test-principal' to receive offers for roles '{ role2 }'
3: I1123 08:07:02.119114 29054 master.cpp:3043] Subscribing framework framework2 with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1123 08:07:02.119624 29060 sched.cpp:751] Framework registered with 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0001
3: I1123 08:07:02.119663 29060 sched.cpp:765] Scheduler::registered took 17193ns
3: I1123 08:07:02.119796 29045 hierarchical.cpp:306] Added framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0001
3: I1123 08:07:02.121027 29045 hierarchical.cpp:2175] Filtered offer with mem(reservations: [(DYNAMIC,role1,test-principal)]):256 on agent 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0 for role role1 of framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000
3: I1123 08:07:02.121280 29045 hierarchical.cpp:1457] Performed allocation for 1 agents in 1.342782ms
3: I1123 08:07:02.121671 29056 master.cpp:8142] Sending 1 offers to framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0001 (framework2) at scheduler-8717cad6-6f3e-44d5-8b11-4ab9727c4a66@172.17.0.2:33553
3: I1123 08:07:02.121984 29064 hierarchical.cpp:2175] Filtered offer with mem(reservations: [(DYNAMIC,role1,test-principal)]):256 on agent 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0 for role role1 of framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000
3: I1123 08:07:02.122136 29056 sched.cpp:921] Scheduler::resourceOffers took 112277ns
3: I1123 08:07:02.122268 29064 hierarchical.cpp:1457] Performed allocation for 1 agents in 642408ns
3: I1123 08:07:02.123710 29055 master.cpp:10063] Removing offer 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-O2
3: I1123 08:07:02.123853 29055 master.cpp:4230] Processing ACCEPT call for offers: [ 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-O2 ] on agent 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0 at slave(951)@172.17.0.2:33553 (dce3e4c418cb) for framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0001 (framework2) at scheduler-8717cad6-6f3e-44d5-8b11-4ab9727c4a66@172.17.0.2:33553
3: I1123 08:07:02.123989 29055 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: W1123 08:07:02.125120 29043 master.cpp:2365] Dropping UNRESERVE offer operation from framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0001 (framework2) at scheduler-8717cad6-6f3e-44d5-8b11-4ab9727c4a66@172.17.0.2:33553: 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: I1123 08:07:02.126170 29062 hierarchical.cpp:1132] 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 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0 from framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0001
3: I1123 08:07:02.131615 29048 hierarchical.cpp:2175] Filtered offer with mem(reservations: [(DYNAMIC,role1,test-principal)]):256 on agent 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0 for role role1 of framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000
3: I1123 08:07:02.131799 29048 hierarchical.cpp:1457] Performed allocation for 1 agents in 1.342168ms
3: I1123 08:07:02.132169 29054 master.cpp:8142] Sending 1 offers to framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0001 (framework2) at scheduler-8717cad6-6f3e-44d5-8b11-4ab9727c4a66@172.17.0.2:33553
3: I1123 08:07:02.132602 29054 sched.cpp:921] Scheduler::resourceOffers took 90686ns
3: I1123 08:07:02.133033 20036 sched.cpp:2009] Asked to stop the driver
3: W1123 08:07:02.133100 29063 sched.cpp:1402] Attempting to decline an unknown offer 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-O2
3: I1123 08:07:02.133225 29063 sched.cpp:1191] Stopping framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0001
3: I1123 08:07:02.133363 29061 master.cpp:5434] Processing DECLINE call for offers: [ 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-O2 ] for framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0001 (framework2) at scheduler-8717cad6-6f3e-44d5-8b11-4ab9727c4a66@172.17.0.2:33553
3: W1123 08:07:02.133399 29061 master.cpp:5455] Ignoring decline of offer 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-O2 since it is no longer valid
3: I1123 08:07:02.133502 29061 master.cpp:8819] Processing TEARDOWN call for framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0001 (framework2) at scheduler-8717cad6-6f3e-44d5-8b11-4ab9727c4a66@172.17.0.2:33553
3: I1123 08:07:02.133525 29061 master.cpp:8831] Removing framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0001 (framework2) at scheduler-8717cad6-6f3e-44d5-8b11-4ab9727c4a66@172.17.0.2:33553
3: I1123 08:07:02.133535 29061 master.cpp:3333] Deactivating framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0001 (framework2) at scheduler-8717cad6-6f3e-44d5-8b11-4ab9727c4a66@172.17.0.2:33553
3: I1123 08:07:02.133678 29047 hierarchical.cpp:419] Deactivated framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0001
3: I1123 08:07:02.134030 29061 master.cpp:10063] Removing offer 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-O3
3: I1123 08:07:02.134238 29058 slave.cpp:3270] Asked to shut down framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0001 by master@172.17.0.2:33553
3: I1123 08:07:02.134268 29058 slave.cpp:3285] Cannot shut down unknown framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0001
3: I1123 08:07:02.134407 29061 master.cpp:5539] Processing REVIVE call for framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000 (framework1) at scheduler-45420782-bd4d-4881-9009-bad29a7608c1@172.17.0.2:33553
3: I1123 08:07:02.134552 29047 hierarchical.cpp:1132] 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 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0 from framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0001
3: I1123 08:07:02.134795 29047 hierarchical.cpp:358] Removed framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0001
3: I1123 08:07:02.134925 29047 hierarchical.cpp:1279] Revived offers for roles { role1 } of framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000
3: I1123 08:07:02.136319 29047 hierarchical.cpp:1457] Performed allocation for 1 agents in 1.2184ms
3: I1123 08:07:02.136835 29059 master.cpp:8142] Sending 1 offers to framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000 (framework1) at scheduler-45420782-bd4d-4881-9009-bad29a7608c1@172.17.0.2:33553
3: I1123 08:07:02.137380 29044 sched.cpp:921] Scheduler::resourceOffers took 113313ns
3: I1123 08:07:02.137900 20036 sched.cpp:2009] Asked to stop the driver
3: I1123 08:07:02.138056 29060 sched.cpp:1191] Stopping framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000
3: I1123 08:07:02.138278 29046 master.cpp:8819] Processing TEARDOWN call for framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000 (framework1) at scheduler-45420782-bd4d-4881-9009-bad29a7608c1@172.17.0.2:33553
3: I1123 08:07:02.138303 29046 master.cpp:8831] Removing framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000 (framework1) at scheduler-45420782-bd4d-4881-9009-bad29a7608c1@172.17.0.2:33553
3: I1123 08:07:02.138314 29046 master.cpp:3333] Deactivating framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000 (framework1) at scheduler-45420782-bd4d-4881-9009-bad29a7608c1@172.17.0.2:33553
3: I1123 08:07:02.138567 29056 hierarchical.cpp:1457] Performed allocation for 1 agents in 177046ns
3: I1123 08:07:02.138788 29056 hierarchical.cpp:419] Deactivated framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000
3: I1123 08:07:02.139029 29046 master.cpp:10063] Removing offer 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-O4
3: I1123 08:07:02.139225 29041 slave.cpp:3270] Asked to shut down framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000 by master@172.17.0.2:33553
3: I1123 08:07:02.139256 29041 slave.cpp:3285] Cannot shut down unknown framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000
3: I1123 08:07:02.139953 29049 slave.cpp:883] Agent terminating
3: I1123 08:07:02.139956 29056 hierarchical.cpp:1132] 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 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0 from framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000
3: I1123 08:07:02.140123 29049 master.cpp:1311] Agent 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0 at slave(951)@172.17.0.2:33553 (dce3e4c418cb) disconnected
3: I1123 08:07:02.140142 29049 master.cpp:3370] Disconnecting agent 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0 at slave(951)@172.17.0.2:33553 (dce3e4c418cb)
3: I1123 08:07:02.140182 29049 master.cpp:3389] Deactivating agent 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0 at slave(951)@172.17.0.2:33553 (dce3e4c418cb)
3: I1123 08:07:02.140198 29056 hierarchical.cpp:358] Removed framework 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-0000
3: I1123 08:07:02.140272 29061 hierarchical.cpp:697] Agent 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0 deactivated
3: I1123 08:07:02.146389 29048 hierarchical.cpp:1457] Performed allocation for 1 agents in 109560ns
3: I1123 08:07:02.147698 20036 master.cpp:1153] Master terminating
3: I1123 08:07:02.148469 29057 hierarchical.cpp:633] Removed agent 04f5bbc4-23d1-47d2-9b15-53bf3a9f73f5-S0
3: [ OK ] ResourceProviderCapability/ReservationTest.PreventUnreservingAlienResources/1 (110 ms)
3: [----------] 36 tests from ResourceProviderCapability/ReservationTest (3311 ms total)
3:
3: [----------] Global test environment tear-down
3: [==========] 1771 tests from 183 test cases ran. (407524 ms total)
3: [ PASSED ] 1770 tests.
3: [ FAILED ] 1 test, listed below:
3: [ FAILED ] ContentType/ResourceProviderManagerHttpApiTest.ConvertResources/1, where GetParam() = application/json
3:
3: 1 FAILED TEST
3: YOU HAVE 23 DISABLED TESTS
3:
3: I1123 08:07:02.220273 29065 process.cpp:887] Failed to accept socket: future discarded
3/3 Test #3: MesosTests .......................***Failed 412.23 sec
67% tests passed, 1 tests failed out of 3
Total Test time (real) = 454.15 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-1511422017-20779
Untagged: mesos-1511422017-20779:latest
Deleted: sha256:a03f326d4bd6e30445f031592a0a3a115f850dec5a129bf78429558815757041
Deleted: sha256:99aa98f1b6e504ceb5a16c1e9d4ed59ae8273d216993b135e068e34f381ef20f
Deleted: sha256:a0659202af38d5b5d6885fb4ed15b4bcb8037af224ec6b99dc7c9e4842465cc1
Deleted: sha256:158df3189762705337a9a1cd4177020d8faab70fd3efc67584f8792f4e2c585a
Deleted: sha256:b4e03aed4ff1e775d016b4f5b92f9a84da3c97516331a3860cf14b6930cb378c
Deleted: sha256:30cdb8102943738fd9ada3fb97822e831d512a65160c75c263d6cb95503f8b3d
Deleted: sha256:66a0936d110116a2f168edf299beb672f2f161d8188e60b04a881008b63f6dee
Deleted: sha256:3c3ebcfee1905e338a459e053ea2d7bf9f4b3a3841566ccd7ad80ce398c3c1ae
Deleted: sha256:9275246a1ffb26746e31eaf3fd37d97a7e6242730ddc281f5ae6c5bcf72e3d64
Deleted: sha256:c403f43049a6037dfc1e3a1416557947c1890c1c6f70bd8999a2d70697b48e83
Deleted: sha256:35e64c7dccd60d41310b29fe5e1028f20852f646718e81420a6ecd5fb5740fdc
Deleted: sha256:4bbdc7368c309c4472e14c597834f48490378fcecb076813e9d00cd0f68c3d58
Deleted: sha256:8b6c33e30f06dbdce773268801ae050cc38b5378f0c4f95400cd2ce5e04e9ef0
Deleted: sha256:09e5a5da43baf101902faf6b9911a37209edc3e83c0d17c4f07c7cb4715bf487
Deleted: sha256:08a6330969dbc8b1cccc1ec4eed0fa9618706a7ee7b912754ff58e71f92ea82d
Deleted: sha256:f5c885ccbfb6655360abbe32bcba09c8a26bc29865baf18ee80039d8ad28f278
Deleted: sha256:85b50e54d15457cdd7aa2b32393a82c22ff21e319eb212d00c3f97bb7ff45148
Deleted: sha256:83ebb265284185df7fe88a5045698cae8c612d5c57b171c17eab0f9f4cc2a40a
Deleted: sha256:c889ec87218364cb167f92f396c4c585fc05ddd91fb7dede4fb22b80ecb9b182
Deleted: sha256:aed0510006b375f3560d5af3ad69941af4ba58c84d5f10cd5ae56fb0089d4133
Deleted: sha256:451dce9e3fe6c6b09500b7339dd060c756cda5aebc7c84db005f85107548deaf
Deleted: sha256:fc2e41300fff10a27747f126fc5e64e13fe9c386e3876f935c431aec9c7373a3
Deleted: sha256:15ea5177333d5393df362ce0c9a07a51a77a34ebe290463a202953b17ac64214
Deleted: sha256:002eb808b55312ac4f221641719b78ede9dc39050e298b5ad36f20ba861ff4b6
Deleted: sha256:5cf86d035d3f3d76a6cb85a1546cd3201011194b9884966989ca07d0149e0613
Deleted: sha256:3a91e09586af8071d2223845b258b9d78a6a564c1ff5ca1b073cdb490ac26c16
Deleted: sha256:e11b81a64f4477f7e26d0d0a7bf338c9e159a55b65b76e705689df87f39e61c0
Deleted: sha256:d4b589e1e2a0cd202c8a2182bc3afe15bed7581ef1d6ccc90c8377ccfa6e0206
Deleted: sha256:a8dcce72326d3d7479ac88bd3acd4365aac22df15dc26b23660d823d49688297
Deleted: sha256:3016362fdb0946fcefbb4233eade6ffe6b0325129afbda726d8445444a556c18
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user yujie.jay@gmail.com
Jenkins build is back to normal : Mesos-Buildbot » cmake,gcc,--verbose --disable-libtool-wrappers --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4495
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,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)/4495/display/redirect?page=changes>