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-Buildbot » cmake,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3549
Date Fri, 21 Apr 2017 21:54:36 GMT
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3549/display/redirect?page=changes>

Changes:

[anand] Added MESOS-7400 to 1.2.1 CHANGELOG.

[vinodkone] Changed 'Principal.claims' to a hashmap.

[vinodkone] Allowed the local authorizer to accept subjects with no value.

[vinodkone] Added a ContainerID to 'ObjectApprover::Object'.

[vinodkone] Added implicit executor authorization to the agent operator API.

[vinodkone] Added implicit authorization to the agent executor API.

[vinodkone] Added a new agent authorization test which runs a task group.

[vinodkone] Added tests for failed executor authorization.

[vinodkone] Enabled authorization in default executor check tests.

------------------------------------------
[...truncated 17.96 MB...]
I0421 21:54:15.346823 27777 http.cpp:1115] HTTP POST for /(558)/api/v1/executor from 172.17.0.2:45392
I0421 21:54:15.347412 27777 executor.cpp:723] Enqueuing locally injected event ERROR
I0421 21:54:15.347877 27772 slave.cpp:790] Agent terminating
I0421 21:54:15.347908 27772 slave.cpp:3057] Asked to shut down framework 5da98cb1-0b60-453d-bba9-829d03993ab9-0000
by @0.0.0.0:0
I0421 21:54:15.347923 27772 slave.cpp:3082] Shutting down framework 5da98cb1-0b60-453d-bba9-829d03993ab9-0000
I0421 21:54:15.347937 27772 slave.cpp:5475] Shutting down executor 'default' of framework
5da98cb1-0b60-453d-bba9-829d03993ab9-0000
W0421 21:54:15.347949 27772 slave.hpp:986] Unable to send event to executor 'default' of framework
5da98cb1-0b60-453d-bba9-829d03993ab9-0000: unknown connection type
I0421 21:54:15.348124 27772 master.cpp:1315] Agent 5da98cb1-0b60-453d-bba9-829d03993ab9-S0
at (558)@172.17.0.2:44744 (87e23b2fa107) disconnected
I0421 21:54:15.348150 27772 master.cpp:3199] Disconnecting agent 5da98cb1-0b60-453d-bba9-829d03993ab9-S0
at (558)@172.17.0.2:44744 (87e23b2fa107)
I0421 21:54:15.348171 27772 master.cpp:3218] Deactivating agent 5da98cb1-0b60-453d-bba9-829d03993ab9-S0
at (558)@172.17.0.2:44744 (87e23b2fa107)
I0421 21:54:15.348204 27772 master.cpp:1342] Removing framework 5da98cb1-0b60-453d-bba9-829d03993ab9-0000
(default) from disconnected agent 5da98cb1-0b60-453d-bba9-829d03993ab9-S0 at (558)@172.17.0.2:44744
(87e23b2fa107) because the framework is not checkpointing
I0421 21:54:15.348219 27772 master.cpp:7946] Removing framework 5da98cb1-0b60-453d-bba9-829d03993ab9-0000
(default) from agent 5da98cb1-0b60-453d-bba9-829d03993ab9-S0 at (558)@172.17.0.2:44744 (87e23b2fa107)
I0421 21:54:15.348258 27772 master.cpp:8350] Updating the state of task 06c18e33-ec58-4e11-a99d-42df80f9988c
of framework 5da98cb1-0b60-453d-bba9-829d03993ab9-0000 (latest state: TASK_LOST, status update
state: TASK_LOST)
I0421 21:54:15.348408 27772 master.cpp:8444] Removing task 06c18e33-ec58-4e11-a99d-42df80f9988c
with resources cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32
of framework 5da98cb1-0b60-453d-bba9-829d03993ab9-0000 on agent 5da98cb1-0b60-453d-bba9-829d03993ab9-S0
at (558)@172.17.0.2:44744 (87e23b2fa107)
I0421 21:54:15.348497 27772 master.cpp:6314] Sending status update TASK_LOST for task 06c18e33-ec58-4e11-a99d-42df80f9988c
of framework 5da98cb1-0b60-453d-bba9-829d03993ab9-0000 'Agent 87e23b2fa107 disconnected'
I0421 21:54:15.348636 27772 master.cpp:8473] Removing executor 'default' with resources cpus(*)(allocated:
*):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 of framework 5da98cb1-0b60-453d-bba9-829d03993ab9-0000
on agent 5da98cb1-0b60-453d-bba9-829d03993ab9-S0 at (558)@172.17.0.2:44744 (87e23b2fa107)
I0421 21:54:15.349552 27777 master.cpp:1432] Framework 5da98cb1-0b60-453d-bba9-829d03993ab9-0000
(default) disconnected
I0421 21:54:15.349663 27777 master.cpp:3162] Deactivating framework 5da98cb1-0b60-453d-bba9-829d03993ab9-0000
(default)
I0421 21:54:15.349794 27777 master.cpp:3139] Disconnecting framework 5da98cb1-0b60-453d-bba9-829d03993ab9-0000
(default)
I0421 21:54:15.349895 27777 master.cpp:1447] Giving framework 5da98cb1-0b60-453d-bba9-829d03993ab9-0000
(default) 0ns to failover
I0421 21:54:15.350164 27777 master.cpp:6928] Framework failover timeout, removing framework
5da98cb1-0b60-453d-bba9-829d03993ab9-0000 (default)
I0421 21:54:15.350283 27777 master.cpp:7782] Removing framework 5da98cb1-0b60-453d-bba9-829d03993ab9-0000
(default)
I0421 21:54:15.350401 27772 hierarchical.cpp:655] Agent 5da98cb1-0b60-453d-bba9-829d03993ab9-S0
deactivated
I0421 21:54:15.350599 27772 hierarchical.cpp:1116] Recovered cpus(*)(allocated: *):0.1; mem(*)(allocated:
*):32; disk(*)(allocated: *):32 (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000],
allocated: cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32) on
agent 5da98cb1-0b60-453d-bba9-829d03993ab9-S0 from framework 5da98cb1-0b60-453d-bba9-829d03993ab9-0000
I0421 21:54:15.350718 27772 hierarchical.cpp:1116] Recovered cpus(*)(allocated: *):0.1; mem(*)(allocated:
*):32; disk(*)(allocated: *):32 (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000],
allocated: {}) on agent 5da98cb1-0b60-453d-bba9-829d03993ab9-S0 from framework 5da98cb1-0b60-453d-bba9-829d03993ab9-0000
I0421 21:54:15.350754 27772 hierarchical.cpp:376] Deactivated framework 5da98cb1-0b60-453d-bba9-829d03993ab9-0000
I0421 21:54:15.350797 27772 hierarchical.cpp:323] Removed framework 5da98cb1-0b60-453d-bba9-829d03993ab9-0000
I0421 21:54:15.356803 27768 master.cpp:1157] Master terminating
[       OK ] ExecutorAuthorizationTest.FailedSubscribe (86 ms)
[ RUN      ] ExecutorAuthorizationTest.FailedApiCalls
I0421 21:54:15.365419 27768 cluster.cpp:162] Creating default 'local' authorizer
I0421 21:54:15.366902 27780 master.cpp:438] Master 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112 (87e23b2fa107)
started on 172.17.0.2:44744
I0421 21:54:15.366924 27780 master.cpp:440] 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/mbQI5t/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/mbQI5t/master" --zk_session_timeout="10secs"
I0421 21:54:15.367079 27780 master.cpp:490] Master only allowing authenticated frameworks
to register
I0421 21:54:15.367086 27780 master.cpp:504] Master only allowing authenticated agents to register
I0421 21:54:15.367092 27780 master.cpp:517] Master only allowing authenticated HTTP frameworks
to register
I0421 21:54:15.367099 27780 credentials.hpp:37] Loading credentials for authentication from
'/tmp/mbQI5t/credentials'
I0421 21:54:15.367252 27780 master.cpp:562] Using default 'crammd5' authenticator
I0421 21:54:15.367305 27780 http.cpp:975] Creating default 'basic' HTTP authenticator for
realm 'mesos-master-readonly'
I0421 21:54:15.367341 27780 http.cpp:975] Creating default 'basic' HTTP authenticator for
realm 'mesos-master-readwrite'
I0421 21:54:15.367363 27780 http.cpp:975] Creating default 'basic' HTTP authenticator for
realm 'mesos-master-scheduler'
I0421 21:54:15.367398 27780 master.cpp:642] Authorization enabled
I0421 21:54:15.367532 27784 whitelist_watcher.cpp:77] No whitelist given
I0421 21:54:15.367561 27769 hierarchical.cpp:159] Initialized hierarchical allocator process
I0421 21:54:15.369426 27776 master.cpp:2163] Elected as the leading master!
I0421 21:54:15.369448 27776 master.cpp:1702] Recovering from registrar
I0421 21:54:15.369513 27776 registrar.cpp:345] Recovering registrar
I0421 21:54:15.369751 27776 registrar.cpp:389] Successfully fetched the registry (0B) in 219904ns
I0421 21:54:15.369791 27776 registrar.cpp:493] Applied 1 operations in 6185ns; attempting
to update the registry
I0421 21:54:15.369988 27776 registrar.cpp:550] Successfully updated the registry in 178944ns
I0421 21:54:15.370028 27776 registrar.cpp:422] Successfully recovered registrar
I0421 21:54:15.370142 27776 master.cpp:1801] Recovered 0 agents from the registry (129B);
allowing 10mins for agents to re-register
I0421 21:54:15.370201 27776 hierarchical.cpp:186] Skipping recovery of hierarchical allocator:
nothing to recover
I0421 21:54:15.374058 27768 cluster.cpp:448] Creating default 'local' authorizer
I0421 21:54:15.375326 27768 scheduler.cpp:184] Version: 1.3.0
I0421 21:54:15.375458 27775 slave.cpp:225] Mesos agent started on (494)@172.17.0.2:44744
I0421 21:54:15.375771 27783 scheduler.cpp:470] New master detected at master@172.17.0.2:44744
I0421 21:54:15.375798 27783 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection)
attempt with the master
I0421 21:54:15.375488 27775 slave.cpp:226] Flags at startup: --acls="permissive: true
" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/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/ExecutorAuthorizationTest_FailedApiCalls_cEaNQY/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_secret_key="/tmp/ExecutorAuthorizationTest_FailedApiCalls_cEaNQY/executor_secret_key"
--executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/ExecutorAuthorizationTest_FailedApiCalls_cEaNQY/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/ExecutorAuthorizationTest_FailedApiCalls_cEaNQY/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/ExecutorAuthorizationTest_FailedApiCalls_cEaNQY" --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/ExecutorAuthorizationTest_FailedApiCalls_MEefte"
I0421 21:54:15.376170 27775 credentials.hpp:86] Loading credential for authentication from
'/tmp/ExecutorAuthorizationTest_FailedApiCalls_cEaNQY/credential'
I0421 21:54:15.376693 27775 slave.cpp:258] Agent using credential for: test-principal
I0421 21:54:15.376709 27775 credentials.hpp:37] Loading credentials for authentication from
'/tmp/ExecutorAuthorizationTest_FailedApiCalls_cEaNQY/http_credentials'
I0421 21:54:15.376936 27783 scheduler.cpp:361] Connected with the master at http://172.17.0.2:44744/master/api/v1/scheduler
I0421 21:54:15.379628 27783 scheduler.cpp:243] Sending SUBSCRIBE call to http://172.17.0.2:44744/master/api/v1/scheduler
I0421 21:54:15.381819 27783 process.cpp:3722] Handling HTTP event for process 'master' with
path: '/master/api/v1/scheduler'
I0421 21:54:15.382200 27783 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:45395
I0421 21:54:15.382292 27783 master.cpp:2515] Received subscription request for HTTP framework
'default'
I0421 21:54:15.382323 27783 master.cpp:2199] Authorizing framework principal 'test-principal'
to receive offers for roles '{ * }'
I0421 21:54:15.382542 27783 master.cpp:2630] Subscribing framework 'default' with checkpointing
disabled and capabilities [  ]
I0421 21:54:15.382803 27783 hierarchical.cpp:271] Added framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000
I0421 21:54:15.382846 27783 hierarchical.cpp:1862] No allocations performed
I0421 21:54:15.382858 27783 hierarchical.cpp:1952] No inverse offers to send out!
I0421 21:54:15.382869 27783 hierarchical.cpp:1446] Performed allocation for 0 agents in 30257ns
I0421 21:54:15.382951 27783 master.hpp:2167] Sending heartbeat to 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000
I0421 21:54:15.386775 27769 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from http://172.17.0.2:44744/master/api/v1/scheduler
I0421 21:54:15.387316 27784 scheduler.cpp:676] Enqueuing event HEARTBEAT received from http://172.17.0.2:44744/master/api/v1/scheduler
I0421 21:54:15.396191 27775 http.cpp:975] Creating default 'basic' HTTP authenticator for
realm 'mesos-agent-executor'
I0421 21:54:15.396284 27775 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm
'mesos-agent-executor'
I0421 21:54:15.396386 27775 http.cpp:975] Creating default 'basic' HTTP authenticator for
realm 'mesos-agent-readonly'
I0421 21:54:15.396415 27775 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm
'mesos-agent-readonly'
I0421 21:54:15.396499 27775 http.cpp:975] Creating default 'basic' HTTP authenticator for
realm 'mesos-agent-readwrite'
I0421 21:54:15.399919 27775 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm
'mesos-agent-readwrite'
I0421 21:54:15.400563 27775 slave.cpp:525] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024;
ports(*):[31000-32000]
I0421 21:54:15.400619 27775 slave.cpp:533] Agent attributes: [  ]
I0421 21:54:15.400629 27775 slave.cpp:538] Agent hostname: 87e23b2fa107
I0421 21:54:15.400961 27769 status_update_manager.cpp:177] Pausing sending status updates
I0421 21:54:15.401115 27772 state.cpp:62] Recovering state from '/tmp/ExecutorAuthorizationTest_FailedApiCalls_MEefte/meta'
I0421 21:54:15.401360 27771 status_update_manager.cpp:203] Recovering status update manager
I0421 21:54:15.401571 27771 slave.cpp:5963] Finished recovery
I0421 21:54:15.402024 27771 slave.cpp:6145] Querying resource estimator for oversubscribable
resources
I0421 21:54:15.402138 27771 slave.cpp:918] New master detected at master@172.17.0.2:44744
I0421 21:54:15.402176 27771 slave.cpp:953] Detecting new master
I0421 21:54:15.402202 27771 slave.cpp:6159] Received oversubscribable resources {} from the
resource estimator
I0421 21:54:15.402225 27771 status_update_manager.cpp:177] Pausing sending status updates
I0421 21:54:15.408596 27771 slave.cpp:980] Authenticating with master master@172.17.0.2:44744
I0421 21:54:15.408653 27771 slave.cpp:991] Using default CRAM-MD5 authenticatee
I0421 21:54:15.408771 27771 authenticatee.cpp:121] Creating new client SASL connection
I0421 21:54:15.408996 27771 master.cpp:7257] Authenticating slave(494)@172.17.0.2:44744
I0421 21:54:15.409122 27780 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1007)@172.17.0.2:44744
I0421 21:54:15.409212 27780 authenticator.cpp:98] Creating new server SASL connection
I0421 21:54:15.409346 27780 authenticatee.cpp:213] Received SASL authentication mechanisms:
CRAM-MD5
I0421 21:54:15.409363 27780 authenticatee.cpp:239] Attempting to authenticate with mechanism
'CRAM-MD5'
I0421 21:54:15.409400 27780 authenticator.cpp:204] Received SASL authentication start
I0421 21:54:15.409447 27780 authenticator.cpp:326] Authentication requires more steps
I0421 21:54:15.409481 27780 authenticatee.cpp:259] Received SASL authentication step
I0421 21:54:15.409523 27780 authenticator.cpp:232] Received SASL authentication step
I0421 21:54:15.409543 27780 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: '87e23b2fa107' server FQDN: '87e23b2fa107' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0421 21:54:15.409553 27780 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0421 21:54:15.409566 27780 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0421 21:54:15.409579 27780 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: '87e23b2fa107' server FQDN: '87e23b2fa107' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0421 21:54:15.409587 27780 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since
SASL_AUXPROP_AUTHZID == true
I0421 21:54:15.409595 27780 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5'
since SASL_AUXPROP_AUTHZID == true
I0421 21:54:15.409610 27780 authenticator.cpp:318] Authentication success
I0421 21:54:15.409662 27780 authenticatee.cpp:299] Authentication success
I0421 21:54:15.409696 27780 master.cpp:7287] Successfully authenticated principal 'test-principal'
at slave(494)@172.17.0.2:44744
I0421 21:54:15.409726 27780 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1007)@172.17.0.2:44744
I0421 21:54:15.409811 27780 slave.cpp:1075] Successfully authenticated with master master@172.17.0.2:44744
I0421 21:54:15.409886 27780 slave.cpp:1503] Will retry registration in 18.15501ms if necessary
I0421 21:54:15.410040 27780 master.cpp:5447] Registering agent at slave(494)@172.17.0.2:44744
(87e23b2fa107) with id 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-S0
I0421 21:54:15.410202 27780 registrar.cpp:493] Applied 1 operations in 21366ns; attempting
to update the registry
I0421 21:54:15.410429 27780 registrar.cpp:550] Successfully updated the registry in 203008ns
I0421 21:54:15.410745 27780 master.cpp:5521] Registered agent 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-S0
at slave(494)@172.17.0.2:44744 (87e23b2fa107) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0421 21:54:15.410810 27773 slave.cpp:1121] Registered with master master@172.17.0.2:44744;
given agent ID 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-S0
I0421 21:54:15.410826 27773 fetcher.cpp:94] Clearing fetcher cache
I0421 21:54:15.410835 27782 hierarchical.cpp:527] Added agent 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-S0
(87e23b2fa107) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated:
{})
I0421 21:54:15.411020 27780 status_update_manager.cpp:184] Resuming sending status updates
I0421 21:54:15.411201 27782 hierarchical.cpp:1952] No inverse offers to send out!
I0421 21:54:15.411223 27782 hierarchical.cpp:1446] Performed allocation for 1 agents in 327547ns
I0421 21:54:15.411442 27770 master.cpp:7087] Sending 1 offers to framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000
(default)
I0421 21:54:15.412281 27784 scheduler.cpp:676] Enqueuing event OFFERS received from http://172.17.0.2:44744/master/api/v1/scheduler
I0421 21:54:15.413208 27784 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.2:44744/master/api/v1/scheduler
I0421 21:54:15.414034 27784 process.cpp:3722] Handling HTTP event for process 'master' with
path: '/master/api/v1/scheduler'
I0421 21:54:15.414434 27784 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:45394
I0421 21:54:15.414769 27784 master.cpp:3853] Processing ACCEPT call for offers: [ 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-O0
] on agent 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-S0 at slave(494)@172.17.0.2:44744 (87e23b2fa107)
for framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000 (default)
I0421 21:54:15.414831 27784 master.cpp:3429] Authorizing framework principal 'test-principal'
to launch task b3ee5920-bede-426e-868a-65bd2c8f4748
I0421 21:54:15.416249 27784 master.cpp:9102] Adding task b3ee5920-bede-426e-868a-65bd2c8f4748
with resources cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32
on agent 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-S0 at slave(494)@172.17.0.2:44744 (87e23b2fa107)
I0421 21:54:15.416342 27784 master.cpp:4708] Launching task group { b3ee5920-bede-426e-868a-65bd2c8f4748
} of framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000 (default) with resources cpus(*)(allocated:
*):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 on agent 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-S0
at slave(494)@172.17.0.2:44744 (87e23b2fa107)
I0421 21:54:15.416612 27770 hierarchical.cpp:1116] Recovered cpus(*)(allocated: *):1.8; mem(*)(allocated:
*):960; disk(*)(allocated: *):960; ports(*)(allocated: *):[31000-32000] (total: cpus(*):2;
mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*)(allocated: *):0.2; mem(*)(allocated:
*):64; disk(*)(allocated: *):64) on agent 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-S0 from framework
0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000
I0421 21:54:15.416647 27770 hierarchical.cpp:1153] Framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000
filtered agent 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-S0 for 5secs
I0421 21:54:15.447882 27773 slave.cpp:1149] Checkpointing SlaveInfo to '/tmp/ExecutorAuthorizationTest_FailedApiCalls_MEefte/meta/slaves/0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-S0/slave.info'
I0421 21:54:15.448282 27773 slave.cpp:1187] Forwarding total oversubscribed resources {}
I0421 21:54:15.448421 27781 master.cpp:6106] Received update of agent 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-S0
at slave(494)@172.17.0.2:44744 (87e23b2fa107) with total oversubscribed resources {}
I0421 21:54:15.448475 27773 slave.cpp:4745] Received ping from slave-observer(483)@172.17.0.2:44744
I0421 21:54:15.448657 27773 slave.cpp:1613] Got assigned task group containing tasks [ b3ee5920-bede-426e-868a-65bd2c8f4748
] for framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000
I0421 21:54:15.449112 27773 slave.cpp:1894] Authorizing task group containing tasks [ b3ee5920-bede-426e-868a-65bd2c8f4748
] for framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000
I0421 21:54:15.449143 27773 slave.cpp:6582] Authorizing framework principal 'test-principal'
to launch task b3ee5920-bede-426e-868a-65bd2c8f4748
I0421 21:54:15.449643 27773 slave.cpp:2081] Launching task group containing tasks [ b3ee5920-bede-426e-868a-65bd2c8f4748
] for framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000
I0421 21:54:15.450328 27773 paths.cpp:556] Trying to chown '/tmp/ExecutorAuthorizationTest_FailedApiCalls_MEefte/slaves/0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-S0/frameworks/0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000/executors/default/runs/4df3e01c-e1c9-4d15-9bf1-b8e8bc2e23cb'
to user 'mesos'
I0421 21:54:15.450572 27773 slave.cpp:6926] Launching executor 'default' of framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000
with resources cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32
in work directory '/tmp/ExecutorAuthorizationTest_FailedApiCalls_MEefte/slaves/0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-S0/frameworks/0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000/executors/default/runs/4df3e01c-e1c9-4d15-9bf1-b8e8bc2e23cb'
I0421 21:54:15.450969 27773 slave.cpp:2310] Queued task group containing tasks [ b3ee5920-bede-426e-868a-65bd2c8f4748
] for executor 'default' of framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000
I0421 21:54:15.451076 27773 slave.cpp:871] Successfully attached file '/tmp/ExecutorAuthorizationTest_FailedApiCalls_MEefte/slaves/0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-S0/frameworks/0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000/executors/default/runs/4df3e01c-e1c9-4d15-9bf1-b8e8bc2e23cb'
I0421 21:54:15.452584 27778 executor.cpp:192] Version: 1.3.0
I0421 21:54:15.453783 27780 executor.cpp:410] Connected with the agent
I0421 21:54:15.454519 27784 executor.cpp:307] Sending SUBSCRIBE call to http://172.17.0.2:44744/slave(494)/api/v1/executor
I0421 21:54:15.455075 27784 process.cpp:3722] Handling HTTP event for process 'slave(494)'
with path: '/slave(494)/api/v1/executor'
I0421 21:54:15.455900 27784 http.cpp:1115] HTTP POST for /slave(494)/api/v1/executor from
172.17.0.2:45404
I0421 21:54:15.455991 27784 slave.cpp:3568] Received Subscribe request for HTTP executor 'default'
of framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000
I0421 21:54:15.457371 27784 slave.cpp:2552] Sending queued task group task group containing
tasks [ b3ee5920-bede-426e-868a-65bd2c8f4748 ] to executor 'default' of framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000
(via HTTP)
I0421 21:54:15.460391 27773 executor.cpp:725] Enqueuing event SUBSCRIBED received from http://172.17.0.2:44744/slave(494)/api/v1/executor
I0421 21:54:15.460721 27784 executor.cpp:725] Enqueuing event LAUNCH_GROUP received from http://172.17.0.2:44744/slave(494)/api/v1/executor
I0421 21:54:15.462455 27778 process.cpp:3722] Handling HTTP event for process 'slave(494)'
with path: '/slave(494)/api/v1'
I0421 21:54:15.463165 27778 http.cpp:1115] HTTP POST for /slave(494)/api/v1 from 172.17.0.2:45412
I0421 21:54:15.463305 27778 http.cpp:527] Processing call LAUNCH_NESTED_CONTAINER
I0421 21:54:15.464862 27783 process.cpp:3722] Handling HTTP event for process 'slave(494)'
with path: '/slave(494)/api/v1'
I0421 21:54:15.465517 27783 http.cpp:1115] HTTP POST for /slave(494)/api/v1 from 172.17.0.2:45413
I0421 21:54:15.465677 27783 http.cpp:527] Processing call LAUNCH_NESTED_CONTAINER_SESSION
I0421 21:54:15.469816 27778 process.cpp:3722] Handling HTTP event for process 'slave(494)'
with path: '/slave(494)/api/v1'
I0421 21:54:15.470537 27778 http.cpp:1115] HTTP POST for /slave(494)/api/v1 from 172.17.0.2:45414
I0421 21:54:15.470684 27778 http.cpp:527] Processing call WAIT_NESTED_CONTAINER
I0421 21:54:15.472357 27774 process.cpp:3722] Handling HTTP event for process 'slave(494)'
with path: '/slave(494)/api/v1'
I0421 21:54:15.473042 27769 http.cpp:1115] HTTP POST for /slave(494)/api/v1 from 172.17.0.2:45415
I0421 21:54:15.473152 27769 http.cpp:527] Processing call KILL_NESTED_CONTAINER
I0421 21:54:15.479714 27776 process.cpp:3722] Handling HTTP event for process 'slave(494)'
with path: '/slave(494)/api/v1'
I0421 21:54:15.480401 27776 http.cpp:1115] HTTP POST for /slave(494)/api/v1 from 172.17.0.2:45416
I0421 21:54:15.480551 27776 http.cpp:527] Processing call REMOVE_NESTED_CONTAINER
I0421 21:54:15.482995 27773 process.cpp:3722] Handling HTTP event for process 'slave(494)'
with path: '/slave(494)/api/v1'
I0421 21:54:15.485586 27772 http.cpp:1115] HTTP POST for /slave(494)/api/v1 from 172.17.0.2:45417
I0421 21:54:15.485766 27772 http.cpp:527] Processing call ATTACH_CONTAINER_OUTPUT
I0421 21:54:15.488070 27772 process.cpp:3722] Handling HTTP event for process 'slave(494)'
with path: '/slave(494)/api/v1/executor'
I0421 21:54:15.488983 27778 http.cpp:1115] HTTP POST for /slave(494)/api/v1/executor from
172.17.0.2:45418
I0421 21:54:15.490478 27783 process.cpp:3722] Handling HTTP event for process 'slave(494)'
with path: '/slave(494)/api/v1/executor'
I0421 21:54:15.491421 27777 http.cpp:1115] HTTP POST for /slave(494)/api/v1/executor from
172.17.0.2:45420
I0421 21:54:15.496040 27776 master.cpp:1432] Framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000
(default) disconnected
I0421 21:54:15.496074 27776 master.cpp:3162] Deactivating framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000
(default)
I0421 21:54:15.496101 27776 master.cpp:3139] Disconnecting framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000
(default)
I0421 21:54:15.496115 27776 master.cpp:1447] Giving framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000
(default) 0ns to failover
I0421 21:54:15.496140 27769 hierarchical.cpp:376] Deactivated framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000
I0421 21:54:15.496260 27772 master.cpp:6928] Framework failover timeout, removing framework
0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000 (default)
I0421 21:54:15.496276 27772 master.cpp:7782] Removing framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000
(default)
I0421 21:54:15.496346 27772 master.cpp:8350] Updating the state of task b3ee5920-bede-426e-868a-65bd2c8f4748
of framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000 (latest state: TASK_KILLED, status
update state: TASK_KILLED)
I0421 21:54:15.496363 27771 slave.cpp:3057] Asked to shut down framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000
by master@172.17.0.2:44744
I0421 21:54:15.496399 27771 slave.cpp:3082] Shutting down framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000
I0421 21:54:15.496414 27771 slave.cpp:5475] Shutting down executor 'default' of framework
0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000 (via HTTP)
I0421 21:54:15.496529 27772 master.cpp:8444] Removing task b3ee5920-bede-426e-868a-65bd2c8f4748
with resources cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32
of framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000 on agent 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-S0
at slave(494)@172.17.0.2:44744 (87e23b2fa107)
I0421 21:54:15.496662 27772 master.cpp:8473] Removing executor 'default' with resources cpus(*)(allocated:
*):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 of framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000
on agent 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-S0 at slave(494)@172.17.0.2:44744 (87e23b2fa107)
I0421 21:54:15.496682 27771 hierarchical.cpp:1116] Recovered cpus(*)(allocated: *):0.1; mem(*)(allocated:
*):32; disk(*)(allocated: *):32 (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000],
allocated: cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32) on
agent 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-S0 from framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000
I0421 21:54:15.496904 27771 hierarchical.cpp:1116] Recovered cpus(*)(allocated: *):0.1; mem(*)(allocated:
*):32; disk(*)(allocated: *):32 (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000],
allocated: {}) on agent 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-S0 from framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000
I0421 21:54:15.497036 27771 hierarchical.cpp:323] Removed framework 0d3a29a3-ffe9-4e6c-9c43-bf81cff61112-0000
I0421 21:54:15.497769 27772 executor.cpp:725] Enqueuing event SHUTDOWN received from http://172.17.0.2:44744/slave(494)/api/v1/executor
*** Aborted at 1492811655 (unix time) try "date -d @1492811655" if you are using GNU date
***
PC: @          0x1cacdc3 testing::internal::UntypedFunctionMockerBase::SetOwnerAndName()
*** SIGSEGV (@0x358) received by PID 27768 (TID 0x2ac9d5ce8700) from PID 856; stack trace:
***
    @     0x2ac9ccad3330 (unknown)
    @          0x1cacdc3 testing::internal::UntypedFunctionMockerBase::SetOwnerAndName()
    @           0xdd77d1 mesos::internal::tests::executor::MockHTTPExecutor<>::event()
    @           0xdfb9d7 mesos::internal::tests::executor::TestMesos<>::events()
    @           0xde784d std::_Function_handler<>::_M_invoke()
    @     0x2ac9c9ea9805 process::AsyncExecutorProcess::execute<>()
    @     0x2ac9c9eb33e5 _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8dispatchI7NothingNS0_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v18executor5EventESt5dequeISC_SaISC_EEEEESG_SK_SG_EENS0_6FutureIT_EERKNS0_3PIDIT0_EEMSR_FSO_T1_T2_ET3_T4_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_
    @     0x2ac9caea5011 process::ProcessManager::resume()
    @     0x2ac9caeade97 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv
    @     0x2ac9ccd92a60 (unknown)
    @     0x2ac9ccacb184 start_thread
    @     0x2ac9cd5febed (unknown)
