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/07/04 05:05:31 UTC
Build failed in Jenkins: Mesos-Buildbot » cmake,clang,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3860
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=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3860/display/redirect?page=changes>
Changes:
[toenshoff] Fixed interference of unbundled dependency include paths with Boost.
[toenshoff] Added MESOS-7581 to the 1.2.2 CHANGELOG.
------------------------------------------
[...truncated 11.89 MB...]
I0704 05:05:27.166313 24937 status_update_manager.cpp:500] Creating StatusUpdate stream for task 1 of framework daee918d-6a20-48de-9afb-5f77153e3737-0000
I0704 05:05:27.166512 24937 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 6ef579d4-e141-4f9e-91f7-b62d96ff5a61) for task 1 of framework daee918d-6a20-48de-9afb-5f77153e3737-0000 to the agent
I0704 05:05:27.166621 24930 slave.cpp:4305] Forwarding the update TASK_RUNNING (UUID: 6ef579d4-e141-4f9e-91f7-b62d96ff5a61) for task 1 of framework daee918d-6a20-48de-9afb-5f77153e3737-0000 to master@172.17.0.4:41524
I0704 05:05:27.166720 24930 slave.cpp:4199] Status update manager successfully handled status update TASK_RUNNING (UUID: 6ef579d4-e141-4f9e-91f7-b62d96ff5a61) for task 1 of framework daee918d-6a20-48de-9afb-5f77153e3737-0000
I0704 05:05:27.166740 24930 slave.cpp:4215] Sending acknowledgement for status update TASK_RUNNING (UUID: 6ef579d4-e141-4f9e-91f7-b62d96ff5a61) for task 1 of framework daee918d-6a20-48de-9afb-5f77153e3737-0000 to executor(120)@172.17.0.4:41524
I0704 05:05:27.166756 24943 master.cpp:6190] Status update TASK_RUNNING (UUID: 6ef579d4-e141-4f9e-91f7-b62d96ff5a61) for task 1 of framework daee918d-6a20-48de-9afb-5f77153e3737-0000 from agent daee918d-6a20-48de-9afb-5f77153e3737-S0 at slave(286)@172.17.0.4:41524 (7d1098f5ef7e)
I0704 05:05:27.166782 24943 master.cpp:6258] Forwarding status update TASK_RUNNING (UUID: 6ef579d4-e141-4f9e-91f7-b62d96ff5a61) for task 1 of framework daee918d-6a20-48de-9afb-5f77153e3737-0000
I0704 05:05:27.166793 24930 exec.cpp:388] Executor received status update acknowledgement 6ef579d4-e141-4f9e-91f7-b62d96ff5a61 for task 1 of framework daee918d-6a20-48de-9afb-5f77153e3737-0000
I0704 05:05:27.166836 24943 master.cpp:8338] Updating the state of task 1 of framework daee918d-6a20-48de-9afb-5f77153e3737-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0704 05:05:27.166934 24932 sched.cpp:1041] Scheduler::statusUpdate took 48917ns
I0704 05:05:27.167067 24945 master.cpp:5092] Processing ACKNOWLEDGE call 6ef579d4-e141-4f9e-91f7-b62d96ff5a61 for task 1 of framework daee918d-6a20-48de-9afb-5f77153e3737-0000 (default) at scheduler-23218f2c-2dc5-4677-86e4-d095ec0af8b4@172.17.0.4:41524 on agent daee918d-6a20-48de-9afb-5f77153e3737-S0
I0704 05:05:27.167353 24929 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 6ef579d4-e141-4f9e-91f7-b62d96ff5a61) for task 1 of framework daee918d-6a20-48de-9afb-5f77153e3737-0000
I0704 05:05:27.167424 24936 exec.cpp:416] Executor received framework message
I0704 05:05:27.167454 24936 exec.cpp:425] Executor::frameworkMessage took 21064ns
I0704 05:05:27.167469 24935 slave.cpp:3111] Status update manager successfully handled status update acknowledgement (UUID: 6ef579d4-e141-4f9e-91f7-b62d96ff5a61) for task 1 of framework daee918d-6a20-48de-9afb-5f77153e3737-0000
I0704 05:05:27.167712 24926 slave.cpp:4373] Sending message for framework daee918d-6a20-48de-9afb-5f77153e3737-0000 to scheduler-23218f2c-2dc5-4677-86e4-d095ec0af8b4@172.17.0.4:41524
I0704 05:05:27.167805 24932 sched.cpp:1177] Scheduler::frameworkMessage took 38865ns
I0704 05:05:27.168105 24923 sched.cpp:2021] Asked to stop the driver
I0704 05:05:27.168161 24925 sched.cpp:1203] Stopping framework daee918d-6a20-48de-9afb-5f77153e3737-0000
I0704 05:05:27.168252 24927 master.cpp:7741] Processing TEARDOWN call for framework daee918d-6a20-48de-9afb-5f77153e3737-0000 (default) at scheduler-23218f2c-2dc5-4677-86e4-d095ec0af8b4@172.17.0.4:41524
I0704 05:05:27.168273 24927 master.cpp:7753] Removing framework daee918d-6a20-48de-9afb-5f77153e3737-0000 (default) at scheduler-23218f2c-2dc5-4677-86e4-d095ec0af8b4@172.17.0.4:41524
I0704 05:05:27.168287 24927 master.cpp:3081] Deactivating framework daee918d-6a20-48de-9afb-5f77153e3737-0000 (default) at scheduler-23218f2c-2dc5-4677-86e4-d095ec0af8b4@172.17.0.4:41524
I0704 05:05:27.168517 24935 hierarchical.cpp:415] Deactivated framework daee918d-6a20-48de-9afb-5f77153e3737-0000
I0704 05:05:27.168558 24936 slave.cpp:2664] Asked to shut down framework daee918d-6a20-48de-9afb-5f77153e3737-0000 by master@172.17.0.4:41524
I0704 05:05:27.168561 24927 master.cpp:8338] Updating the state of task 1 of framework daee918d-6a20-48de-9afb-5f77153e3737-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0704 05:05:27.168581 24936 slave.cpp:2689] Shutting down framework daee918d-6a20-48de-9afb-5f77153e3737-0000
I0704 05:05:27.168592 24936 slave.cpp:5131] Shutting down executor 'default' of framework daee918d-6a20-48de-9afb-5f77153e3737-0000 at executor(120)@172.17.0.4:41524
I0704 05:05:27.168666 24946 exec.cpp:435] Executor asked to shutdown
I0704 05:05:27.168699 24946 exec.cpp:450] Executor::shutdown took 18114ns
I0704 05:05:27.168828 24927 master.cpp:8432] Removing task 1 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework daee918d-6a20-48de-9afb-5f77153e3737-0000 on agent daee918d-6a20-48de-9afb-5f77153e3737-S0 at slave(286)@172.17.0.4:41524 (7d1098f5ef7e)
I0704 05:05:27.168880 24937 hierarchical.cpp:1064] Recovered cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: {}) on agent daee918d-6a20-48de-9afb-5f77153e3737-S0 from framework daee918d-6a20-48de-9afb-5f77153e3737-0000
I0704 05:05:27.168910 24945 slave.cpp:4437] Got exited event for executor(120)@172.17.0.4:41524
I0704 05:05:27.168942 24927 master.cpp:8461] Removing executor 'default' with resources {} of framework daee918d-6a20-48de-9afb-5f77153e3737-0000 on agent daee918d-6a20-48de-9afb-5f77153e3737-S0 at slave(286)@172.17.0.4:41524 (7d1098f5ef7e)
I0704 05:05:27.169245 24943 hierarchical.cpp:362] Removed framework daee918d-6a20-48de-9afb-5f77153e3737-0000
I0704 05:05:27.169474 24932 slave.cpp:4817] Executor 'default' of framework daee918d-6a20-48de-9afb-5f77153e3737-0000 exited with status 0
I0704 05:05:27.169634 24932 slave.cpp:4917] Cleaning up executor 'default' of framework daee918d-6a20-48de-9afb-5f77153e3737-0000 at executor(120)@172.17.0.4:41524
W0704 05:05:27.169663 24945 master.cpp:6314] Ignoring unknown exited executor 'default' of framework daee918d-6a20-48de-9afb-5f77153e3737-0000 on agent daee918d-6a20-48de-9afb-5f77153e3737-S0 at slave(286)@172.17.0.4:41524 (7d1098f5ef7e)
I0704 05:05:27.169793 24928 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_C67ImJ/slaves/daee918d-6a20-48de-9afb-5f77153e3737-S0/frameworks/daee918d-6a20-48de-9afb-5f77153e3737-0000/executors/default/runs/7a9b201e-7843-496b-82d9-f1d16e2ec32f' for gc 6.99999803557926days in the future
I0704 05:05:27.169811 24932 slave.cpp:5005] Cleaning up framework daee918d-6a20-48de-9afb-5f77153e3737-0000
I0704 05:05:27.169844 24928 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_C67ImJ/slaves/daee918d-6a20-48de-9afb-5f77153e3737-S0/frameworks/daee918d-6a20-48de-9afb-5f77153e3737-0000/executors/default' for gc 6.99999803475852days in the future
I0704 05:05:27.169872 24944 status_update_manager.cpp:285] Closing status update streams for framework daee918d-6a20-48de-9afb-5f77153e3737-0000
I0704 05:05:27.169886 24944 status_update_manager.cpp:531] Cleaning up status update stream for task 1 of framework daee918d-6a20-48de-9afb-5f77153e3737-0000
I0704 05:05:27.169899 24928 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_C67ImJ/slaves/daee918d-6a20-48de-9afb-5f77153e3737-S0/frameworks/daee918d-6a20-48de-9afb-5f77153e3737-0000' for gc 6.99999803402963days in the future
I0704 05:05:27.170135 24924 slave.cpp:809] Agent terminating
I0704 05:05:27.170217 24935 master.cpp:1264] Agent daee918d-6a20-48de-9afb-5f77153e3737-S0 at slave(286)@172.17.0.4:41524 (7d1098f5ef7e) disconnected
I0704 05:05:27.170235 24935 master.cpp:3118] Disconnecting agent daee918d-6a20-48de-9afb-5f77153e3737-S0 at slave(286)@172.17.0.4:41524 (7d1098f5ef7e)
I0704 05:05:27.170264 24935 master.cpp:3137] Deactivating agent daee918d-6a20-48de-9afb-5f77153e3737-S0 at slave(286)@172.17.0.4:41524 (7d1098f5ef7e)
I0704 05:05:27.170429 24938 hierarchical.cpp:618] Agent daee918d-6a20-48de-9afb-5f77153e3737-S0 deactivated
I0704 05:05:27.171605 24947 master.cpp:1103] Master terminating
I0704 05:05:27.171751 24942 hierarchical.cpp:549] Removed agent daee918d-6a20-48de-9afb-5f77153e3737-S0
[ OK ] MasterTest.FrameworkMessage (26 ms)
[ RUN ] MasterTest.MultipleExecutors
I0704 05:05:27.175623 24923 cluster.cpp:160] Creating default 'local' authorizer
I0704 05:05:27.176766 24937 master.cpp:383] Master af8bb066-1779-4a42-aeda-67744e515d41 (7d1098f5ef7e) started on 172.17.0.4:41524
I0704 05:05:27.176789 24937 master.cpp:385] 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/Zt1rrM/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/Zt1rrM/master" --zk_session_timeout="10secs"
I0704 05:05:27.176965 24937 master.cpp:435] Master only allowing authenticated frameworks to register
I0704 05:05:27.176975 24937 master.cpp:449] Master only allowing authenticated agents to register
I0704 05:05:27.176980 24937 master.cpp:462] Master only allowing authenticated HTTP frameworks to register
I0704 05:05:27.176991 24937 credentials.hpp:37] Loading credentials for authentication from '/tmp/Zt1rrM/credentials'
I0704 05:05:27.177163 24937 master.cpp:507] Using default 'crammd5' authenticator
I0704 05:05:27.177217 24937 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0704 05:05:27.177302 24937 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0704 05:05:27.177425 24937 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0704 05:05:27.177569 24937 master.cpp:587] Authorization enabled
I0704 05:05:27.177636 24932 hierarchical.cpp:161] Initialized hierarchical allocator process
I0704 05:05:27.177639 24924 whitelist_watcher.cpp:77] No whitelist given
I0704 05:05:27.178511 24937 master.cpp:2124] Elected as the leading master!
I0704 05:05:27.178525 24937 master.cpp:1646] Recovering from registrar
I0704 05:05:27.178571 24942 registrar.cpp:329] Recovering registrar
I0704 05:05:27.178776 24927 registrar.cpp:362] Successfully fetched the registry (0B) in 173056ns
I0704 05:05:27.178817 24927 registrar.cpp:461] Applied 1 operations in 9497ns; attempting to update the registry
I0704 05:05:27.179044 24927 registrar.cpp:506] Successfully updated the registry in 205824ns
I0704 05:05:27.179100 24927 registrar.cpp:392] Successfully recovered registrar
I0704 05:05:27.179374 24924 hierarchical.cpp:188] Skipping recovery of hierarchical allocator: nothing to recover
I0704 05:05:27.179381 24930 master.cpp:1762] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0704 05:05:27.181519 24923 cluster.cpp:446] Creating default 'local' authorizer
I0704 05:05:27.182127 24947 slave.cpp:217] Mesos agent started on (287)@172.17.0.4:41524
I0704 05:05:27.182152 24947 slave.cpp:218] 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/MasterTest_MultipleExecutors_JAMy4i/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/MasterTest_MultipleExecutors_JAMy4i/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/MasterTest_MultipleExecutors_JAMy4i/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/MasterTest_MultipleExecutors_JAMy4i" --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/MasterTest_MultipleExecutors_HhWZKx"
I0704 05:05:27.182468 24947 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterTest_MultipleExecutors_JAMy4i/credential'
I0704 05:05:27.182551 24947 slave.cpp:360] Agent using credential for: test-principal
I0704 05:05:27.182564 24947 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterTest_MultipleExecutors_JAMy4i/http_credentials'
I0704 05:05:27.182657 24947 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0704 05:05:27.182721 24947 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0704 05:05:27.183001 24923 sched.cpp:232] Version: 1.2.2
I0704 05:05:27.183197 24926 sched.cpp:336] New master detected at master@172.17.0.4:41524
I0704 05:05:27.183240 24926 sched.cpp:407] Authenticating with master master@172.17.0.4:41524
I0704 05:05:27.183254 24926 sched.cpp:414] Using default CRAM-MD5 authenticatee
I0704 05:05:27.183235 24947 slave.cpp:547] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0704 05:05:27.183275 24947 slave.cpp:555] Agent attributes: [ ]
I0704 05:05:27.183281 24947 slave.cpp:560] Agent hostname: 7d1098f5ef7e
I0704 05:05:27.183346 24929 authenticatee.cpp:121] Creating new client SASL connection
I0704 05:05:27.183359 24942 status_update_manager.cpp:177] Pausing sending status updates
I0704 05:05:27.183552 24939 master.cpp:7199] Authenticating scheduler-966d346e-f39a-4812-8b27-661a3b470795@172.17.0.4:41524
I0704 05:05:27.183670 24925 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(633)@172.17.0.4:41524
I0704 05:05:27.183724 24924 state.cpp:62] Recovering state from '/tmp/MasterTest_MultipleExecutors_HhWZKx/meta'
I0704 05:05:27.183938 24926 status_update_manager.cpp:203] Recovering status update manager
I0704 05:05:27.183979 24944 authenticator.cpp:98] Creating new server SASL connection
I0704 05:05:27.184193 24928 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0704 05:05:27.184226 24928 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0704 05:05:27.184243 24943 slave.cpp:5662] Finished recovery
I0704 05:05:27.184284 24929 authenticator.cpp:204] Received SASL authentication start
I0704 05:05:27.184348 24929 authenticator.cpp:326] Authentication requires more steps
I0704 05:05:27.184387 24929 authenticatee.cpp:259] Received SASL authentication step
I0704 05:05:27.184449 24925 authenticator.cpp:232] Received SASL authentication step
I0704 05:05:27.184470 24925 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '7d1098f5ef7e' server FQDN: '7d1098f5ef7e' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0704 05:05:27.184479 24925 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0704 05:05:27.184492 24925 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0704 05:05:27.184504 24925 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '7d1098f5ef7e' server FQDN: '7d1098f5ef7e' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0704 05:05:27.184510 24925 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0704 05:05:27.184514 24925 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0704 05:05:27.184528 24925 authenticator.cpp:318] Authentication success
I0704 05:05:27.184592 24943 slave.cpp:5836] Querying resource estimator for oversubscribable resources
I0704 05:05:27.184609 24947 master.cpp:7229] Successfully authenticated principal 'test-principal' at scheduler-966d346e-f39a-4812-8b27-661a3b470795@172.17.0.4:41524
I0704 05:05:27.184623 24931 authenticatee.cpp:299] Authentication success
I0704 05:05:27.184622 24938 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(633)@172.17.0.4:41524
I0704 05:05:27.184772 24940 sched.cpp:513] Successfully authenticated with master master@172.17.0.4:41524
I0704 05:05:27.184783 24940 sched.cpp:836] Sending SUBSCRIBE call to master@172.17.0.4:41524
I0704 05:05:27.184825 24940 sched.cpp:869] Will retry registration in 1.116369629secs if necessary
I0704 05:05:27.184865 24943 slave.cpp:937] New master detected at master@172.17.0.4:41524
I0704 05:05:27.184870 24941 status_update_manager.cpp:177] Pausing sending status updates
I0704 05:05:27.184911 24943 slave.cpp:972] Detecting new master
I0704 05:05:27.185012 24943 slave.cpp:5850] Received oversubscribable resources {} from the resource estimator
I0704 05:05:27.185016 24925 master.cpp:2737] Received SUBSCRIBE call for framework 'default' at scheduler-966d346e-f39a-4812-8b27-661a3b470795@172.17.0.4:41524
I0704 05:05:27.185039 24925 master.cpp:2160] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0704 05:05:27.185310 24943 master.cpp:2813] Subscribing framework default with checkpointing disabled and capabilities [ ]
I0704 05:05:27.185497 24934 hierarchical.cpp:286] Added framework af8bb066-1779-4a42-aeda-67744e515d41-0000
I0704 05:05:27.185523 24942 sched.cpp:759] Framework registered with af8bb066-1779-4a42-aeda-67744e515d41-0000
I0704 05:05:27.185536 24934 hierarchical.cpp:1810] No allocations performed
I0704 05:05:27.185544 24934 hierarchical.cpp:1900] No inverse offers to send out!
I0704 05:05:27.185552 24934 hierarchical.cpp:1394] Performed allocation for 0 agents in 26884ns
I0704 05:05:27.185555 24942 sched.cpp:773] Scheduler::registered took 19632ns
I0704 05:05:27.192255 24928 slave.cpp:999] Authenticating with master master@172.17.0.4:41524
I0704 05:05:27.192297 24928 slave.cpp:1010] Using default CRAM-MD5 authenticatee
I0704 05:05:27.192394 24944 authenticatee.cpp:121] Creating new client SASL connection
I0704 05:05:27.192634 24940 master.cpp:7199] Authenticating slave(287)@172.17.0.4:41524
I0704 05:05:27.192692 24937 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(634)@172.17.0.4:41524
I0704 05:05:27.192786 24938 authenticator.cpp:98] Creating new server SASL connection
I0704 05:05:27.192936 24927 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0704 05:05:27.192960 24927 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0704 05:05:27.193027 24935 authenticator.cpp:204] Received SASL authentication start
I0704 05:05:27.193078 24935 authenticator.cpp:326] Authentication requires more steps
I0704 05:05:27.193119 24935 authenticatee.cpp:259] Received SASL authentication step
I0704 05:05:27.193162 24935 authenticator.cpp:232] Received SASL authentication step
I0704 05:05:27.193178 24935 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '7d1098f5ef7e' server FQDN: '7d1098f5ef7e' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0704 05:05:27.193190 24935 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0704 05:05:27.193207 24935 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0704 05:05:27.193217 24935 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '7d1098f5ef7e' server FQDN: '7d1098f5ef7e' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0704 05:05:27.193224 24935 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0704 05:05:27.193228 24935 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0704 05:05:27.193240 24935 authenticator.cpp:318] Authentication success
I0704 05:05:27.193282 24927 authenticatee.cpp:299] Authentication success
I0704 05:05:27.193313 24924 master.cpp:7229] Successfully authenticated principal 'test-principal' at slave(287)@172.17.0.4:41524
I0704 05:05:27.193356 24935 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(634)@172.17.0.4:41524
I0704 05:05:27.193596 24943 slave.cpp:1094] Successfully authenticated with master master@172.17.0.4:41524
I0704 05:05:27.193682 24943 slave.cpp:1521] Will retry registration in 10.20115ms if necessary
I0704 05:05:27.193783 24947 master.cpp:5396] Registering agent at slave(287)@172.17.0.4:41524 (7d1098f5ef7e) with id af8bb066-1779-4a42-aeda-67744e515d41-S0
I0704 05:05:27.193915 24932 registrar.cpp:461] Applied 1 operations in 29428ns; attempting to update the registry
I0704 05:05:27.194300 24945 registrar.cpp:506] Successfully updated the registry in 356096ns
I0704 05:05:27.194540 24940 slave.cpp:4395] Received ping from slave-observer(281)@172.17.0.4:41524
I0704 05:05:27.194552 24933 master.cpp:5470] Registered agent af8bb066-1779-4a42-aeda-67744e515d41-S0 at slave(287)@172.17.0.4:41524 (7d1098f5ef7e) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0704 05:05:27.194646 24932 hierarchical.cpp:516] Added agent af8bb066-1779-4a42-aeda-67744e515d41-S0 (7d1098f5ef7e) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0704 05:05:27.194696 24940 slave.cpp:1140] Registered with master master@172.17.0.4:41524; given agent ID af8bb066-1779-4a42-aeda-67744e515d41-S0
I0704 05:05:27.194712 24940 fetcher.cpp:94] Clearing fetcher cache
I0704 05:05:27.194839 24939 status_update_manager.cpp:184] Resuming sending status updates
I0704 05:05:27.194905 24932 hierarchical.cpp:1900] No inverse offers to send out!
I0704 05:05:27.194927 24932 hierarchical.cpp:1394] Performed allocation for 1 agents in 230279ns
I0704 05:05:27.195063 24940 slave.cpp:1168] Checkpointing SlaveInfo to '/tmp/MasterTest_MultipleExecutors_HhWZKx/meta/slaves/af8bb066-1779-4a42-aeda-67744e515d41-S0/slave.info'
I0704 05:05:27.195061 24934 master.cpp:7028] Sending 1 offers to framework af8bb066-1779-4a42-aeda-67744e515d41-0000 (default) at scheduler-966d346e-f39a-4812-8b27-661a3b470795@172.17.0.4:41524
I0704 05:05:27.195257 24942 sched.cpp:933] Scheduler::resourceOffers took 57086ns
I0704 05:05:27.195332 24940 slave.cpp:1206] Forwarding total oversubscribed resources {}
I0704 05:05:27.195462 24943 master.cpp:6045] Received update of agent af8bb066-1779-4a42-aeda-67744e515d41-S0 at slave(287)@172.17.0.4:41524 (7d1098f5ef7e) with total oversubscribed resources {}
I0704 05:05:27.195677 24928 hierarchical.cpp:589] Agent af8bb066-1779-4a42-aeda-67744e515d41-S0 (7d1098f5ef7e) updated with oversubscribed resources {} (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000])
I0704 05:05:27.195761 24928 hierarchical.cpp:1810] No allocations performed
I0704 05:05:27.195772 24928 hierarchical.cpp:1900] No inverse offers to send out!
I0704 05:05:27.195780 24928 hierarchical.cpp:1394] Performed allocation for 1 agents in 46962ns
I0704 05:05:27.196219 24935 master.cpp:3776] Processing ACCEPT call for offers: [ af8bb066-1779-4a42-aeda-67744e515d41-O0 ] on agent af8bb066-1779-4a42-aeda-67744e515d41-S0 at slave(287)@172.17.0.4:41524 (7d1098f5ef7e) for framework af8bb066-1779-4a42-aeda-67744e515d41-0000 (default) at scheduler-966d346e-f39a-4812-8b27-661a3b470795@172.17.0.4:41524
I0704 05:05:27.196260 24935 master.cpp:3352] Authorizing framework principal 'test-principal' to launch task 1
I0704 05:05:27.196372 24935 master.cpp:3352] Authorizing framework principal 'test-principal' to launch task 2
W0704 05:05:27.196965 24935 validation.cpp:1064] Executor 'executor-1' for task '1' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0704 05:05:27.196985 24935 validation.cpp:1076] Executor 'executor-1' for task '1' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0704 05:05:27.197057 24935 master.cpp:9089] Adding task 1 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent af8bb066-1779-4a42-aeda-67744e515d41-S0 at slave(287)@172.17.0.4:41524 (7d1098f5ef7e)
I0704 05:05:27.197115 24935 master.cpp:4426] Launching task 1 of framework af8bb066-1779-4a42-aeda-67744e515d41-0000 (default) at scheduler-966d346e-f39a-4812-8b27-661a3b470795@172.17.0.4:41524 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent af8bb066-1779-4a42-aeda-67744e515d41-S0 at slave(287)@172.17.0.4:41524 (7d1098f5ef7e)
I0704 05:05:27.197255 24926 slave.cpp:1631] Got assigned task '1' for framework af8bb066-1779-4a42-aeda-67744e515d41-0000
W0704 05:05:27.197360 24935 validation.cpp:1064] Executor 'executor-2' for task '2' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0704 05:05:27.197386 24935 validation.cpp:1076] Executor 'executor-2' for task '2' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0704 05:05:27.197473 24926 slave.cpp:1791] Launching task '1' for framework af8bb066-1779-4a42-aeda-67744e515d41-0000
I0704 05:05:27.197459 24935 master.cpp:9089] Adding task 2 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent af8bb066-1779-4a42-aeda-67744e515d41-S0 at slave(287)@172.17.0.4:41524 (7d1098f5ef7e)
I0704 05:05:27.197531 24935 master.cpp:4426] Launching task 2 of framework af8bb066-1779-4a42-aeda-67744e515d41-0000 (default) at scheduler-966d346e-f39a-4812-8b27-661a3b470795@172.17.0.4:41524 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent af8bb066-1779-4a42-aeda-67744e515d41-S0 at slave(287)@172.17.0.4:41524 (7d1098f5ef7e)
I0704 05:05:27.197921 24926 paths.cpp:547] Trying to chown '/tmp/MasterTest_MultipleExecutors_HhWZKx/slaves/af8bb066-1779-4a42-aeda-67744e515d41-S0/frameworks/af8bb066-1779-4a42-aeda-67744e515d41-0000/executors/executor-1/runs/e1c77b91-3975-41e9-9cdd-601ddd009833' to user 'mesos'
I0704 05:05:27.198050 24928 hierarchical.cpp:807] Updated allocation of framework af8bb066-1779-4a42-aeda-67744e515d41-0000 on agent af8bb066-1779-4a42-aeda-67744e515d41-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]
I0704 05:05:27.198097 24926 slave.cpp:6584] Launching executor 'executor-1' of framework af8bb066-1779-4a42-aeda-67744e515d41-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_HhWZKx/slaves/af8bb066-1779-4a42-aeda-67744e515d41-S0/frameworks/af8bb066-1779-4a42-aeda-67744e515d41-0000/executors/executor-1/runs/e1c77b91-3975-41e9-9cdd-601ddd009833'
I0704 05:05:27.198169 24928 hierarchical.cpp:1064] Recovered ports(*)(allocated: *):[31000-32000]; disk(*)(allocated: *):1024 (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*)(allocated: *):2; mem(*)(allocated: *):1024) on agent af8bb066-1779-4a42-aeda-67744e515d41-S0 from framework af8bb066-1779-4a42-aeda-67744e515d41-0000
I0704 05:05:27.198205 24928 hierarchical.cpp:1101] Framework af8bb066-1779-4a42-aeda-67744e515d41-0000 filtered agent af8bb066-1779-4a42-aeda-67744e515d41-S0 for 5secs
I0704 05:05:27.198310 24926 slave.cpp:2124] Queued task '1' for executor 'executor-1' of framework af8bb066-1779-4a42-aeda-67744e515d41-0000
I0704 05:05:27.198377 24926 slave.cpp:1631] Got assigned task '2' for framework af8bb066-1779-4a42-aeda-67744e515d41-0000
I0704 05:05:27.198513 24926 slave.cpp:890] Successfully attached file '/tmp/MasterTest_MultipleExecutors_HhWZKx/slaves/af8bb066-1779-4a42-aeda-67744e515d41-S0/frameworks/af8bb066-1779-4a42-aeda-67744e515d41-0000/executors/executor-1/runs/e1c77b91-3975-41e9-9cdd-601ddd009833'
I0704 05:05:27.198534 24926 slave.cpp:1791] Launching task '2' for framework af8bb066-1779-4a42-aeda-67744e515d41-0000
I0704 05:05:27.198796 24926 paths.cpp:547] Trying to chown '/tmp/MasterTest_MultipleExecutors_HhWZKx/slaves/af8bb066-1779-4a42-aeda-67744e515d41-S0/frameworks/af8bb066-1779-4a42-aeda-67744e515d41-0000/executors/executor-2/runs/a31481f4-f59e-4f5c-9cb0-1a040946c549' to user 'mesos'
I0704 05:05:27.198920 24926 slave.cpp:6584] Launching executor 'executor-2' of framework af8bb066-1779-4a42-aeda-67744e515d41-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_HhWZKx/slaves/af8bb066-1779-4a42-aeda-67744e515d41-S0/frameworks/af8bb066-1779-4a42-aeda-67744e515d41-0000/executors/executor-2/runs/a31481f4-f59e-4f5c-9cb0-1a040946c549'
*** Aborted at 1499144727 (unix time) try "date -d @1499144727" if you are using GNU date ***
I0704 05:05:27.199134 24943 exec.cpp:162] Version: 1.2.2
PC: @ 0x2b3ee080b82d (unknown)
I0704 05:05:27.199290 24928 exec.cpp:212] Executor started at: executor(121)@172.17.0.4:41524 with pid 24923
*** SIGSEGV (@0x31) received by PID 24923 (TID 0x2b3ee7b93700) from PID 49; stack trace: ***
@ 0x2b3edfda2330 (unknown)
@ 0x2b3ee080b82d (unknown)
@ 0x2b3edb7a03c2 mesos::internal::slave::executorEnvironment()
@ 0x2b3edb77e6f6 mesos::internal::slave::Framework::launchExecutor()
@ 0x2b3edb77ae8f mesos::internal::slave::Slave::_run()
@ 0x2b3edcfea987 process::ProcessManager::resume()
@ 0x2b3edcfff12f std::thread::_Impl<>::_M_run()
@ 0x2b3ee0061a60 (unknown)
@ 0x2b3edfd9a184 start_thread
@ 0x2b3ee08cdffd (unknown)
make[3]: *** [CMakeFiles/check] Segmentation fault (core dumped)
make[3]: Leaving directory `/mesos/build'
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-1499142384-27632
Untagged: mesos-1499142384-27632:latest
Deleted: sha256:984bb4c436425ad928569990f195b0e246f5e43e5cb17a6249866cef0d1f5cf1
Deleted: sha256:aa032e194ec6f7e8fcc996615e4ae84e22ad65abcefa8b2b4893884fd0cb5e5a
Deleted: sha256:55f67ff50deadbe069cfbc5de36feffac84710567b0187155a4231d171e3712e
Deleted: sha256:f1e04fbdb4272a0cf95592d30c4cb716accdb3185ab472fe17e34d885d5d5d38
Deleted: sha256:b4bbf24f55a5f9e1df0a02923d6b8a0249d0d947af8e7c889e8c15e967fdb8ea
Deleted: sha256:a2ef311c52e51dac83aa7910e55071a94e5a1f593a64d7d72928c82ad9c5f88c
Deleted: sha256:44180ebdec059b6298fb0628b0937393a959e1d45b891109738763270592cdab
Deleted: sha256:04c76bef2f7af2494300ffab8f6af657ec7c5600af308d5de3d443515b8a91cf
Deleted: sha256:70116890e3183aac51e05f4c13e7dbdd0426eb5df79fa6915645944157cd7515
Deleted: sha256:a1323dab601106be9219155539b30a3e3ba9ff9c3c518ab953214b649a346541
Deleted: sha256:3ff0f05d0e69f7bf3398003ab51c617c2b92c7f05ac704c7ab486b00ff875b3d
Deleted: sha256:ad539f766755112e8af5d80eac8822ccda07318e0999afffbabb80145953979f
Deleted: sha256:8d2c978dc401d5532f9e2bc8290a91b610ee7f67e6b2bfb6899cf06c1ca51ddf
Deleted: sha256:057c35bb36558a03b82409b022f3b55c426948523d7e31b06a9f50fa3b633eea
Deleted: sha256:4d143ef3942fe6ac07089b74c83c74589d922b808a3f4164eedf7fe904ff4c64
Deleted: sha256:80fa3d6e4583bbf26a077fa8e3452da426e6414ef75637aa292bd97fe4aaebc8
Deleted: sha256:511b9c82bdea16d1c2470984763df8c751415690290792e1e67784db70146052
Deleted: sha256:d59b8fd163158a294043b86dea35d0c104b62062fd1278d98df5e40700688218
Deleted: sha256:47e5e6bd75e71a3dc96f1d8124faf244e1d25e14574a679fc995934e289b9af3
Deleted: sha256:bb0e5bcbd8aaf26ac7e675e4b0de8b0bcb75470c9be73bbc4437ac318d67305c
Deleted: sha256:ca5fa84c4e87a6de085f0741f410461992d92e176d7b781937aa3af7d5f7ae89
Deleted: sha256:173f5c9f1f9fd0501120e3686f11fa2cb6793143020d9f3deca5aa734b0d10b7
Deleted: sha256:a4f0e05541628aa6d52db02c28e108b12a5491c1bbfa7b9bc75cd6793bd1efb3
Deleted: sha256:b2d5a736500fa5371109f1373c408f7583cb9fac892dbf38e92fd07e88b32423
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user toenshoff@me.com
Jenkins build is back to normal : Mesos-Buildbot » cmake,clang,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3861
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=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3861/display/redirect?page=changes>