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 2016/03/23 19:22:18 UTC
Build failed in Jenkins: Mesos » gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1) #1853
See <https://builds.apache.org/job/Mesos/COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)/1853/changes>
Changes:
[yujie.jay] Replaced const ref to temporary in tests for consistency.
------------------------------------------
[...truncated 120195 lines...]
I0323 18:22:02.321001 2941 authenticator.cpp:325] Authentication requires more steps
I0323 18:22:02.321097 2941 authenticatee.cpp:258] Received SASL authentication step
I0323 18:22:02.321208 2941 authenticator.cpp:231] Received SASL authentication step
I0323 18:22:02.321256 2941 auxprop.cpp:107] Request to lookup properties for user: 'test-principal' realm: 'c9c989a3c99d' server FQDN: 'c9c989a3c99d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0323 18:22:02.321290 2941 auxprop.cpp:179] Looking up auxiliary property '*userPassword'
I0323 18:22:02.321369 2941 auxprop.cpp:179] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0323 18:22:02.321405 2941 auxprop.cpp:107] Request to lookup properties for user: 'test-principal' realm: 'c9c989a3c99d' server FQDN: 'c9c989a3c99d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0323 18:22:02.321430 2941 auxprop.cpp:129] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0323 18:22:02.321439 2941 auxprop.cpp:129] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0323 18:22:02.321475 2941 authenticator.cpp:317] Authentication success
I0323 18:22:02.321689 2941 authenticatee.cpp:298] Authentication success
I0323 18:22:02.321817 2941 master.cpp:5689] Successfully authenticated principal 'test-principal' at slave(295)@172.17.0.3:59269
I0323 18:22:02.321943 2941 authenticator.cpp:431] Authentication session cleanup for crammd5_authenticatee(624)@172.17.0.3:59269
I0323 18:22:02.322547 2940 slave.cpp:927] Successfully authenticated with master master@172.17.0.3:59269
I0323 18:22:02.322731 2940 slave.cpp:1321] Will retry registration in 10.860756ms if necessary
I0323 18:22:02.323083 2938 master.cpp:4370] Registering slave at slave(295)@172.17.0.3:59269 (c9c989a3c99d) with id 78e433a4-15ef-41bf-9735-db9ac65c9190-S8
I0323 18:22:02.323897 2911 sched.cpp:222] Version: 0.29.0
I0323 18:22:02.324843 2940 slave.cpp:1321] Will retry registration in 152.623527ms if necessary
I0323 18:22:02.325050 2940 master.cpp:4358] Ignoring register slave message from slave(288)@172.17.0.3:59269 (c9c989a3c99d) as admission is already in progress
I0323 18:22:02.325500 2939 sched.cpp:326] New master detected at master@172.17.0.3:59269
I0323 18:22:02.325587 2939 sched.cpp:382] Authenticating with master master@172.17.0.3:59269
I0323 18:22:02.325608 2939 sched.cpp:389] Using default CRAM-MD5 authenticatee
I0323 18:22:02.325954 2939 authenticatee.cpp:121] Creating new client SASL connection
I0323 18:22:02.326208 2932 slave.cpp:1321] Will retry registration in 17.300603ms if necessary
I0323 18:22:02.326375 2937 master.cpp:4358] Ignoring register slave message from slave(293)@172.17.0.3:59269 (c9c989a3c99d) as admission is already in progress
I0323 18:22:02.326489 2937 master.cpp:5659] Authenticating scheduler-7629439b-af3b-47e4-a43b-afae1a5699b2@172.17.0.3:59269
I0323 18:22:02.326676 2937 authenticator.cpp:413] Starting authentication session for crammd5_authenticatee(625)@172.17.0.3:59269
I0323 18:22:02.327014 2937 authenticator.cpp:98] Creating new server SASL connection
I0323 18:22:02.327338 2937 authenticatee.cpp:212] Received SASL authentication mechanisms: CRAM-MD5
I0323 18:22:02.327420 2937 authenticatee.cpp:238] Attempting to authenticate with mechanism 'CRAM-MD5'
I0323 18:22:02.327566 2937 authenticator.cpp:203] Received SASL authentication start
I0323 18:22:02.327708 2937 authenticator.cpp:325] Authentication requires more steps
I0323 18:22:02.327853 2937 authenticatee.cpp:258] Received SASL authentication step
I0323 18:22:02.327999 2937 authenticator.cpp:231] Received SASL authentication step
I0323 18:22:02.328083 2937 auxprop.cpp:107] Request to lookup properties for user: 'test-principal' realm: 'c9c989a3c99d' server FQDN: 'c9c989a3c99d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0323 18:22:02.328150 2937 auxprop.cpp:179] Looking up auxiliary property '*userPassword'
I0323 18:22:02.328264 2937 auxprop.cpp:179] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0323 18:22:02.328384 2937 auxprop.cpp:107] Request to lookup properties for user: 'test-principal' realm: 'c9c989a3c99d' server FQDN: 'c9c989a3c99d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0323 18:22:02.328449 2937 auxprop.cpp:129] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0323 18:22:02.328505 2937 auxprop.cpp:129] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0323 18:22:02.328569 2937 authenticator.cpp:317] Authentication success
I0323 18:22:02.328807 2937 authenticatee.cpp:298] Authentication success
I0323 18:22:02.328968 2937 master.cpp:5689] Successfully authenticated principal 'test-principal' at scheduler-7629439b-af3b-47e4-a43b-afae1a5699b2@172.17.0.3:59269
I0323 18:22:02.329123 2937 authenticator.cpp:431] Authentication session cleanup for crammd5_authenticatee(625)@172.17.0.3:59269
I0323 18:22:02.329478 2935 slave.cpp:324] Slave using credential for: test-principal
I0323 18:22:02.330436 2933 sched.cpp:471] Successfully authenticated with master master@172.17.0.3:59269
I0323 18:22:02.330487 2933 sched.cpp:776] Sending SUBSCRIBE call to master@172.17.0.3:59269
I0323 18:22:02.330637 2933 sched.cpp:809] Will retry registration in 1.930018557secs if necessary
I0323 18:22:02.330888 2933 master.cpp:2326] Received SUBSCRIBE call for framework 'default' at scheduler-7629439b-af3b-47e4-a43b-afae1a5699b2@172.17.0.3:59269
I0323 18:22:02.330965 2933 master.cpp:1845] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0323 18:22:02.331403 2935 resources.cpp:572] Parsing resources as JSON failed: cpus:2;mem:1024
Trying semicolon-delimited string format instead
I0323 18:22:02.331960 2935 slave.cpp:464] Slave resources: cpus(*):2; mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000]
I0323 18:22:02.332046 2935 slave.cpp:472] Slave attributes: [ ]
I0323 18:22:02.332059 2935 slave.cpp:477] Slave hostname: c9c989a3c99d
I0323 18:22:02.333451 2933 master.cpp:2397] Subscribing framework default with checkpointing disabled and capabilities [ ]
I0323 18:22:02.334079 2944 hierarchical.cpp:265] Added framework 78e433a4-15ef-41bf-9735-db9ac65c9190-0000
I0323 18:22:02.334157 2933 sched.cpp:703] Framework registered with 78e433a4-15ef-41bf-9735-db9ac65c9190-0000
I0323 18:22:02.334203 2933 sched.cpp:717] Scheduler::registered took 23096ns
I0323 18:22:02.334422 2933 state.cpp:58] Recovering state from '/tmp/ResourceOffersTest_ResourceOfferWithMultipleSlaves_fPQONo/meta'
I0323 18:22:02.334805 2932 slave.cpp:1321] Will retry registration in 107.619697ms if necessary
I0323 18:22:02.335036 2932 master.cpp:4358] Ignoring register slave message from slave(292)@172.17.0.3:59269 (c9c989a3c99d) as admission is already in progress
I0323 18:22:02.335253 2935 status_update_manager.cpp:200] Recovering status update manager
I0323 18:22:02.335444 2935 containerizer.cpp:407] Recovering containerizer
I0323 18:22:02.335700 2944 hierarchical.cpp:1561] No inverse offers to send out!
I0323 18:22:02.335871 2944 hierarchical.cpp:1138] Performed allocation for 1 slaves in 1.72458ms
I0323 18:22:02.336242 2938 slave.cpp:1321] Will retry registration in 15.340089ms if necessary
I0323 18:22:02.336724 2944 master.cpp:5488] Sending 1 offers to framework 78e433a4-15ef-41bf-9735-db9ac65c9190-0000 (default) at scheduler-7629439b-af3b-47e4-a43b-afae1a5699b2@172.17.0.3:59269
I0323 18:22:02.337308 2933 provisioner.cpp:245] Provisioner recovery complete
I0323 18:22:02.337643 2939 slave.cpp:4565] Finished recovery
I0323 18:22:02.337664 2934 leveldb.cpp:341] Persisting action (692 bytes) to leveldb took 28.61693ms
I0323 18:22:02.337704 2934 replica.cpp:712] Persisted action at 5
I0323 18:22:02.337736 2934 replica.cpp:697] Replica learned APPEND action at position 5
I0323 18:22:02.338238 2939 slave.cpp:4737] Querying resource estimator for oversubscribable resources
I0323 18:22:02.338699 2935 slave.cpp:796] New master detected at master@172.17.0.3:59269
I0323 18:22:02.338862 2935 slave.cpp:859] Authenticating with master master@172.17.0.3:59269
I0323 18:22:02.338888 2935 slave.cpp:864] Using default CRAM-MD5 authenticatee
I0323 18:22:02.339105 2935 slave.cpp:832] Detecting new master
I0323 18:22:02.339292 2931 status_update_manager.cpp:174] Pausing sending status updates
I0323 18:22:02.339376 2935 slave.cpp:4751] Received oversubscribable resources from the resource estimator
I0323 18:22:02.339397 2938 authenticatee.cpp:121] Creating new client SASL connection
I0323 18:22:02.339838 2944 master.cpp:4358] Ignoring register slave message from slave(295)@172.17.0.3:59269 (c9c989a3c99d) as admission is already in progress
I0323 18:22:02.340003 2941 sched.cpp:873] Scheduler::resourceOffers took 136422ns
I0323 18:22:02.341003 2944 master.cpp:5659] Authenticating slave(296)@172.17.0.3:59269
I0323 18:22:02.341881 2945 registrar.cpp:484] Successfully updated the 'registry' in 148.944896ms
I0323 18:22:02.343127 2945 registrar.cpp:439] Applied 6 operations in 258216ns; attempting to update the 'registry'
I0323 18:22:02.342274 2931 log.cpp:702] Attempting to truncate the log to 5
I0323 18:22:02.344744 2933 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 6
I0323 18:22:02.344897 2931 slave.cpp:1321] Will retry registration in 132.470313ms if necessary
I0323 18:22:02.346803 2934 authenticator.cpp:413] Starting authentication session for crammd5_authenticatee(626)@172.17.0.3:59269
I0323 18:22:02.342110 2911 sched.cpp:1903] Asked to stop the driver
I0323 18:22:02.347434 2930 sched.cpp:1143] Stopping framework '78e433a4-15ef-41bf-9735-db9ac65c9190-0000'
I0323 18:22:02.347818 2940 slave.cpp:3482] Received ping from slave-observer(277)@172.17.0.3:59269
I0323 18:22:02.348107 2935 replica.cpp:537] Replica received write request for position 6 from (9666)@172.17.0.3:59269
I0323 18:22:02.348186 2930 hierarchical.cpp:473] Added slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S1 (c9c989a3c99d) with cpus(*):2; mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000] (allocated: )
I0323 18:22:02.348345 2940 slave.cpp:971] Registered with master master@172.17.0.3:59269; given slave ID 78e433a4-15ef-41bf-9735-db9ac65c9190-S1
I0323 18:22:02.348369 2940 fetcher.cpp:81] Clearing fetcher cache
I0323 18:22:02.348534 2938 status_update_manager.cpp:181] Resuming sending status updates
I0323 18:22:02.348783 2936 slave.cpp:1321] Will retry registration in 145.606098ms if necessary
I0323 18:22:02.348793 2940 slave.cpp:994] Checkpointing SlaveInfo to '/tmp/ResourceOffersTest_ResourceOfferWithMultipleSlaves_F1JoHQ/meta/slaves/78e433a4-15ef-41bf-9735-db9ac65c9190-S1/slave.info'
I0323 18:22:02.348938 2934 authenticator.cpp:98] Creating new server SASL connection
I0323 18:22:02.349206 2930 hierarchical.cpp:1561] No inverse offers to send out!
I0323 18:22:02.349258 2940 slave.cpp:1030] Forwarding total oversubscribed resources
I0323 18:22:02.349330 2930 hierarchical.cpp:1161] Performed allocation for slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S1 in 1.084466ms
I0323 18:22:02.349436 2934 authenticatee.cpp:212] Received SASL authentication mechanisms: CRAM-MD5
I0323 18:22:02.349542 2934 authenticatee.cpp:238] Attempting to authenticate with mechanism 'CRAM-MD5'
I0323 18:22:02.349750 2932 authenticator.cpp:203] Received SASL authentication start
I0323 18:22:02.349822 2932 authenticator.cpp:325] Authentication requires more steps
I0323 18:22:02.349928 2932 authenticatee.cpp:258] Received SASL authentication step
I0323 18:22:02.350030 2932 authenticator.cpp:231] Received SASL authentication step
I0323 18:22:02.350066 2932 auxprop.cpp:107] Request to lookup properties for user: 'test-principal' realm: 'c9c989a3c99d' server FQDN: 'c9c989a3c99d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0323 18:22:02.350080 2932 auxprop.cpp:179] Looking up auxiliary property '*userPassword'
I0323 18:22:02.350132 2932 auxprop.cpp:179] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0323 18:22:02.350175 2932 auxprop.cpp:107] Request to lookup properties for user: 'test-principal' realm: 'c9c989a3c99d' server FQDN: 'c9c989a3c99d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0323 18:22:02.350191 2932 auxprop.cpp:129] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0323 18:22:02.350200 2932 auxprop.cpp:129] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0323 18:22:02.348278 2944 master.cpp:4438] Registered slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S1 at slave(288)@172.17.0.3:59269 (c9c989a3c99d) with cpus(*):2; mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000]
I0323 18:22:02.350230 2932 authenticator.cpp:317] Authentication success
I0323 18:22:02.350435 2937 authenticatee.cpp:298] Authentication success
I0323 18:22:02.350638 2932 authenticator.cpp:431] Authentication session cleanup for crammd5_authenticatee(626)@172.17.0.3:59269
I0323 18:22:02.351112 2937 slave.cpp:927] Successfully authenticated with master master@172.17.0.3:59269
I0323 18:22:02.351306 2937 slave.cpp:1321] Will retry registration in 13.006559ms if necessary
I0323 18:22:02.352216 2941 slave.cpp:3482] Received ping from slave-observer(278)@172.17.0.3:59269
I0323 18:22:02.352587 2934 slave.cpp:1321] Will retry registration in 58.254346ms if necessary
I0323 18:22:02.352784 2943 slave.cpp:971] Registered with master master@172.17.0.3:59269; given slave ID 78e433a4-15ef-41bf-9735-db9ac65c9190-S2
I0323 18:22:02.352813 2943 fetcher.cpp:81] Clearing fetcher cache
I0323 18:22:02.352951 2931 hierarchical.cpp:473] Added slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S2 (c9c989a3c99d) with cpus(*):2; mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000] (allocated: )
I0323 18:22:02.359412 2944 master.cpp:4438] Registered slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S2 at slave(289)@172.17.0.3:59269 (c9c989a3c99d) with cpus(*):2; mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000]
I0323 18:22:02.359962 2944 master.cpp:4358] Ignoring register slave message from slave(293)@172.17.0.3:59269 (c9c989a3c99d) as admission is already in progress
I0323 18:22:02.360174 2944 master.cpp:6061] Processing TEARDOWN call for framework 78e433a4-15ef-41bf-9735-db9ac65c9190-0000 (default) at scheduler-7629439b-af3b-47e4-a43b-afae1a5699b2@172.17.0.3:59269
I0323 18:22:02.360249 2944 master.cpp:6073] Removing framework 78e433a4-15ef-41bf-9735-db9ac65c9190-0000 (default) at scheduler-7629439b-af3b-47e4-a43b-afae1a5699b2@172.17.0.3:59269
I0323 18:22:02.360405 2931 hierarchical.cpp:1561] No inverse offers to send out!
I0323 18:22:02.360525 2934 status_update_manager.cpp:181] Resuming sending status updates
I0323 18:22:02.360540 2931 hierarchical.cpp:1161] Performed allocation for slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S2 in 7.546805ms
I0323 18:22:02.361374 2932 slave.cpp:2079] Asked to shut down framework 78e433a4-15ef-41bf-9735-db9ac65c9190-0000 by master@172.17.0.3:59269
W0323 18:22:02.361414 2932 slave.cpp:2094] Cannot shut down unknown framework 78e433a4-15ef-41bf-9735-db9ac65c9190-0000
I0323 18:22:02.361508 2941 hierarchical.cpp:375] Deactivated framework 78e433a4-15ef-41bf-9735-db9ac65c9190-0000
I0323 18:22:02.362126 2941 hierarchical.cpp:890] Recovered cpus(*):2; mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000] (total: cpus(*):2; mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000], allocated: ) on slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S0 from framework 78e433a4-15ef-41bf-9735-db9ac65c9190-0000
I0323 18:22:02.362301 2938 slave.cpp:2079] Asked to shut down framework 78e433a4-15ef-41bf-9735-db9ac65c9190-0000 by master@172.17.0.3:59269
W0323 18:22:02.362336 2938 slave.cpp:2094] Cannot shut down unknown framework 78e433a4-15ef-41bf-9735-db9ac65c9190-0000
I0323 18:22:02.362913 2944 master.cpp:4358] Ignoring register slave message from slave(294)@172.17.0.3:59269 (c9c989a3c99d) as admission is already in progress
I0323 18:22:02.363051 2941 hierarchical.cpp:326] Removed framework 78e433a4-15ef-41bf-9735-db9ac65c9190-0000
W0323 18:22:02.363284 2944 master.cpp:5353] Master returning resources offered to framework 78e433a4-15ef-41bf-9735-db9ac65c9190-0000 because the framework has terminated or is inactive
I0323 18:22:02.364215 2944 master.cpp:4782] Received update of slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S1 at slave(288)@172.17.0.3:59269 (c9c989a3c99d) with total oversubscribed resources
I0323 18:22:02.364470 2944 master.cpp:5689] Successfully authenticated principal 'test-principal' at slave(296)@172.17.0.3:59269
I0323 18:22:02.364711 2944 master.cpp:4370] Registering slave at slave(296)@172.17.0.3:59269 (c9c989a3c99d) with id 78e433a4-15ef-41bf-9735-db9ac65c9190-S9
I0323 18:22:02.365250 2944 master.cpp:4358] Ignoring register slave message from slave(295)@172.17.0.3:59269 (c9c989a3c99d) as admission is already in progress
W0323 18:22:02.365373 2944 master.cpp:5353] Master returning resources offered to framework 78e433a4-15ef-41bf-9735-db9ac65c9190-0000 because the framework has terminated or is inactive
I0323 18:22:02.365573 2939 hierarchical.cpp:890] Recovered cpus(*):2; mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000] (total: cpus(*):2; mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000], allocated: ) on slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S1 from framework 78e433a4-15ef-41bf-9735-db9ac65c9190-0000
I0323 18:22:02.365900 2944 slave.cpp:1321] Will retry registration in 30.343785ms if necessary
I0323 18:22:02.366039 2939 hierarchical.cpp:531] Slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S1 (c9c989a3c99d) updated with oversubscribed resources (total: cpus(*):2; mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000], allocated: )
I0323 18:22:02.366278 2944 master.cpp:4358] Ignoring register slave message from slave(296)@172.17.0.3:59269 (c9c989a3c99d) as admission is already in progress
I0323 18:22:02.366323 2939 hierarchical.cpp:1466] No resources available to allocate!
I0323 18:22:02.366400 2939 hierarchical.cpp:1161] Performed allocation for slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S1 in 316804ns
I0323 18:22:02.366456 2943 slave.cpp:994] Checkpointing SlaveInfo to '/tmp/ResourceOffersTest_ResourceOfferWithMultipleSlaves_cESGar/meta/slaves/78e433a4-15ef-41bf-9735-db9ac65c9190-S2/slave.info'
I0323 18:22:02.366614 2939 hierarchical.cpp:890] Recovered cpus(*):2; mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000] (total: cpus(*):2; mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000], allocated: ) on slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S2 from framework 78e433a4-15ef-41bf-9735-db9ac65c9190-0000
I0323 18:22:02.366919 2943 slave.cpp:1030] Forwarding total oversubscribed resources
I0323 18:22:02.367105 2943 slave.cpp:2079] Asked to shut down framework 78e433a4-15ef-41bf-9735-db9ac65c9190-0000 by master@172.17.0.3:59269
W0323 18:22:02.367137 2943 slave.cpp:2094] Cannot shut down unknown framework 78e433a4-15ef-41bf-9735-db9ac65c9190-0000
I0323 18:22:02.367173 2911 slave.cpp:668] Slave terminating
I0323 18:22:02.367184 2930 master.cpp:4782] Received update of slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S2 at slave(289)@172.17.0.3:59269 (c9c989a3c99d) with total oversubscribed resources
I0323 18:22:02.370318 2930 master.cpp:1212] Slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S0 at slave(287)@172.17.0.3:59269 (c9c989a3c99d) disconnected
I0323 18:22:02.370378 2930 master.cpp:2681] Disconnecting slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S0 at slave(287)@172.17.0.3:59269 (c9c989a3c99d)
I0323 18:22:02.370455 2941 hierarchical.cpp:531] Slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S2 (c9c989a3c99d) updated with oversubscribed resources (total: cpus(*):2; mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000], allocated: )
I0323 18:22:02.370455 2930 master.cpp:2700] Deactivating slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S0 at slave(287)@172.17.0.3:59269 (c9c989a3c99d)
I0323 18:22:02.370674 2941 hierarchical.cpp:1466] No resources available to allocate!
I0323 18:22:02.370754 2941 hierarchical.cpp:1161] Performed allocation for slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S2 in 241368ns
I0323 18:22:02.370811 2941 hierarchical.cpp:560] Slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S0 deactivated
I0323 18:22:02.374295 2935 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 26.136791ms
I0323 18:22:02.374368 2935 replica.cpp:712] Persisted action at 6
I0323 18:22:02.375668 2935 replica.cpp:691] Replica received learned notice for position 6 from @0.0.0.0:0
I0323 18:22:02.376976 2937 slave.cpp:1321] Will retry registration in 221.425497ms if necessary
I0323 18:22:02.377257 2937 master.cpp:4358] Ignoring register slave message from slave(290)@172.17.0.3:59269 (c9c989a3c99d) as admission is already in progress
I0323 18:22:02.380519 2911 slave.cpp:668] Slave terminating
I0323 18:22:02.381369 2938 master.cpp:1212] Slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S1 at slave(288)@172.17.0.3:59269 (c9c989a3c99d) disconnected
I0323 18:22:02.381405 2938 master.cpp:2681] Disconnecting slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S1 at slave(288)@172.17.0.3:59269 (c9c989a3c99d)
I0323 18:22:02.381459 2938 master.cpp:2700] Deactivating slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S1 at slave(288)@172.17.0.3:59269 (c9c989a3c99d)
I0323 18:22:02.382899 2938 hierarchical.cpp:560] Slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S1 deactivated
I0323 18:22:02.391275 2943 slave.cpp:668] Slave terminating
I0323 18:22:02.391595 2943 master.cpp:1212] Slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S2 at slave(289)@172.17.0.3:59269 (c9c989a3c99d) disconnected
I0323 18:22:02.391628 2943 master.cpp:2681] Disconnecting slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S2 at slave(289)@172.17.0.3:59269 (c9c989a3c99d)
I0323 18:22:02.391681 2943 master.cpp:2700] Deactivating slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S2 at slave(289)@172.17.0.3:59269 (c9c989a3c99d)
I0323 18:22:02.391851 2943 hierarchical.cpp:560] Slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S2 deactivated
I0323 18:22:02.397086 2934 slave.cpp:668] Slave terminating
I0323 18:22:02.397230 2930 slave.cpp:1321] Will retry registration in 7.833284ms if necessary
I0323 18:22:02.397588 2939 master.cpp:4358] Ignoring register slave message from slave(296)@172.17.0.3:59269 (c9c989a3c99d) as admission is already in progress
I0323 18:22:02.403197 2911 slave.cpp:668] Slave terminating
I0323 18:22:02.406466 2942 slave.cpp:1321] Will retry registration in 125.892495ms if necessary
I0323 18:22:02.406788 2942 master.cpp:4358] Ignoring register slave message from slave(296)@172.17.0.3:59269 (c9c989a3c99d) as admission is already in progress
I0323 18:22:02.408346 2935 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 32.639158ms
I0323 18:22:02.408462 2935 leveldb.cpp:399] Deleting ~2 keys from leveldb took 70787ns
I0323 18:22:02.408490 2935 replica.cpp:712] Persisted action at 6
I0323 18:22:02.408524 2935 replica.cpp:697] Replica learned TRUNCATE action at position 6
I0323 18:22:02.410260 2934 log.cpp:683] Attempting to append 1667 bytes to the log
I0323 18:22:02.411176 2935 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 7
I0323 18:22:02.414021 2936 replica.cpp:537] Replica received write request for position 7 from (9667)@172.17.0.3:59269
I0323 18:22:02.415431 2911 slave.cpp:668] Slave terminating
I0323 18:22:02.415554 2939 slave.cpp:1321] Will retry registration in 97.680337ms if necessary
I0323 18:22:02.415791 2939 master.cpp:4358] Ignoring register slave message from slave(295)@172.17.0.3:59269 (c9c989a3c99d) as admission is already in progress
I0323 18:22:02.424763 2911 slave.cpp:668] Slave terminating
I0323 18:22:02.448796 2936 leveldb.cpp:341] Persisting action (1686 bytes) to leveldb took 34.705697ms
I0323 18:22:02.448873 2936 replica.cpp:712] Persisted action at 7
I0323 18:22:02.449777 2938 replica.cpp:691] Replica received learned notice for position 7 from @0.0.0.0:0
I0323 18:22:02.454486 2945 slave.cpp:668] Slave terminating
I0323 18:22:02.462158 2911 slave.cpp:668] Slave terminating
I0323 18:22:02.467150 2911 slave.cpp:668] Slave terminating
I0323 18:22:02.477807 2911 master.cpp:1065] Master terminating
I0323 18:22:02.478652 2937 hierarchical.cpp:505] Removed slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S2
I0323 18:22:02.478966 2937 hierarchical.cpp:505] Removed slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S1
I0323 18:22:02.479739 2944 hierarchical.cpp:505] Removed slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S0
I0323 18:22:02.480309 2938 leveldb.cpp:341] Persisting action (1688 bytes) to leveldb took 30.498549ms
I0323 18:22:02.480361 2938 replica.cpp:712] Persisted action at 7
I0323 18:22:02.480394 2938 replica.cpp:697] Replica learned APPEND action at position 7
I0323 18:22:02.485790 2944 registrar.cpp:484] Successfully updated the 'registry' in 142.418944ms
I0323 18:22:02.487464 2944 registrar.cpp:439] Applied 1 operations in 242955ns; attempting to update the 'registry'
*** Aborted at 1458757322 (unix time) try "date -d @1458757322" if you are using GNU date ***
PC: @ 0x0 (unknown)
*** SIGSEGV (@0x0) received by PID 2911 (TID 0x2aae22ede700) from PID 0; stack trace: ***
@ 0x2aae5179fff7 (unknown)
@ 0x2aae517a4159 (unknown)
@ 0x2aae18412340 (unknown)
make[4]: Leaving directory `/mesos/mesos-0.29.0/_build/src'
make[4]: *** [check-local] Segmentation fault
make[3]: Leaving directory `/mesos/mesos-0.29.0/_build/src'
make[3]: *** [check-am] Error 2
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-0.29.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-0.29.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1458753723-21898
Untagged: mesos-1458753723-21898:latest
Deleted: e3049ad3b9d88afdc3b688e2f74e1b05151aa4e846ba25ba3d677d9f628165e6
Deleted: b67583dd1f07732f340842af43a099c8ac87c2660f79cf276b507cf01ad3a43e
Deleted: 13c909d7ac3061a1c12ef40b72ad22613e32996fa725bcca92052cb33e12d03d
Deleted: 032e1c21bafb9558cf5743db9d6e236199ee99583239f7df6e2ab25f4f8e91ed
Deleted: 8d49c54e7b0354f46d1c6cff47f80d664a5b56a2c9e8676cd76c1f1350375b0d
Deleted: 078e225a6d08d8c03c197f5284bd454f60906307443279c819e20cdb81d9054f
Deleted: bdbe1f09c1ebbe76f0678d66e3b7256d3ba721b91e20e12e6a7b31f4f56cb957
Deleted: ac7376cad5116ce629f6cb12ff9f4d1f258796b038b5101a1ca45fa0e5dcab96
Deleted: 2160b030a0b4e990b7ae58df199112342bf35039f47f45b724c433ab2aabbae3
Deleted: 6d6b70047edbb680210fe7d35ce10c0cc027b231d5862d5922efdacb130fd97d
Deleted: e2087504d53a916f5bb7e901c8141b034aabd44c263b76eaeaa61fb362193869
Deleted: 97d6f9bd5fac802c7d552c779c7da2f0286aadc94742815e59cadb0b5ee23877
Deleted: aa0d32e2525e601363fc7ffe0f311211b52b76e67589a114bb0950cd9c7cc43e
Deleted: 95f14b8a1f7058019a4cae455539d95856218ad421c7681ae06f4dbc892f5f65
Deleted: 5da7b73096f2d56ceed66584891a252ea2aa60b7e761b7cf64d7096be2aa016a
Deleted: 661c127a1cac9f24fe13e892f5f36da29de283290837797f451bccfee3bfe8b0
Build step 'Execute shell' marked build as failure
Re: Build failed in Jenkins: Mesos » gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1) #1853
Posted by Greg Mann <gr...@mesosphere.io>.
Tracked by https://issues.apache.org/jira/browse/MESOS-4968
On Wed, Mar 23, 2016 at 11:22 AM, Apache Jenkins Server <
jenkins@builds.apache.org> wrote:
> See <
> https://builds.apache.org/job/Mesos/COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)/1853/changes
> >
>
> Changes:
>
> [yujie.jay] Replaced const ref to temporary in tests for consistency.
>
> ------------------------------------------
> [...truncated 120195 lines...]
> I0323 18:22:02.321001 2941 authenticator.cpp:325] Authentication requires
> more steps
> I0323 18:22:02.321097 2941 authenticatee.cpp:258] Received SASL
> authentication step
> I0323 18:22:02.321208 2941 authenticator.cpp:231] Received SASL
> authentication step
> I0323 18:22:02.321256 2941 auxprop.cpp:107] Request to lookup properties
> for user: 'test-principal' realm: 'c9c989a3c99d' server FQDN:
> 'c9c989a3c99d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
> I0323 18:22:02.321290 2941 auxprop.cpp:179] Looking up auxiliary property
> '*userPassword'
> I0323 18:22:02.321369 2941 auxprop.cpp:179] Looking up auxiliary property
> '*cmusaslsecretCRAM-MD5'
> I0323 18:22:02.321405 2941 auxprop.cpp:107] Request to lookup properties
> for user: 'test-principal' realm: 'c9c989a3c99d' server FQDN:
> 'c9c989a3c99d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
> I0323 18:22:02.321430 2941 auxprop.cpp:129] Skipping auxiliary property
> '*userPassword' since SASL_AUXPROP_AUTHZID == true
> I0323 18:22:02.321439 2941 auxprop.cpp:129] Skipping auxiliary property
> '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
> I0323 18:22:02.321475 2941 authenticator.cpp:317] Authentication success
> I0323 18:22:02.321689 2941 authenticatee.cpp:298] Authentication success
> I0323 18:22:02.321817 2941 master.cpp:5689] Successfully authenticated
> principal 'test-principal' at slave(295)@172.17.0.3:59269
> I0323 18:22:02.321943 2941 authenticator.cpp:431] Authentication session
> cleanup for crammd5_authenticatee(624)@172.17.0.3:59269
> I0323 18:22:02.322547 2940 slave.cpp:927] Successfully authenticated with
> master master@172.17.0.3:59269
> I0323 18:22:02.322731 2940 slave.cpp:1321] Will retry registration in
> 10.860756ms if necessary
> I0323 18:22:02.323083 2938 master.cpp:4370] Registering slave at
> slave(295)@172.17.0.3:59269 (c9c989a3c99d) with id
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S8
> I0323 18:22:02.323897 2911 sched.cpp:222] Version: 0.29.0
> I0323 18:22:02.324843 2940 slave.cpp:1321] Will retry registration in
> 152.623527ms if necessary
> I0323 18:22:02.325050 2940 master.cpp:4358] Ignoring register slave
> message from slave(288)@172.17.0.3:59269 (c9c989a3c99d) as admission is
> already in progress
> I0323 18:22:02.325500 2939 sched.cpp:326] New master detected at
> master@172.17.0.3:59269
> I0323 18:22:02.325587 2939 sched.cpp:382] Authenticating with master
> master@172.17.0.3:59269
> I0323 18:22:02.325608 2939 sched.cpp:389] Using default CRAM-MD5
> authenticatee
> I0323 18:22:02.325954 2939 authenticatee.cpp:121] Creating new client
> SASL connection
> I0323 18:22:02.326208 2932 slave.cpp:1321] Will retry registration in
> 17.300603ms if necessary
> I0323 18:22:02.326375 2937 master.cpp:4358] Ignoring register slave
> message from slave(293)@172.17.0.3:59269 (c9c989a3c99d) as admission is
> already in progress
> I0323 18:22:02.326489 2937 master.cpp:5659] Authenticating
> scheduler-7629439b-af3b-47e4-a43b-afae1a5699b2@172.17.0.3:59269
> I0323 18:22:02.326676 2937 authenticator.cpp:413] Starting authentication
> session for crammd5_authenticatee(625)@172.17.0.3:59269
> I0323 18:22:02.327014 2937 authenticator.cpp:98] Creating new server SASL
> connection
> I0323 18:22:02.327338 2937 authenticatee.cpp:212] Received SASL
> authentication mechanisms: CRAM-MD5
> I0323 18:22:02.327420 2937 authenticatee.cpp:238] Attempting to
> authenticate with mechanism 'CRAM-MD5'
> I0323 18:22:02.327566 2937 authenticator.cpp:203] Received SASL
> authentication start
> I0323 18:22:02.327708 2937 authenticator.cpp:325] Authentication requires
> more steps
> I0323 18:22:02.327853 2937 authenticatee.cpp:258] Received SASL
> authentication step
> I0323 18:22:02.327999 2937 authenticator.cpp:231] Received SASL
> authentication step
> I0323 18:22:02.328083 2937 auxprop.cpp:107] Request to lookup properties
> for user: 'test-principal' realm: 'c9c989a3c99d' server FQDN:
> 'c9c989a3c99d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
> I0323 18:22:02.328150 2937 auxprop.cpp:179] Looking up auxiliary property
> '*userPassword'
> I0323 18:22:02.328264 2937 auxprop.cpp:179] Looking up auxiliary property
> '*cmusaslsecretCRAM-MD5'
> I0323 18:22:02.328384 2937 auxprop.cpp:107] Request to lookup properties
> for user: 'test-principal' realm: 'c9c989a3c99d' server FQDN:
> 'c9c989a3c99d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
> I0323 18:22:02.328449 2937 auxprop.cpp:129] Skipping auxiliary property
> '*userPassword' since SASL_AUXPROP_AUTHZID == true
> I0323 18:22:02.328505 2937 auxprop.cpp:129] Skipping auxiliary property
> '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
> I0323 18:22:02.328569 2937 authenticator.cpp:317] Authentication success
> I0323 18:22:02.328807 2937 authenticatee.cpp:298] Authentication success
> I0323 18:22:02.328968 2937 master.cpp:5689] Successfully authenticated
> principal 'test-principal' at
> scheduler-7629439b-af3b-47e4-a43b-afae1a5699b2@172.17.0.3:59269
> I0323 18:22:02.329123 2937 authenticator.cpp:431] Authentication session
> cleanup for crammd5_authenticatee(625)@172.17.0.3:59269
> I0323 18:22:02.329478 2935 slave.cpp:324] Slave using credential for:
> test-principal
> I0323 18:22:02.330436 2933 sched.cpp:471] Successfully authenticated with
> master master@172.17.0.3:59269
> I0323 18:22:02.330487 2933 sched.cpp:776] Sending SUBSCRIBE call to
> master@172.17.0.3:59269
> I0323 18:22:02.330637 2933 sched.cpp:809] Will retry registration in
> 1.930018557secs if necessary
> I0323 18:22:02.330888 2933 master.cpp:2326] Received SUBSCRIBE call for
> framework 'default' at
> scheduler-7629439b-af3b-47e4-a43b-afae1a5699b2@172.17.0.3:59269
> I0323 18:22:02.330965 2933 master.cpp:1845] Authorizing framework
> principal 'test-principal' to receive offers for role '*'
> I0323 18:22:02.331403 2935 resources.cpp:572] Parsing resources as JSON
> failed: cpus:2;mem:1024
> Trying semicolon-delimited string format instead
> I0323 18:22:02.331960 2935 slave.cpp:464] Slave resources: cpus(*):2;
> mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000]
> I0323 18:22:02.332046 2935 slave.cpp:472] Slave attributes: [ ]
> I0323 18:22:02.332059 2935 slave.cpp:477] Slave hostname: c9c989a3c99d
> I0323 18:22:02.333451 2933 master.cpp:2397] Subscribing framework default
> with checkpointing disabled and capabilities [ ]
> I0323 18:22:02.334079 2944 hierarchical.cpp:265] Added framework
> 78e433a4-15ef-41bf-9735-db9ac65c9190-0000
> I0323 18:22:02.334157 2933 sched.cpp:703] Framework registered with
> 78e433a4-15ef-41bf-9735-db9ac65c9190-0000
> I0323 18:22:02.334203 2933 sched.cpp:717] Scheduler::registered took
> 23096ns
> I0323 18:22:02.334422 2933 state.cpp:58] Recovering state from
> '/tmp/ResourceOffersTest_ResourceOfferWithMultipleSlaves_fPQONo/meta'
> I0323 18:22:02.334805 2932 slave.cpp:1321] Will retry registration in
> 107.619697ms if necessary
> I0323 18:22:02.335036 2932 master.cpp:4358] Ignoring register slave
> message from slave(292)@172.17.0.3:59269 (c9c989a3c99d) as admission is
> already in progress
> I0323 18:22:02.335253 2935 status_update_manager.cpp:200] Recovering
> status update manager
> I0323 18:22:02.335444 2935 containerizer.cpp:407] Recovering containerizer
> I0323 18:22:02.335700 2944 hierarchical.cpp:1561] No inverse offers to
> send out!
> I0323 18:22:02.335871 2944 hierarchical.cpp:1138] Performed allocation
> for 1 slaves in 1.72458ms
> I0323 18:22:02.336242 2938 slave.cpp:1321] Will retry registration in
> 15.340089ms if necessary
> I0323 18:22:02.336724 2944 master.cpp:5488] Sending 1 offers to framework
> 78e433a4-15ef-41bf-9735-db9ac65c9190-0000 (default) at
> scheduler-7629439b-af3b-47e4-a43b-afae1a5699b2@172.17.0.3:59269
> I0323 18:22:02.337308 2933 provisioner.cpp:245] Provisioner recovery
> complete
> I0323 18:22:02.337643 2939 slave.cpp:4565] Finished recovery
> I0323 18:22:02.337664 2934 leveldb.cpp:341] Persisting action (692 bytes)
> to leveldb took 28.61693ms
> I0323 18:22:02.337704 2934 replica.cpp:712] Persisted action at 5
> I0323 18:22:02.337736 2934 replica.cpp:697] Replica learned APPEND action
> at position 5
> I0323 18:22:02.338238 2939 slave.cpp:4737] Querying resource estimator
> for oversubscribable resources
> I0323 18:22:02.338699 2935 slave.cpp:796] New master detected at
> master@172.17.0.3:59269
> I0323 18:22:02.338862 2935 slave.cpp:859] Authenticating with master
> master@172.17.0.3:59269
> I0323 18:22:02.338888 2935 slave.cpp:864] Using default CRAM-MD5
> authenticatee
> I0323 18:22:02.339105 2935 slave.cpp:832] Detecting new master
> I0323 18:22:02.339292 2931 status_update_manager.cpp:174] Pausing sending
> status updates
> I0323 18:22:02.339376 2935 slave.cpp:4751] Received oversubscribable
> resources from the resource estimator
> I0323 18:22:02.339397 2938 authenticatee.cpp:121] Creating new client
> SASL connection
> I0323 18:22:02.339838 2944 master.cpp:4358] Ignoring register slave
> message from slave(295)@172.17.0.3:59269 (c9c989a3c99d) as admission is
> already in progress
> I0323 18:22:02.340003 2941 sched.cpp:873] Scheduler::resourceOffers took
> 136422ns
> I0323 18:22:02.341003 2944 master.cpp:5659] Authenticating slave(296)@
> 172.17.0.3:59269
> I0323 18:22:02.341881 2945 registrar.cpp:484] Successfully updated the
> 'registry' in 148.944896ms
> I0323 18:22:02.343127 2945 registrar.cpp:439] Applied 6 operations in
> 258216ns; attempting to update the 'registry'
> I0323 18:22:02.342274 2931 log.cpp:702] Attempting to truncate the log to
> 5
> I0323 18:22:02.344744 2933 coordinator.cpp:348] Coordinator attempting to
> write TRUNCATE action at position 6
> I0323 18:22:02.344897 2931 slave.cpp:1321] Will retry registration in
> 132.470313ms if necessary
> I0323 18:22:02.346803 2934 authenticator.cpp:413] Starting authentication
> session for crammd5_authenticatee(626)@172.17.0.3:59269
> I0323 18:22:02.342110 2911 sched.cpp:1903] Asked to stop the driver
> I0323 18:22:02.347434 2930 sched.cpp:1143] Stopping framework
> '78e433a4-15ef-41bf-9735-db9ac65c9190-0000'
> I0323 18:22:02.347818 2940 slave.cpp:3482] Received ping from
> slave-observer(277)@172.17.0.3:59269
> I0323 18:22:02.348107 2935 replica.cpp:537] Replica received write
> request for position 6 from (9666)@172.17.0.3:59269
> I0323 18:22:02.348186 2930 hierarchical.cpp:473] Added slave
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S1 (c9c989a3c99d) with cpus(*):2;
> mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000] (allocated: )
> I0323 18:22:02.348345 2940 slave.cpp:971] Registered with master
> master@172.17.0.3:59269; given slave ID
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S1
> I0323 18:22:02.348369 2940 fetcher.cpp:81] Clearing fetcher cache
> I0323 18:22:02.348534 2938 status_update_manager.cpp:181] Resuming
> sending status updates
> I0323 18:22:02.348783 2936 slave.cpp:1321] Will retry registration in
> 145.606098ms if necessary
> I0323 18:22:02.348793 2940 slave.cpp:994] Checkpointing SlaveInfo to
> '/tmp/ResourceOffersTest_ResourceOfferWithMultipleSlaves_F1JoHQ/meta/slaves/78e433a4-15ef-41bf-9735-db9ac65c9190-S1/
> slave.info'
> I0323 18:22:02.348938 2934 authenticator.cpp:98] Creating new server SASL
> connection
> I0323 18:22:02.349206 2930 hierarchical.cpp:1561] No inverse offers to
> send out!
> I0323 18:22:02.349258 2940 slave.cpp:1030] Forwarding total
> oversubscribed resources
> I0323 18:22:02.349330 2930 hierarchical.cpp:1161] Performed allocation
> for slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S1 in 1.084466ms
> I0323 18:22:02.349436 2934 authenticatee.cpp:212] Received SASL
> authentication mechanisms: CRAM-MD5
> I0323 18:22:02.349542 2934 authenticatee.cpp:238] Attempting to
> authenticate with mechanism 'CRAM-MD5'
> I0323 18:22:02.349750 2932 authenticator.cpp:203] Received SASL
> authentication start
> I0323 18:22:02.349822 2932 authenticator.cpp:325] Authentication requires
> more steps
> I0323 18:22:02.349928 2932 authenticatee.cpp:258] Received SASL
> authentication step
> I0323 18:22:02.350030 2932 authenticator.cpp:231] Received SASL
> authentication step
> I0323 18:22:02.350066 2932 auxprop.cpp:107] Request to lookup properties
> for user: 'test-principal' realm: 'c9c989a3c99d' server FQDN:
> 'c9c989a3c99d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
> I0323 18:22:02.350080 2932 auxprop.cpp:179] Looking up auxiliary property
> '*userPassword'
> I0323 18:22:02.350132 2932 auxprop.cpp:179] Looking up auxiliary property
> '*cmusaslsecretCRAM-MD5'
> I0323 18:22:02.350175 2932 auxprop.cpp:107] Request to lookup properties
> for user: 'test-principal' realm: 'c9c989a3c99d' server FQDN:
> 'c9c989a3c99d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
> I0323 18:22:02.350191 2932 auxprop.cpp:129] Skipping auxiliary property
> '*userPassword' since SASL_AUXPROP_AUTHZID == true
> I0323 18:22:02.350200 2932 auxprop.cpp:129] Skipping auxiliary property
> '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
> I0323 18:22:02.348278 2944 master.cpp:4438] Registered slave
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S1 at slave(288)@172.17.0.3:59269
> (c9c989a3c99d) with cpus(*):2; mem(*):1024; disk(*):3.70122e+06;
> ports(*):[31000-32000]
> I0323 18:22:02.350230 2932 authenticator.cpp:317] Authentication success
> I0323 18:22:02.350435 2937 authenticatee.cpp:298] Authentication success
> I0323 18:22:02.350638 2932 authenticator.cpp:431] Authentication session
> cleanup for crammd5_authenticatee(626)@172.17.0.3:59269
> I0323 18:22:02.351112 2937 slave.cpp:927] Successfully authenticated with
> master master@172.17.0.3:59269
> I0323 18:22:02.351306 2937 slave.cpp:1321] Will retry registration in
> 13.006559ms if necessary
> I0323 18:22:02.352216 2941 slave.cpp:3482] Received ping from
> slave-observer(278)@172.17.0.3:59269
> I0323 18:22:02.352587 2934 slave.cpp:1321] Will retry registration in
> 58.254346ms if necessary
> I0323 18:22:02.352784 2943 slave.cpp:971] Registered with master
> master@172.17.0.3:59269; given slave ID
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S2
> I0323 18:22:02.352813 2943 fetcher.cpp:81] Clearing fetcher cache
> I0323 18:22:02.352951 2931 hierarchical.cpp:473] Added slave
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S2 (c9c989a3c99d) with cpus(*):2;
> mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000] (allocated: )
> I0323 18:22:02.359412 2944 master.cpp:4438] Registered slave
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S2 at slave(289)@172.17.0.3:59269
> (c9c989a3c99d) with cpus(*):2; mem(*):1024; disk(*):3.70122e+06;
> ports(*):[31000-32000]
> I0323 18:22:02.359962 2944 master.cpp:4358] Ignoring register slave
> message from slave(293)@172.17.0.3:59269 (c9c989a3c99d) as admission is
> already in progress
> I0323 18:22:02.360174 2944 master.cpp:6061] Processing TEARDOWN call for
> framework 78e433a4-15ef-41bf-9735-db9ac65c9190-0000 (default) at
> scheduler-7629439b-af3b-47e4-a43b-afae1a5699b2@172.17.0.3:59269
> I0323 18:22:02.360249 2944 master.cpp:6073] Removing framework
> 78e433a4-15ef-41bf-9735-db9ac65c9190-0000 (default) at
> scheduler-7629439b-af3b-47e4-a43b-afae1a5699b2@172.17.0.3:59269
> I0323 18:22:02.360405 2931 hierarchical.cpp:1561] No inverse offers to
> send out!
> I0323 18:22:02.360525 2934 status_update_manager.cpp:181] Resuming
> sending status updates
> I0323 18:22:02.360540 2931 hierarchical.cpp:1161] Performed allocation
> for slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S2 in 7.546805ms
> I0323 18:22:02.361374 2932 slave.cpp:2079] Asked to shut down framework
> 78e433a4-15ef-41bf-9735-db9ac65c9190-0000 by master@172.17.0.3:59269
> W0323 18:22:02.361414 2932 slave.cpp:2094] Cannot shut down unknown
> framework 78e433a4-15ef-41bf-9735-db9ac65c9190-0000
> I0323 18:22:02.361508 2941 hierarchical.cpp:375] Deactivated framework
> 78e433a4-15ef-41bf-9735-db9ac65c9190-0000
> I0323 18:22:02.362126 2941 hierarchical.cpp:890] Recovered cpus(*):2;
> mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000] (total: cpus(*):2;
> mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000], allocated: ) on
> slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S0 from framework
> 78e433a4-15ef-41bf-9735-db9ac65c9190-0000
> I0323 18:22:02.362301 2938 slave.cpp:2079] Asked to shut down framework
> 78e433a4-15ef-41bf-9735-db9ac65c9190-0000 by master@172.17.0.3:59269
> W0323 18:22:02.362336 2938 slave.cpp:2094] Cannot shut down unknown
> framework 78e433a4-15ef-41bf-9735-db9ac65c9190-0000
> I0323 18:22:02.362913 2944 master.cpp:4358] Ignoring register slave
> message from slave(294)@172.17.0.3:59269 (c9c989a3c99d) as admission is
> already in progress
> I0323 18:22:02.363051 2941 hierarchical.cpp:326] Removed framework
> 78e433a4-15ef-41bf-9735-db9ac65c9190-0000
> W0323 18:22:02.363284 2944 master.cpp:5353] Master returning resources
> offered to framework 78e433a4-15ef-41bf-9735-db9ac65c9190-0000 because the
> framework has terminated or is inactive
> I0323 18:22:02.364215 2944 master.cpp:4782] Received update of slave
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S1 at slave(288)@172.17.0.3:59269
> (c9c989a3c99d) with total oversubscribed resources
> I0323 18:22:02.364470 2944 master.cpp:5689] Successfully authenticated
> principal 'test-principal' at slave(296)@172.17.0.3:59269
> I0323 18:22:02.364711 2944 master.cpp:4370] Registering slave at
> slave(296)@172.17.0.3:59269 (c9c989a3c99d) with id
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S9
> I0323 18:22:02.365250 2944 master.cpp:4358] Ignoring register slave
> message from slave(295)@172.17.0.3:59269 (c9c989a3c99d) as admission is
> already in progress
> W0323 18:22:02.365373 2944 master.cpp:5353] Master returning resources
> offered to framework 78e433a4-15ef-41bf-9735-db9ac65c9190-0000 because the
> framework has terminated or is inactive
> I0323 18:22:02.365573 2939 hierarchical.cpp:890] Recovered cpus(*):2;
> mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000] (total: cpus(*):2;
> mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000], allocated: ) on
> slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S1 from framework
> 78e433a4-15ef-41bf-9735-db9ac65c9190-0000
> I0323 18:22:02.365900 2944 slave.cpp:1321] Will retry registration in
> 30.343785ms if necessary
> I0323 18:22:02.366039 2939 hierarchical.cpp:531] Slave
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S1 (c9c989a3c99d) updated with
> oversubscribed resources (total: cpus(*):2; mem(*):1024;
> disk(*):3.70122e+06; ports(*):[31000-32000], allocated: )
> I0323 18:22:02.366278 2944 master.cpp:4358] Ignoring register slave
> message from slave(296)@172.17.0.3:59269 (c9c989a3c99d) as admission is
> already in progress
> I0323 18:22:02.366323 2939 hierarchical.cpp:1466] No resources available
> to allocate!
> I0323 18:22:02.366400 2939 hierarchical.cpp:1161] Performed allocation
> for slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S1 in 316804ns
> I0323 18:22:02.366456 2943 slave.cpp:994] Checkpointing SlaveInfo to
> '/tmp/ResourceOffersTest_ResourceOfferWithMultipleSlaves_cESGar/meta/slaves/78e433a4-15ef-41bf-9735-db9ac65c9190-S2/
> slave.info'
> I0323 18:22:02.366614 2939 hierarchical.cpp:890] Recovered cpus(*):2;
> mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000] (total: cpus(*):2;
> mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000], allocated: ) on
> slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S2 from framework
> 78e433a4-15ef-41bf-9735-db9ac65c9190-0000
> I0323 18:22:02.366919 2943 slave.cpp:1030] Forwarding total
> oversubscribed resources
> I0323 18:22:02.367105 2943 slave.cpp:2079] Asked to shut down framework
> 78e433a4-15ef-41bf-9735-db9ac65c9190-0000 by master@172.17.0.3:59269
> W0323 18:22:02.367137 2943 slave.cpp:2094] Cannot shut down unknown
> framework 78e433a4-15ef-41bf-9735-db9ac65c9190-0000
> I0323 18:22:02.367173 2911 slave.cpp:668] Slave terminating
> I0323 18:22:02.367184 2930 master.cpp:4782] Received update of slave
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S2 at slave(289)@172.17.0.3:59269
> (c9c989a3c99d) with total oversubscribed resources
> I0323 18:22:02.370318 2930 master.cpp:1212] Slave
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S0 at slave(287)@172.17.0.3:59269
> (c9c989a3c99d) disconnected
> I0323 18:22:02.370378 2930 master.cpp:2681] Disconnecting slave
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S0 at slave(287)@172.17.0.3:59269
> (c9c989a3c99d)
> I0323 18:22:02.370455 2941 hierarchical.cpp:531] Slave
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S2 (c9c989a3c99d) updated with
> oversubscribed resources (total: cpus(*):2; mem(*):1024;
> disk(*):3.70122e+06; ports(*):[31000-32000], allocated: )
> I0323 18:22:02.370455 2930 master.cpp:2700] Deactivating slave
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S0 at slave(287)@172.17.0.3:59269
> (c9c989a3c99d)
> I0323 18:22:02.370674 2941 hierarchical.cpp:1466] No resources available
> to allocate!
> I0323 18:22:02.370754 2941 hierarchical.cpp:1161] Performed allocation
> for slave 78e433a4-15ef-41bf-9735-db9ac65c9190-S2 in 241368ns
> I0323 18:22:02.370811 2941 hierarchical.cpp:560] Slave
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S0 deactivated
> I0323 18:22:02.374295 2935 leveldb.cpp:341] Persisting action (16 bytes)
> to leveldb took 26.136791ms
> I0323 18:22:02.374368 2935 replica.cpp:712] Persisted action at 6
> I0323 18:22:02.375668 2935 replica.cpp:691] Replica received learned
> notice for position 6 from @0.0.0.0:0
> I0323 18:22:02.376976 2937 slave.cpp:1321] Will retry registration in
> 221.425497ms if necessary
> I0323 18:22:02.377257 2937 master.cpp:4358] Ignoring register slave
> message from slave(290)@172.17.0.3:59269 (c9c989a3c99d) as admission is
> already in progress
> I0323 18:22:02.380519 2911 slave.cpp:668] Slave terminating
> I0323 18:22:02.381369 2938 master.cpp:1212] Slave
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S1 at slave(288)@172.17.0.3:59269
> (c9c989a3c99d) disconnected
> I0323 18:22:02.381405 2938 master.cpp:2681] Disconnecting slave
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S1 at slave(288)@172.17.0.3:59269
> (c9c989a3c99d)
> I0323 18:22:02.381459 2938 master.cpp:2700] Deactivating slave
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S1 at slave(288)@172.17.0.3:59269
> (c9c989a3c99d)
> I0323 18:22:02.382899 2938 hierarchical.cpp:560] Slave
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S1 deactivated
> I0323 18:22:02.391275 2943 slave.cpp:668] Slave terminating
> I0323 18:22:02.391595 2943 master.cpp:1212] Slave
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S2 at slave(289)@172.17.0.3:59269
> (c9c989a3c99d) disconnected
> I0323 18:22:02.391628 2943 master.cpp:2681] Disconnecting slave
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S2 at slave(289)@172.17.0.3:59269
> (c9c989a3c99d)
> I0323 18:22:02.391681 2943 master.cpp:2700] Deactivating slave
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S2 at slave(289)@172.17.0.3:59269
> (c9c989a3c99d)
> I0323 18:22:02.391851 2943 hierarchical.cpp:560] Slave
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S2 deactivated
> I0323 18:22:02.397086 2934 slave.cpp:668] Slave terminating
> I0323 18:22:02.397230 2930 slave.cpp:1321] Will retry registration in
> 7.833284ms if necessary
> I0323 18:22:02.397588 2939 master.cpp:4358] Ignoring register slave
> message from slave(296)@172.17.0.3:59269 (c9c989a3c99d) as admission is
> already in progress
> I0323 18:22:02.403197 2911 slave.cpp:668] Slave terminating
> I0323 18:22:02.406466 2942 slave.cpp:1321] Will retry registration in
> 125.892495ms if necessary
> I0323 18:22:02.406788 2942 master.cpp:4358] Ignoring register slave
> message from slave(296)@172.17.0.3:59269 (c9c989a3c99d) as admission is
> already in progress
> I0323 18:22:02.408346 2935 leveldb.cpp:341] Persisting action (18 bytes)
> to leveldb took 32.639158ms
> I0323 18:22:02.408462 2935 leveldb.cpp:399] Deleting ~2 keys from leveldb
> took 70787ns
> I0323 18:22:02.408490 2935 replica.cpp:712] Persisted action at 6
> I0323 18:22:02.408524 2935 replica.cpp:697] Replica learned TRUNCATE
> action at position 6
> I0323 18:22:02.410260 2934 log.cpp:683] Attempting to append 1667 bytes
> to the log
> I0323 18:22:02.411176 2935 coordinator.cpp:348] Coordinator attempting to
> write APPEND action at position 7
> I0323 18:22:02.414021 2936 replica.cpp:537] Replica received write
> request for position 7 from (9667)@172.17.0.3:59269
> I0323 18:22:02.415431 2911 slave.cpp:668] Slave terminating
> I0323 18:22:02.415554 2939 slave.cpp:1321] Will retry registration in
> 97.680337ms if necessary
> I0323 18:22:02.415791 2939 master.cpp:4358] Ignoring register slave
> message from slave(295)@172.17.0.3:59269 (c9c989a3c99d) as admission is
> already in progress
> I0323 18:22:02.424763 2911 slave.cpp:668] Slave terminating
> I0323 18:22:02.448796 2936 leveldb.cpp:341] Persisting action (1686
> bytes) to leveldb took 34.705697ms
> I0323 18:22:02.448873 2936 replica.cpp:712] Persisted action at 7
> I0323 18:22:02.449777 2938 replica.cpp:691] Replica received learned
> notice for position 7 from @0.0.0.0:0
> I0323 18:22:02.454486 2945 slave.cpp:668] Slave terminating
> I0323 18:22:02.462158 2911 slave.cpp:668] Slave terminating
> I0323 18:22:02.467150 2911 slave.cpp:668] Slave terminating
> I0323 18:22:02.477807 2911 master.cpp:1065] Master terminating
> I0323 18:22:02.478652 2937 hierarchical.cpp:505] Removed slave
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S2
> I0323 18:22:02.478966 2937 hierarchical.cpp:505] Removed slave
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S1
> I0323 18:22:02.479739 2944 hierarchical.cpp:505] Removed slave
> 78e433a4-15ef-41bf-9735-db9ac65c9190-S0
> I0323 18:22:02.480309 2938 leveldb.cpp:341] Persisting action (1688
> bytes) to leveldb took 30.498549ms
> I0323 18:22:02.480361 2938 replica.cpp:712] Persisted action at 7
> I0323 18:22:02.480394 2938 replica.cpp:697] Replica learned APPEND action
> at position 7
> I0323 18:22:02.485790 2944 registrar.cpp:484] Successfully updated the
> 'registry' in 142.418944ms
> I0323 18:22:02.487464 2944 registrar.cpp:439] Applied 1 operations in
> 242955ns; attempting to update the 'registry'
> *** Aborted at 1458757322 (unix time) try "date -d @1458757322" if you are
> using GNU date ***
> PC: @ 0x0 (unknown)
> *** SIGSEGV (@0x0) received by PID 2911 (TID 0x2aae22ede700) from PID 0;
> stack trace: ***
> @ 0x2aae5179fff7 (unknown)
> @ 0x2aae517a4159 (unknown)
> @ 0x2aae18412340 (unknown)
> make[4]: Leaving directory `/mesos/mesos-0.29.0/_build/src'
> make[4]: *** [check-local] Segmentation fault
> make[3]: Leaving directory `/mesos/mesos-0.29.0/_build/src'
> make[3]: *** [check-am] Error 2
> make[2]: *** [check] Error 2
> make[2]: Leaving directory `/mesos/mesos-0.29.0/_build/src'
> make[1]: *** [check-recursive] Error 1
> make[1]: Leaving directory `/mesos/mesos-0.29.0/_build'
> make: *** [distcheck] Error 1
> + docker rmi mesos-1458753723-21898
> Untagged: mesos-1458753723-21898:latest
> Deleted: e3049ad3b9d88afdc3b688e2f74e1b05151aa4e846ba25ba3d677d9f628165e6
> Deleted: b67583dd1f07732f340842af43a099c8ac87c2660f79cf276b507cf01ad3a43e
> Deleted: 13c909d7ac3061a1c12ef40b72ad22613e32996fa725bcca92052cb33e12d03d
> Deleted: 032e1c21bafb9558cf5743db9d6e236199ee99583239f7df6e2ab25f4f8e91ed
> Deleted: 8d49c54e7b0354f46d1c6cff47f80d664a5b56a2c9e8676cd76c1f1350375b0d
> Deleted: 078e225a6d08d8c03c197f5284bd454f60906307443279c819e20cdb81d9054f
> Deleted: bdbe1f09c1ebbe76f0678d66e3b7256d3ba721b91e20e12e6a7b31f4f56cb957
> Deleted: ac7376cad5116ce629f6cb12ff9f4d1f258796b038b5101a1ca45fa0e5dcab96
> Deleted: 2160b030a0b4e990b7ae58df199112342bf35039f47f45b724c433ab2aabbae3
> Deleted: 6d6b70047edbb680210fe7d35ce10c0cc027b231d5862d5922efdacb130fd97d
> Deleted: e2087504d53a916f5bb7e901c8141b034aabd44c263b76eaeaa61fb362193869
> Deleted: 97d6f9bd5fac802c7d552c779c7da2f0286aadc94742815e59cadb0b5ee23877
> Deleted: aa0d32e2525e601363fc7ffe0f311211b52b76e67589a114bb0950cd9c7cc43e
> Deleted: 95f14b8a1f7058019a4cae455539d95856218ad421c7681ae06f4dbc892f5f65
> Deleted: 5da7b73096f2d56ceed66584891a252ea2aa60b7e761b7cf64d7096be2aa016a
> Deleted: 661c127a1cac9f24fe13e892f5f36da29de283290837797f451bccfee3bfe8b0
> Build step 'Execute shell' marked build as failure
>
Jenkins build is back to normal : Mesos » gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1) #1854
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos/COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)/1854/changes>