mesos-builds mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Jenkins Server <jenk...@builds.apache.org>
Subject Build failed in Jenkins: Mesos-Reviewbot #18647
Date Sun, 30 Jul 2017 17:18:29 GMT
See <https://builds.apache.org/job/Mesos-Reviewbot/18647/display/redirect>

------------------------------------------
[...truncated 12.39 MB...]
I0730 17:18:22.826143  5123 master.cpp:8334] Processing TEARDOWN call for framework c333c457-12ed-4d58-b4c8-2fb642fbb2e7-0000
(default) at scheduler-573b9ff6-57b5-4792-ade9-4597a991046c@172.17.0.3:34861
I0730 17:18:22.826195  5123 master.cpp:8346] Removing framework c333c457-12ed-4d58-b4c8-2fb642fbb2e7-0000
(default) at scheduler-573b9ff6-57b5-4792-ade9-4597a991046c@172.17.0.3:34861
I0730 17:18:22.826220  5123 master.cpp:3264] Deactivating framework c333c457-12ed-4d58-b4c8-2fb642fbb2e7-0000
(default) at scheduler-573b9ff6-57b5-4792-ade9-4597a991046c@172.17.0.3:34861
I0730 17:18:22.826522  5120 hierarchical.cpp:412] Deactivated framework c333c457-12ed-4d58-b4c8-2fb642fbb2e7-0000
I0730 17:18:22.826743  5123 master.cpp:8919] Updating the state of task 1 of framework c333c457-12ed-4d58-b4c8-2fb642fbb2e7-0000
(latest state: TASK_KILLED, status update state: TASK_KILLED)
I0730 17:18:22.826786  5120 slave.cpp:3155] Asked to shut down framework c333c457-12ed-4d58-b4c8-2fb642fbb2e7-0000
by master@172.17.0.3:34861
I0730 17:18:22.826836  5120 slave.cpp:3180] Shutting down framework c333c457-12ed-4d58-b4c8-2fb642fbb2e7-0000
I0730 17:18:22.827016  5120 slave.cpp:5648] Shutting down executor 'default' of framework
c333c457-12ed-4d58-b4c8-2fb642fbb2e7-0000 at executor(78)@172.17.0.3:34861
I0730 17:18:22.827364  5122 exec.cpp:435] Executor asked to shutdown
I0730 17:18:22.827432  5122 exec.cpp:450] Executor::shutdown took 28712ns
I0730 17:18:22.828125  5120 slave.cpp:4925] Got exited event for executor(78)@172.17.0.3:34861
I0730 17:18:22.828404  5124 slave.cpp:5326] Executor 'default' of framework c333c457-12ed-4d58-b4c8-2fb642fbb2e7-0000
exited with status 0
I0730 17:18:22.828603  5124 slave.cpp:5426] Cleaning up executor 'default' of framework c333c457-12ed-4d58-b4c8-2fb642fbb2e7-0000
at executor(78)@172.17.0.3:34861
I0730 17:18:22.829124  5125 gc.cpp:59] Scheduling '/tmp/MasterTest_FrameworkMessage_9WY8Iu/slaves/c333c457-12ed-4d58-b4c8-2fb642fbb2e7-S0/frameworks/c333c457-12ed-4d58-b4c8-2fb642fbb2e7-0000/executors/default/runs/243ea239-c644-409d-bb99-d324c5a83181'
for gc 6.99999040735111days in the future
I0730 17:18:22.829514  5125 gc.cpp:59] Scheduling '/tmp/MasterTest_FrameworkMessage_9WY8Iu/slaves/c333c457-12ed-4d58-b4c8-2fb642fbb2e7-S0/frameworks/c333c457-12ed-4d58-b4c8-2fb642fbb2e7-0000/executors/default'
for gc 6.99999040221037days in the future
I0730 17:18:22.829572  5124 slave.cpp:5522] Cleaning up framework c333c457-12ed-4d58-b4c8-2fb642fbb2e7-0000
I0730 17:18:22.829804  5120 status_update_manager.cpp:285] Closing status update streams for
framework c333c457-12ed-4d58-b4c8-2fb642fbb2e7-0000
I0730 17:18:22.828972  5123 master.cpp:9013] Removing task 1 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
of framework c333c457-12ed-4d58-b4c8-2fb642fbb2e7-0000 on agent c333c457-12ed-4d58-b4c8-2fb642fbb2e7-S0
at slave(207)@172.17.0.3:34861 (67eb933dde2f)
I0730 17:18:22.829876  5124 slave.cpp:843] Agent terminating
I0730 17:18:22.829876  5120 status_update_manager.cpp:531] Cleaning up status update stream
for task 1 of framework c333c457-12ed-4d58-b4c8-2fb642fbb2e7-0000
I0730 17:18:22.829871  5121 gc.cpp:59] Scheduling '/tmp/MasterTest_FrameworkMessage_9WY8Iu/slaves/c333c457-12ed-4d58-b4c8-2fb642fbb2e7-S0/frameworks/c333c457-12ed-4d58-b4c8-2fb642fbb2e7-0000'
for gc 6.99999039646815days in the future
I0730 17:18:22.830303  5126 hierarchical.cpp:1152] 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 c333c457-12ed-4d58-b4c8-2fb642fbb2e7-S0
from framework c333c457-12ed-4d58-b4c8-2fb642fbb2e7-0000
I0730 17:18:22.830752  5123 master.cpp:9042] Removing executor 'default' with resources []
of framework c333c457-12ed-4d58-b4c8-2fb642fbb2e7-0000 on agent c333c457-12ed-4d58-b4c8-2fb642fbb2e7-S0
at slave(207)@172.17.0.3:34861 (67eb933dde2f)
W0730 17:18:22.831679  5123 master.cpp:6949] Ignoring unknown exited executor 'default' of
framework c333c457-12ed-4d58-b4c8-2fb642fbb2e7-0000 on agent c333c457-12ed-4d58-b4c8-2fb642fbb2e7-S0
at slave(207)@172.17.0.3:34861 (67eb933dde2f)
I0730 17:18:22.832043  5123 master.cpp:1318] Agent c333c457-12ed-4d58-b4c8-2fb642fbb2e7-S0
at slave(207)@172.17.0.3:34861 (67eb933dde2f) disconnected
I0730 17:18:22.832094  5123 master.cpp:3301] Disconnecting agent c333c457-12ed-4d58-b4c8-2fb642fbb2e7-S0
at slave(207)@172.17.0.3:34861 (67eb933dde2f)
I0730 17:18:22.832043  5122 hierarchical.cpp:355] Removed framework c333c457-12ed-4d58-b4c8-2fb642fbb2e7-0000
I0730 17:18:22.832425  5123 master.cpp:3320] Deactivating agent c333c457-12ed-4d58-b4c8-2fb642fbb2e7-S0
at slave(207)@172.17.0.3:34861 (67eb933dde2f)
I0730 17:18:22.832685  5120 hierarchical.cpp:690] Agent c333c457-12ed-4d58-b4c8-2fb642fbb2e7-S0
deactivated
I0730 17:18:22.834708  5100 master.cpp:1160] Master terminating
I0730 17:18:22.835830  5126 hierarchical.cpp:626] Removed agent c333c457-12ed-4d58-b4c8-2fb642fbb2e7-S0
[       OK ] MasterTest.FrameworkMessage (109 ms)
[ RUN      ] MasterTest.MultipleExecutors
I0730 17:18:22.846487  5100 cluster.cpp:162] Creating default 'local' authorizer
I0730 17:18:22.850709  5124 master.cpp:442] Master 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c (67eb933dde2f)
started on 172.17.0.3:34861
I0730 17:18:22.850749  5124 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/rYgqj5/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/rYgqj5/master"
--zk_session_timeout="10secs"
I0730 17:18:22.851266  5124 master.cpp:494] Master only allowing authenticated frameworks
to register
I0730 17:18:22.851287  5124 master.cpp:508] Master only allowing authenticated agents to register
I0730 17:18:22.851305  5124 master.cpp:521] Master only allowing authenticated HTTP frameworks
to register
I0730 17:18:22.851320  5124 credentials.hpp:37] Loading credentials for authentication from
'/tmp/rYgqj5/credentials'
I0730 17:18:22.851757  5124 master.cpp:566] Using default 'crammd5' authenticator
I0730 17:18:22.851972  5124 http.cpp:993] Creating default 'basic' HTTP authenticator for
realm 'mesos-master-readonly'
I0730 17:18:22.852159  5124 http.cpp:993] Creating default 'basic' HTTP authenticator for
realm 'mesos-master-readwrite'
I0730 17:18:22.852303  5124 http.cpp:993] Creating default 'basic' HTTP authenticator for
realm 'mesos-master-scheduler'
I0730 17:18:22.852447  5124 master.cpp:646] Authorization enabled
I0730 17:18:22.852710  5121 whitelist_watcher.cpp:77] No whitelist given
I0730 17:18:22.852831  5122 hierarchical.cpp:171] Initialized hierarchical allocator process
I0730 17:18:22.856233  5119 master.cpp:2163] Elected as the leading master!
I0730 17:18:22.856283  5119 master.cpp:1702] Recovering from registrar
I0730 17:18:22.856429  5120 registrar.cpp:345] Recovering registrar
I0730 17:18:22.857348  5120 registrar.cpp:389] Successfully fetched the registry (0B) in 771072ns
I0730 17:18:22.857578  5120 registrar.cpp:493] Applied 1 operations in 34788ns; attempting
to update the registry
I0730 17:18:22.858355  5120 registrar.cpp:550] Successfully updated the registry in 703744ns
I0730 17:18:22.858567  5120 registrar.cpp:422] Successfully recovered registrar
I0730 17:18:22.859354  5123 hierarchical.cpp:209] Skipping recovery of hierarchical allocator:
nothing to recover
I0730 17:18:22.859478  5121 master.cpp:1801] Recovered 0 agents from the registry (129B);
allowing 10mins for agents to re-register
I0730 17:18:22.867573  5100 cluster.cpp:448] Creating default 'local' authorizer
I0730 17:18:22.870303  5121 slave.cpp:250] Mesos agent started on (208)@172.17.0.3:34861
I0730 17:18:22.870339  5121 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"
--appc_store_dir="/tmp/MasterTest_MultipleExecutors_XwGHZn/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_XwGHZn/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/MasterTest_MultipleExecutors_XwGHZn/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_XwGHZn/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/MasterTest_MultipleExecutors_XwGHZn/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;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true"
--runtime_dir="/tmp/MasterTest_MultipleExecutors_XwGHZn" --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_fWdyEe"
I0730 17:18:22.871074  5121 credentials.hpp:86] Loading credential for authentication from
'/tmp/MasterTest_MultipleExecutors_XwGHZn/credential'
I0730 17:18:22.871341  5121 slave.cpp:283] Agent using credential for: test-principal
I0730 17:18:22.871367  5121 credentials.hpp:37] Loading credentials for authentication from
'/tmp/MasterTest_MultipleExecutors_XwGHZn/http_credentials'
I0730 17:18:22.871738  5121 http.cpp:993] Creating default 'basic' HTTP authenticator for
realm 'mesos-agent-readonly'
I0730 17:18:22.871968  5121 http.cpp:993] Creating default 'basic' HTTP authenticator for
realm 'mesos-agent-readwrite'
I0730 17:18:22.872889  5100 sched.cpp:232] Version: 1.4.0
I0730 17:18:22.873947  5120 sched.cpp:336] New master detected at master@172.17.0.3:34861
I0730 17:18:22.874233  5120 sched.cpp:407] Authenticating with master master@172.17.0.3:34861
I0730 17:18:22.874258  5120 sched.cpp:414] Using default CRAM-MD5 authenticatee
I0730 17:18:22.874327  5121 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":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0730 17:18:22.874763  5121 slave.cpp:573] Agent attributes: [  ]
I0730 17:18:22.874786  5121 slave.cpp:582] Agent hostname: 67eb933dde2f
I0730 17:18:22.874837  5125 authenticatee.cpp:121] Creating new client SASL connection
I0730 17:18:22.874994  5119 status_update_manager.cpp:177] Pausing sending status updates
I0730 17:18:22.875285  5125 master.cpp:7823] Authenticating scheduler-d829fd0e-8d65-4fa7-801e-3ecc66de00fb@172.17.0.3:34861
I0730 17:18:22.875531  5124 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(448)@172.17.0.3:34861
I0730 17:18:22.876252  5124 authenticator.cpp:98] Creating new server SASL connection
I0730 17:18:22.877050  5119 authenticatee.cpp:213] Received SASL authentication mechanisms:
CRAM-MD5
I0730 17:18:22.877099  5119 authenticatee.cpp:239] Attempting to authenticate with mechanism
'CRAM-MD5'
I0730 17:18:22.877058  5124 state.cpp:64] Recovering state from '/tmp/MasterTest_MultipleExecutors_fWdyEe/meta'
I0730 17:18:22.877327  5122 authenticator.cpp:204] Received SASL authentication start
I0730 17:18:22.877776  5122 authenticator.cpp:326] Authentication requires more steps
I0730 17:18:22.878278  5121 status_update_manager.cpp:203] Recovering status update manager
I0730 17:18:22.878345  5122 authenticatee.cpp:259] Received SASL authentication step
I0730 17:18:22.878775  5126 slave.cpp:6207] Finished recovery
I0730 17:18:22.879448  5123 authenticator.cpp:232] Received SASL authentication step
I0730 17:18:22.879504  5123 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: '67eb933dde2f' server FQDN: '67eb933dde2f' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0730 17:18:22.879528  5123 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0730 17:18:22.879580  5123 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0730 17:18:22.879616  5123 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: '67eb933dde2f' server FQDN: '67eb933dde2f' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0730 17:18:22.879637  5123 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since
SASL_AUXPROP_AUTHZID == true
I0730 17:18:22.879654  5123 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5'
since SASL_AUXPROP_AUTHZID == true
I0730 17:18:22.879683  5123 authenticator.cpp:318] Authentication success
I0730 17:18:22.879920  5125 authenticatee.cpp:299] Authentication success
I0730 17:18:22.879961  5126 slave.cpp:6389] Querying resource estimator for oversubscribable
resources
I0730 17:18:22.880017  5121 master.cpp:7853] Successfully authenticated principal 'test-principal'
at scheduler-d829fd0e-8d65-4fa7-801e-3ecc66de00fb@172.17.0.3:34861
I0730 17:18:22.880379  5125 sched.cpp:513] Successfully authenticated with master master@172.17.0.3:34861
I0730 17:18:22.880417  5125 sched.cpp:836] Sending SUBSCRIBE call to master@172.17.0.3:34861
I0730 17:18:22.880190  5124 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(448)@172.17.0.3:34861
I0730 17:18:22.880573  5125 sched.cpp:869] Will retry registration in 1.314524126secs if necessary
I0730 17:18:22.880812  5119 master.cpp:2894] Received SUBSCRIBE call for framework 'default'
at scheduler-d829fd0e-8d65-4fa7-801e-3ecc66de00fb@172.17.0.3:34861
I0730 17:18:22.880846  5122 status_update_manager.cpp:177] Pausing sending status updates
I0730 17:18:22.880941  5119 master.cpp:2228] Authorizing framework principal 'test-principal'
to receive offers for roles '{ * }'
I0730 17:18:22.881007  5126 slave.cpp:971] New master detected at master@172.17.0.3:34861
I0730 17:18:22.881383  5126 slave.cpp:1006] Detecting new master
I0730 17:18:22.881759  5126 slave.cpp:6403] Received oversubscribable resources {} from the
resource estimator
I0730 17:18:22.882117  5122 master.cpp:2974] Subscribing framework default with checkpointing
disabled and capabilities [ RESERVATION_REFINEMENT ]
I0730 17:18:22.883065  5122 sched.cpp:759] Framework registered with 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000
I0730 17:18:22.883138  5122 sched.cpp:773] Scheduler::registered took 26868ns
I0730 17:18:22.883215  5125 hierarchical.cpp:303] Added framework 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000
I0730 17:18:22.883450  5125 hierarchical.cpp:1925] No allocations performed
I0730 17:18:22.883492  5125 hierarchical.cpp:2015] No inverse offers to send out!
I0730 17:18:22.883535  5125 hierarchical.cpp:1468] Performed allocation for 0 agents in 130378ns
I0730 17:18:22.890810  5123 slave.cpp:1033] Authenticating with master master@172.17.0.3:34861
I0730 17:18:22.890944  5123 slave.cpp:1044] Using default CRAM-MD5 authenticatee
I0730 17:18:22.891422  5126 authenticatee.cpp:121] Creating new client SASL connection
I0730 17:18:22.892025  5124 master.cpp:7823] Authenticating slave(208)@172.17.0.3:34861
I0730 17:18:22.892356  5119 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(449)@172.17.0.3:34861
I0730 17:18:22.892757  5121 authenticator.cpp:98] Creating new server SASL connection
I0730 17:18:22.893144  5122 authenticatee.cpp:213] Received SASL authentication mechanisms:
CRAM-MD5
I0730 17:18:22.893190  5122 authenticatee.cpp:239] Attempting to authenticate with mechanism
'CRAM-MD5'
I0730 17:18:22.893442  5122 authenticator.cpp:204] Received SASL authentication start
I0730 17:18:22.893527  5122 authenticator.cpp:326] Authentication requires more steps
I0730 17:18:22.893770  5120 authenticatee.cpp:259] Received SASL authentication step
I0730 17:18:22.893935  5120 authenticator.cpp:232] Received SASL authentication step
I0730 17:18:22.893975  5120 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: '67eb933dde2f' server FQDN: '67eb933dde2f' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0730 17:18:22.893999  5120 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0730 17:18:22.894050  5120 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0730 17:18:22.894084  5120 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: '67eb933dde2f' server FQDN: '67eb933dde2f' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0730 17:18:22.894105  5120 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since
SASL_AUXPROP_AUTHZID == true
I0730 17:18:22.894124  5120 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5'
since SASL_AUXPROP_AUTHZID == true
I0730 17:18:22.894151  5120 authenticator.cpp:318] Authentication success
I0730 17:18:22.894408  5119 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(449)@172.17.0.3:34861
I0730 17:18:22.894457  5126 authenticatee.cpp:299] Authentication success
I0730 17:18:22.894662  5124 master.cpp:7853] Successfully authenticated principal 'test-principal'
at slave(208)@172.17.0.3:34861
I0730 17:18:22.895834  5125 slave.cpp:1128] Successfully authenticated with master master@172.17.0.3:34861
I0730 17:18:22.896170  5125 slave.cpp:1572] Will retry registration in 7.562196ms if necessary
I0730 17:18:22.896647  5125 master.cpp:5707] Received register agent message from slave(208)@172.17.0.3:34861
(67eb933dde2f)
I0730 17:18:22.896818  5125 master.cpp:3803] Authorizing agent with principal 'test-principal'
I0730 17:18:22.897431  5119 master.cpp:5767] Authorized registration of agent at slave(208)@172.17.0.3:34861
(67eb933dde2f)
I0730 17:18:22.897610  5119 master.cpp:5860] Registering agent at slave(208)@172.17.0.3:34861
(67eb933dde2f) with id 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-S0
I0730 17:18:22.898260  5122 registrar.cpp:493] Applied 1 operations in 81987ns; attempting
to update the registry
I0730 17:18:22.899966  5122 registrar.cpp:550] Successfully updated the registry in 1.606144ms
I0730 17:18:22.900339  5122 master.cpp:5907] Admitted agent 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-S0
at slave(208)@172.17.0.3:34861 (67eb933dde2f)
I0730 17:18:22.901451  5124 slave.cpp:4883] Received ping from slave-observer(203)@172.17.0.3:34861
I0730 17:18:22.901340  5122 master.cpp:5938] Registered agent 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-S0
at slave(208)@172.17.0.3:34861 (67eb933dde2f) with [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0730 17:18:22.902045  5124 slave.cpp:1174] Registered with master master@172.17.0.3:34861;
given agent ID 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-S0
I0730 17:18:22.902397  5125 status_update_manager.cpp:184] Resuming sending status updates
I0730 17:18:22.902428  5126 hierarchical.cpp:593] Added agent 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-S0
(67eb933dde2f) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0730 17:18:22.902801  5124 slave.cpp:1194] Checkpointing SlaveInfo to '/tmp/MasterTest_MultipleExecutors_fWdyEe/meta/slaves/884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-S0/slave.info'
I0730 17:18:22.903381  5124 slave.cpp:1232] Forwarding total oversubscribed resources {}
I0730 17:18:22.903816  5121 master.cpp:6674] Received update of agent 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-S0
at slave(208)@172.17.0.3:34861 (67eb933dde2f) with total oversubscribed resources {}
I0730 17:18:22.905020  5126 hierarchical.cpp:2015] No inverse offers to send out!
I0730 17:18:22.905338  5126 hierarchical.cpp:1468] Performed allocation for 1 agents in 2.379959ms
I0730 17:18:22.905730  5126 hierarchical.cpp:660] Agent 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-S0
(67eb933dde2f) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0730 17:18:22.905812  5122 master.cpp:7653] Sending 1 offers to framework 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000
(default) at scheduler-d829fd0e-8d65-4fa7-801e-3ecc66de00fb@172.17.0.3:34861
I0730 17:18:22.906545  5123 sched.cpp:933] Scheduler::resourceOffers took 148384ns
I0730 17:18:22.910118  5123 master.cpp:4153] Processing ACCEPT call for offers: [ 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-O0
] on agent 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-S0 at slave(208)@172.17.0.3:34861 (67eb933dde2f)
for framework 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000 (default) at scheduler-d829fd0e-8d65-4fa7-801e-3ecc66de00fb@172.17.0.3:34861
I0730 17:18:22.910284  5123 master.cpp:3530] Authorizing framework principal 'test-principal'
to launch task 1
I0730 17:18:22.910666  5123 master.cpp:3530] Authorizing framework principal 'test-principal'
to launch task 2
W0730 17:18:22.914234  5125 validation.cpp:1294] 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.
W0730 17:18:22.914301  5125 validation.cpp:1306] 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.
I0730 17:18:22.914863  5125 master.cpp:9709] Adding task 1 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}]
on agent 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-S0 at slave(208)@172.17.0.3:34861 (67eb933dde2f)
I0730 17:18:22.915469  5125 master.cpp:4816] Launching task 1 of framework 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000
(default) at scheduler-d829fd0e-8d65-4fa7-801e-3ecc66de00fb@172.17.0.3:34861 with resources
[{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}]
on agent 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-S0 at slave(208)@172.17.0.3:34861 (67eb933dde2f)
I0730 17:18:22.916304  5122 slave.cpp:1697] Got assigned task '1' for framework 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000
I0730 17:18:22.917280  5122 slave.cpp:1978] Authorizing task '1' for framework 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000
I0730 17:18:22.917366  5122 slave.cpp:6706] Authorizing framework principal 'test-principal'
to launch task 1
W0730 17:18:22.917356  5125 validation.cpp:1294] 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.
W0730 17:18:22.917423  5125 validation.cpp:1306] 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.
I0730 17:18:22.917992  5125 master.cpp:9709] Adding task 2 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}]
on agent 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-S0 at slave(208)@172.17.0.3:34861 (67eb933dde2f)
I0730 17:18:22.918620  5125 master.cpp:4816] Launching task 2 of framework 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000
(default) at scheduler-d829fd0e-8d65-4fa7-801e-3ecc66de00fb@172.17.0.3:34861 with resources
[{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}]
on agent 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-S0 at slave(208)@172.17.0.3:34861 (67eb933dde2f)
I0730 17:18:22.919157  5124 slave.cpp:2165] Launching task '1' for framework 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000
I0730 17:18:22.920104  5124 paths.cpp:578] Trying to chown '/tmp/MasterTest_MultipleExecutors_fWdyEe/slaves/884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-S0/frameworks/884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000/executors/executor-1/runs/e15b66e6-466a-41d9-ba61-950778bf9cce'
to user 'mesos'
I0730 17:18:22.920610  5124 slave.cpp:7162] Launching executor 'executor-1' of framework 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000
with resources [] in work directory '/tmp/MasterTest_MultipleExecutors_fWdyEe/slaves/884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-S0/frameworks/884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000/executors/executor-1/runs/e15b66e6-466a-41d9-ba61-950778bf9cce'
I0730 17:18:22.921401  5124 slave.cpp:2852] Launching container e15b66e6-466a-41d9-ba61-950778bf9cce
for executor 'executor-1' of framework 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000
I0730 17:18:22.922116  5124 slave.cpp:2394] Queued task '1' for executor 'executor-1' of framework
884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000
I0730 17:18:22.922372  5119 hierarchical.cpp:887] Updated allocation of framework 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000
on agent 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-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]
I0730 17:18:22.922830  5124 slave.cpp:1697] Got assigned task '2' for framework 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000
I0730 17:18:22.923499  5119 hierarchical.cpp:1152] 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 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-S0
from framework 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000
I0730 17:18:22.923598  5119 hierarchical.cpp:1189] Framework 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000
filtered agent 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-S0 for 5secs
I0730 17:18:22.923954  5124 slave.cpp:924] Successfully attached file '/tmp/MasterTest_MultipleExecutors_fWdyEe/slaves/884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-S0/frameworks/884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000/executors/executor-1/runs/e15b66e6-466a-41d9-ba61-950778bf9cce'
I0730 17:18:22.924103  5124 slave.cpp:924] Successfully attached file '/tmp/MasterTest_MultipleExecutors_fWdyEe/slaves/884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-S0/frameworks/884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000/executors/executor-1/runs/e15b66e6-466a-41d9-ba61-950778bf9cce'
I0730 17:18:22.924399  5124 slave.cpp:1978] Authorizing task '2' for framework 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000
I0730 17:18:22.924608  5124 slave.cpp:6706] Authorizing framework principal 'test-principal'
to launch task 2
I0730 17:18:22.925995  5121 slave.cpp:2165] Launching task '2' for framework 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000
I0730 17:18:22.926590  5121 paths.cpp:578] Trying to chown '/tmp/MasterTest_MultipleExecutors_fWdyEe/slaves/884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-S0/frameworks/884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000/executors/executor-2/runs/86d8e8de-1d42-49ee-baf2-b0596bd84cb3'
to user 'mesos'
I0730 17:18:22.926911  5121 slave.cpp:7162] Launching executor 'executor-2' of framework 884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000
with resources [] in work directory '/tmp/MasterTest_MultipleExecutors_fWdyEe/slaves/884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-S0/frameworks/884e79e4-5c7f-44fc-a8a0-d1a95f8c335c-0000/executors/executor-2/runs/86d8e8de-1d42-49ee-baf2-b0596bd84cb3'
*** Aborted at 1501435102 (unix time) try "date -d @1501435102" if you are using GNU date
***
PC: @     0x2b248ce2a82d (unknown)
I0730 17:18:22.928104  5119 exec.cpp:162] Version: 1.4.0
I0730 17:18:22.928488  5125 exec.cpp:212] Executor started at: executor(79)@172.17.0.3:34861
with pid 5100
*** SIGSEGV (@0xd0) received by PID 5100 (TID 0x2b249548e700) from PID 208; stack trace: ***
    @     0x2b24bc9da417 (unknown)
    @     0x2b24bc9de6f9 (unknown)
    @     0x2b248cbe1330 (unknown)
    @     0x2b248ce2a82d (unknown)
    @     0x55e729a9923d os::getenv()
    @     0x2b24897f421e mesos::internal::slave::executorEnvironment()
    @     0x2b24897ca4e7 mesos::internal::slave::Slave::launchExecutor()
    @     0x2b24897c5dca mesos::internal::slave::Slave::__run()
    @     0x2b248982cbfb _ZZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS_6FutureISt4listIbSaIbEEEERKNS1_13FrameworkInfoERKNS1_12ExecutorInfoERK6OptionINS1_8TaskInfoEERKSI_INS1_13TaskGroupInfoEES9_SC_SF_SK_SO_EEvRKNS_3PIDIT_EEMSS_FvT0_T1_T2_T3_T4_ET5_T6_T7_T8_T9_ENKUlPNS_11ProcessBaseEE_clES19_
    @     0x2b248986705e _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8dispatchIN5mesos8internal5slave5SlaveERKNS0_6FutureISt4listIbSaIbEEEERKNS5_13FrameworkInfoERKNS5_12ExecutorInfoERK6OptionINS5_8TaskInfoEERKSM_INS5_13TaskGroupInfoEESD_SG_SJ_SO_SS_EEvRKNS0_3PIDIT_EEMSW_FvT0_T1_T2_T3_T4_ET5_T6_T7_T8_T9_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_
    @     0x2b248a688f9b std::function<>::operator()()
    @     0x2b248a66c60f process::ProcessBase::visit()
    @     0x2b248a677c72 process::DispatchEvent::visit()
    @     0x55e729a6cd7c process::ProcessBase::serve()
    @     0x2b248a668b4b process::ProcessManager::resume()
    @     0x2b248a664dd8 _ZZN7process14ProcessManager12init_threadsEvENKUlvE_clEv
    @     0x2b248a676f52 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
    @     0x2b248a676ea9 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEclEv
    @     0x2b248a676e42 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEE6_M_runEv
    @     0x2b248c462a60 (unknown)
    @     0x2b248cbd9184 start_thread
    @     0x2b248ceecffd (unknown)
