You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2017/05/25 01:58:37 UTC

Build failed in Jenkins: Mesos-Buildbot » cmake,clang,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3723

See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3723/display/redirect?page=changes>

Changes:

[neil.conway] Added sorter test for allocation queries about inactive clients.

[neil.conway] Added a new sorter test case, `HierarchicalIterationOrder`.

[neil.conway] Added benchmark for allocator perf with many suppressed frameworks.

[neil.conway] Cleaned up allocator benchmark tests.

[neil.conway] Replaced the sorter's notion of "activation" with a three-valued enum.

[neil.conway] Introduced `DRFSorter::Node::isLeaf()`.

[neil.conway] Optimized sorter performance with many inactive clients.

[neil.conway] Added MESOS-7521 to 1.3.0 CHANGELOG.

[neil.conway] Fixed typos in test comments.

------------------------------------------
[...truncated 23.83 MB...]
I0525 01:58:28.371471 24033 whitelist_watcher.cpp:77] No whitelist given
I0525 01:58:28.372051 24040 master.cpp:2161] Elected as the leading master!
I0525 01:58:28.372064 24040 master.cpp:1700] Recovering from registrar
I0525 01:58:28.372115 24038 registrar.cpp:345] Recovering registrar
I0525 01:58:28.372249 24038 registrar.cpp:389] Successfully fetched the registry (0B) in 112896ns
I0525 01:58:28.372288 24038 registrar.cpp:493] Applied 1 operations in 14098ns; attempting to update the registry
I0525 01:58:28.372462 24038 registrar.cpp:550] Successfully updated the registry in 146688ns
I0525 01:58:28.372503 24038 registrar.cpp:422] Successfully recovered registrar
I0525 01:58:28.372593 24038 master.cpp:1799] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0525 01:58:28.372634 24038 hierarchical.cpp:185] Skipping recovery of hierarchical allocator: nothing to recover
I0525 01:58:28.373008 24029 scheduler.cpp:184] Version: 1.4.0
I0525 01:58:28.373199 24036 scheduler.cpp:470] New master detected at master@172.17.0.4:40176
I0525 01:58:28.373216 24036 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0525 01:58:28.374894 24031 scheduler.cpp:361] Connected with the master at http://172.17.0.4:40176/master/api/v1/scheduler
I0525 01:58:28.375514 24039 scheduler.cpp:444] Re-detecting master
I0525 01:58:28.375671 24039 scheduler.cpp:395] Ignoring disconnection attempt from stale connection
I0525 01:58:28.375748 24039 scheduler.cpp:395] Ignoring disconnection attempt from stale connection
I0525 01:58:28.375793 24039 scheduler.cpp:470] New master detected at master@172.17.0.4:40176
I0525 01:58:28.375814 24039 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0525 01:58:28.377709 24037 scheduler.cpp:361] Connected with the master at http://172.17.0.4:40176/master/api/v1/scheduler
I0525 01:58:28.378175 24044 scheduler.cpp:448] Lost leading master
I0525 01:58:28.378422 24044 scheduler.cpp:395] Ignoring disconnection attempt from stale connection
I0525 01:58:28.378576 24044 scheduler.cpp:395] Ignoring disconnection attempt from stale connection
I0525 01:58:28.378918 24040 scheduler.cpp:295] Ignoring reconnect request from scheduler since we are disconnected
I0525 01:58:28.379261 24029 master.cpp:1155] Master terminating
[       OK ] ContentType/SchedulerTest.SchedulerReconnect/0 (11 ms)
[ RUN      ] ContentType/SchedulerTest.SchedulerReconnect/1
I0525 01:58:28.381605 24029 cluster.cpp:162] Creating default 'local' authorizer
I0525 01:58:28.382400 24031 master.cpp:436] Master cbfaa3e1-561c-4834-b4e9-0baa92446563 (51d91f6739ff) started on 172.17.0.4:40176
I0525 01:58:28.382483 24031 master.cpp:438] Flags at startup: --acls="" --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate_agents="true" --authenticate_frameworks="true" --authenticate_http_frameworks="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/SlY9yi/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --port="5050" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/SlY9yi/master" --zk_session_timeout="10secs"
I0525 01:58:28.382645 24031 master.cpp:488] Master only allowing authenticated frameworks to register
I0525 01:58:28.382659 24031 master.cpp:502] Master only allowing authenticated agents to register
I0525 01:58:28.382668 24031 master.cpp:515] Master only allowing authenticated HTTP frameworks to register
I0525 01:58:28.382676 24031 credentials.hpp:37] Loading credentials for authentication from '/tmp/SlY9yi/credentials'
I0525 01:58:28.382802 24031 master.cpp:560] Using default 'crammd5' authenticator
I0525 01:58:28.382845 24031 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0525 01:58:28.382899 24031 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0525 01:58:28.382952 24031 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0525 01:58:28.383002 24031 master.cpp:640] Authorization enabled
I0525 01:58:28.383087 24038 whitelist_watcher.cpp:77] No whitelist given
I0525 01:58:28.383195 24044 hierarchical.cpp:158] Initialized hierarchical allocator process
I0525 01:58:28.383738 24031 master.cpp:2161] Elected as the leading master!
I0525 01:58:28.383750 24031 master.cpp:1700] Recovering from registrar
I0525 01:58:28.383798 24031 registrar.cpp:345] Recovering registrar
I0525 01:58:28.383960 24031 registrar.cpp:389] Successfully fetched the registry (0B) in 141824ns
I0525 01:58:28.383993 24031 registrar.cpp:493] Applied 1 operations in 11940ns; attempting to update the registry
I0525 01:58:28.384205 24031 registrar.cpp:550] Successfully updated the registry in 173312ns
I0525 01:58:28.384246 24031 registrar.cpp:422] Successfully recovered registrar
I0525 01:58:28.384402 24037 master.cpp:1799] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0525 01:58:28.385777 24031 hierarchical.cpp:185] Skipping recovery of hierarchical allocator: nothing to recover
I0525 01:58:28.386142 24029 scheduler.cpp:184] Version: 1.4.0
I0525 01:58:28.386302 24033 scheduler.cpp:470] New master detected at master@172.17.0.4:40176
I0525 01:58:28.386322 24033 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0525 01:58:28.388108 24045 scheduler.cpp:361] Connected with the master at http://172.17.0.4:40176/master/api/v1/scheduler
I0525 01:58:28.388747 24039 scheduler.cpp:444] Re-detecting master
I0525 01:58:28.388804 24039 scheduler.cpp:395] Ignoring disconnection attempt from stale connection
I0525 01:58:28.389199 24034 scheduler.cpp:395] Ignoring disconnection attempt from stale connection
I0525 01:58:28.389430 24034 scheduler.cpp:470] New master detected at master@172.17.0.4:40176
I0525 01:58:28.389580 24034 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0525 01:58:28.391716 24042 scheduler.cpp:361] Connected with the master at http://172.17.0.4:40176/master/api/v1/scheduler
I0525 01:58:28.392232 24042 scheduler.cpp:448] Lost leading master
I0525 01:58:28.392429 24042 scheduler.cpp:395] Ignoring disconnection attempt from stale connection
I0525 01:58:28.392462 24042 scheduler.cpp:395] Ignoring disconnection attempt from stale connection
I0525 01:58:28.392925 24040 scheduler.cpp:295] Ignoring reconnect request from scheduler since we are disconnected
I0525 01:58:28.394013 24029 master.cpp:1155] Master terminating
[       OK ] ContentType/SchedulerTest.SchedulerReconnect/1 (15 ms)
[----------] 30 tests from ContentType/SchedulerTest (2122 ms total)

