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:02:01 UTC
Build failed in Jenkins: Mesos » clang,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1) #1853
See <https://builds.apache.org/job/Mesos/COMPILER=clang,CONFIGURATION=--verbose,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 120264 lines...]
I0323 17:54:07.224808 32320 auxprop.cpp:179] Looking up auxiliary property '*userPassword'
I0323 17:54:07.224860 32320 auxprop.cpp:179] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0323 17:54:07.224885 32320 auxprop.cpp:107] Request to lookup properties for user: 'test-principal' realm: 'd43c35ea1983' server FQDN: 'd43c35ea1983' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0323 17:54:07.224897 32320 auxprop.cpp:129] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0323 17:54:07.224905 32320 auxprop.cpp:129] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0323 17:54:07.224923 32320 authenticator.cpp:317] Authentication success
I0323 17:54:07.225018 32319 slave.cpp:1321] Will retry registration in 10.569866ms if necessary
I0323 17:54:07.225036 32312 authenticatee.cpp:298] Authentication success
I0323 17:54:07.225074 32320 master.cpp:5689] Successfully authenticated principal 'test-principal' at slave(294)@172.17.0.2:51707
I0323 17:54:07.225102 32319 authenticator.cpp:431] Authentication session cleanup for crammd5_authenticatee(625)@172.17.0.2:51707
I0323 17:54:07.225230 32320 master.cpp:4358] Ignoring register slave message from slave(292)@172.17.0.2:51707 (d43c35ea1983) as admission is already in progress
I0323 17:54:07.225420 32312 slave.cpp:927] Successfully authenticated with master master@172.17.0.2:51707
I0323 17:54:07.225528 32312 slave.cpp:1321] Will retry registration in 7.218563ms if necessary
I0323 17:54:07.225674 32317 master.cpp:4370] Registering slave at slave(294)@172.17.0.2:51707 (d43c35ea1983) with id 2ce2ad01-b334-4c59-a806-3a292497a589-S7
I0323 17:54:07.234006 32317 slave.cpp:1321] Will retry registration in 23.521448ms if necessary
I0323 17:54:07.234287 32312 master.cpp:4358] Ignoring register slave message from slave(293)@172.17.0.2:51707 (d43c35ea1983) as admission is already in progress
I0323 17:54:07.235854 32320 slave.cpp:1321] Will retry registration in 20.546645ms if necessary
I0323 17:54:07.236071 32320 master.cpp:4358] Ignoring register slave message from slave(294)@172.17.0.2:51707 (d43c35ea1983) as admission is already in progress
I0323 17:54:07.236935 32320 slave.cpp:1321] Will retry registration in 30.502541ms if necessary
I0323 17:54:07.237125 32320 master.cpp:4358] Ignoring register slave message from slave(292)@172.17.0.2:51707 (d43c35ea1983) as admission is already in progress
I0323 17:54:07.248242 32309 slave.cpp:324] Slave using credential for: test-principal
I0323 17:54:07.248534 32309 resources.cpp:572] Parsing resources as JSON failed: cpus:2;mem:1024
Trying semicolon-delimited string format instead
I0323 17:54:07.249102 32309 slave.cpp:464] Slave resources: cpus(*):2; mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000]
I0323 17:54:07.249184 32309 slave.cpp:472] Slave attributes: [ ]
I0323 17:54:07.249199 32309 slave.cpp:477] Slave hostname: d43c35ea1983
I0323 17:54:07.250300 32287 containerizer.cpp:149] Using isolation: posix/cpu,posix/mem,filesystem/posix
I0323 17:54:07.251621 32309 state.cpp:58] Recovering state from '/tmp/ResourceOffersTest_ResourceOfferWithMultipleSlaves_fUnJZL/meta'
I0323 17:54:07.252082 32308 status_update_manager.cpp:200] Recovering status update manager
W0323 17:54:07.252089 32287 backend.cpp:66] Failed to create 'bind' backend: BindBackend requires root privileges
I0323 17:54:07.252389 32308 containerizer.cpp:407] Recovering containerizer
I0323 17:54:07.253458 32317 slave.cpp:1321] Will retry registration in 316.784222ms if necessary
I0323 17:54:07.253851 32317 master.cpp:4358] Ignoring register slave message from slave(289)@172.17.0.2:51707 (d43c35ea1983) as admission is already in progress
I0323 17:54:07.256048 32310 slave.cpp:193] Slave started on 296)@172.17.0.2:51707
I0323 17:54:07.256321 32308 provisioner.cpp:245] Provisioner recovery complete
I0323 17:54:07.256091 32310 slave.cpp:194] Flags at startup: --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticatee="crammd5" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/ResourceOffersTest_ResourceOfferWithMultipleSlaves_Nk94YC/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/ResourceOffersTest_ResourceOfferWithMultipleSlaves_Nk94YC/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher_dir="/mesos/mesos-0.29.0/_build/src" --logbufsecs="0" --logging_level="INFO" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;mem:1024" --revocable_cpu_low_priority="true" --sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true" --systemd_enable_support="true" --systemd_runtime_directory="/run/systemd/system" --version="false" --work_dir="/tmp/ResourceOffersTest_ResourceOfferWithMultipleSlaves_Nk94YC"
I0323 17:54:07.256669 32310 credentials.hpp:83] Loading credential for authentication from '/tmp/ResourceOffersTest_ResourceOfferWithMultipleSlaves_Nk94YC/credential'
I0323 17:54:07.256759 32311 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 51.099538ms
I0323 17:54:07.256795 32319 slave.cpp:4565] Finished recovery
I0323 17:54:07.256803 32311 replica.cpp:712] Persisted action at 4
I0323 17:54:07.256906 32310 slave.cpp:324] Slave using credential for: test-principal
I0323 17:54:07.257072 32310 resources.cpp:572] Parsing resources as JSON failed: cpus:2;mem:1024
Trying semicolon-delimited string format instead
I0323 17:54:07.257335 32319 slave.cpp:4737] Querying resource estimator for oversubscribable resources
I0323 17:54:07.257581 32310 slave.cpp:464] Slave resources: cpus(*):2; mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000]
I0323 17:54:07.257661 32310 slave.cpp:472] Slave attributes: [ ]
I0323 17:54:07.257676 32310 slave.cpp:477] Slave hostname: d43c35ea1983
I0323 17:54:07.258199 32319 slave.cpp:796] New master detected at master@172.17.0.2:51707
I0323 17:54:07.258275 32319 slave.cpp:859] Authenticating with master master@172.17.0.2:51707
I0323 17:54:07.258296 32319 slave.cpp:864] Using default CRAM-MD5 authenticatee
I0323 17:54:07.258429 32319 slave.cpp:832] Detecting new master
I0323 17:54:07.258584 32287 sched.cpp:222] Version: 0.29.0
I0323 17:54:07.258666 32309 status_update_manager.cpp:174] Pausing sending status updates
I0323 17:54:07.258780 32320 authenticatee.cpp:121] Creating new client SASL connection
I0323 17:54:07.259131 32316 slave.cpp:1321] Will retry registration in 62.664778ms if necessary
I0323 17:54:07.259268 32312 slave.cpp:1321] Will retry registration in 50.032152ms if necessary
I0323 17:54:07.259289 32317 master.cpp:5659] Authenticating slave(295)@172.17.0.2:51707
I0323 17:54:07.259441 32314 authenticator.cpp:413] Starting authentication session for crammd5_authenticatee(626)@172.17.0.2:51707
I0323 17:54:07.259590 32317 master.cpp:4358] Ignoring register slave message from slave(293)@172.17.0.2:51707 (d43c35ea1983) as admission is already in progress
I0323 17:54:07.259748 32317 master.cpp:4358] Ignoring register slave message from slave(294)@172.17.0.2:51707 (d43c35ea1983) as admission is already in progress
I0323 17:54:07.259757 32316 state.cpp:58] Recovering state from '/tmp/ResourceOffersTest_ResourceOfferWithMultipleSlaves_Nk94YC/meta'
I0323 17:54:07.259830 32318 authenticator.cpp:98] Creating new server SASL connection
I0323 17:54:07.259879 32312 slave.cpp:4751] Received oversubscribable resources from the resource estimator
I0323 17:54:07.260010 32320 replica.cpp:691] Replica received learned notice for position 4 from @0.0.0.0:0
I0323 17:54:07.260033 32317 authenticatee.cpp:212] Received SASL authentication mechanisms: CRAM-MD5
I0323 17:54:07.260066 32317 authenticatee.cpp:238] Attempting to authenticate with mechanism 'CRAM-MD5'
I0323 17:54:07.260156 32317 authenticator.cpp:203] Received SASL authentication start
I0323 17:54:07.260212 32306 status_update_manager.cpp:200] Recovering status update manager
I0323 17:54:07.260227 32317 authenticator.cpp:325] Authentication requires more steps
I0323 17:54:07.260313 32317 authenticatee.cpp:258] Received SASL authentication step
I0323 17:54:07.260402 32317 containerizer.cpp:407] Recovering containerizer
I0323 17:54:07.261147 32311 sched.cpp:326] New master detected at master@172.17.0.2:51707
I0323 17:54:07.261231 32311 sched.cpp:382] Authenticating with master master@172.17.0.2:51707
I0323 17:54:07.261255 32311 sched.cpp:389] Using default CRAM-MD5 authenticatee
I0323 17:54:07.261549 32311 authenticatee.cpp:121] Creating new client SASL connection
I0323 17:54:07.261817 32311 master.cpp:5659] Authenticating scheduler-46ad1cc9-675b-4d4d-8f49-f0a5833c5c76@172.17.0.2:51707
I0323 17:54:07.262071 32311 slave.cpp:1321] Will retry registration in 111.765463ms if necessary
I0323 17:54:07.262223 32311 slave.cpp:1321] Will retry registration in 19.597814ms if necessary
I0323 17:54:07.262300 32311 authenticator.cpp:413] Starting authentication session for crammd5_authenticatee(627)@172.17.0.2:51707
I0323 17:54:07.262624 32311 master.cpp:4358] Ignoring register slave message from slave(290)@172.17.0.2:51707 (d43c35ea1983) as admission is already in progress
I0323 17:54:07.262800 32311 master.cpp:4358] Ignoring register slave message from slave(291)@172.17.0.2:51707 (d43c35ea1983) as admission is already in progress
I0323 17:54:07.263839 32305 provisioner.cpp:245] Provisioner recovery complete
I0323 17:54:07.264230 32309 slave.cpp:4565] Finished recovery
I0323 17:54:07.264739 32318 authenticator.cpp:98] Creating new server SASL connection
I0323 17:54:07.264804 32309 slave.cpp:4737] Querying resource estimator for oversubscribable resources
I0323 17:54:07.265014 32318 authenticatee.cpp:212] Received SASL authentication mechanisms: CRAM-MD5
I0323 17:54:07.265053 32318 authenticatee.cpp:238] Attempting to authenticate with mechanism 'CRAM-MD5'
I0323 17:54:07.265092 32309 status_update_manager.cpp:174] Pausing sending status updates
I0323 17:54:07.265099 32316 slave.cpp:796] New master detected at master@172.17.0.2:51707
I0323 17:54:07.265138 32318 authenticator.cpp:203] Received SASL authentication start
I0323 17:54:07.265200 32318 authenticator.cpp:325] Authentication requires more steps
I0323 17:54:07.265198 32316 slave.cpp:859] Authenticating with master master@172.17.0.2:51707
I0323 17:54:07.265235 32316 slave.cpp:864] Using default CRAM-MD5 authenticatee
I0323 17:54:07.265300 32306 authenticator.cpp:231] Received SASL authentication step
I0323 17:54:07.265339 32306 auxprop.cpp:107] Request to lookup properties for user: 'test-principal' realm: 'd43c35ea1983' server FQDN: 'd43c35ea1983' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0323 17:54:07.265353 32306 auxprop.cpp:179] Looking up auxiliary property '*userPassword'
I0323 17:54:07.265406 32306 auxprop.cpp:179] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0323 17:54:07.265437 32306 auxprop.cpp:107] Request to lookup properties for user: 'test-principal' realm: 'd43c35ea1983' server FQDN: 'd43c35ea1983' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0323 17:54:07.265450 32306 auxprop.cpp:129] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0323 17:54:07.265457 32306 auxprop.cpp:129] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0323 17:54:07.265478 32306 authenticator.cpp:317] Authentication success
I0323 17:54:07.265653 32306 authenticatee.cpp:298] Authentication success
I0323 17:54:07.265748 32319 master.cpp:5689] Successfully authenticated principal 'test-principal' at slave(295)@172.17.0.2:51707
I0323 17:54:07.265797 32311 authenticatee.cpp:258] Received SASL authentication step
I0323 17:54:07.265882 32316 slave.cpp:832] Detecting new master
I0323 17:54:07.265911 32319 authenticatee.cpp:121] Creating new client SASL connection
I0323 17:54:07.266002 32316 slave.cpp:4751] Received oversubscribable resources from the resource estimator
I0323 17:54:07.266165 32319 master.cpp:5659] Authenticating slave(296)@172.17.0.2:51707
I0323 17:54:07.266350 32305 authenticator.cpp:431] Authentication session cleanup for crammd5_authenticatee(626)@172.17.0.2:51707
I0323 17:54:07.266667 32314 slave.cpp:927] Successfully authenticated with master master@172.17.0.2:51707
I0323 17:54:07.266831 32314 slave.cpp:1321] Will retry registration in 18.406582ms if necessary
I0323 17:54:07.267076 32314 master.cpp:4370] Registering slave at slave(295)@172.17.0.2:51707 (d43c35ea1983) with id 2ce2ad01-b334-4c59-a806-3a292497a589-S8
I0323 17:54:07.267606 32305 authenticator.cpp:413] Starting authentication session for crammd5_authenticatee(628)@172.17.0.2:51707
I0323 17:54:07.265883 32311 authenticator.cpp:231] Received SASL authentication step
I0323 17:54:07.267722 32311 auxprop.cpp:107] Request to lookup properties for user: 'test-principal' realm: 'd43c35ea1983' server FQDN: 'd43c35ea1983' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0323 17:54:07.267737 32311 auxprop.cpp:179] Looking up auxiliary property '*userPassword'
I0323 17:54:07.267776 32311 auxprop.cpp:179] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0323 17:54:07.267802 32311 auxprop.cpp:107] Request to lookup properties for user: 'test-principal' realm: 'd43c35ea1983' server FQDN: 'd43c35ea1983' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0323 17:54:07.267814 32311 auxprop.cpp:129] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0323 17:54:07.267823 32311 auxprop.cpp:129] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0323 17:54:07.267840 32311 authenticator.cpp:317] Authentication success
I0323 17:54:07.268163 32305 authenticator.cpp:98] Creating new server SASL connection
I0323 17:54:07.268520 32305 slave.cpp:1321] Will retry registration in 92.441769ms if necessary
I0323 17:54:07.268780 32319 master.cpp:4358] Ignoring register slave message from slave(292)@172.17.0.2:51707 (d43c35ea1983) as admission is already in progress
I0323 17:54:07.268648 32314 authenticatee.cpp:212] Received SASL authentication mechanisms: CRAM-MD5
I0323 17:54:07.268836 32314 authenticatee.cpp:238] Attempting to authenticate with mechanism 'CRAM-MD5'
I0323 17:54:07.268837 32311 authenticator.cpp:431] Authentication session cleanup for crammd5_authenticatee(627)@172.17.0.2:51707
I0323 17:54:07.268852 32319 master.cpp:5689] Successfully authenticated principal 'test-principal' at scheduler-46ad1cc9-675b-4d4d-8f49-f0a5833c5c76@172.17.0.2:51707
I0323 17:54:07.268924 32314 authenticator.cpp:203] Received SASL authentication start
I0323 17:54:07.268986 32314 authenticator.cpp:325] Authentication requires more steps
I0323 17:54:07.269074 32314 authenticatee.cpp:258] Received SASL authentication step
I0323 17:54:07.269160 32314 authenticator.cpp:231] Received SASL authentication step
I0323 17:54:07.269191 32314 auxprop.cpp:107] Request to lookup properties for user: 'test-principal' realm: 'd43c35ea1983' server FQDN: 'd43c35ea1983' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0323 17:54:07.269206 32314 auxprop.cpp:179] Looking up auxiliary property '*userPassword'
I0323 17:54:07.269240 32314 auxprop.cpp:179] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0323 17:54:07.269268 32314 auxprop.cpp:107] Request to lookup properties for user: 'test-principal' realm: 'd43c35ea1983' server FQDN: 'd43c35ea1983' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0323 17:54:07.269281 32314 auxprop.cpp:129] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0323 17:54:07.269290 32314 auxprop.cpp:129] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0323 17:54:07.269307 32314 authenticator.cpp:317] Authentication success
I0323 17:54:07.269429 32314 authenticatee.cpp:298] Authentication success
I0323 17:54:07.269515 32314 master.cpp:5689] Successfully authenticated principal 'test-principal' at slave(296)@172.17.0.2:51707
I0323 17:54:07.268790 32305 authenticatee.cpp:298] Authentication success
I0323 17:54:07.269840 32314 slave.cpp:927] Successfully authenticated with master master@172.17.0.2:51707
I0323 17:54:07.269948 32314 slave.cpp:1321] Will retry registration in 3.98535ms if necessary
I0323 17:54:07.270289 32314 master.cpp:4370] Registering slave at slave(296)@172.17.0.2:51707 (d43c35ea1983) with id 2ce2ad01-b334-4c59-a806-3a292497a589-S9
I0323 17:54:07.270892 32311 authenticator.cpp:431] Authentication session cleanup for crammd5_authenticatee(628)@172.17.0.2:51707
I0323 17:54:07.271224 32305 sched.cpp:471] Successfully authenticated with master master@172.17.0.2:51707
I0323 17:54:07.271244 32305 sched.cpp:776] Sending SUBSCRIBE call to master@172.17.0.2:51707
I0323 17:54:07.271355 32305 sched.cpp:809] Will retry registration in 728.337429ms if necessary
I0323 17:54:07.271529 32313 master.cpp:2326] Received SUBSCRIBE call for framework 'default' at scheduler-46ad1cc9-675b-4d4d-8f49-f0a5833c5c76@172.17.0.2:51707
I0323 17:54:07.271559 32313 master.cpp:1845] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0323 17:54:07.271872 32305 master.cpp:2397] Subscribing framework default with checkpointing disabled and capabilities [ ]
I0323 17:54:07.272533 32305 hierarchical.cpp:265] Added framework 2ce2ad01-b334-4c59-a806-3a292497a589-0000
I0323 17:54:07.272840 32315 sched.cpp:703] Framework registered with 2ce2ad01-b334-4c59-a806-3a292497a589-0000
I0323 17:54:07.272886 32315 sched.cpp:717] Scheduler::registered took 30106ns
I0323 17:54:07.273797 32305 hierarchical.cpp:1561] No inverse offers to send out!
I0323 17:54:07.273895 32305 hierarchical.cpp:1138] Performed allocation for 1 slaves in 1.352187ms
I0323 17:54:07.274353 32305 master.cpp:5488] Sending 1 offers to framework 2ce2ad01-b334-4c59-a806-3a292497a589-0000 (default) at scheduler-46ad1cc9-675b-4d4d-8f49-f0a5833c5c76@172.17.0.2:51707
I0323 17:54:07.274893 32305 sched.cpp:873] Scheduler::resourceOffers took 149454ns
I0323 17:54:07.276010 32318 slave.cpp:1321] Will retry registration in 10.996991ms if necessary
I0323 17:54:07.276274 32318 master.cpp:4358] Ignoring register slave message from slave(296)@172.17.0.2:51707 (d43c35ea1983) as admission is already in progress
I0323 17:54:07.276798 32287 sched.cpp:1903] Asked to stop the driver
I0323 17:54:07.277035 32305 sched.cpp:1143] Stopping framework '2ce2ad01-b334-4c59-a806-3a292497a589-0000'
I0323 17:54:07.277369 32305 master.cpp:6061] Processing TEARDOWN call for framework 2ce2ad01-b334-4c59-a806-3a292497a589-0000 (default) at scheduler-46ad1cc9-675b-4d4d-8f49-f0a5833c5c76@172.17.0.2:51707
I0323 17:54:07.277397 32305 master.cpp:6073] Removing framework 2ce2ad01-b334-4c59-a806-3a292497a589-0000 (default) at scheduler-46ad1cc9-675b-4d4d-8f49-f0a5833c5c76@172.17.0.2:51707
I0323 17:54:07.277918 32318 hierarchical.cpp:375] Deactivated framework 2ce2ad01-b334-4c59-a806-3a292497a589-0000
I0323 17:54:07.278267 32305 slave.cpp:2079] Asked to shut down framework 2ce2ad01-b334-4c59-a806-3a292497a589-0000 by master@172.17.0.2:51707
W0323 17:54:07.278295 32305 slave.cpp:2094] Cannot shut down unknown framework 2ce2ad01-b334-4c59-a806-3a292497a589-0000
I0323 17:54:07.278498 32318 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 2ce2ad01-b334-4c59-a806-3a292497a589-S0 from framework 2ce2ad01-b334-4c59-a806-3a292497a589-0000
I0323 17:54:07.278663 32318 hierarchical.cpp:326] Removed framework 2ce2ad01-b334-4c59-a806-3a292497a589-0000
I0323 17:54:07.283814 32287 slave.cpp:668] Slave terminating
I0323 17:54:07.283901 32315 slave.cpp:1321] Will retry registration in 140.308038ms if necessary
I0323 17:54:07.284121 32311 master.cpp:4358] Ignoring register slave message from slave(291)@172.17.0.2:51707 (d43c35ea1983) as admission is already in progress
I0323 17:54:07.284212 32311 master.cpp:1212] Slave 2ce2ad01-b334-4c59-a806-3a292497a589-S0 at slave(287)@172.17.0.2:51707 (d43c35ea1983) disconnected
I0323 17:54:07.284240 32311 master.cpp:2681] Disconnecting slave 2ce2ad01-b334-4c59-a806-3a292497a589-S0 at slave(287)@172.17.0.2:51707 (d43c35ea1983)
I0323 17:54:07.284351 32311 master.cpp:2700] Deactivating slave 2ce2ad01-b334-4c59-a806-3a292497a589-S0 at slave(287)@172.17.0.2:51707 (d43c35ea1983)
I0323 17:54:07.284483 32312 hierarchical.cpp:560] Slave 2ce2ad01-b334-4c59-a806-3a292497a589-S0 deactivated
I0323 17:54:07.286497 32309 slave.cpp:1321] Will retry registration in 31.377752ms if necessary
I0323 17:54:07.286661 32314 master.cpp:4358] Ignoring register slave message from slave(295)@172.17.0.2:51707 (d43c35ea1983) as admission is already in progress
I0323 17:54:07.287947 32309 slave.cpp:1321] Will retry registration in 45.651198ms if necessary
I0323 17:54:07.288131 32309 master.cpp:4358] Ignoring register slave message from slave(296)@172.17.0.2:51707 (d43c35ea1983) as admission is already in progress
I0323 17:54:07.292438 32315 slave.cpp:668] Slave terminating
I0323 17:54:07.300504 32320 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 40.488522ms
I0323 17:54:07.300663 32320 leveldb.cpp:399] Deleting ~2 keys from leveldb took 95007ns
I0323 17:54:07.300701 32320 replica.cpp:712] Persisted action at 4
I0323 17:54:07.300741 32320 replica.cpp:697] Replica learned TRUNCATE action at position 4
I0323 17:54:07.302139 32315 log.cpp:683] Attempting to append 1003 bytes to the log
I0323 17:54:07.302383 32315 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 5
I0323 17:54:07.303483 32320 replica.cpp:537] Replica received write request for position 5 from (9693)@172.17.0.2:51707
I0323 17:54:07.306979 32287 slave.cpp:668] Slave terminating
I0323 17:54:07.310907 32317 slave.cpp:1321] Will retry registration in 104.949639ms if necessary
I0323 17:54:07.311111 32306 master.cpp:4358] Ignoring register slave message from slave(294)@172.17.0.2:51707 (d43c35ea1983) as admission is already in progress
I0323 17:54:07.313953 32287 slave.cpp:668] Slave terminating
I0323 17:54:07.317785 32305 slave.cpp:668] Slave terminating
I0323 17:54:07.325778 32317 slave.cpp:1321] Will retry registration in 57.183744ms if necessary
I0323 17:54:07.326148 32317 master.cpp:4358] Ignoring register slave message from slave(295)@172.17.0.2:51707 (d43c35ea1983) as admission is already in progress
I0323 17:54:07.326323 32317 slave.cpp:1321] Will retry registration in 140.316734ms if necessary
I0323 17:54:07.326735 32317 master.cpp:4358] Ignoring register slave message from slave(293)@172.17.0.2:51707 (d43c35ea1983) as admission is already in progress
I0323 17:54:07.328997 32311 slave.cpp:668] Slave terminating
I0323 17:54:07.332283 32309 slave.cpp:668] Slave terminating
I0323 17:54:07.334852 32315 slave.cpp:1321] Will retry registration in 76.549837ms if necessary
I0323 17:54:07.335178 32315 master.cpp:4358] Ignoring register slave message from slave(296)@172.17.0.2:51707 (d43c35ea1983) as admission is already in progress
I0323 17:54:07.342803 32320 leveldb.cpp:341] Persisting action (1022 bytes) to leveldb took 39.215411ms
I0323 17:54:07.342901 32320 replica.cpp:712] Persisted action at 5
I0323 17:54:07.349373 32311 replica.cpp:691] Replica received learned notice for position 5 from @0.0.0.0:0
I0323 17:54:07.349716 32308 slave.cpp:668] Slave terminating
I0323 17:54:07.375403 32287 slave.cpp:668] Slave terminating
I0323 17:54:07.381862 32287 slave.cpp:668] Slave terminating
I0323 17:54:07.397877 32287 master.cpp:1065] Master terminating
I0323 17:54:07.398568 32311 leveldb.cpp:341] Persisting action (1024 bytes) to leveldb took 49.147806ms
I0323 17:54:07.398622 32311 replica.cpp:712] Persisted action at 5
I0323 17:54:07.398656 32311 replica.cpp:697] Replica learned APPEND action at position 5
I0323 17:54:07.398906 32307 hierarchical.cpp:505] Removed slave 2ce2ad01-b334-4c59-a806-3a292497a589-S0
I0323 17:54:07.405854 32316 registrar.cpp:484] Successfully updated the 'registry' in 205.292032ms
I0323 17:54:07.406823 32316 registrar.cpp:439] Applied 5 operations in 259326ns; attempting to update the 'registry'
*** Aborted at 1458755647 (unix time) try "date -d @1458755647" if you are using GNU date ***
PC: @ 0x0 (unknown)
*** SIGSEGV (@0x0) received by PID 32287 (TID 0x2baa42a8b700) from PID 0; stack trace: ***
@ 0x2baa89d82ff7 (unknown)
@ 0x2baa89d87159 (unknown)
@ 0x2baa394df340 (unknown)
make[4]: *** [check-local] Segmentation fault
make[4]: Leaving directory `/mesos/mesos-0.29.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-0.29.0/_build/src'
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-1458753249-29789
Untagged: mesos-1458753249-29789:latest
Deleted: 1241bd9b519a71b53a8d48565a91bb6e8e1b140265ab6bb3d6f0f1ad750a153b
Deleted: 7f2c55799164c719bcc217cafff40680a957c58e9c0937ffbe8ba19e5f535a3c
Deleted: 32173771bc99ac8ec33e050ae8942493b8dd884499a706425ed8ae2995949377
Deleted: e6fa12c16c86ca5dfdca99a3e1d532f8bd3d49c30b5e7905758f4f9fafc145ed
Deleted: f70518e6334861c803685c5d3ff6069f5adf3fe3f46ff10ad51772cfbbb01b31
Deleted: c09278f84b23429a3751ea7f2503b8d6771cedf05916068fd8bbe5f4ffa834a6
Deleted: f0f332cbb6d6778ce3b2cf30a9234936da233dde6641c0125960d65fa6851be2
Deleted: 1f0c71c122995055f0871096e6ed19f0f8367724ab674a85a14e5935e595b446
Deleted: 2bf4d69c88d650df6c5366eb5ab44fcab9ddbd2ff386203edef81f687bfc9d3b
Deleted: ac7a6501df08b241be9238dc8aaa240ea86aea60b4a2a36d4bfdc197b226a3f9
Deleted: dd2690dab55892235efd9d9fe63dc0cae7ded47fd788d31cebaa111d3bc76561
Deleted: dff4e054d3cbb9649959ec8a29a029a077261db7aaac465163212337a49978e6
Deleted: 2330cc19e9112636fb385856ec51db686c79d6c0ec54dadf32338145e96e180f
Deleted: 1bd17ff1d10a10daaebd0ceef76e9a4acf8e0f9020ea34644cc5ead7c1994554
Deleted: 08678e238ca1662c50a0b3ac2a7d6b103bae184dddb5a578209bc24373b62bd1
Deleted: 9d3a266ddaf6d490c0841684ebc3b09683109d67afa9d7c9e2a0e8dd02020712
Build step 'Execute shell' marked build as failure
Re: Build failed in Jenkins: Mesos » clang,--verbose,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:02 AM, Apache Jenkins Server <
jenkins@builds.apache.org> wrote:
> See <
> https://builds.apache.org/job/Mesos/COMPILER=clang,CONFIGURATION=--verbose,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 120264 lines...]
> I0323 17:54:07.224808 32320 auxprop.cpp:179] Looking up auxiliary property
> '*userPassword'
> I0323 17:54:07.224860 32320 auxprop.cpp:179] Looking up auxiliary property
> '*cmusaslsecretCRAM-MD5'
> I0323 17:54:07.224885 32320 auxprop.cpp:107] Request to lookup properties
> for user: 'test-principal' realm: 'd43c35ea1983' server FQDN:
> 'd43c35ea1983' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
> I0323 17:54:07.224897 32320 auxprop.cpp:129] Skipping auxiliary property
> '*userPassword' since SASL_AUXPROP_AUTHZID == true
> I0323 17:54:07.224905 32320 auxprop.cpp:129] Skipping auxiliary property
> '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
> I0323 17:54:07.224923 32320 authenticator.cpp:317] Authentication success
> I0323 17:54:07.225018 32319 slave.cpp:1321] Will retry registration in
> 10.569866ms if necessary
> I0323 17:54:07.225036 32312 authenticatee.cpp:298] Authentication success
> I0323 17:54:07.225074 32320 master.cpp:5689] Successfully authenticated
> principal 'test-principal' at slave(294)@172.17.0.2:51707
> I0323 17:54:07.225102 32319 authenticator.cpp:431] Authentication session
> cleanup for crammd5_authenticatee(625)@172.17.0.2:51707
> I0323 17:54:07.225230 32320 master.cpp:4358] Ignoring register slave
> message from slave(292)@172.17.0.2:51707 (d43c35ea1983) as admission is
> already in progress
> I0323 17:54:07.225420 32312 slave.cpp:927] Successfully authenticated with
> master master@172.17.0.2:51707
> I0323 17:54:07.225528 32312 slave.cpp:1321] Will retry registration in
> 7.218563ms if necessary
> I0323 17:54:07.225674 32317 master.cpp:4370] Registering slave at
> slave(294)@172.17.0.2:51707 (d43c35ea1983) with id
> 2ce2ad01-b334-4c59-a806-3a292497a589-S7
> I0323 17:54:07.234006 32317 slave.cpp:1321] Will retry registration in
> 23.521448ms if necessary
> I0323 17:54:07.234287 32312 master.cpp:4358] Ignoring register slave
> message from slave(293)@172.17.0.2:51707 (d43c35ea1983) as admission is
> already in progress
> I0323 17:54:07.235854 32320 slave.cpp:1321] Will retry registration in
> 20.546645ms if necessary
> I0323 17:54:07.236071 32320 master.cpp:4358] Ignoring register slave
> message from slave(294)@172.17.0.2:51707 (d43c35ea1983) as admission is
> already in progress
> I0323 17:54:07.236935 32320 slave.cpp:1321] Will retry registration in
> 30.502541ms if necessary
> I0323 17:54:07.237125 32320 master.cpp:4358] Ignoring register slave
> message from slave(292)@172.17.0.2:51707 (d43c35ea1983) as admission is
> already in progress
> I0323 17:54:07.248242 32309 slave.cpp:324] Slave using credential for:
> test-principal
> I0323 17:54:07.248534 32309 resources.cpp:572] Parsing resources as JSON
> failed: cpus:2;mem:1024
> Trying semicolon-delimited string format instead
> I0323 17:54:07.249102 32309 slave.cpp:464] Slave resources: cpus(*):2;
> mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000]
> I0323 17:54:07.249184 32309 slave.cpp:472] Slave attributes: [ ]
> I0323 17:54:07.249199 32309 slave.cpp:477] Slave hostname: d43c35ea1983
> I0323 17:54:07.250300 32287 containerizer.cpp:149] Using isolation:
> posix/cpu,posix/mem,filesystem/posix
> I0323 17:54:07.251621 32309 state.cpp:58] Recovering state from
> '/tmp/ResourceOffersTest_ResourceOfferWithMultipleSlaves_fUnJZL/meta'
> I0323 17:54:07.252082 32308 status_update_manager.cpp:200] Recovering
> status update manager
> W0323 17:54:07.252089 32287 backend.cpp:66] Failed to create 'bind'
> backend: BindBackend requires root privileges
> I0323 17:54:07.252389 32308 containerizer.cpp:407] Recovering containerizer
> I0323 17:54:07.253458 32317 slave.cpp:1321] Will retry registration in
> 316.784222ms if necessary
> I0323 17:54:07.253851 32317 master.cpp:4358] Ignoring register slave
> message from slave(289)@172.17.0.2:51707 (d43c35ea1983) as admission is
> already in progress
> I0323 17:54:07.256048 32310 slave.cpp:193] Slave started on 296)@
> 172.17.0.2:51707
> I0323 17:54:07.256321 32308 provisioner.cpp:245] Provisioner recovery
> complete
> I0323 17:54:07.256091 32310 slave.cpp:194] Flags at startup:
> --appc_simple_discovery_uri_prefix="http://"
> --appc_store_dir="/tmp/mesos/store/appc" --authenticatee="crammd5"
> --cgroups_cpu_enable_pids_and_tids_count="false"
> --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup"
> --cgroups_limit_swap="false" --cgroups_root="mesos"
> --container_disk_watch_interval="15secs" --containerizers="mesos"
> --credential="/tmp/ResourceOffersTest_ResourceOfferWithMultipleSlaves_Nk94YC/credential"
> --default_role="*" --disk_watch_interval="1mins" --docker="docker"
> --docker_kill_orphans="true" --docker_registry="
> https://registry-1.docker.io" --docker_remove_delay="6hrs"
> --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns"
> --docker_store_dir="/tmp/mesos/store/docker"
> --enforce_container_disk_quota="false"
> --executor_registration_timeout="1mins"
> --executor_shutdown_grace_period="5secs"
> --fetcher_cache_dir="/tmp/ResourceOffersTest_ResourceOfferWithMultipleSlaves_Nk94YC/fetch"
> --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks"
> --gc_disk_headroom="0.1" --hadoop_home="" --help="false"
> --hostname_lookup="true" --image_provisioner_backend="copy"
> --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem"
> --launcher_dir="/mesos/mesos-0.29.0/_build/src" --logbufsecs="0"
> --logging_level="INFO" --oversubscribed_resources_interval="15secs"
> --perf_duration="10secs" --perf_interval="1mins"
> --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect"
> --recovery_timeout="15mins" --registration_backoff_factor="10ms"
> --resources="cpus:2;mem:1024" --revocable_cpu_low_priority="true"
> --sandbox_directory="/mnt/mesos/sandbox" --strict="true"
> --switch_user="true" --systemd_enable_support="true"
> --systemd_runtime_directory="/run/systemd/system" --version="false"
> --work_dir="/tmp/ResourceOffersTest_ResourceOfferWithMultipleSlaves_Nk94YC"
> I0323 17:54:07.256669 32310 credentials.hpp:83] Loading credential for
> authentication from
> '/tmp/ResourceOffersTest_ResourceOfferWithMultipleSlaves_Nk94YC/credential'
> I0323 17:54:07.256759 32311 leveldb.cpp:341] Persisting action (16 bytes)
> to leveldb took 51.099538ms
> I0323 17:54:07.256795 32319 slave.cpp:4565] Finished recovery
> I0323 17:54:07.256803 32311 replica.cpp:712] Persisted action at 4
> I0323 17:54:07.256906 32310 slave.cpp:324] Slave using credential for:
> test-principal
> I0323 17:54:07.257072 32310 resources.cpp:572] Parsing resources as JSON
> failed: cpus:2;mem:1024
> Trying semicolon-delimited string format instead
> I0323 17:54:07.257335 32319 slave.cpp:4737] Querying resource estimator
> for oversubscribable resources
> I0323 17:54:07.257581 32310 slave.cpp:464] Slave resources: cpus(*):2;
> mem(*):1024; disk(*):3.70122e+06; ports(*):[31000-32000]
> I0323 17:54:07.257661 32310 slave.cpp:472] Slave attributes: [ ]
> I0323 17:54:07.257676 32310 slave.cpp:477] Slave hostname: d43c35ea1983
> I0323 17:54:07.258199 32319 slave.cpp:796] New master detected at
> master@172.17.0.2:51707
> I0323 17:54:07.258275 32319 slave.cpp:859] Authenticating with master
> master@172.17.0.2:51707
> I0323 17:54:07.258296 32319 slave.cpp:864] Using default CRAM-MD5
> authenticatee
> I0323 17:54:07.258429 32319 slave.cpp:832] Detecting new master
> I0323 17:54:07.258584 32287 sched.cpp:222] Version: 0.29.0
> I0323 17:54:07.258666 32309 status_update_manager.cpp:174] Pausing sending
> status updates
> I0323 17:54:07.258780 32320 authenticatee.cpp:121] Creating new client
> SASL connection
> I0323 17:54:07.259131 32316 slave.cpp:1321] Will retry registration in
> 62.664778ms if necessary
> I0323 17:54:07.259268 32312 slave.cpp:1321] Will retry registration in
> 50.032152ms if necessary
> I0323 17:54:07.259289 32317 master.cpp:5659] Authenticating slave(295)@
> 172.17.0.2:51707
> I0323 17:54:07.259441 32314 authenticator.cpp:413] Starting authentication
> session for crammd5_authenticatee(626)@172.17.0.2:51707
> I0323 17:54:07.259590 32317 master.cpp:4358] Ignoring register slave
> message from slave(293)@172.17.0.2:51707 (d43c35ea1983) as admission is
> already in progress
> I0323 17:54:07.259748 32317 master.cpp:4358] Ignoring register slave
> message from slave(294)@172.17.0.2:51707 (d43c35ea1983) as admission is
> already in progress
> I0323 17:54:07.259757 32316 state.cpp:58] Recovering state from
> '/tmp/ResourceOffersTest_ResourceOfferWithMultipleSlaves_Nk94YC/meta'
> I0323 17:54:07.259830 32318 authenticator.cpp:98] Creating new server SASL
> connection
> I0323 17:54:07.259879 32312 slave.cpp:4751] Received oversubscribable
> resources from the resource estimator
> I0323 17:54:07.260010 32320 replica.cpp:691] Replica received learned
> notice for position 4 from @0.0.0.0:0
> I0323 17:54:07.260033 32317 authenticatee.cpp:212] Received SASL
> authentication mechanisms: CRAM-MD5
> I0323 17:54:07.260066 32317 authenticatee.cpp:238] Attempting to
> authenticate with mechanism 'CRAM-MD5'
> I0323 17:54:07.260156 32317 authenticator.cpp:203] Received SASL
> authentication start
> I0323 17:54:07.260212 32306 status_update_manager.cpp:200] Recovering
> status update manager
> I0323 17:54:07.260227 32317 authenticator.cpp:325] Authentication requires
> more steps
> I0323 17:54:07.260313 32317 authenticatee.cpp:258] Received SASL
> authentication step
> I0323 17:54:07.260402 32317 containerizer.cpp:407] Recovering containerizer
> I0323 17:54:07.261147 32311 sched.cpp:326] New master detected at
> master@172.17.0.2:51707
> I0323 17:54:07.261231 32311 sched.cpp:382] Authenticating with master
> master@172.17.0.2:51707
> I0323 17:54:07.261255 32311 sched.cpp:389] Using default CRAM-MD5
> authenticatee
> I0323 17:54:07.261549 32311 authenticatee.cpp:121] Creating new client
> SASL connection
> I0323 17:54:07.261817 32311 master.cpp:5659] Authenticating
> scheduler-46ad1cc9-675b-4d4d-8f49-f0a5833c5c76@172.17.0.2:51707
> I0323 17:54:07.262071 32311 slave.cpp:1321] Will retry registration in
> 111.765463ms if necessary
> I0323 17:54:07.262223 32311 slave.cpp:1321] Will retry registration in
> 19.597814ms if necessary
> I0323 17:54:07.262300 32311 authenticator.cpp:413] Starting authentication
> session for crammd5_authenticatee(627)@172.17.0.2:51707
> I0323 17:54:07.262624 32311 master.cpp:4358] Ignoring register slave
> message from slave(290)@172.17.0.2:51707 (d43c35ea1983) as admission is
> already in progress
> I0323 17:54:07.262800 32311 master.cpp:4358] Ignoring register slave
> message from slave(291)@172.17.0.2:51707 (d43c35ea1983) as admission is
> already in progress
> I0323 17:54:07.263839 32305 provisioner.cpp:245] Provisioner recovery
> complete
> I0323 17:54:07.264230 32309 slave.cpp:4565] Finished recovery
> I0323 17:54:07.264739 32318 authenticator.cpp:98] Creating new server SASL
> connection
> I0323 17:54:07.264804 32309 slave.cpp:4737] Querying resource estimator
> for oversubscribable resources
> I0323 17:54:07.265014 32318 authenticatee.cpp:212] Received SASL
> authentication mechanisms: CRAM-MD5
> I0323 17:54:07.265053 32318 authenticatee.cpp:238] Attempting to
> authenticate with mechanism 'CRAM-MD5'
> I0323 17:54:07.265092 32309 status_update_manager.cpp:174] Pausing sending
> status updates
> I0323 17:54:07.265099 32316 slave.cpp:796] New master detected at
> master@172.17.0.2:51707
> I0323 17:54:07.265138 32318 authenticator.cpp:203] Received SASL
> authentication start
> I0323 17:54:07.265200 32318 authenticator.cpp:325] Authentication requires
> more steps
> I0323 17:54:07.265198 32316 slave.cpp:859] Authenticating with master
> master@172.17.0.2:51707
> I0323 17:54:07.265235 32316 slave.cpp:864] Using default CRAM-MD5
> authenticatee
> I0323 17:54:07.265300 32306 authenticator.cpp:231] Received SASL
> authentication step
> I0323 17:54:07.265339 32306 auxprop.cpp:107] Request to lookup properties
> for user: 'test-principal' realm: 'd43c35ea1983' server FQDN:
> 'd43c35ea1983' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
> I0323 17:54:07.265353 32306 auxprop.cpp:179] Looking up auxiliary property
> '*userPassword'
> I0323 17:54:07.265406 32306 auxprop.cpp:179] Looking up auxiliary property
> '*cmusaslsecretCRAM-MD5'
> I0323 17:54:07.265437 32306 auxprop.cpp:107] Request to lookup properties
> for user: 'test-principal' realm: 'd43c35ea1983' server FQDN:
> 'd43c35ea1983' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
> I0323 17:54:07.265450 32306 auxprop.cpp:129] Skipping auxiliary property
> '*userPassword' since SASL_AUXPROP_AUTHZID == true
> I0323 17:54:07.265457 32306 auxprop.cpp:129] Skipping auxiliary property
> '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
> I0323 17:54:07.265478 32306 authenticator.cpp:317] Authentication success
> I0323 17:54:07.265653 32306 authenticatee.cpp:298] Authentication success
> I0323 17:54:07.265748 32319 master.cpp:5689] Successfully authenticated
> principal 'test-principal' at slave(295)@172.17.0.2:51707
> I0323 17:54:07.265797 32311 authenticatee.cpp:258] Received SASL
> authentication step
> I0323 17:54:07.265882 32316 slave.cpp:832] Detecting new master
> I0323 17:54:07.265911 32319 authenticatee.cpp:121] Creating new client
> SASL connection
> I0323 17:54:07.266002 32316 slave.cpp:4751] Received oversubscribable
> resources from the resource estimator
> I0323 17:54:07.266165 32319 master.cpp:5659] Authenticating slave(296)@
> 172.17.0.2:51707
> I0323 17:54:07.266350 32305 authenticator.cpp:431] Authentication session
> cleanup for crammd5_authenticatee(626)@172.17.0.2:51707
> I0323 17:54:07.266667 32314 slave.cpp:927] Successfully authenticated with
> master master@172.17.0.2:51707
> I0323 17:54:07.266831 32314 slave.cpp:1321] Will retry registration in
> 18.406582ms if necessary
> I0323 17:54:07.267076 32314 master.cpp:4370] Registering slave at
> slave(295)@172.17.0.2:51707 (d43c35ea1983) with id
> 2ce2ad01-b334-4c59-a806-3a292497a589-S8
> I0323 17:54:07.267606 32305 authenticator.cpp:413] Starting authentication
> session for crammd5_authenticatee(628)@172.17.0.2:51707
> I0323 17:54:07.265883 32311 authenticator.cpp:231] Received SASL
> authentication step
> I0323 17:54:07.267722 32311 auxprop.cpp:107] Request to lookup properties
> for user: 'test-principal' realm: 'd43c35ea1983' server FQDN:
> 'd43c35ea1983' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
> I0323 17:54:07.267737 32311 auxprop.cpp:179] Looking up auxiliary property
> '*userPassword'
> I0323 17:54:07.267776 32311 auxprop.cpp:179] Looking up auxiliary property
> '*cmusaslsecretCRAM-MD5'
> I0323 17:54:07.267802 32311 auxprop.cpp:107] Request to lookup properties
> for user: 'test-principal' realm: 'd43c35ea1983' server FQDN:
> 'd43c35ea1983' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
> I0323 17:54:07.267814 32311 auxprop.cpp:129] Skipping auxiliary property
> '*userPassword' since SASL_AUXPROP_AUTHZID == true
> I0323 17:54:07.267823 32311 auxprop.cpp:129] Skipping auxiliary property
> '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
> I0323 17:54:07.267840 32311 authenticator.cpp:317] Authentication success
> I0323 17:54:07.268163 32305 authenticator.cpp:98] Creating new server SASL
> connection
> I0323 17:54:07.268520 32305 slave.cpp:1321] Will retry registration in
> 92.441769ms if necessary
> I0323 17:54:07.268780 32319 master.cpp:4358] Ignoring register slave
> message from slave(292)@172.17.0.2:51707 (d43c35ea1983) as admission is
> already in progress
> I0323 17:54:07.268648 32314 authenticatee.cpp:212] Received SASL
> authentication mechanisms: CRAM-MD5
> I0323 17:54:07.268836 32314 authenticatee.cpp:238] Attempting to
> authenticate with mechanism 'CRAM-MD5'
> I0323 17:54:07.268837 32311 authenticator.cpp:431] Authentication session
> cleanup for crammd5_authenticatee(627)@172.17.0.2:51707
> I0323 17:54:07.268852 32319 master.cpp:5689] Successfully authenticated
> principal 'test-principal' at
> scheduler-46ad1cc9-675b-4d4d-8f49-f0a5833c5c76@172.17.0.2:51707
> I0323 17:54:07.268924 32314 authenticator.cpp:203] Received SASL
> authentication start
> I0323 17:54:07.268986 32314 authenticator.cpp:325] Authentication requires
> more steps
> I0323 17:54:07.269074 32314 authenticatee.cpp:258] Received SASL
> authentication step
> I0323 17:54:07.269160 32314 authenticator.cpp:231] Received SASL
> authentication step
> I0323 17:54:07.269191 32314 auxprop.cpp:107] Request to lookup properties
> for user: 'test-principal' realm: 'd43c35ea1983' server FQDN:
> 'd43c35ea1983' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
> I0323 17:54:07.269206 32314 auxprop.cpp:179] Looking up auxiliary property
> '*userPassword'
> I0323 17:54:07.269240 32314 auxprop.cpp:179] Looking up auxiliary property
> '*cmusaslsecretCRAM-MD5'
> I0323 17:54:07.269268 32314 auxprop.cpp:107] Request to lookup properties
> for user: 'test-principal' realm: 'd43c35ea1983' server FQDN:
> 'd43c35ea1983' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
> I0323 17:54:07.269281 32314 auxprop.cpp:129] Skipping auxiliary property
> '*userPassword' since SASL_AUXPROP_AUTHZID == true
> I0323 17:54:07.269290 32314 auxprop.cpp:129] Skipping auxiliary property
> '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
> I0323 17:54:07.269307 32314 authenticator.cpp:317] Authentication success
> I0323 17:54:07.269429 32314 authenticatee.cpp:298] Authentication success
> I0323 17:54:07.269515 32314 master.cpp:5689] Successfully authenticated
> principal 'test-principal' at slave(296)@172.17.0.2:51707
> I0323 17:54:07.268790 32305 authenticatee.cpp:298] Authentication success
> I0323 17:54:07.269840 32314 slave.cpp:927] Successfully authenticated with
> master master@172.17.0.2:51707
> I0323 17:54:07.269948 32314 slave.cpp:1321] Will retry registration in
> 3.98535ms if necessary
> I0323 17:54:07.270289 32314 master.cpp:4370] Registering slave at
> slave(296)@172.17.0.2:51707 (d43c35ea1983) with id
> 2ce2ad01-b334-4c59-a806-3a292497a589-S9
> I0323 17:54:07.270892 32311 authenticator.cpp:431] Authentication session
> cleanup for crammd5_authenticatee(628)@172.17.0.2:51707
> I0323 17:54:07.271224 32305 sched.cpp:471] Successfully authenticated with
> master master@172.17.0.2:51707
> I0323 17:54:07.271244 32305 sched.cpp:776] Sending SUBSCRIBE call to
> master@172.17.0.2:51707
> I0323 17:54:07.271355 32305 sched.cpp:809] Will retry registration in
> 728.337429ms if necessary
> I0323 17:54:07.271529 32313 master.cpp:2326] Received SUBSCRIBE call for
> framework 'default' at
> scheduler-46ad1cc9-675b-4d4d-8f49-f0a5833c5c76@172.17.0.2:51707
> I0323 17:54:07.271559 32313 master.cpp:1845] Authorizing framework
> principal 'test-principal' to receive offers for role '*'
> I0323 17:54:07.271872 32305 master.cpp:2397] Subscribing framework default
> with checkpointing disabled and capabilities [ ]
> I0323 17:54:07.272533 32305 hierarchical.cpp:265] Added framework
> 2ce2ad01-b334-4c59-a806-3a292497a589-0000
> I0323 17:54:07.272840 32315 sched.cpp:703] Framework registered with
> 2ce2ad01-b334-4c59-a806-3a292497a589-0000
> I0323 17:54:07.272886 32315 sched.cpp:717] Scheduler::registered took
> 30106ns
> I0323 17:54:07.273797 32305 hierarchical.cpp:1561] No inverse offers to
> send out!
> I0323 17:54:07.273895 32305 hierarchical.cpp:1138] Performed allocation
> for 1 slaves in 1.352187ms
> I0323 17:54:07.274353 32305 master.cpp:5488] Sending 1 offers to framework
> 2ce2ad01-b334-4c59-a806-3a292497a589-0000 (default) at
> scheduler-46ad1cc9-675b-4d4d-8f49-f0a5833c5c76@172.17.0.2:51707
> I0323 17:54:07.274893 32305 sched.cpp:873] Scheduler::resourceOffers took
> 149454ns
> I0323 17:54:07.276010 32318 slave.cpp:1321] Will retry registration in
> 10.996991ms if necessary
> I0323 17:54:07.276274 32318 master.cpp:4358] Ignoring register slave
> message from slave(296)@172.17.0.2:51707 (d43c35ea1983) as admission is
> already in progress
> I0323 17:54:07.276798 32287 sched.cpp:1903] Asked to stop the driver
> I0323 17:54:07.277035 32305 sched.cpp:1143] Stopping framework
> '2ce2ad01-b334-4c59-a806-3a292497a589-0000'
> I0323 17:54:07.277369 32305 master.cpp:6061] Processing TEARDOWN call for
> framework 2ce2ad01-b334-4c59-a806-3a292497a589-0000 (default) at
> scheduler-46ad1cc9-675b-4d4d-8f49-f0a5833c5c76@172.17.0.2:51707
> I0323 17:54:07.277397 32305 master.cpp:6073] Removing framework
> 2ce2ad01-b334-4c59-a806-3a292497a589-0000 (default) at
> scheduler-46ad1cc9-675b-4d4d-8f49-f0a5833c5c76@172.17.0.2:51707
> I0323 17:54:07.277918 32318 hierarchical.cpp:375] Deactivated framework
> 2ce2ad01-b334-4c59-a806-3a292497a589-0000
> I0323 17:54:07.278267 32305 slave.cpp:2079] Asked to shut down framework
> 2ce2ad01-b334-4c59-a806-3a292497a589-0000 by master@172.17.0.2:51707
> W0323 17:54:07.278295 32305 slave.cpp:2094] Cannot shut down unknown
> framework 2ce2ad01-b334-4c59-a806-3a292497a589-0000
> I0323 17:54:07.278498 32318 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 2ce2ad01-b334-4c59-a806-3a292497a589-S0 from framework
> 2ce2ad01-b334-4c59-a806-3a292497a589-0000
> I0323 17:54:07.278663 32318 hierarchical.cpp:326] Removed framework
> 2ce2ad01-b334-4c59-a806-3a292497a589-0000
> I0323 17:54:07.283814 32287 slave.cpp:668] Slave terminating
> I0323 17:54:07.283901 32315 slave.cpp:1321] Will retry registration in
> 140.308038ms if necessary
> I0323 17:54:07.284121 32311 master.cpp:4358] Ignoring register slave
> message from slave(291)@172.17.0.2:51707 (d43c35ea1983) as admission is
> already in progress
> I0323 17:54:07.284212 32311 master.cpp:1212] Slave
> 2ce2ad01-b334-4c59-a806-3a292497a589-S0 at slave(287)@172.17.0.2:51707
> (d43c35ea1983) disconnected
> I0323 17:54:07.284240 32311 master.cpp:2681] Disconnecting slave
> 2ce2ad01-b334-4c59-a806-3a292497a589-S0 at slave(287)@172.17.0.2:51707
> (d43c35ea1983)
> I0323 17:54:07.284351 32311 master.cpp:2700] Deactivating slave
> 2ce2ad01-b334-4c59-a806-3a292497a589-S0 at slave(287)@172.17.0.2:51707
> (d43c35ea1983)
> I0323 17:54:07.284483 32312 hierarchical.cpp:560] Slave
> 2ce2ad01-b334-4c59-a806-3a292497a589-S0 deactivated
> I0323 17:54:07.286497 32309 slave.cpp:1321] Will retry registration in
> 31.377752ms if necessary
> I0323 17:54:07.286661 32314 master.cpp:4358] Ignoring register slave
> message from slave(295)@172.17.0.2:51707 (d43c35ea1983) as admission is
> already in progress
> I0323 17:54:07.287947 32309 slave.cpp:1321] Will retry registration in
> 45.651198ms if necessary
> I0323 17:54:07.288131 32309 master.cpp:4358] Ignoring register slave
> message from slave(296)@172.17.0.2:51707 (d43c35ea1983) as admission is
> already in progress
> I0323 17:54:07.292438 32315 slave.cpp:668] Slave terminating
> I0323 17:54:07.300504 32320 leveldb.cpp:341] Persisting action (18 bytes)
> to leveldb took 40.488522ms
> I0323 17:54:07.300663 32320 leveldb.cpp:399] Deleting ~2 keys from leveldb
> took 95007ns
> I0323 17:54:07.300701 32320 replica.cpp:712] Persisted action at 4
> I0323 17:54:07.300741 32320 replica.cpp:697] Replica learned TRUNCATE
> action at position 4
> I0323 17:54:07.302139 32315 log.cpp:683] Attempting to append 1003 bytes
> to the log
> I0323 17:54:07.302383 32315 coordinator.cpp:348] Coordinator attempting to
> write APPEND action at position 5
> I0323 17:54:07.303483 32320 replica.cpp:537] Replica received write
> request for position 5 from (9693)@172.17.0.2:51707
> I0323 17:54:07.306979 32287 slave.cpp:668] Slave terminating
> I0323 17:54:07.310907 32317 slave.cpp:1321] Will retry registration in
> 104.949639ms if necessary
> I0323 17:54:07.311111 32306 master.cpp:4358] Ignoring register slave
> message from slave(294)@172.17.0.2:51707 (d43c35ea1983) as admission is
> already in progress
> I0323 17:54:07.313953 32287 slave.cpp:668] Slave terminating
> I0323 17:54:07.317785 32305 slave.cpp:668] Slave terminating
> I0323 17:54:07.325778 32317 slave.cpp:1321] Will retry registration in
> 57.183744ms if necessary
> I0323 17:54:07.326148 32317 master.cpp:4358] Ignoring register slave
> message from slave(295)@172.17.0.2:51707 (d43c35ea1983) as admission is
> already in progress
> I0323 17:54:07.326323 32317 slave.cpp:1321] Will retry registration in
> 140.316734ms if necessary
> I0323 17:54:07.326735 32317 master.cpp:4358] Ignoring register slave
> message from slave(293)@172.17.0.2:51707 (d43c35ea1983) as admission is
> already in progress
> I0323 17:54:07.328997 32311 slave.cpp:668] Slave terminating
> I0323 17:54:07.332283 32309 slave.cpp:668] Slave terminating
> I0323 17:54:07.334852 32315 slave.cpp:1321] Will retry registration in
> 76.549837ms if necessary
> I0323 17:54:07.335178 32315 master.cpp:4358] Ignoring register slave
> message from slave(296)@172.17.0.2:51707 (d43c35ea1983) as admission is
> already in progress
> I0323 17:54:07.342803 32320 leveldb.cpp:341] Persisting action (1022
> bytes) to leveldb took 39.215411ms
> I0323 17:54:07.342901 32320 replica.cpp:712] Persisted action at 5
> I0323 17:54:07.349373 32311 replica.cpp:691] Replica received learned
> notice for position 5 from @0.0.0.0:0
> I0323 17:54:07.349716 32308 slave.cpp:668] Slave terminating
> I0323 17:54:07.375403 32287 slave.cpp:668] Slave terminating
> I0323 17:54:07.381862 32287 slave.cpp:668] Slave terminating
> I0323 17:54:07.397877 32287 master.cpp:1065] Master terminating
> I0323 17:54:07.398568 32311 leveldb.cpp:341] Persisting action (1024
> bytes) to leveldb took 49.147806ms
> I0323 17:54:07.398622 32311 replica.cpp:712] Persisted action at 5
> I0323 17:54:07.398656 32311 replica.cpp:697] Replica learned APPEND action
> at position 5
> I0323 17:54:07.398906 32307 hierarchical.cpp:505] Removed slave
> 2ce2ad01-b334-4c59-a806-3a292497a589-S0
> I0323 17:54:07.405854 32316 registrar.cpp:484] Successfully updated the
> 'registry' in 205.292032ms
> I0323 17:54:07.406823 32316 registrar.cpp:439] Applied 5 operations in
> 259326ns; attempting to update the 'registry'
> *** Aborted at 1458755647 (unix time) try "date -d @1458755647" if you are
> using GNU date ***
> PC: @ 0x0 (unknown)
> *** SIGSEGV (@0x0) received by PID 32287 (TID 0x2baa42a8b700) from PID 0;
> stack trace: ***
> @ 0x2baa89d82ff7 (unknown)
> @ 0x2baa89d87159 (unknown)
> @ 0x2baa394df340 (unknown)
> make[4]: *** [check-local] Segmentation fault
> make[4]: Leaving directory `/mesos/mesos-0.29.0/_build/src'
> make[3]: *** [check-am] Error 2
> make[3]: Leaving directory `/mesos/mesos-0.29.0/_build/src'
> 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-1458753249-29789
> Untagged: mesos-1458753249-29789:latest
> Deleted: 1241bd9b519a71b53a8d48565a91bb6e8e1b140265ab6bb3d6f0f1ad750a153b
> Deleted: 7f2c55799164c719bcc217cafff40680a957c58e9c0937ffbe8ba19e5f535a3c
> Deleted: 32173771bc99ac8ec33e050ae8942493b8dd884499a706425ed8ae2995949377
> Deleted: e6fa12c16c86ca5dfdca99a3e1d532f8bd3d49c30b5e7905758f4f9fafc145ed
> Deleted: f70518e6334861c803685c5d3ff6069f5adf3fe3f46ff10ad51772cfbbb01b31
> Deleted: c09278f84b23429a3751ea7f2503b8d6771cedf05916068fd8bbe5f4ffa834a6
> Deleted: f0f332cbb6d6778ce3b2cf30a9234936da233dde6641c0125960d65fa6851be2
> Deleted: 1f0c71c122995055f0871096e6ed19f0f8367724ab674a85a14e5935e595b446
> Deleted: 2bf4d69c88d650df6c5366eb5ab44fcab9ddbd2ff386203edef81f687bfc9d3b
> Deleted: ac7a6501df08b241be9238dc8aaa240ea86aea60b4a2a36d4bfdc197b226a3f9
> Deleted: dd2690dab55892235efd9d9fe63dc0cae7ded47fd788d31cebaa111d3bc76561
> Deleted: dff4e054d3cbb9649959ec8a29a029a077261db7aaac465163212337a49978e6
> Deleted: 2330cc19e9112636fb385856ec51db686c79d6c0ec54dadf32338145e96e180f
> Deleted: 1bd17ff1d10a10daaebd0ceef76e9a4acf8e0f9020ea34644cc5ead7c1994554
> Deleted: 08678e238ca1662c50a0b3ac2a7d6b103bae184dddb5a578209bc24373b62bd1
> Deleted: 9d3a266ddaf6d490c0841684ebc3b09683109d67afa9d7c9e2a0e8dd02020712
> Build step 'Execute shell' marked build as failure
>
Jenkins build is back to normal : Mesos » clang,--verbose,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=clang,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)/1854/changes>