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/08/08 00:05:18 UTC
Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #4076
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/4076/display/redirect?page=changes>
Changes:
[yujie.jay] Removed an unused function in src/linux/ns.hpp.
[yujie.jay] Added an async signal safe ASSERT to stout.
[yujie.jay] Used clone instead of fork in ns::clone.
[yujie.jay] Used async signal safe assert in ns::clone.
------------------------------------------
[...truncated 10.40 MB...]
I0808 00:05:10.256296 7550 slave.cpp:843] Agent terminating
I0808 00:05:10.256552 7575 master.cpp:1318] Agent f6d95c66-f4f6-45a1-95a3-79909639dbed-S0 at slave(125)@172.17.0.3:45503 (5da4e909c2b9) disconnected
I0808 00:05:10.256590 7575 master.cpp:3301] Disconnecting agent f6d95c66-f4f6-45a1-95a3-79909639dbed-S0 at slave(125)@172.17.0.3:45503 (5da4e909c2b9)
I0808 00:05:10.256701 7575 master.cpp:3320] Deactivating agent f6d95c66-f4f6-45a1-95a3-79909639dbed-S0 at slave(125)@172.17.0.3:45503 (5da4e909c2b9)
I0808 00:05:10.256893 7571 hierarchical.cpp:690] Agent f6d95c66-f4f6-45a1-95a3-79909639dbed-S0 deactivated
I0808 00:05:10.262910 7550 slave.cpp:843] Agent terminating
I0808 00:05:10.263121 7575 master.cpp:1318] Agent f6d95c66-f4f6-45a1-95a3-79909639dbed-S1 at slave(126)@172.17.0.3:45503 (5da4e909c2b9) disconnected
I0808 00:05:10.263160 7575 master.cpp:3301] Disconnecting agent f6d95c66-f4f6-45a1-95a3-79909639dbed-S1 at slave(126)@172.17.0.3:45503 (5da4e909c2b9)
I0808 00:05:10.263267 7575 master.cpp:3320] Deactivating agent f6d95c66-f4f6-45a1-95a3-79909639dbed-S1 at slave(126)@172.17.0.3:45503 (5da4e909c2b9)
I0808 00:05:10.263455 7581 hierarchical.cpp:690] Agent f6d95c66-f4f6-45a1-95a3-79909639dbed-S1 deactivated
I0808 00:05:10.268824 7550 slave.cpp:843] Agent terminating
I0808 00:05:10.269047 7584 master.cpp:1318] Agent f6d95c66-f4f6-45a1-95a3-79909639dbed-S2 at slave(127)@172.17.0.3:45503 (5da4e909c2b9) disconnected
I0808 00:05:10.269090 7584 master.cpp:3301] Disconnecting agent f6d95c66-f4f6-45a1-95a3-79909639dbed-S2 at slave(127)@172.17.0.3:45503 (5da4e909c2b9)
I0808 00:05:10.269171 7584 master.cpp:3320] Deactivating agent f6d95c66-f4f6-45a1-95a3-79909639dbed-S2 at slave(127)@172.17.0.3:45503 (5da4e909c2b9)
I0808 00:05:10.269353 7573 hierarchical.cpp:690] Agent f6d95c66-f4f6-45a1-95a3-79909639dbed-S2 deactivated
I0808 00:05:10.274441 7550 master.cpp:1160] Master terminating
I0808 00:05:10.275092 7575 hierarchical.cpp:626] Removed agent f6d95c66-f4f6-45a1-95a3-79909639dbed-S2
I0808 00:05:10.275674 7575 hierarchical.cpp:626] Removed agent f6d95c66-f4f6-45a1-95a3-79909639dbed-S1
I0808 00:05:10.276331 7575 hierarchical.cpp:626] Removed agent f6d95c66-f4f6-45a1-95a3-79909639dbed-S0
[ OK ] MasterAllocatorTest/0.RebalancedForUpdatedWeights (173 ms)
[ RUN ] MasterAllocatorTest/0.NestedRoles
I0808 00:05:10.286327 7550 cluster.cpp:162] Creating default 'local' authorizer
I0808 00:05:10.289801 7569 master.cpp:442] Master f9f88a46-cbbd-4b71-bd3e-697615298a3d (5da4e909c2b9) started on 172.17.0.3:45503
I0808 00:05:10.289827 7569 master.cpp:444] 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/36oMY6/credentials" --filter_gpu_resources="true" --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="/mesos/mesos-1.4.0/_inst/share/mesos/webui" --work_dir="/tmp/36oMY6/master" --zk_session_timeout="10secs"
I0808 00:05:10.290091 7569 master.cpp:494] Master only allowing authenticated frameworks to register
I0808 00:05:10.290107 7569 master.cpp:508] Master only allowing authenticated agents to register
I0808 00:05:10.290122 7569 master.cpp:521] Master only allowing authenticated HTTP frameworks to register
I0808 00:05:10.290136 7569 credentials.hpp:37] Loading credentials for authentication from '/tmp/36oMY6/credentials'
I0808 00:05:10.290393 7569 master.cpp:566] Using default 'crammd5' authenticator
I0808 00:05:10.290599 7569 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0808 00:05:10.290774 7569 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0808 00:05:10.290967 7569 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0808 00:05:10.291141 7569 master.cpp:646] Authorization enabled
I0808 00:05:10.291311 7572 hierarchical.cpp:171] Initialized hierarchical allocator process
I0808 00:05:10.291366 7582 whitelist_watcher.cpp:77] No whitelist given
I0808 00:05:10.293992 7571 master.cpp:2163] Elected as the leading master!
I0808 00:05:10.294039 7571 master.cpp:1702] Recovering from registrar
I0808 00:05:10.294158 7578 registrar.cpp:347] Recovering registrar
I0808 00:05:10.294868 7578 registrar.cpp:391] Successfully fetched the registry (0B) in 0ns
I0808 00:05:10.294984 7578 registrar.cpp:495] Applied 1 operations in 33182ns; attempting to update the registry
I0808 00:05:10.295537 7578 registrar.cpp:552] Successfully updated the registry in 0ns
I0808 00:05:10.295637 7578 registrar.cpp:424] Successfully recovered registrar
I0808 00:05:10.296000 7573 master.cpp:1801] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0808 00:05:10.296067 7576 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
I0808 00:05:10.300284 7550 process.cpp:3228] Attempting to spawn already spawned process files@172.17.0.3:45503
I0808 00:05:10.300529 7550 cluster.cpp:448] Creating default 'local' authorizer
I0808 00:05:10.302392 7577 slave.cpp:250] Mesos agent started on (128)@172.17.0.3:45503
I0808 00:05:10.302872 7550 process.cpp:3228] Attempting to spawn already spawned process version@172.17.0.3:45503
I0808 00:05:10.302422 7577 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/MasterAllocatorTest_0_NestedRoles_Xf6Bsc/store/appc" --authenticate_http_executors="true" --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/MasterAllocatorTest_0_NestedRoles_Xf6Bsc/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/MasterAllocatorTest_0_NestedRoles_Xf6Bsc/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_secret_key="/tmp/MasterAllocatorTest_0_NestedRoles_Xf6Bsc/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/MasterAllocatorTest_0_NestedRoles_Xf6Bsc/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/MasterAllocatorTest_0_NestedRoles_Xf6Bsc/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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;mem:1024" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/MasterAllocatorTest_0_NestedRoles_Xf6Bsc" --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/MasterAllocatorTest_0_NestedRoles_VPQGIE"
I0808 00:05:10.303094 7577 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterAllocatorTest_0_NestedRoles_Xf6Bsc/credential'
I0808 00:05:10.303349 7577 slave.cpp:283] Agent using credential for: test-principal
I0808 00:05:10.303370 7577 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterAllocatorTest_0_NestedRoles_Xf6Bsc/http_credentials'
I0808 00:05:10.303692 7577 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0808 00:05:10.303903 7577 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0808 00:05:10.303922 7550 sched.cpp:232] Version: 1.4.0
I0808 00:05:10.303937 7576 hierarchical.cpp:1925] No allocations performed
I0808 00:05:10.304038 7576 hierarchical.cpp:1468] Performed allocation for 0 agents in 136787ns
I0808 00:05:10.304244 7577 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0808 00:05:10.304364 7577 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0808 00:05:10.304533 7574 sched.cpp:336] New master detected at master@172.17.0.3:45503
I0808 00:05:10.304647 7577 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0808 00:05:10.304662 7574 sched.cpp:407] Authenticating with master master@172.17.0.3:45503
I0808 00:05:10.304682 7574 sched.cpp:414] Using default CRAM-MD5 authenticatee
I0808 00:05:10.304796 7577 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0808 00:05:10.304988 7583 authenticatee.cpp:121] Creating new client SASL connection
I0808 00:05:10.305269 7576 master.cpp:7837] Authenticating scheduler-5de46c07-8397-4bf5-bbb7-59e176b35131@172.17.0.3:45503
I0808 00:05:10.305393 7569 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(277)@172.17.0.3:45503
I0808 00:05:10.305652 7580 authenticator.cpp:98] Creating new server SASL connection
I0808 00:05:10.305846 7572 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0808 00:05:10.305871 7572 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0808 00:05:10.305974 7573 authenticator.cpp:204] Received SASL authentication start
I0808 00:05:10.306041 7573 authenticator.cpp:326] Authentication requires more steps
I0808 00:05:10.306174 7571 authenticatee.cpp:259] Received SASL authentication step
I0808 00:05:10.306309 7571 authenticator.cpp:232] Received SASL authentication step
I0808 00:05:10.306339 7571 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '5da4e909c2b9' server FQDN: '5da4e909c2b9' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0808 00:05:10.306360 7571 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0808 00:05:10.306183 7577 slave.cpp:565] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":3701220.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0808 00:05:10.306406 7577 slave.cpp:573] Agent attributes: [ ]
I0808 00:05:10.306426 7577 slave.cpp:582] Agent hostname: 5da4e909c2b9
I0808 00:05:10.306421 7571 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0808 00:05:10.306483 7571 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '5da4e909c2b9' server FQDN: '5da4e909c2b9' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0808 00:05:10.306583 7584 status_update_manager.cpp:177] Pausing sending status updates
I0808 00:05:10.306641 7571 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0808 00:05:10.306707 7571 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0808 00:05:10.306757 7571 authenticator.cpp:318] Authentication success
I0808 00:05:10.306882 7570 authenticatee.cpp:299] Authentication success
I0808 00:05:10.306924 7582 master.cpp:7867] Successfully authenticated principal 'test-principal' at scheduler-5de46c07-8397-4bf5-bbb7-59e176b35131@172.17.0.3:45503
I0808 00:05:10.307045 7571 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(277)@172.17.0.3:45503
I0808 00:05:10.307272 7579 sched.cpp:513] Successfully authenticated with master master@172.17.0.3:45503
I0808 00:05:10.307293 7579 sched.cpp:836] Sending SUBSCRIBE call to master@172.17.0.3:45503
I0808 00:05:10.307435 7579 sched.cpp:869] Will retry registration in 982.373908ms if necessary
*** Aborted at 1502150710 (unix time) try "date -d @1502150710" if you are using GNU date ***
I0808 00:05:10.307608 7569 master.cpp:2894] Received SUBSCRIBE call for framework 'default' at scheduler-5de46c07-8397-4bf5-bbb7-59e176b35131@172.17.0.3:45503
I0808 00:05:10.307770 7569 master.cpp:2228] Authorizing framework principal 'test-principal' to receive offers for roles '{ a/b }'
I0808 00:05:10.308238 7575 state.cpp:64] Recovering state from '/tmp/MasterAllocatorTest_0_NestedRoles_VPQGIE/meta'
I0808 00:05:10.308357 7569 master.cpp:2974] Subscribing framework default with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
I0808 00:05:10.308619 7576 status_update_manager.cpp:203] Recovering status update manager
I0808 00:05:10.308955 7581 sched.cpp:759] Framework registered with f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000
I0808 00:05:10.309022 7581 sched.cpp:773] Scheduler::registered took 35254ns
I0808 00:05:10.309075 7572 slave.cpp:6207] Finished recovery
I0808 00:05:10.309126 7579 hierarchical.cpp:303] Added framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000
I0808 00:05:10.309337 7579 hierarchical.cpp:1925] No allocations performed
I0808 00:05:10.309447 7579 hierarchical.cpp:2015] No inverse offers to send out!
I0808 00:05:10.309496 7579 hierarchical.cpp:1468] Performed allocation for 0 agents in 206274ns
I0808 00:05:10.309630 7572 slave.cpp:6389] Querying resource estimator for oversubscribable resources
I0808 00:05:10.309842 7575 status_update_manager.cpp:177] Pausing sending status updates
I0808 00:05:10.309864 7572 slave.cpp:971] New master detected at master@172.17.0.3:45503
I0808 00:05:10.309934 7572 slave.cpp:1006] Detecting new master
I0808 00:05:10.310068 7572 slave.cpp:6403] Received oversubscribable resources {} from the resource estimator
I0808 00:05:10.310168 7572 slave.cpp:1033] Authenticating with master master@172.17.0.3:45503
I0808 00:05:10.310245 7572 slave.cpp:1044] Using default CRAM-MD5 authenticatee
I0808 00:05:10.310461 7571 authenticatee.cpp:121] Creating new client SASL connection
I0808 00:05:10.310715 7583 master.cpp:7837] Authenticating slave(128)@172.17.0.3:45503
I0808 00:05:10.310827 7578 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(278)@172.17.0.3:45503
I0808 00:05:10.311048 7580 authenticator.cpp:98] Creating new server SASL connection
I0808 00:05:10.311239 7573 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0808 00:05:10.311264 7573 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0808 00:05:10.311385 7573 authenticator.cpp:204] Received SASL authentication start
I0808 00:05:10.311449 7573 authenticator.cpp:326] Authentication requires more steps
I0808 00:05:10.311568 7576 authenticatee.cpp:259] Received SASL authentication step
I0808 00:05:10.311695 7581 authenticator.cpp:232] Received SASL authentication step
I0808 00:05:10.311736 7581 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '5da4e909c2b9' server FQDN: '5da4e909c2b9' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0808 00:05:10.311774 7581 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0808 00:05:10.311820 7581 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0808 00:05:10.311851 7581 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '5da4e909c2b9' server FQDN: '5da4e909c2b9' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0808 00:05:10.311868 7581 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0808 00:05:10.311882 7581 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0808 00:05:10.311903 7581 authenticator.cpp:318] Authentication success
I0808 00:05:10.311998 7569 authenticatee.cpp:299] Authentication success
I0808 00:05:10.312065 7579 master.cpp:7867] Successfully authenticated principal 'test-principal' at slave(128)@172.17.0.3:45503
I0808 00:05:10.312124 7574 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(278)@172.17.0.3:45503
I0808 00:05:10.312381 7569 slave.cpp:1128] Successfully authenticated with master master@172.17.0.3:45503
I0808 00:05:10.312597 7569 slave.cpp:1572] Will retry registration in 15.474288ms if necessary
I0808 00:05:10.312739 7571 master.cpp:5712] Received register agent message from slave(128)@172.17.0.3:45503 (5da4e909c2b9)
I0808 00:05:10.312857 7571 master.cpp:3803] Authorizing agent with principal 'test-principal'
I0808 00:05:10.313194 7578 master.cpp:5772] Authorized registration of agent at slave(128)@172.17.0.3:45503 (5da4e909c2b9)
I0808 00:05:10.313292 7578 master.cpp:5865] Registering agent at slave(128)@172.17.0.3:45503 (5da4e909c2b9) with id f9f88a46-cbbd-4b71-bd3e-697615298a3d-S0
I0808 00:05:10.313701 7580 registrar.cpp:495] Applied 1 operations in 50130ns; attempting to update the registry
I0808 00:05:10.314255 7580 registrar.cpp:552] Successfully updated the registry in 0ns
I0808 00:05:10.314406 7575 master.cpp:5912] Admitted agent f9f88a46-cbbd-4b71-bd3e-697615298a3d-S0 at slave(128)@172.17.0.3:45503 (5da4e909c2b9)
I0808 00:05:10.314949 7582 slave.cpp:4883] Received ping from slave-observer(123)@172.17.0.3:45503
I0808 00:05:10.315158 7569 slave.cpp:1174] Registered with master master@172.17.0.3:45503; given agent ID f9f88a46-cbbd-4b71-bd3e-697615298a3d-S0
I0808 00:05:10.315313 7583 status_update_manager.cpp:184] Resuming sending status updates
I0808 00:05:10.315374 7574 hierarchical.cpp:593] Added agent f9f88a46-cbbd-4b71-bd3e-697615298a3d-S0 (5da4e909c2b9) with cpus:2; mem:1024; disk:3701220; ports:[31000-32000] (allocated: {})
I0808 00:05:10.315107 7575 master.cpp:5943] Registered agent f9f88a46-cbbd-4b71-bd3e-697615298a3d-S0 at slave(128)@172.17.0.3:45503 (5da4e909c2b9) with [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":3701220.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0808 00:05:10.315515 7569 slave.cpp:1194] Checkpointing SlaveInfo to '/tmp/MasterAllocatorTest_0_NestedRoles_VPQGIE/meta/slaves/f9f88a46-cbbd-4b71-bd3e-697615298a3d-S0/slave.info'
I0808 00:05:10.315830 7569 slave.cpp:1232] Forwarding total oversubscribed resources {}
I0808 00:05:10.315982 7578 master.cpp:6688] Received update of agent f9f88a46-cbbd-4b71-bd3e-697615298a3d-S0 at slave(128)@172.17.0.3:45503 (5da4e909c2b9) with total oversubscribed resources {}
I0808 00:05:10.316670 7574 hierarchical.cpp:2015] No inverse offers to send out!
I0808 00:05:10.316716 7574 hierarchical.cpp:1468] Performed allocation for 1 agents in 1.184568ms
I0808 00:05:10.316926 7574 hierarchical.cpp:660] Agent f9f88a46-cbbd-4b71-bd3e-697615298a3d-S0 (5da4e909c2b9) updated with total resources cpus:2; mem:1024; disk:3701220; ports:[31000-32000]
I0808 00:05:10.317158 7576 master.cpp:7667] Sending 1 offers to framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000 (default) at scheduler-5de46c07-8397-4bf5-bbb7-59e176b35131@172.17.0.3:45503
I0808 00:05:10.318377 7584 sched.cpp:933] Scheduler::resourceOffers took 814354ns
PC: @ 0x2abf379b7b4c process::EventQueue::Consumer::empty()
I0808 00:05:10.319443 7573 master.cpp:9164] Removing offer f9f88a46-cbbd-4b71-bd3e-697615298a3d-O0
I*** SIGSEGV (@0x8) received by PID 7550 (TID 0x2abf43511700) from PID 8; stack trace: ***
0808 00:05:10.319553 7573 master.cpp:4153] Processing ACCEPT call for offers: [ f9f88a46-cbbd-4b71-bd3e-697615298a3d-O0 ] on agent f9f88a46-cbbd-4b71-bd3e-697615298a3d-S0 at slave(128)@172.17.0.3:45503 (5da4e909c2b9) for framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000 (default) at scheduler-5de46c07-8397-4bf5-bbb7-59e176b35131@172.17.0.3:45503
I0808 00:05:10.319633 7573 master.cpp:3530] Authorizing framework principal 'test-principal' to launch task 0
@ 0x2abf907d9417 (unknown)
W0808 00:05:10.321295 7580 validation.cpp:1294] Executor 'default' for task '0' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0808 00:05:10.321326 7580 validation.cpp:1306] Executor 'default' for task '0' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
@ 0x2abf907dd6f9 (unknown)
I @ 0x2abf3a38a330 (unknown)
0808 00:05:10.321632 7580 master.cpp:9724] Adding task 0 with resources [{"allocation_info":{"role":"a\/b"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"a\/b"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"}] on agent f9f88a46-cbbd-4b71-bd3e-697615298a3d-S0 at slave(128)@172.17.0.3:45503 (5da4e909c2b9)
I0808 00:05:10.321925 7580 master.cpp:4816] Launching task 0 of framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000 (default) at scheduler-5de46c07-8397-4bf5-bbb7-59e176b35131@172.17.0.3:45503 with resources [{"allocation_info":{"role":"a\/b"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"a\/b"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"}] on agent f9f88a46-cbbd-4b71-bd3e-697615298a3d-S0 at slave(128)@172.17.0.3:45503 (5da4e909c2b9)
I0808 00:05:10.322374 7571 slave.cpp:1697] Got assigned task '0' for framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000
I0808 00:05:10.322937 7571 slave.cpp:1978] Authorizing task '0' for framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000
I0808 00:05:10.322983 7571 slave.cpp:6706] Authorizing framework principal 'test-principal' to launch task 0
I0808 00:05:10.323741 7576 slave.cpp:2165] Launching task '0' for framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000
I0808 00:05:10.324103 7583 hierarchical.cpp:887] Updated allocation of framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000 on agent f9f88a46-cbbd-4b71-bd3e-697615298a3d-S0 from cpus(allocated: a/b):2; mem(allocated: a/b):1024; disk(allocated: a/b):3701220; ports(allocated: a/b):[31000-32000] to cpus(allocated: a/b):2; mem(allocated: a/b):1024; disk(allocated: a/b):3701220; ports(allocated: a/b):[31000-32000]
I0808 00:05:10.324265 7576 paths.cpp:578] Trying to chown '/tmp/MasterAllocatorTest_0_NestedRoles_VPQGIE/slaves/f9f88a46-cbbd-4b71-bd3e-697615298a3d-S0/frameworks/f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000/executors/default/runs/e786d94b-0ef3-44a4-90e5-8124edd4840d' to user 'mesos'
I0808 00:05:10.324488 7576 slave.cpp:7162] Launching executor 'default' of framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000 with resources [] in work directory '/tmp/MasterAllocatorTest_0_NestedRoles_VPQGIE/slaves/f9f88a46-cbbd-4b71-bd3e-697615298a3d-S0/frameworks/f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000/executors/default/runs/e786d94b-0ef3-44a4-90e5-8124edd4840d'
I0808 00:05:10.325001 7583 hierarchical.cpp:1152] Recovered ports(allocated: a/b):[31000-32000]; disk(allocated: a/b):3701220 (total: cpus:2; mem:1024; disk:3701220; ports:[31000-32000], allocated: cpus(allocated: a/b):2; mem(allocated: a/b):1024) on agent f9f88a46-cbbd-4b71-bd3e-697615298a3d-S0 from framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000
I0808 00:05:10.325055 7583 hierarchical.cpp:1189] Framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000 filtered agent f9f88a46-cbbd-4b71-bd3e-697615298a3d-S0 for 5secs
I0808 00:05:10.325170 7576 slave.cpp:2394] Queued task '0' for executor 'default' of framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000
I0808 00:05:10.325237 7576 slave.cpp:924] Successfully attached file '/tmp/MasterAllocatorTest_0_NestedRoles_VPQGIE/slaves/f9f88a46-cbbd-4b71-bd3e-697615298a3d-S0/frameworks/f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000/executors/default/runs/e786d94b-0ef3-44a4-90e5-8124edd4840d'
I0808 00:05:10.325270 7576 slave.cpp:924] Successfully attached file '/tmp/MasterAllocatorTest_0_NestedRoles_VPQGIE/slaves/f9f88a46-cbbd-4b71-bd3e-697615298a3d-S0/frameworks/f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000/executors/default/runs/e786d94b-0ef3-44a4-90e5-8124edd4840d'
I0808 00:05:10.325453 7576 slave.cpp:2852] Launching container e786d94b-0ef3-44a4-90e5-8124edd4840d for executor 'default' of framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000
I0808 00:05:10.327617 7573 process.cpp:3228] Attempting to spawn already spawned process version@172.17.0.3:45503
I0808 00:05:10.327821 7573 exec.cpp:162] Version: 1.4.0
I0808 00:05:10.328086 7582 exec.cpp:212] Executor started at: executor(37)@172.17.0.3:45503 with pid 7550
I0808 00:05:10.328287 7582 slave.cpp:3877] Got registration for executor 'default' of framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000 from executor(37)@172.17.0.3:45503
I0808 00:05:10.328651 7578 exec.cpp:237] Executor registered on agent f9f88a46-cbbd-4b71-bd3e-697615298a3d-S0
I0808 00:05:10.328706 7578 exec.cpp:249] Executor::registered took 29681ns
I0808 00:05:10.329186 7582 slave.cpp:2599] Sending queued task '0' to executor 'default' of framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000 at executor(37)@172.17.0.3:45503
I0808 00:05:10.329468 7582 exec.cpp:331] Executor asked to run task '0'
I0808 00:05:10.329545 7582 exec.cpp:340] Executor::launchTask took 55696ns
I0808 00:05:10.329643 7582 exec.cpp:571] Executor sending status update TASK_RUNNING (UUID: c9e270c9-2d0b-4ac3-8c79-263589d1112f) for task 0 of framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000
I0808 00:05:10.329963 7575 slave.cpp:4341] Handling status update TASK_RUNNING (UUID: c9e270c9-2d0b-4ac3-8c79-263589d1112f) for task 0 of framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000 from executor(37)@172.17.0.3:45503
I0808 00:05:10.330595 7577 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: c9e270c9-2d0b-4ac3-8c79-263589d1112f) for task 0 of framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000
I0808 00:05:10.330646 7577 status_update_manager.cpp:500] Creating StatusUpdate stream for task 0 of framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000
I0808 00:05:10.331043 7577 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: c9e270c9-2d0b-4ac3-8c79-263589d1112f) for task 0 of framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000 to the agent
I0808 00:05:10.331238 7583 slave.cpp:4793] Forwarding the update TASK_RUNNING (UUID: c9e270c9-2d0b-4ac3-8c79-263589d1112f) for task 0 of framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000 to master@172.17.0.3:45503
I0808 00:05:10.331430 7583 slave.cpp:4687] Status update manager successfully handled status update TASK_RUNNING (UUID: c9e270c9-2d0b-4ac3-8c79-263589d1112f) for task 0 of framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000
I0808 00:05:10.331478 7583 slave.cpp:4703] Sending acknowledgement for status update TASK_RUNNING (UUID: c9e270c9-2d0b-4ac3-8c79-263589d1112f) for task 0 of framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000 to executor(37)@172.17.0.3:45503
I0808 00:05:10.331557 7576 master.cpp:6846] Status update TASK_RUNNING (UUID: c9e270c9-2d0b-4ac3-8c79-263589d1112f) for task 0 of framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000 from agent f9f88a46-cbbd-4b71-bd3e-697615298a3d-S0 at slave(128)@172.17.0.3:45503 (5da4e909c2b9)
I0808 00:05:10.331617 7576 master.cpp:6908] Forwarding status update TASK_RUNNING (UUID: c9e270c9-2d0b-4ac3-8c79-263589d1112f) for task 0 of framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000
I0808 00:05:10.331646 7581 exec.cpp:388] Executor received status update acknowledgement c9e270c9-2d0b-4ac3-8c79-263589d1112f for task 0 of framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000
I0808 00:05:10.331794 7576 master.cpp:8933] Updating the state of task 0 of framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0808 00:05:10.331966 7572 sched.cpp:1041] Scheduler::statusUpdate took 59022ns
I0808 00:05:10.332222 7580 master.cpp:5477] Processing ACKNOWLEDGE call c9e270c9-2d0b-4ac3-8c79-263589d1112f for task 0 of framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000 (default) at scheduler-5de46c07-8397-4bf5-bbb7-59e176b35131@172.17.0.3:45503 on agent f9f88a46-cbbd-4b71-bd3e-697615298a3d-S0
I0808 00:05:10.332484 7569 status_update_manager.cpp:395] Received status update acknowledgement (UUID: c9e270c9-2d0b-4ac3-8c79-263589d1112f) for task 0 of framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000
I0808 00:05:10.332695 7578 slave.cpp:3605] Status update manager successfully handled status update acknowledgement (UUID: c9e270c9-2d0b-4ac3-8c79-263589d1112f) for task 0 of framework f9f88a46-cbbd-4b71-bd3e-697615298a3d-0000
@ 0x2abf379b7b4c process::EventQueue::Consumer::empty()
@ 0x2abf379a3c5c process::ProcessManager::resume()
@ 0x2abf3799ff8c _ZZN7process14ProcessManager12init_threadsEvENKUlvE_clEv
@ 0x2abf379b2564 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
@ 0x2abf379b24bb _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEclEv
@ 0x2abf379b2454 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEE6_M_runEv
@ 0x2abf39c0ba60 (unknown)
@ 0x2abf3a382184 start_thread
@ 0x2abf3a695ffd (unknown)
make[4]: *** [check-local] Segmentation fault
make[4]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.4.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1502147372-30108
Untagged: mesos-1502147372-30108:latest
Deleted: sha256:272cb035ebcd783bfb1fde30ba73c7e1baf9e5417690e0294032a7a23d2c248c
Deleted: sha256:429f12d6a52944e1fdb6d6c336ec967e34072d50615488ec8d0ce5e41a65f06d
Deleted: sha256:529810edc537eb615a4f513d0cb449206f6985eda0c0d67cdd444dbb64a7eef9
Deleted: sha256:8ab6d5f296eb4bdcabffc561a003c334fdb490d991ba0f65e31c9b868199d3e3
Deleted: sha256:6b4f4c4981dd4d94de0a69324b19598dcb608a774784c4ab7ee1479df957669b
Deleted: sha256:c194537ff1920dac084aee21d7ae50762dfff1b464e21347b94d30844266bb81
Deleted: sha256:edf255f5419dd2a02f1298e06e10a5b58cfc6b1b52e2de76339817849bdd89ce
Deleted: sha256:451680edde36e2579ae7cc1603817291bc92a33b9271c5e55c67b2b64b9b4375
Deleted: sha256:e0f956acb1768b2ed3753da6433e9f49a3a54f1b2d54d71915266100aa40eabc
Deleted: sha256:68fbc521368a1d9bbc6ca8f95de493611bfd789de15a2f6e47396442807e0a4f
Deleted: sha256:5c4f34e66390d34bb2a780c81fa5497695b72ca0c775311ff7b0aec3cf524008
Deleted: sha256:c1be4ffac717c30b275a647b963546bd6a5de0976a7f50fe23a7ca900cc8b9b5
Deleted: sha256:d01f2c663a31aa0a35e7f1cedd395bf47c108a1edc24809e718345e9cdf42c19
Deleted: sha256:9d2dbf56a72e22055fe7225880ceae46cfa0510b4621f9bc2916e56da510862f
Deleted: sha256:5377611d4ea4d85c83d1e8d158aa7ad79f528d0e55367487ec53c74b431a8cb6
Deleted: sha256:d7b19559c7b1b3c045931ddad49d3ab9ecd132685e79bbda8fa40ddbf7c01bdb
Deleted: sha256:45b6f5c2ff986fa0273473870f9534f78007a813e71e199e6e684995be081a55
Deleted: sha256:06a1d5396a48d6e439bfb7db7748439f4fb01255f11aa8a3ff71af4aecea4604
Deleted: sha256:9a9d66b4b8426902129411b63001eca4192493c3015a5da3ad8858b36edec694
Deleted: sha256:9c0939c18d5bf2790a6855c553f99c97733a70145ef64c1bb2b9f907c36c7fff
Deleted: sha256:911bb8c3da82e8f81b7a0e9870570a85a3f3534524bd823e376e02e8ebe4a023
Deleted: sha256:0f9bd5859d2d8853f3b0b918d9566e66cf5e6c535b52c66d5bdb339a9bab1e5c
Deleted: sha256:4eaab7dd98a82322c02b50d48b820cd62dd817d6d7c3d7138a29c4543c64d2b7
Deleted: sha256:7c43b8c6df0ce5c1c89a4bad505f7a9f845921c93e5d35de9c9ef16aa4bbc579
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user yujie.jay@gmail.com
Jenkins build is back to normal : Mesos-Buildbot » autotools,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #4077
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/4077/display/redirect>