make[3]: *** [CMakeFiles/check] Segmentation fault
make[3]: Leaving directory `/mesos/build'
make[2]: *** [CMakeFiles/check.dir/all] Error 2
make[2]: Leaving directory `/mesos/build'
make[1]: *** [CMakeFiles/check.dir/rule] Error 2
make[1]: Leaving directory `/mesos/build'
make: *** [check] Error 2
+ docker rmi mesos-1492806359-24321
Untagged: mesos-1492806359-24321:latest
Deleted: sha256:5de95137678705e08c63e77cd277541de1ed111f6b794bea768cc299cc5878f7
Deleted: sha256:b4c0a8bd5926d63145e8a54f8270907af12f5d6853467b7bde0eb2a73335c357
Deleted: sha256:faaac0c9b72fdf813743b3ab14777ea128f77460823c124bb72934d4702aa69b
Deleted: sha256:02b51b272f10a3f2afdf787db451ad9aaa07fed5781fd04f262c7f8ddca99b29
Deleted: sha256:cd32636ce15faf9b3a5395eb0bfc0169c586c88c6130098956764f08d3ac0b31
Deleted: sha256:0366bbf791d220e60a8a53da0c09d7dceb01d2a3e1a71c1d77c5eb91ba531314
Deleted: sha256:43fd34bc8839d1dd12bb2860b2baa64990458c137c4eb25e82743859a1d7345d
Deleted: sha256:57f83795b5ca40ce1254b753bfe38e1c252b4296286c9e37c0f90789331d34ba
Deleted: sha256:8ebbc70c1e11102cda2f054fcc40f2a1f09636ebe484f2f77ac698f8b8edfe6c
Deleted: sha256:8af2fc446a116c02f336e5433afd4e41efaf650ffeb463add5c490a41fe4016e
Deleted: sha256:57426bfb9f0b4b97e214c8aa38dfdbbb5ac2000c630a38b35fce57c54b7b1f86
Deleted: sha256:2bfa7d803f27f0c2a1974d2f58368d1c97b0aad85aa2d811580714d85cf6a883
Deleted: sha256:f92e000eacc3e75105f8d2823993c748d824534adbd6c01879f1b14b67b75451
Deleted: sha256:0f74663a1c780f2534dbe21d9c83ab38419be269ed096a7f27cb276dc976bbff
Deleted: sha256:4d2c700b015d4bfda058c2db881c5d50d0986ca42aade2f2a74849b5cefddcfc
Deleted: sha256:1c7db7aef2d40815fdbefe14aa2896e0d2116284a23b186214637c7c3f684304
Deleted: sha256:071cd9588cc481f0c904b48b1ce7db5df372c616ccd656a7c19699767a9e3348
Deleted: sha256:213aa550421d299f0591e719e07ef81248cb1068ec7218ac0b89adc3526d559b
Deleted: sha256:7447a2faddab1ee56df58ca3ac9d52a890e3d9fbaeeacd2731c1ffa4572f1fb0
Deleted: sha256:520f1b4d0081e8db9821001cf54b1dcab4ca2f9b629e8039b09e1c19ee45c0c9
Deleted: sha256:175c917b6afc932f8e44940eb9fe86d5ce5f25b9fc63187e5f52c515fd638acf
Deleted: sha256:7cbf46c849558ef6ec32c385c49fa73ae2248b2e4790ccf5d57b09ec2aa6fb78
Deleted: sha256:7886f87f8b3cc90c823e6609c2c612817eaa44739460a1213deb6e4bd893707f
Deleted: sha256:c1e27cc89f1b66273c8b3468f51fba77e83e17c76bce1310702b42bf2832f93b
Build step 'Execute shell' marked build as failure

Mime
View raw message