[----------] 2 tests from ContentTypeAndSSLConfig/SchedulerSSLTest
[ RUN      ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/0
I0525 01:58:28.397882 24029 cluster.cpp:162] Creating default 'local' authorizer
I0525 01:58:28.399626 24039 master.cpp:436] Master 61be2685-a9e6-449f-b98c-ed49ae15bd64 (51d91f6739ff) started on 172.17.0.4:40176
I0525 01:58:28.399655 24039 master.cpp:438] Flags at startup: --acls="" --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate_agents="true" --authenticate_frameworks="true" --authenticate_http_frameworks="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/etvdFa/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --port="5050" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/etvdFa/master" --zk_session_timeout="10secs"
I0525 01:58:28.399827 24039 master.cpp:488] Master only allowing authenticated frameworks to register
I0525 01:58:28.399979 24039 master.cpp:502] Master only allowing authenticated agents to register
I0525 01:58:28.400076 24039 master.cpp:515] Master only allowing authenticated HTTP frameworks to register
I0525 01:58:28.400148 24039 credentials.hpp:37] Loading credentials for authentication from '/tmp/etvdFa/credentials'
I0525 01:58:28.400385 24039 master.cpp:560] Using default 'crammd5' authenticator
I0525 01:58:28.400532 24039 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0525 01:58:28.400665 24039 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0525 01:58:28.400786 24039 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0525 01:58:28.400971 24039 master.cpp:640] Authorization enabled
I0525 01:58:28.401266 24045 hierarchical.cpp:158] Initialized hierarchical allocator process
I0525 01:58:28.401381 24045 whitelist_watcher.cpp:77] No whitelist given
I0525 01:58:28.402393 24039 master.cpp:2161] Elected as the leading master!
I0525 01:58:28.402411 24039 master.cpp:1700] Recovering from registrar
I0525 01:58:28.402482 24038 registrar.cpp:345] Recovering registrar
I0525 01:58:28.402701 24038 registrar.cpp:389] Successfully fetched the registry (0B) in 196864ns
I0525 01:58:28.402747 24038 registrar.cpp:493] Applied 1 operations in 14268ns; attempting to update the registry
I0525 01:58:28.402978 24038 registrar.cpp:550] Successfully updated the registry in 208896ns
I0525 01:58:28.403023 24038 registrar.cpp:422] Successfully recovered registrar
I0525 01:58:28.403223 24039 master.cpp:1799] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0525 01:58:28.403316 24039 hierarchical.cpp:185] Skipping recovery of hierarchical allocator: nothing to recover
I0525 01:58:28.406204 24029 cluster.cpp:448] Creating default 'local' authorizer
I0525 01:58:28.406864 24032 slave.cpp:225] Mesos agent started on (700)@172.17.0.4:40176
I0525 01:58:28.407073 24029 scheduler.cpp:184] Version: 1.4.0
I0525 01:58:28.406903 24032 slave.cpp:226] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --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/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_0_EXC4TU/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" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_0_EXC4TU/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_0_EXC4TU/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_0_EXC4TU" --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/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_0_DirDM2"
I0525 01:58:28.407145 24032 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_0_EXC4TU/credential'
I0525 01:58:28.407258 24032 slave.cpp:258] Agent using credential for: test-principal
I0525 01:58:28.407271 24032 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_0_EXC4TU/http_credentials'
I0525 01:58:28.407392 24032 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0525 01:58:28.407449 24032 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0525 01:58:28.407933 24032 slave.cpp:529] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0525 01:58:28.407979 24032 slave.cpp:537] Agent attributes: [  ]
I0525 01:58:28.407985 24032 slave.cpp:542] Agent hostname: 51d91f6739ff
I0525 01:58:28.408571 24032 scheduler.cpp:470] New master detected at master@172.17.0.4:40176
I0525 01:58:28.408593 24032 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0525 01:58:28.409049 24036 state.cpp:62] Recovering state from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_0_DirDM2/meta'
I0525 01:58:28.409235 24030 status_update_manager.cpp:177] Pausing sending status updates
I0525 01:58:28.409266 24030 status_update_manager.cpp:203] Recovering status update manager
I0525 01:58:28.409386 24030 slave.cpp:5976] Finished recovery
I0525 01:58:28.410388 24030 slave.cpp:6158] Querying resource estimator for oversubscribable resources
I0525 01:58:28.410399 24042 scheduler.cpp:361] Connected with the master at http://172.17.0.4:40176/master/api/v1/scheduler
I0525 01:58:28.410533 24030 slave.cpp:922] New master detected at master@172.17.0.4:40176
I0525 01:58:28.410562 24035 status_update_manager.cpp:177] Pausing sending status updates
I0525 01:58:28.412415 24030 slave.cpp:957] Detecting new master
I0525 01:58:28.412766 24030 slave.cpp:6172] Received oversubscribable resources {} from the resource estimator
I0525 01:58:28.413535 24044 scheduler.cpp:243] Sending SUBSCRIBE call to http://172.17.0.4:40176/master/api/v1/scheduler
I0525 01:58:28.414194 24044 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0525 01:58:28.414789 24044 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:50136
I0525 01:58:28.415050 24044 master.cpp:2513] Received subscription request for HTTP framework 'default'
I0525 01:58:28.415228 24044 master.cpp:2197] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0525 01:58:28.415390 24032 slave.cpp:984] Authenticating with master master@172.17.0.4:40176
I0525 01:58:28.415417 24032 slave.cpp:995] Using default CRAM-MD5 authenticatee
I0525 01:58:28.415551 24032 authenticatee.cpp:121] Creating new client SASL connection
I0525 01:58:28.415743 24044 master.cpp:2628] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I0525 01:58:28.415944 24044 master.cpp:7487] Authenticating slave(700)@172.17.0.4:40176
I0525 01:58:28.416077 24044 hierarchical.cpp:273] Added framework 61be2685-a9e6-449f-b98c-ed49ae15bd64-0000
I0525 01:58:28.416131 24044 hierarchical.cpp:1854] No allocations performed
I0525 01:58:28.416144 24044 hierarchical.cpp:1944] No inverse offers to send out!
I0525 01:58:28.416154 24044 hierarchical.cpp:1438] Performed allocation for 0 agents in 36271ns
I0525 01:58:28.416219 24044 master.hpp:2194] Sending heartbeat to 61be2685-a9e6-449f-b98c-ed49ae15bd64-0000
I0525 01:58:28.416265 24044 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1291)@172.17.0.4:40176
I0525 01:58:28.416337 24044 authenticator.cpp:98] Creating new server SASL connection
I0525 01:58:28.416461 24044 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0525 01:58:28.416483 24044 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0525 01:58:28.416517 24044 authenticator.cpp:204] Received SASL authentication start
I0525 01:58:28.416568 24044 authenticator.cpp:326] Authentication requires more steps
I0525 01:58:28.416602 24044 authenticatee.cpp:259] Received SASL authentication step
I0525 01:58:28.416651 24044 authenticator.cpp:232] Received SASL authentication step
I0525 01:58:28.416669 24044 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '51d91f6739ff' server FQDN: '51d91f6739ff' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0525 01:58:28.416679 24044 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0525 01:58:28.416694 24044 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0525 01:58:28.416710 24044 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '51d91f6739ff' server FQDN: '51d91f6739ff' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0525 01:58:28.416718 24044 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0525 01:58:28.416724 24044 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0525 01:58:28.416738 24044 authenticator.cpp:318] Authentication success
I0525 01:58:28.416779 24044 authenticatee.cpp:299] Authentication success
I0525 01:58:28.416806 24044 master.cpp:7517] Successfully authenticated principal 'test-principal' at slave(700)@172.17.0.4:40176
I0525 01:58:28.416839 24044 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1291)@172.17.0.4:40176
I0525 01:58:28.416911 24044 slave.cpp:1079] Successfully authenticated with master master@172.17.0.4:40176
I0525 01:58:28.416972 24044 slave.cpp:1507] Will retry registration in 1.025756ms if necessary
I0525 01:58:28.417071 24044 master.cpp:5429] Received register agent message from slave(700)@172.17.0.4:40176 (51d91f6739ff)
I0525 01:58:28.417090 24044 master.cpp:3659] Authorizing agent with principal 'test-principal'
I0525 01:58:28.417214 24044 master.cpp:5489] Authorized registration of agent at slave(700)@172.17.0.4:40176 (51d91f6739ff)
I0525 01:58:28.417268 24044 master.cpp:5568] Registering agent at slave(700)@172.17.0.4:40176 (51d91f6739ff) with id 61be2685-a9e6-449f-b98c-ed49ae15bd64-S0
I0525 01:58:28.417414 24044 registrar.cpp:493] Applied 1 operations in 27384ns; attempting to update the registry
I0525 01:58:28.417615 24044 registrar.cpp:550] Successfully updated the registry in 177920ns
I0525 01:58:28.417711 24044 master.cpp:5615] Admitted agent 61be2685-a9e6-449f-b98c-ed49ae15bd64-S0 at slave(700)@172.17.0.4:40176 (51d91f6739ff)
I0525 01:58:28.417923 24044 master.cpp:5646] Registered agent 61be2685-a9e6-449f-b98c-ed49ae15bd64-S0 at slave(700)@172.17.0.4:40176 (51d91f6739ff) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0525 01:58:28.418078 24044 hierarchical.cpp:525] Added agent 61be2685-a9e6-449f-b98c-ed49ae15bd64-S0 (51d91f6739ff) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0525 01:58:28.418392 24044 hierarchical.cpp:1944] No inverse offers to send out!
I0525 01:58:28.418411 24044 hierarchical.cpp:1438] Performed allocation for 1 agents in 280683ns
I0525 01:58:28.418443 24044 slave.cpp:1125] Registered with master master@172.17.0.4:40176; given agent ID 61be2685-a9e6-449f-b98c-ed49ae15bd64-S0
I0525 01:58:28.418458 24044 fetcher.cpp:94] Clearing fetcher cache
I0525 01:58:28.418812 24044 slave.cpp:1153] Checkpointing SlaveInfo to '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_0_DirDM2/meta/slaves/61be2685-a9e6-449f-b98c-ed49ae15bd64-S0/slave.info'
I0525 01:58:28.419116 24044 slave.cpp:1191] Forwarding total oversubscribed resources {}
I0525 01:58:28.419160 24044 slave.cpp:4751] Received ping from slave-observer(633)@172.17.0.4:40176
I0525 01:58:28.419344 24044 master.cpp:7317] Sending 1 offers to framework 61be2685-a9e6-449f-b98c-ed49ae15bd64-0000 (default)
I0525 01:58:28.419513 24044 master.cpp:6336] Received update of agent 61be2685-a9e6-449f-b98c-ed49ae15bd64-S0 at slave(700)@172.17.0.4:40176 (51d91f6739ff) with total oversubscribed resources {}
I0525 01:58:28.419587 24044 status_update_manager.cpp:184] Resuming sending status updates
I0525 01:58:28.420680 24044 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from http://172.17.0.4:40176/master/api/v1/scheduler
I0525 01:58:28.420907 24044 scheduler.cpp:676] Enqueuing event HEARTBEAT received from http://172.17.0.4:40176/master/api/v1/scheduler
I0525 01:58:28.421229 24044 scheduler.cpp:676] Enqueuing event OFFERS received from http://172.17.0.4:40176/master/api/v1/scheduler
I0525 01:58:28.422263 24033 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.4:40176/master/api/v1/scheduler
I0525 01:58:28.422957 24033 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0525 01:58:28.423527 24033 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:50137
I0525 01:58:28.424015 24033 master.cpp:3875] Processing ACCEPT call for offers: [ 61be2685-a9e6-449f-b98c-ed49ae15bd64-O0 ] on agent 61be2685-a9e6-449f-b98c-ed49ae15bd64-S0 at slave(700)@172.17.0.4:40176 (51d91f6739ff) for framework 61be2685-a9e6-449f-b98c-ed49ae15bd64-0000 (default)
I0525 01:58:28.424232 24033 master.cpp:3426] Authorizing framework principal 'test-principal' to launch task 22ce6f25-4b69-441f-9282-6b5f520ca2de
W0525 01:58:28.425377 24033 validation.cpp:1284] Executor 'default' for task '22ce6f25-4b69-441f-9282-6b5f520ca2de' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0525 01:58:28.425897 24033 validation.cpp:1296] Executor 'default' for task '22ce6f25-4b69-441f-9282-6b5f520ca2de' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0525 01:58:28.426198 24033 master.cpp:9338] Adding task 22ce6f25-4b69-441f-9282-6b5f520ca2de with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 61be2685-a9e6-449f-b98c-ed49ae15bd64-S0 at slave(700)@172.17.0.4:40176 (51d91f6739ff)
I0525 01:58:28.426476 24033 master.cpp:4531] Launching task 22ce6f25-4b69-441f-9282-6b5f520ca2de of framework 61be2685-a9e6-449f-b98c-ed49ae15bd64-0000 (default) with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 61be2685-a9e6-449f-b98c-ed49ae15bd64-S0 at slave(700)@172.17.0.4:40176 (51d91f6739ff)
I0525 01:58:28.426849 24039 slave.cpp:1617] Got assigned task '22ce6f25-4b69-441f-9282-6b5f520ca2de' for framework 61be2685-a9e6-449f-b98c-ed49ae15bd64-0000
I0525 01:58:28.427248 24039 slave.cpp:1898] Authorizing task '22ce6f25-4b69-441f-9282-6b5f520ca2de' for framework 61be2685-a9e6-449f-b98c-ed49ae15bd64-0000
I0525 01:58:28.427278 24039 slave.cpp:6595] Authorizing framework principal 'test-principal' to launch task 22ce6f25-4b69-441f-9282-6b5f520ca2de
I0525 01:58:28.427613 24039 slave.cpp:2085] Launching task '22ce6f25-4b69-441f-9282-6b5f520ca2de' for framework 61be2685-a9e6-449f-b98c-ed49ae15bd64-0000
I0525 01:58:28.427814 24033 hierarchical.cpp:850] Updated allocation of framework 61be2685-a9e6-449f-b98c-ed49ae15bd64-0000 on agent 61be2685-a9e6-449f-b98c-ed49ae15bd64-S0 from cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] to cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000]
I0525 01:58:28.428213 24039 paths.cpp:573] Trying to chown '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_0_DirDM2/slaves/61be2685-a9e6-449f-b98c-ed49ae15bd64-S0/frameworks/61be2685-a9e6-449f-b98c-ed49ae15bd64-0000/executors/default/runs/56ad26fe-98ee-463c-91cc-8a42e10bbd20' to user 'mesos'
I0525 01:58:28.428544 24039 slave.cpp:6935] Launching executor 'default' of framework 61be2685-a9e6-449f-b98c-ed49ae15bd64-0000 with resources {} in work directory '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_0_DirDM2/slaves/61be2685-a9e6-449f-b98c-ed49ae15bd64-S0/frameworks/61be2685-a9e6-449f-b98c-ed49ae15bd64-0000/executors/default/runs/56ad26fe-98ee-463c-91cc-8a42e10bbd20'
I0525 01:58:28.428793 24039 slave.cpp:2314] Queued task '22ce6f25-4b69-441f-9282-6b5f520ca2de' for executor 'default' of framework 61be2685-a9e6-449f-b98c-ed49ae15bd64-0000
I0525 01:58:28.429867 24041 slave.cpp:875] Successfully attached file '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_0_DirDM2/slaves/61be2685-a9e6-449f-b98c-ed49ae15bd64-S0/frameworks/61be2685-a9e6-449f-b98c-ed49ae15bd64-0000/executors/default/runs/56ad26fe-98ee-463c-91cc-8a42e10bbd20'
I0525 01:58:28.430217 24039 executor.cpp:192] Version: 1.4.0
I0525 01:58:28.431134 24031 executor.cpp:410] Connected with the agent
I0525 01:58:28.431339 24031 executor.cpp:307] Sending SUBSCRIBE call to http://172.17.0.4:40176/slave(700)/api/v1/executor
I0525 01:58:28.431922 24030 process.cpp:3730] Handling HTTP event for process 'slave(700)' with path: '/slave(700)/api/v1/executor'
I0525 01:58:28.432221 24030 http.cpp:1115] HTTP POST for /slave(700)/api/v1/executor from 172.17.0.4:50138
I0525 01:58:28.432304 24030 slave.cpp:3572] Received Subscribe request for HTTP executor 'default' of framework 61be2685-a9e6-449f-b98c-ed49ae15bd64-0000
I0525 01:58:28.433382 24032 executor.cpp:725] Enqueuing event SUBSCRIBED received from http://172.17.0.4:40176/slave(700)/api/v1/executor
*** Aborted at 1495677508 (unix time) try "date -d @1495677508" if you are using GNU date ***
PC: @          0x2ce7f11 testing::internal::UntypedFunctionMockerBase::SetOwnerAndName()
*** SIGSEGV (@0x0) received by PID 24029 (TID 0x2acc554c1700) from PID 0; stack trace: ***
    @     0x2acc4d6d2330 (unknown)
    @          0x2ce7f11 testing::internal::UntypedFunctionMockerBase::SetOwnerAndName()
    @           0xd1759b mesos::internal::tests::executor::MockHTTPExecutor<>::subscribed()
    @           0xd16aa1 mesos::internal::tests::executor::TestMesos<>::events()
    @           0xd16c5a std::_Function_handler<>::_M_invoke()
    @     0x2acc4949640c process::AsyncExecutorProcess::execute<>()
    @     0x2acc49496f71 _ZZN7process8dispatchI7NothingNS_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v18executor5EventESt5dequeIS8_SaIS8_EEEEESC_SG_SC_EENS_6FutureIT_EERKNS_3PIDIT0_EEMSN_FSK_T1_T2_ET3_T4_ENKUlPNS_11ProcessBaseEE_clESY_
    @     0x2acc4a8b1717 process::ProcessManager::resume()
    @     0x2acc4a8c6b9f std::thread::_Impl<>::_M_run()
    @     0x2acc4d991a60 (unknown)
    @     0x2acc4d6ca184 start_thread
    @     0x2acc4e1fdbed (unknown)