make[4]: *** [check-local] Segmentation fault (core dumped)
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-1501429483-20450
Untagged: mesos-1501429483-20450:latest
Deleted: sha256:c0f2f367c98277a7d3addce9c63a6177b6e44b1cd813e7721424f3c9371f59aa
Deleted: sha256:b212a67259c41e6d43a7aa0240b38a0fa992f37edaf0b15427dc59afc6c8a771
Deleted: sha256:459f5b5c6b6b66416db36b0e593c39091bf3374541b181af5d8a725489773859
Deleted: sha256:27ca5d02ee3cd9fc8e3f2fef95d9f6826c8b9dc543a93698828a465515fbf74c
Deleted: sha256:46bf7ab1d93da85446f8fea055cec037d0c926f1ad6b03f49cfd064861912a23
Deleted: sha256:3432db223bdf04ded6648cff91c7374314d4babd4fbbb7c669b20bdf47db825a
Deleted: sha256:a0ac44c4024b8818a373a7363ac9255467088609bf73bd3a6e83373534a7497d
Deleted: sha256:6a21f0ccaebf5d393adc748d1bb509106ffc7f10bcdcc760bf9fb9a6fd8a444c
Deleted: sha256:1239cebd68408f783a0d420665ed4b7e41f3624fb6552fbaa33085fb52b27994
Deleted: sha256:df320deea2ca3051bef3f79b6e3813d77b66a0d0257becceb83f290ccdf4faf0
Deleted: sha256:ed988512836a35893eb33762809ac7a082752afc7c5e19518fb7ff441917525d
Deleted: sha256:a9a60923889b1f069cf3a001099aabde5a8e9644820bcec9fd121d037bf115a5
Deleted: sha256:0ffa2280493ae67522d4f49ab68d49ceeaf8655c2940a87edc3917955ae6f16d
Deleted: sha256:aab1d10f7066137cf1ce4c82fe6340f88943c564a0dccad2bf44f78fd737f183
Deleted: sha256:c5d388644ef9eab8a094981ca3189720ac8513bdbbeeb6d6e88f2a67eefa9303
Deleted: sha256:d76b144b0f9e3a3b3d7a0d48decacece5451dd40e7f2b8c7a3f73a5b1cb170b3
Deleted: sha256:579efd21d6f98d29e025995f2e988c5f7fcf3da2a7cd9e5549f11a26f1eff6fc
Deleted: sha256:b771b75e1f113e864037364c803633cdb52afee394f770cb3d2205a575cb8547
Deleted: sha256:5f302523857a52f301dc3852fe100de865f5602267a496a23bfd88891c163bf4
Deleted: sha256:56d8cfd696440f1fac71fda9adf2ca0af02875578ca9904882fbfdadfb54f9a1
Deleted: sha256:50919f959614c50cf3f5118bd5954e59b302afac2884020ca760270c024c0faa
Deleted: sha256:3beb25302de55aeb23da61c9c7278e3a79087689cb736488260cd88c66b483b5
Deleted: sha256:7ed77fd2dd23769c79ce4ff43fd597b7bbfe1a89f390578d5ad46d8956fe6134
Deleted: sha256:9ac5894aecaf57685f56e73a9478feaecdde1e76eeac81dda8ee2f83ce3f86d2
Build step 'Execute shell' marked build as failure

Mime
View raw message