See
<https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=clang,CONFIGURATION=--verbose%20--disable-libtool-wrappers%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4324/display/redirect?page=changes>
Changes:
[jpeach] Added a benchmark test for allocating shared resources.
------------------------------------------
[...truncated 19.11 MB...]
I1013 23:51:44.853505 6771 slave.cpp:6506] Received oversubscribable resources
{} from the resource estimator
I1013 23:51:44.864217 6762 slave.cpp:1055] Authenticating with master
[email protected]:46604
I1013 23:51:44.864317 6762 slave.cpp:1064] Using default CRAM-MD5 authenticatee
I1013 23:51:44.864644 6767 authenticatee.cpp:121] Creating new client SASL
connection
I1013 23:51:44.865123 6774 master.cpp:7936] Authenticating
slave(392)@172.17.0.2:46604
I1013 23:51:44.865224 6781 authenticator.cpp:414] Starting authentication
session for crammd5-authenticatee(836)@172.17.0.2:46604
I1013 23:51:44.865525 6768 authenticator.cpp:98] Creating new server SASL
connection
I1013 23:51:44.865767 6770 authenticatee.cpp:213] Received SASL authentication
mechanisms: CRAM-MD5
I1013 23:51:44.865798 6770 authenticatee.cpp:239] Attempting to authenticate
with mechanism 'CRAM-MD5'
I1013 23:51:44.865952 6768 authenticator.cpp:204] Received SASL authentication
start
I1013 23:51:44.866011 6768 authenticator.cpp:326] Authentication requires more
steps
I1013 23:51:44.866137 6775 authenticatee.cpp:259] Received SASL authentication
step
I1013 23:51:44.866300 6761 authenticator.cpp:232] Received SASL authentication
step
I1013 23:51:44.866336 6761 auxprop.cpp:109] Request to lookup properties for
user: 'test-principal' realm: '080f3c58946f' server FQDN: '080f3c58946f'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: false
I1013 23:51:44.866356 6761 auxprop.cpp:181] Looking up auxiliary property
'*userPassword'
I1013 23:51:44.866408 6761 auxprop.cpp:181] Looking up auxiliary property
'*cmusaslsecretCRAM-MD5'
I1013 23:51:44.866432 6761 auxprop.cpp:109] Request to lookup properties for
user: 'test-principal' realm: '080f3c58946f' server FQDN: '080f3c58946f'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: true
I1013 23:51:44.866443 6761 auxprop.cpp:131] Skipping auxiliary property
'*userPassword' since SASL_AUXPROP_AUTHZID == true
I1013 23:51:44.866452 6761 auxprop.cpp:131] Skipping auxiliary property
'*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I1013 23:51:44.866468 6761 authenticator.cpp:318] Authentication success
I1013 23:51:44.866561 6773 authenticatee.cpp:299] Authentication success
I1013 23:51:44.866659 6761 master.cpp:7966] Successfully authenticated
principal 'test-principal' at slave(392)@172.17.0.2:46604
I1013 23:51:44.866688 6773 authenticator.cpp:432] Authentication session
cleanup for crammd5-authenticatee(836)@172.17.0.2:46604
I1013 23:51:44.867077 6766 slave.cpp:1147] Successfully authenticated with
master [email protected]:46604
I1013 23:51:44.867318 6766 slave.cpp:1626] Will retry registration in
7.247958ms if necessary
I1013 23:51:44.867620 6777 master.cpp:5801] Received register agent message
from slave(392)@172.17.0.2:46604 (080f3c58946f)
I1013 23:51:44.867686 6777 master.cpp:3838] Authorizing agent with principal
'test-principal'
I1013 23:51:44.868329 6777 master.cpp:5861] Authorized registration of agent
at slave(392)@172.17.0.2:46604 (080f3c58946f)
I1013 23:51:44.868458 6777 master.cpp:5954] Registering agent at
slave(392)@172.17.0.2:46604 (080f3c58946f) with id
ce5bcce8-7821-47cb-a7b0-79d947909c38-S0
I1013 23:51:44.868827 6763 registrar.cpp:495] Applied 1 operations in
100687ns; attempting to update the registry
I1013 23:51:44.869575 6763 registrar.cpp:552] Successfully updated the
registry in 674816ns
I1013 23:51:44.869781 6771 master.cpp:6001] Admitted agent
ce5bcce8-7821-47cb-a7b0-79d947909c38-S0 at slave(392)@172.17.0.2:46604
(080f3c58946f)
I1013 23:51:44.870461 6767 slave.cpp:4966] Received ping from
slave-observer(398)@172.17.0.2:46604
I1013 23:51:44.870743 6767 slave.cpp:1193] Registered with master
[email protected]:46604; given agent ID ce5bcce8-7821-47cb-a7b0-79d947909c38-S0
I1013 23:51:44.870496 6771 master.cpp:6032] Registered agent
ce5bcce8-7821-47cb-a7b0-79d947909c38-S0 at slave(392)@172.17.0.2:46604
(080f3c58946f) 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"}]
I1013 23:51:44.870847 6775 status_update_manager.cpp:184] Resuming sending
status updates
I1013 23:51:44.870831 6781 hierarchical.cpp:593] Added agent
ce5bcce8-7821-47cb-a7b0-79d947909c38-S0 (080f3c58946f) with cpus:2; mem:1024;
disk:1024; ports:[31000-32000] (allocated: {})
I1013 23:51:44.871044 6767 slave.cpp:1213] Checkpointing SlaveInfo to
'/tmp/ReservationEndpointsTest_InsufficientResources_L0rieD/meta/slaves/ce5bcce8-7821-47cb-a7b0-79d947909c38-S0/slave.info'
I1013 23:51:44.871212 6781 hierarchical.cpp:1943] No allocations performed
I1013 23:51:44.871276 6781 hierarchical.cpp:1486] Performed allocation for 1
agents in 189658ns
I1013 23:51:44.871387 6767 slave.cpp:1262] Forwarding total oversubscribed
resources {}
I1013 23:51:44.871593 6769 master.cpp:6817] Received update of agent
ce5bcce8-7821-47cb-a7b0-79d947909c38-S0 at slave(392)@172.17.0.2:46604
(080f3c58946f) with total oversubscribed resources {}
I1013 23:51:44.871763 6769 master.cpp:6828] Ignoring update on agent
ce5bcce8-7821-47cb-a7b0-79d947909c38-S0 at slave(392)@172.17.0.2:46604
(080f3c58946f) as it reports no changes
I1013 23:51:44.874330 6783 process.cpp:3929] Handling HTTP event for process
'master' with path: '/master/reserve'
I1013 23:51:44.875799 6765 hierarchical.cpp:1943] No allocations performed
I1013 23:51:44.875881 6765 hierarchical.cpp:1486] Performed allocation for 1
agents in 242582ns
I1013 23:51:44.876092 6765 http.cpp:1185] HTTP POST for /master/reserve from
172.17.0.2:42984
I1013 23:51:44.876890 6765 master.cpp:3623] Authorizing principal
'test-principal' to reserve resources
'[{"name":"cpus","reservations":[{"principal":"test-principal","role":"role","type":"DYNAMIC"}],"scalar":{"value":4.0},"type":"SCALAR"},{"name":"mem","reservations":[{"principal":"test-principal","role":"role","type":"DYNAMIC"}],"scalar":{"value":4096.0},"type":"SCALAR"}]'
I1013 23:51:44.882134 6778 process.cpp:3929] Handling HTTP event for process
'master' with path: '/master/unreserve'
I1013 23:51:44.883354 6775 http.cpp:1185] HTTP POST for /master/unreserve from
172.17.0.2:42986
I1013 23:51:44.884030 6775 master.cpp:3691] Authorizing principal
'test-principal' to unreserve resources
'[{"name":"cpus","reservations":[{"principal":"test-principal","role":"role","type":"DYNAMIC"}],"scalar":{"value":4.0},"type":"SCALAR"},{"name":"mem","reservations":[{"principal":"test-principal","role":"role","type":"DYNAMIC"}],"scalar":{"value":4096.0},"type":"SCALAR"}]'
I1013 23:51:44.887377 6772 slave.cpp:869] Agent terminating
I1013 23:51:44.887630 6772 master.cpp:1303] Agent
ce5bcce8-7821-47cb-a7b0-79d947909c38-S0 at slave(392)@172.17.0.2:46604
(080f3c58946f) disconnected
I1013 23:51:44.887665 6772 master.cpp:3336] Disconnecting agent
ce5bcce8-7821-47cb-a7b0-79d947909c38-S0 at slave(392)@172.17.0.2:46604
(080f3c58946f)
I1013 23:51:44.887724 6772 master.cpp:3355] Deactivating agent
ce5bcce8-7821-47cb-a7b0-79d947909c38-S0 at slave(392)@172.17.0.2:46604
(080f3c58946f)
I1013 23:51:44.887895 6778 hierarchical.cpp:690] Agent
ce5bcce8-7821-47cb-a7b0-79d947909c38-S0 deactivated
I1013 23:51:44.900769 6760 master.cpp:1145] Master terminating
I1013 23:51:44.901687 6766 hierarchical.cpp:626] Removed agent
ce5bcce8-7821-47cb-a7b0-79d947909c38-S0
[ OK ] ReservationEndpointsTest.InsufficientResources (90 ms)
[ RUN ] ReservationEndpointsTest.NoHeader
I1013 23:51:44.909339 6760 cluster.cpp:162] Creating default 'local' authorizer
I1013 23:51:44.912811 6774 master.cpp:445] Master
93acd52d-cfec-4c64-a368-d07dfebea5f2 (080f3c58946f) started on 172.17.0.2:46604
I1013 23:51:44.912889 6774 master.cpp:447] Flags at startup: --acls=""
--agent_ping_timeout="15secs" --agent_reregister_timeout="10mins"
--allocation_interval="50ms" --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/WS8JrI/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" --roles="role"
--root_submissions="true" --user_sorter="drf" --version="false"
--webui_dir="/mesos/mesos-1.5.0/_inst/share/mesos/webui"
--work_dir="/tmp/WS8JrI/master" --zk_session_timeout="10secs"
I1013 23:51:44.913228 6774 master.cpp:496] Master only allowing authenticated
frameworks to register
I1013 23:51:44.913244 6774 master.cpp:502] Master only allowing authenticated
agents to register
I1013 23:51:44.913254 6774 master.cpp:508] Master only allowing authenticated
HTTP frameworks to register
I1013 23:51:44.913267 6774 credentials.hpp:37] Loading credentials for
authentication from '/tmp/WS8JrI/credentials'
I1013 23:51:44.913619 6774 master.cpp:552] Using default 'crammd5'
authenticator
I1013 23:51:44.913827 6774 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readonly'
I1013 23:51:44.914017 6774 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readwrite'
I1013 23:51:44.914155 6774 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-scheduler'
I1013 23:51:44.914315 6774 master.cpp:631] Authorization enabled
W1013 23:51:44.914337 6774 master.cpp:694] The '--roles' flag is deprecated.
This flag will be removed in the future. See the Mesos 0.27 upgrade notes for
more information
I1013 23:51:44.914554 6773 whitelist_watcher.cpp:77] No whitelist given
I1013 23:51:44.914567 6777 hierarchical.cpp:171] Initialized hierarchical
allocator process
I1013 23:51:44.917316 6780 master.cpp:2198] Elected as the leading master!
I1013 23:51:44.917372 6780 master.cpp:1687] Recovering from registrar
I1013 23:51:44.917650 6778 registrar.cpp:347] Recovering registrar
I1013 23:51:44.918306 6778 registrar.cpp:391] Successfully fetched the
registry (0B) in 614912ns
I1013 23:51:44.918454 6778 registrar.cpp:495] Applied 1 operations in 53634ns;
attempting to update the registry
I1013 23:51:44.919122 6778 registrar.cpp:552] Successfully updated the
registry in 605952ns
I1013 23:51:44.919240 6778 registrar.cpp:424] Successfully recovered registrar
I1013 23:51:44.919714 6761 master.cpp:1791] Recovered 0 agents from the
registry (129B); allowing 10mins for agents to re-register
I1013 23:51:44.919781 6764 hierarchical.cpp:209] Skipping recovery of
hierarchical allocator: nothing to recover
W1013 23:51:44.925555 6760 process.cpp:3194] Attempted to spawn already
running process [email protected]:46604
I1013 23:51:44.926741 6760 containerizer.cpp:292] Using isolation {
environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W1013 23:51:44.927407 6760 backend.cpp:76] Failed to create 'aufs' backend:
AufsBackend requires root privileges
W1013 23:51:44.927531 6760 backend.cpp:76] Failed to create 'bind' backend:
BindBackend requires root privileges
I1013 23:51:44.927572 6760 provisioner.cpp:255] Using default backend 'copy'
I1013 23:51:44.929745 6760 cluster.cpp:448] Creating default 'local' authorizer
I1013 23:51:44.932106 6764 slave.cpp:254] Mesos agent started on
(393)@172.17.0.2:46604
I1013 23:51:44.932163 6764 slave.cpp:255] Flags at startup: --acls=""
--appc_simple_discovery_uri_prefix="http://";
--appc_store_dir="/tmp/ReservationEndpointsTest_NoHeader_msslkg/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/ReservationEndpointsTest_NoHeader_msslkg/credential"
--default_role="*" --disallow_sharing_agent_pid_namespace="false"
--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/ReservationEndpointsTest_NoHeader_msslkg/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/ReservationEndpointsTest_NoHeader_msslkg/executor_secret_key"
--executor_shutdown_grace_period="5secs"
--fetcher_cache_dir="/tmp/ReservationEndpointsTest_NoHeader_msslkg/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/ReservationEndpointsTest_NoHeader_msslkg/http_credentials"
--http_heartbeat_interval="30secs" --initialize_driver_logging="true"
--isolation="posix/cpu,posix/mem" --launcher="posix"
--launcher_dir="/mesos/mesos-1.5.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/ReservationEndpointsTest_NoHeader_msslkg"
--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/ReservationEndpointsTest_NoHeader_0sO1nu"
--zk_session_timeout="10secs"
I1013 23:51:44.932663 6764 credentials.hpp:86] Loading credential for
authentication from '/tmp/ReservationEndpointsTest_NoHeader_msslkg/credential'
I1013 23:51:44.932929 6764 slave.cpp:287] Agent using credential for:
test-principal
I1013 23:51:44.932958 6764 credentials.hpp:37] Loading credentials for
authentication from
'/tmp/ReservationEndpointsTest_NoHeader_msslkg/http_credentials'
I1013 23:51:44.933286 6764 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-executor'
I1013 23:51:44.933439 6764 http.cpp:1066] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-executor'
I1013 23:51:44.933672 6764 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-readonly'
I1013 23:51:44.933784 6764 http.cpp:1066] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-readonly'
I1013 23:51:44.933976 6764 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-readwrite'
I1013 23:51:44.934077 6764 http.cpp:1066] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-readwrite'
I1013 23:51:44.936125 6764 slave.cpp:585] 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"}]
I1013 23:51:44.936452 6764 slave.cpp:593] Agent attributes: [ ]
I1013 23:51:44.936568 6764 slave.cpp:602] Agent hostname: 080f3c58946f
I1013 23:51:44.936805 6779 status_update_manager.cpp:177] Pausing sending
status updates
I1013 23:51:44.938691 6763 state.cpp:64] Recovering state from
'/tmp/ReservationEndpointsTest_NoHeader_0sO1nu/meta'
I1013 23:51:44.939010 6773 status_update_manager.cpp:203] Recovering status
update manager
I1013 23:51:44.939265 6777 containerizer.cpp:648] Recovering containerizer
I1013 23:51:44.940685 6783 provisioner.cpp:416] Provisioner recovery complete
I1013 23:51:44.941107 6779 slave.cpp:6310] Finished recovery
I1013 23:51:44.941654 6779 slave.cpp:6492] Querying resource estimator for
oversubscribable resources
I1013 23:51:44.941874 6775 status_update_manager.cpp:177] Pausing sending
status updates
I1013 23:51:44.941913 6779 slave.cpp:993] New master detected at
[email protected]:46604
I1013 23:51:44.942049 6779 slave.cpp:1028] Detecting new master
I1013 23:51:44.942188 6779 slave.cpp:6506] Received oversubscribable resources
{} from the resource estimator
I1013 23:51:44.946336 6763 slave.cpp:1055] Authenticating with master
[email protected]:46604
I1013 23:51:44.946490 6763 slave.cpp:1064] Using default CRAM-MD5 authenticatee
I1013 23:51:44.946836 6778 authenticatee.cpp:121] Creating new client SASL
connection
I1013 23:51:44.947222 6773 master.cpp:7936] Authenticating
slave(393)@172.17.0.2:46604
I1013 23:51:44.947335 6784 authenticator.cpp:414] Starting authentication
session for crammd5-authenticatee(837)@172.17.0.2:46604
I1013 23:51:44.947573 6762 authenticator.cpp:98] Creating new server SASL
connection
I1013 23:51:44.947834 6762 authenticatee.cpp:213] Received SASL authentication
mechanisms: CRAM-MD5
I1013 23:51:44.947866 6762 authenticatee.cpp:239] Attempting to authenticate
with mechanism 'CRAM-MD5'
I1013 23:51:44.948017 6774 authenticator.cpp:204] Received SASL authentication
start
I1013 23:51:44.948077 6774 authenticator.cpp:326] Authentication requires more
steps
I1013 23:51:44.948181 6772 authenticatee.cpp:259] Received SASL authentication
step
I1013 23:51:44.948318 6780 authenticator.cpp:232] Received SASL authentication
step
I1013 23:51:44.948356 6780 auxprop.cpp:109] Request to lookup properties for
user: 'test-principal' realm: '080f3c58946f' server FQDN: '080f3c58946f'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: false
I1013 23:51:44.948382 6780 auxprop.cpp:181] Looking up auxiliary property
'*userPassword'
I1013 23:51:44.948439 6780 auxprop.cpp:181] Looking up auxiliary property
'*cmusaslsecretCRAM-MD5'
I1013 23:51:44.948511 6780 auxprop.cpp:109] Request to lookup properties for
user: 'test-principal' realm: '080f3c58946f' server FQDN: '080f3c58946f'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: true
I1013 23:51:44.948529 6780 auxprop.cpp:131] Skipping auxiliary property
'*userPassword' since SASL_AUXPROP_AUTHZID == true
I1013 23:51:44.948580 6780 auxprop.cpp:131] Skipping auxiliary property
'*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I1013 23:51:44.948606 6780 authenticator.cpp:318] Authentication success
I1013 23:51:44.948712 6768 authenticatee.cpp:299] Authentication success
I1013 23:51:44.948781 6776 master.cpp:7966] Successfully authenticated
principal 'test-principal' at slave(393)@172.17.0.2:46604
I1013 23:51:44.948822 6777 authenticator.cpp:432] Authentication session
cleanup for crammd5-authenticatee(837)@172.17.0.2:46604
I1013 23:51:44.949009 6770 slave.cpp:1147] Successfully authenticated with
master [email protected]:46604
*** Aborted at 1507938704 (unix time) try "date -d @1507938704" if you are
using GNU date ***
I1013 23:51:44.949247 6770 slave.cpp:1626] Will retry registration in
18.292144ms if necessary
I1013 23:51:44.949527 6770 master.cpp:5801] Received register agent message
from slave(393)@172.17.0.2:46604 (080f3c58946f)
I1013 23:51:44.949563 6770 master.cpp:3838] Authorizing agent with principal
'test-principal'
I1013 23:51:44.950091 6767 master.cpp:5861] Authorized registration of agent
at slave(393)@172.17.0.2:46604 (080f3c58946f)
I1013 23:51:44.950207 6767 master.cpp:5954] Registering agent at
slave(393)@172.17.0.2:46604 (080f3c58946f) with id
93acd52d-cfec-4c64-a368-d07dfebea5f2-S0
I1013 23:51:44.950558 6775 registrar.cpp:495] Applied 1 operations in 82028ns;
attempting to update the registry
I1013 23:51:44.951200 6779 registrar.cpp:552] Successfully updated the
registry in 551168ns
I1013 23:51:44.951483 6763 master.cpp:6001] Admitted agent
93acd52d-cfec-4c64-a368-d07dfebea5f2-S0 at slave(393)@172.17.0.2:46604
(080f3c58946f)
I1013 23:51:44.952137 6773 slave.cpp:4966] Received ping from
slave-observer(399)@172.17.0.2:46604
I1013 23:51:44.952407 6773 slave.cpp:1193] Registered with master
[email protected]:46604; given agent ID 93acd52d-cfec-4c64-a368-d07dfebea5f2-S0
I1013 23:51:44.952188 6763 master.cpp:6032] Registered agent
93acd52d-cfec-4c64-a368-d07dfebea5f2-S0 at slave(393)@172.17.0.2:46604
(080f3c58946f) 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"}]
I1013 23:51:44.952540 6772 status_update_manager.cpp:184] Resuming sending
status updates
I1013 23:51:44.952641 6784 hierarchical.cpp:593] Added agent
93acd52d-cfec-4c64-a368-d07dfebea5f2-S0 (080f3c58946f) with cpus:2; mem:1024;
disk:1024; ports:[31000-32000] (allocated: {})
I1013 23:51:44.952793 6773 slave.cpp:1213] Checkpointing SlaveInfo to
'/tmp/ReservationEndpointsTest_NoHeader_0sO1nu/meta/slaves/93acd52d-cfec-4c64-a368-d07dfebea5f2-S0/slave.info'
I1013 23:51:44.952898 6784 hierarchical.cpp:1943] No allocations performed
I1013 23:51:44.952961 6784 hierarchical.cpp:1486] Performed allocation for 1
agents in 187802ns
I1013 23:51:44.953217 6773 slave.cpp:1262] Forwarding total oversubscribed
resources {}
I1013 23:51:44.953413 6761 master.cpp:6817] Received update of agent
93acd52d-cfec-4c64-a368-d07dfebea5f2-S0 at slave(393)@172.17.0.2:46604
(080f3c58946f) with total oversubscribed resources {}
I1013 23:51:44.953598 6761 master.cpp:6828] Ignoring update on agent
93acd52d-cfec-4c64-a368-d07dfebea5f2-S0 at slave(393)@172.17.0.2:46604
(080f3c58946f) as it reports no changes
I1013 23:51:44.956408 6767 process.cpp:3929] Handling HTTP event for process
'master' with path: '/master/reserve'
I1013 23:51:44.960872 6783 process.cpp:3929] Handling HTTP event for process
'master' with path: '/master/unreserve'
I1013 23:51:44.963680 6784 slave.cpp:869] Agent terminating
I1013 23:51:44.963943 6777 master.cpp:1303] Agent
93acd52d-cfec-4c64-a368-d07dfebea5f2-S0 at slave(393)@172.17.0.2:46604
(080f3c58946f) disconnected
I1013 23:51:44.963977 6777 master.cpp:3336] Disconnecting agent
93acd52d-cfec-4c64-a368-d07dfebea5f2-S0 at slave(393)@172.17.0.2:46604
(080f3c58946f)
I1013 23:51:44.964139 6777 master.cpp:3355] Deactivating agent
93acd52d-cfec-4c64-a368-d07dfebea5f2-S0 at slave(393)@172.17.0.2:46604
(080f3c58946f)
I1013 23:51:44.964375 6771 hierarchical.cpp:690] Agent
93acd52d-cfec-4c64-a368-d07dfebea5f2-S0 deactivated
I1013 23:51:44.965267 6772 hierarchical.cpp:1943] No allocations performed
I1013 23:51:44.965327 6772 hierarchical.cpp:1486] Performed allocation for 1
agents in 201569ns
PC: @ 0x2b5a998b3bc0 process::EventQueue::Consumer::empty()
*** SIGSEGV (@0x8) received by PID 6760 (TID 0x2b5aa6422700) from PID 8; stack
trace: ***
@ 0x2b5aaaa21af7 (unknown)
@ 0x2b5aaaa26449 (unknown)
@ 0x2b5a9c686330 (unknown)
I1013 23:51:44.978029 6765 master.cpp:1145] Master terminating
I1013 23:51:44.978888 6779 hierarchical.cpp:626] Removed agent
93acd52d-cfec-4c64-a368-d07dfebea5f2-S0
[ OK ] ReservationEndpointsTest.NoHeader (78 ms)
[ RUN ] ReservationEndpointsTest.BadCredentials
I1013 23:51:44.988415 6760 cluster.cpp:162] Creating default 'local' authorizer
I1013 23:51:44.991685 6767 master.cpp:445] Master
4c90ee68-8301-4d40-87a4-31d4fdac8152 (080f3c58946f) started on 172.17.0.2:46604
I1013 23:51:44.991749 6767 master.cpp:447] Flags at startup: --acls=""
--agent_ping_timeout="15secs" --agent_reregister_timeout="10mins"
--allocation_interval="50ms" --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/mFzOpA/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" --roles="role"
--root_submissions="true" --user_sorter="drf" --version="false"
--webui_dir="/mesos/mesos-1.5.0/_inst/share/mesos/webui"
--work_dir="/tmp/mFzOpA/master" --zk_session_timeout="10secs"
I1013 23:51:44.992168 6767 master.cpp:496] Master only allowing authenticated
frameworks to register
I1013 23:51:44.992184 6767 master.cpp:502] Master only allowing authenticated
agents to register
I1013 23:51:44.992195 6767 master.cpp:508] Master only allowing authenticated
HTTP frameworks to register
I1013 23:51:44.992208 6767 credentials.hpp:37] Loading credentials for
authentication from '/tmp/mFzOpA/credentials'
I1013 23:51:44.992601 6767 master.cpp:552] Using default 'crammd5'
authenticator
I1013 23:51:44.992825 6767 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readonly'
I1013 23:51:44.993018 6767 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readwrite'
I1013 23:51:44.993167 6767 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-scheduler'
I1013 23:51:44.993330 6767 master.cpp:631] Authorization enabled
W1013 23:51:44.993356 6767 master.cpp:694] The '--roles' flag is deprecated.
This flag will be removed in the future. See the Mesos 0.27 upgrade notes for
more information
I1013 23:51:44.993580 6783 hierarchical.cpp:171] Initialized hierarchical
allocator process
I1013 23:51:44.993702 6773 whitelist_watcher.cpp:77] No whitelist given
I1013 23:51:44.996886 6766 master.cpp:2198] Elected as the leading master!
I1013 23:51:44.996927 6766 master.cpp:1687] Recovering from registrar
I1013 23:51:44.997068 6775 registrar.cpp:347] Recovering registrar
I1013 23:51:44.997629 6775 registrar.cpp:391] Successfully fetched the
registry (0B) in 519168ns
I1013 23:51:44.997750 6775 registrar.cpp:495] Applied 1 operations in 43742ns;
attempting to update the registry
I1013 23:51:44.998252 6775 registrar.cpp:552] Successfully updated the
registry in 442880ns
I1013 23:51:44.998375 6775 registrar.cpp:424] Successfully recovered registrar
I1013 23:51:44.998695 6780 master.cpp:1791] Recovered 0 agents from the
registry (129B); allowing 10mins for agents to re-register
I1013 23:51:44.998767 6774 hierarchical.cpp:209] Skipping recovery of
hierarchical allocator: nothing to recover
@ 0x2b5a998b3bc0 process::EventQueue::Consumer::empty()
@ 0x2b5a998975d9 process::ProcessManager::resume()
@ 0x2b5a998a75a1
process::ProcessManager::init_threads()::$_9::operator()()
@ 0x2b5a998a74e5
_ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvE3$_9vEE9_M_invokeIJEEEvSt12_Index_tupleIJXspT_EEE
@ 0x2b5a998a74b5 std::_Bind_simple<>::operator()()
@ 0x2b5a998a748c std::thread::_Impl<>::_M_run()
@ 0x2b5a9bf07a60 (unknown)
@ 0x2b5a9c67e184 start_thread
@ 0x2b5a9c991ffd (unknown)
make[4]: *** [check-local] Segmentation fault (core dumped)
make[4]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.5.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1507935822-28430
Untagged: mesos-1507935822-28430:latest
Deleted: sha256:e3648af78b3e6ae26ffc3a266602e67b3f121d44252fe477e98f22e941cbea22
Deleted: sha256:67502ccce924895955501bf522d308e7b8a5b5ed3c2e098b769ddb0973c00da2
Deleted: sha256:cda1b97132213c19abf4e36d655b08c0a5977ce1687af8937aad1a75e9739dea
Deleted: sha256:70cfb41bfcd41237a1b90dd607b92f4e8ab93dd5fbbffb67c4b80993266e3044
Deleted: sha256:2d85a6c5326bb016b871d4c31cba136c3b3d37e5d1064e45cd569c750d6e4763
Deleted: sha256:947923828be8850bb9e77a3a75d0785b3ff69aa6c791f7221155cb4bbbd0e59f
Deleted: sha256:37dc5c6d71792b1f7fe5ba43fdc35235ecab10e8a2b1c81e0a139cdcc08aec8f
Deleted: sha256:809fb6a61bfa8344467b978dce391d7ed289458867962008a445f06ccf9c0fd2
Deleted: sha256:660ed53c0e1c2095dfe0fdea683f4b608d611e84503169d527022edbda819056
Deleted: sha256:dba9107e59ffb2c89b5eeb2063b6f94a23ece00eb3fcf2ef9008ab4169a82819
Deleted: sha256:894dee45caa61d03951a882ebc20017ab6773c782029a9445453e85d34ed46ab
Deleted: sha256:8d38c686d807f328f2e4e2e8767e672a9d81d90362e4696542d720cf266071ce
Deleted: sha256:8b713c9ccf97ab36fa018fca7e65564f5c3f674b17f5c2fc3af3928372fbbb64
Deleted: sha256:5d6012cbea2918e6eabd46e5ad3604f3f16c999b7fec56f9d98ffab01e86ac0d
Deleted: sha256:5460be57e9ed899bbfa9529ae6646d3339743e50139366a41686b24d147aa4c8
Deleted: sha256:89a91845cad7e48476595505e0b86bea21023961b7ff2111cba15ff0260f6ae4
Deleted: sha256:0ccda72d3206c6909e5caa5b1d3d6e1f687181303a5b4e6df2c9f93f9f1eae4b
Deleted: sha256:164ede1d611f70958f0edfd9083b9d9442c510fb31f8c1362d0b334c10090326
Deleted: sha256:bcbc419250468ebc4da555f003d55f99f9a6b780338a8213c854b7eee445b8de
Deleted: sha256:2d516c80f202b24fa6e0470bc3780f95c6c6a8e812826c53de6af400e024da9d
Deleted: sha256:4fcfbb967b85ad0b4baddedaead1edb94e53baab873f7f9febc6753bff29d68c
Deleted: sha256:5f838efb36a520edcfe5580dcc32e70db7d521f2f3fbb00a2598a7bb768c36ac
Deleted: sha256:eded8f8bb2951b9edee99f1b0eecb6e0240d0485a7ccbaf738f9b4d2d65e9c6a
Deleted: sha256:5d69a5a4a2948c85d5af94db7de0f123521b6a8b13812a4985a39b0a7dc4a3e6
Deleted: sha256:04982242e2df871d105d41f72f5f89a4b56f005b92f191f7506211379b347b1d
Deleted: sha256:d94f4e78a9bda4f38e97c3c1623ea7ae8f3475a8c4f0764ca58f1156ffd5ebdf
Deleted: sha256:3ffbdd49852c7de75acfd28b7b159ad875d1cbe7412690774b07e3c89b70bf2d
Deleted: sha256:099d167d1d65d2d79750169fc329d43cffa723c41ddeed8df77feb25297a420e
Build step 'Execute shell' marked build as failure