make[3]: Leaving directory `/mesos/build'
make[3]: *** [CMakeFiles/check] Segmentation fault
make[2]: Leaving directory `/mesos/build'
make[2]: *** [CMakeFiles/check.dir/all] Error 2
make[1]: *** [CMakeFiles/check.dir/rule] Error 2
make[1]: Leaving directory `/mesos/build'
make: *** [check] Error 2
+ docker rmi mesos-1495675163-18479
Untagged: mesos-1495675163-18479:latest
Deleted: sha256:61b55551cadc1201d3efc6f5c39e05d499e8d2d8302b8f06611a7e82a09044d0
Deleted: sha256:a36dc00f476a19f1d24e568e1eba045179dc52150028530a09b1acec521afb0e
Deleted: sha256:95afe76b441d9bd12ee9200948109376dea971212c5ef186f8a659ff002debf5
Deleted: sha256:b316ad14a1740d1cfb1250a43706ce181679ed8cbac4c2bb5b471cd1c4c3ba77
Deleted: sha256:5424eb2bf51ac8b8489bf8f589886b246e154d65606dad23adb27d94722da631
Deleted: sha256:009e80f08bd69c55f4f91621d0786a5cc5ccb9dd9038062e97f3ca70b6886b6a
Deleted: sha256:0467ac2a0fc61d1077e5dbff22571d2d8308b3a1294c3e5f257056c7a5365f2c
Deleted: sha256:068d2659f46837c136e75459abbe6f7efcc076793a24f4dd03aa49e48bd1a73f
Deleted: sha256:e339851932456760e4da2aa143d593a3f85e5ee6f5c75dea8a267cad5ed7233f
Deleted: sha256:a0e1d50de11eb4aba7a6e3f77cf11131d53adc342e6cec0fa19fc1f9aa783b1b
Deleted: sha256:988857c23f16b59272d65160d05979d5f779df839e328ce098627c441e377c24
Deleted: sha256:c862fca97c6f0061f0536166b1235c106c7d825602bf03de886b6cb64c31b787
Deleted: sha256:e9598b5c1ed2b5ae49f80a0048e03147dbd392197fbcfd37c6377d0851a46f3e
Deleted: sha256:6214769a85ea8b4af96a2fd9c34eddd0fa2f3b50f6c81f807a41e19b70f4b24c
Deleted: sha256:cf8e555e50a29c7396651153c2ecb968a592da4bdb903a02b730e41d70aa3ea9
Deleted: sha256:b07e3500bf254f3efa378dd162f5a516604ede4c4a16fc4e3136d70f6ec71001
Deleted: sha256:c637c42a12e25f2f45cef20a6e92285577b31af6b2abb8e3cd14fdbfe9ba72ae
Deleted: sha256:3874b59234882c6514fd05184045b5e6fc0480a18b6dfbbd33501d89bca79306
Deleted: sha256:c91406e9407eb6a23d6ad045ac5cefab026c098be0e62e7a11422e8a7d3f7a01
Deleted: sha256:316fd50bebf326744bea80fbdda63439e3b555a376746327009e528d95496a6a
Deleted: sha256:a7bba53520c85dd501ea1ab4db7bad3e101867393b9057986b1239a5f0592a6e
Deleted: sha256:289bc3a9504ebef15b69a25181a4ad62c5c8b4f64a5ae31c9c5ac0e6862e82e8
Deleted: sha256:efacf9ec29a41ec3fcd60b270ef78b11d0ea827c14ed1b6c1d4cb5f8c3dbc811
Deleted: sha256:59a374735bd9f52785b8083a910b9af0327c55c745980c52e48c78e5841a06d9
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user neil.conway@gmail.com

Jenkins build is back to normal : Mesos-Buildbot » cmake,clang,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3724

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3724/display/redirect>