mesos-issues mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From "Jan Schlicht (JIRA)" <j...@apache.org>
Subject [jira] [Updated] (MESOS-8263) ResourceProviderManagerHttpApiTest.ConvertResources is flaky
Date Thu, 23 Nov 2017 15:18:00 GMT

     [ https://issues.apache.org/jira/browse/MESOS-8263?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel
]

Jan Schlicht updated MESOS-8263:
--------------------------------
          Sprint: Mesosphere Sprint 68
    Story Points: 2
          Labels: mesosphere test  (was: test)

> ResourceProviderManagerHttpApiTest.ConvertResources is flaky
> ------------------------------------------------------------
>
>                 Key: MESOS-8263
>                 URL: https://issues.apache.org/jira/browse/MESOS-8263
>             Project: Mesos
>          Issue Type: Bug
>          Components: flaky
>            Reporter: Jan Schlicht
>            Assignee: Jan Schlicht
>              Labels: mesosphere, test
>
> From a ASF CI run:
> {noformat}
> 3: [       OK ] ContentType/ResourceProviderManagerHttpApiTest.ConvertResources/0 (1048
ms)
> 3: [ RUN      ] ContentType/ResourceProviderManagerHttpApiTest.ConvertResources/1
> 3: I1123 08:06:04.233137 20036 cluster.cpp:162] Creating default 'local' authorizer
> 3: I1123 08:06:04.237293 20060 master.cpp:448] Master 7c9d8e8c-3fb3-44c5-8505-488ada3e848e
(dce3e4c418cb) started on 172.17.0.2:35090
> 3: I1123 08:06:04.237325 20060 master.cpp:450] 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/EpiTO7/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="/usr/local/share/mesos/webui" --work_dir="/tmp/EpiTO7/master"
--zk_session_timeout="10secs"
> 3: I1123 08:06:04.237727 20060 master.cpp:499] Master only allowing authenticated frameworks
to register
> 3: I1123 08:06:04.237743 20060 master.cpp:505] Master only allowing authenticated agents
to register
> 3: I1123 08:06:04.237753 20060 master.cpp:511] Master only allowing authenticated HTTP
frameworks to register
> 3: I1123 08:06:04.237764 20060 credentials.hpp:37] Loading credentials for authentication
from '/tmp/EpiTO7/credentials'
> 3: I1123 08:06:04.238149 20060 master.cpp:555] Using default 'crammd5' authenticator
> 3: I1123 08:06:04.238358 20060 http.cpp:1045] Creating default 'basic' HTTP authenticator
for realm 'mesos-master-readonly'
> 3: I1123 08:06:04.238575 20060 http.cpp:1045] Creating default 'basic' HTTP authenticator
for realm 'mesos-master-readwrite'
> 3: I1123 08:06:04.238764 20060 http.cpp:1045] Creating default 'basic' HTTP authenticator
for realm 'mesos-master-scheduler'
> 3: I1123 08:06:04.238939 20060 master.cpp:634] Authorization enabled
> 3: I1123 08:06:04.239159 20043 whitelist_watcher.cpp:77] No whitelist given
> 3: I1123 08:06:04.239187 20045 hierarchical.cpp:173] Initialized hierarchical allocator
process
> 3: I1123 08:06:04.242822 20041 master.cpp:2215] Elected as the leading master!
> 3: I1123 08:06:04.242857 20041 master.cpp:1695] Recovering from registrar
> 3: I1123 08:06:04.243067 20052 registrar.cpp:347] Recovering registrar
> 3: I1123 08:06:04.243808 20052 registrar.cpp:391] Successfully fetched the registry (0B)
in 690944ns
> 3: I1123 08:06:04.243953 20052 registrar.cpp:495] Applied 1 operations in 37370ns; attempting
to update the registry
> 3: I1123 08:06:04.244638 20052 registrar.cpp:552] Successfully updated the registry in
620032ns
> 3: I1123 08:06:04.244798 20052 registrar.cpp:424] Successfully recovered registrar
> 3: I1123 08:06:04.245352 20058 hierarchical.cpp:211] Skipping recovery of hierarchical
allocator: nothing to recover
> 3: I1123 08:06:04.245358 20057 master.cpp:1808] Recovered 0 agents from the registry
(129B); allowing 10mins for agents to re-register
> 3: W1123 08:06:04.251852 20036 process.cpp:2756] Attempted to spawn already running process
files@172.17.0.2:35090
> 3: I1123 08:06:04.253250 20036 containerizer.cpp:301] Using isolation { environment_secret,
posix/cpu, posix/mem, filesystem/posix, network/cni }
> 3: W1123 08:06:04.253965 20036 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend
requires root privileges
> 3: W1123 08:06:04.254109 20036 backend.cpp:76] Failed to create 'bind' backend: BindBackend
requires root privileges
> 3: I1123 08:06:04.254148 20036 provisioner.cpp:259] Using default backend 'copy'
> 3: I1123 08:06:04.256542 20036 cluster.cpp:448] Creating default 'local' authorizer
> 3: I1123 08:06:04.260066 20057 slave.cpp:262] Mesos agent started on (784)@172.17.0.2:35090
> 3: I1123 08:06:04.260093 20057 slave.cpp:263] Flags at startup: --acls="" --agent_features="capabilities
{
> 3:   type: MULTI_ROLE
> 3: }
> 3: capabilities {
> 3:   type: HIERARCHICAL_ROLE
> 3: }
> 3: capabilities {
> 3:   type: RESERVATION_REFINEMENT
> 3: }
> 3: capabilities {
> 3:   type: RESOURCE_PROVIDER
> 3: }
> 3: " --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_1_Vr92Vg/store/appc"
--authenticate_http_executors="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="false"
--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/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_1_Vr92Vg/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/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_1_Vr92Vg/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/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_1_Vr92Vg/executor_secret_key"
--executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_1_Vr92Vg/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/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_1_Vr92Vg/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/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_1_Vr92Vg"
--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/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_1_ycwsnc"
--zk_session_timeout="10secs"
> 3: I1123 08:06:04.260721 20057 credentials.hpp:86] Loading credential for authentication
from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_1_Vr92Vg/credential'
> 3: I1123 08:06:04.260936 20057 slave.cpp:295] Agent using credential for: test-principal
> 3: I1123 08:06:04.260975 20057 credentials.hpp:37] Loading credentials for authentication
from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_1_Vr92Vg/http_credentials'
> 3: I1123 08:06:04.261390 20057 http.cpp:1045] Creating default 'basic' HTTP authenticator
for realm 'mesos-agent-executor'
> 3: I1123 08:06:04.261538 20057 http.cpp:1066] Creating default 'jwt' HTTP authenticator
for realm 'mesos-agent-executor'
> 3: I1123 08:06:04.261780 20057 http.cpp:1045] Creating default 'basic' HTTP authenticator
for realm 'mesos-agent-readonly'
> 3: I1123 08:06:04.261898 20057 http.cpp:1066] Creating default 'jwt' HTTP authenticator
for realm 'mesos-agent-readonly'
> 3: I1123 08:06:04.263828 20057 slave.cpp:593] 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"}]
> 3: I1123 08:06:04.264111 20057 slave.cpp:601] Agent attributes: [  ]
> 3: I1123 08:06:04.264124 20057 slave.cpp:610] Agent hostname: dce3e4c418cb
> 3: I1123 08:06:04.264286 20054 task_status_update_manager.cpp:181] Pausing sending task
status updates
> 3: I1123 08:06:04.266237 20052 state.cpp:64] Recovering state from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_1_ycwsnc/meta'
> 3: I1123 08:06:04.266593 20052 task_status_update_manager.cpp:207] Recovering task status
update manager
> 3: I1123 08:06:04.266840 20045 containerizer.cpp:668] Recovering containerizer
> 3: I1123 08:06:04.268791 20048 provisioner.cpp:455] Provisioner recovery complete
> 3: I1123 08:06:04.269258 20054 slave.cpp:6493] Finished recovery
> 3: I1123 08:06:04.270414 20057 task_status_update_manager.cpp:181] Pausing sending task
status updates
> 3: I1123 08:06:04.270411 20055 slave.cpp:1007] New master detected at master@172.17.0.2:35090
> 3: I1123 08:06:04.270539 20055 slave.cpp:1042] Detecting new master
> 3: I1123 08:06:04.283004 20040 slave.cpp:1069] Authenticating with master master@172.17.0.2:35090
> 3: I1123 08:06:04.283128 20040 slave.cpp:1078] Using default CRAM-MD5 authenticatee
> 3: I1123 08:06:04.283475 20042 authenticatee.cpp:121] Creating new client SASL connection
> 3: I1123 08:06:04.283859 20052 master.cpp:8312] Authenticating slave(784)@172.17.0.2:35090
> 3: I1123 08:06:04.284049 20038 authenticator.cpp:414] Starting authentication session
for crammd5-authenticatee(1421)@172.17.0.2:35090
> 3: I1123 08:06:04.284358 20043 authenticator.cpp:98] Creating new server SASL connection
> 3: I1123 08:06:04.284647 20049 authenticatee.cpp:213] Received SASL authentication mechanisms:
CRAM-MD5
> 3: I1123 08:06:04.284683 20049 authenticatee.cpp:239] Attempting to authenticate with
mechanism 'CRAM-MD5'
> 3: I1123 08:06:04.284826 20060 authenticator.cpp:204] Received SASL authentication start
> 3: I1123 08:06:04.284900 20060 authenticator.cpp:326] Authentication requires more steps
> 3: I1123 08:06:04.285058 20044 authenticatee.cpp:259] Received SASL authentication step
> 3: I1123 08:06:04.285233 20044 authenticator.cpp:232] Received SASL authentication step
> 3: I1123 08:06:04.285275 20044 auxprop.cpp:109] Request to lookup properties for user:
'test-principal' realm: 'dce3e4c418cb' server FQDN: 'dce3e4c418cb' SASL_AUXPROP_VERIFY_AGAINST_HASH:
false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
> 3: I1123 08:06:04.285287 20044 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
> 3: I1123 08:06:04.285326 20044 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
> 3: I1123 08:06:04.285348 20044 auxprop.cpp:109] Request to lookup properties for user:
'test-principal' realm: 'dce3e4c418cb' server FQDN: 'dce3e4c418cb' SASL_AUXPROP_VERIFY_AGAINST_HASH:
false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
> 3: I1123 08:06:04.285357 20044 auxprop.cpp:131] Skipping auxiliary property '*userPassword'
since SASL_AUXPROP_AUTHZID == true
> 3: I1123 08:06:04.285363 20044 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5'
since SASL_AUXPROP_AUTHZID == true
> 3: I1123 08:06:04.285380 20044 authenticator.cpp:318] Authentication success
> 3: I1123 08:06:04.285506 20059 authenticatee.cpp:299] Authentication success
> 3: I1123 08:06:04.285557 20045 master.cpp:8342] Successfully authenticated principal
'test-principal' at slave(784)@172.17.0.2:35090
> 3: I1123 08:06:04.285658 20047 authenticator.cpp:432] Authentication session cleanup
for crammd5-authenticatee(1421)@172.17.0.2:35090
> 3: I1123 08:06:04.285847 20044 slave.cpp:1161] Successfully authenticated with master
master@172.17.0.2:35090
> 3: I1123 08:06:04.286111 20044 slave.cpp:1685] Will retry registration in 2.233007ms
if necessary
> 3: I1123 08:06:04.286402 20046 master.cpp:6036] Received register agent message from
slave(784)@172.17.0.2:35090 (dce3e4c418cb)
> 3: I1123 08:06:04.286550 20046 master.cpp:3872] Authorizing agent with principal 'test-principal'
> 3: I1123 08:06:04.287089 20056 master.cpp:6098] Authorized registration of agent at slave(784)@172.17.0.2:35090
(dce3e4c418cb)
> 3: I1123 08:06:04.287220 20056 master.cpp:6191] Registering agent at slave(784)@172.17.0.2:35090
(dce3e4c418cb) with id 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-S0
> 3: I1123 08:06:04.287748 20053 registrar.cpp:495] Applied 1 operations in 63340ns; attempting
to update the registry
> 3: I1123 08:06:04.288362 20053 registrar.cpp:552] Successfully updated the registry in
548864ns
> 3: I1123 08:06:04.288583 20042 master.cpp:6240] Admitted agent 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-S0
at slave(784)@172.17.0.2:35090 (dce3e4c418cb)
> 3: I1123 08:06:04.289449 20042 master.cpp:6276] Registered agent 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-S0
at slave(784)@172.17.0.2:35090 (dce3e4c418cb) with cpus:2; mem:1024; disk:1024; ports:[31000-32000]
> 3: I1123 08:06:04.289716 20038 slave.cpp:1685] Will retry registration in 35.387012ms
if necessary
> 3: I1123 08:06:04.289844 20043 hierarchical.cpp:600] Added agent 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-S0
(dce3e4c418cb) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
> 3: I1123 08:06:04.289922 20038 slave.cpp:1207] Registered with master master@172.17.0.2:35090;
given agent ID 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-S0
> 3: I1123 08:06:04.289942 20060 master.cpp:6036] Received register agent message from
slave(784)@172.17.0.2:35090 (dce3e4c418cb)
> 3: I1123 08:06:04.290046 20060 master.cpp:3872] Authorizing agent with principal 'test-principal'
> 3: I1123 08:06:04.290077 20050 task_status_update_manager.cpp:188] Resuming sending task
status updates
> 3: I1123 08:06:04.290155 20043 hierarchical.cpp:1457] Performed allocation for 1 agents
in 152178ns
> 3: I1123 08:06:04.290329 20038 slave.cpp:1227] Checkpointing SlaveInfo to '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_1_ycwsnc/meta/slaves/7c9d8e8c-3fb3-44c5-8505-488ada3e848e-S0/slave.info'
> 3: I1123 08:06:04.290479 20059 master.cpp:6098] Authorized registration of agent at slave(784)@172.17.0.2:35090
(dce3e4c418cb)
> 3: I1123 08:06:04.290560 20059 master.cpp:6169] Agent 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-S0
at slave(784)@172.17.0.2:35090 (dce3e4c418cb) already registered, resending acknowledgement
> 3: I1123 08:06:04.290829 20038 slave.cpp:1288] Forwarding total resources cpus:2; mem:1024;
disk:1024; ports:[31000-32000]
> 3: I1123 08:06:04.290917 20038 slave.cpp:1298] Forwarding total oversubscribed resources
{}
> 3: W1123 08:06:04.291487 20038 slave.cpp:1265] Already registered with master master@172.17.0.2:35090
> 3: I1123 08:06:04.291539 20038 slave.cpp:1288] Forwarding total resources cpus:2; mem:1024;
disk:1024; ports:[31000-32000]
> 3: I1123 08:06:04.291553 20037 master.cpp:7078] Received update of agent 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-S0
at slave(784)@172.17.0.2:35090 (dce3e4c418cb) with total resources cpus:2; mem:1024; disk:1024;
ports:[31000-32000]
> 3: I1123 08:06:04.291610 20037 master.cpp:7091] Received update of agent 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-S0
at slave(784)@172.17.0.2:35090 (dce3e4c418cb) with total oversubscribed resources {}
> 3: I1123 08:06:04.291649 20038 slave.cpp:1298] Forwarding total oversubscribed resources
{}
> 3: I1123 08:06:04.291822 20037 master.cpp:7109] Ignoring update on agent 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-S0
at slave(784)@172.17.0.2:35090 (dce3e4c418cb) as it reports no changes
> 3: I1123 08:06:04.292245 20037 master.cpp:7078] Received update of agent 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-S0
at slave(784)@172.17.0.2:35090 (dce3e4c418cb) with total resources cpus:2; mem:1024; disk:1024;
ports:[31000-32000]
> 3: I1123 08:06:04.292304 20037 master.cpp:7091] Received update of agent 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-S0
at slave(784)@172.17.0.2:35090 (dce3e4c418cb) with total oversubscribed resources {}
> 3: I1123 08:06:04.292381 20044 http_connection.hpp:221] New endpoint detected at http://172.17.0.2:35090/slave(784)/api/v1/resource_provider
> 3: I1123 08:06:04.292474 20037 master.cpp:7109] Ignoring update on agent 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-S0
at slave(784)@172.17.0.2:35090 (dce3e4c418cb) as it reports no changes
> 3: I1123 08:06:04.292973 20036 scheduler.cpp:188] Version: 1.5.0
> 3: I1123 08:06:04.293253 20055 scheduler.cpp:311] Using default 'basic' HTTP authenticatee
> 3: I1123 08:06:04.293665 20049 scheduler.cpp:494] New master detected at master@172.17.0.2:35090
> 3: I1123 08:06:04.293694 20049 scheduler.cpp:503] Waiting for 0ns before initiating a
re-(connection) attempt with the master
> 3: I1123 08:06:04.294288 20045 http_connection.hpp:277] Connected with the remote endpoint
at http://172.17.0.2:35090/slave(784)/api/v1/resource_provider
> 3: I1123 08:06:04.294934 20046 http_connection.hpp:129] Sending 1 call to http://172.17.0.2:35090/slave(784)/api/v1/resource_provider
> 3: I1123 08:06:04.295969 20055 scheduler.cpp:385] Connected with the master at http://172.17.0.2:35090/master/api/v1/scheduler
> 3: I1123 08:06:04.296830 20059 process.cpp:3503] Handling HTTP event for process 'slave(784)'
with path: '/slave(784)/api/v1/resource_provider'
> 3: I1123 08:06:04.297196 20054 scheduler.cpp:247] Sending SUBSCRIBE call to http://172.17.0.2:35090/master/api/v1/scheduler
> 3: I1123 08:06:04.298148 20052 http.cpp:1185] HTTP POST for /slave(784)/api/v1/resource_provider
from 172.17.0.2:38204
> 3: I1123 08:06:04.298343 20052 process.cpp:3503] Handling HTTP event for process 'master'
with path: '/master/api/v1/scheduler'
> 3: I1123 08:06:04.298552 20056 manager.cpp:386] Subscribing resource provider {"name":"test","type":"org.apache.mesos.rp.test"}
> 3: I1123 08:06:04.299580 20057 http.cpp:1185] HTTP POST for /master/api/v1/scheduler
from 172.17.0.2:38208
> 3: I1123 08:06:04.299873 20057 master.cpp:2615] Received subscription request for HTTP
framework 'default'
> 3: I1123 08:06:04.300007 20057 master.cpp:2280] Authorizing framework principal 'test-principal'
to receive offers for roles '{ role }'
> 3: I1123 08:06:04.300477 20050 master.cpp:2750] Subscribing framework 'default' with
checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
> 3: I1123 08:06:04.300882 20056 http_connection.hpp:129] Sending 3 call to http://172.17.0.2:35090/slave(784)/api/v1/resource_provider
> 3: I1123 08:06:04.301465 20047 hierarchical.cpp:306] Added framework 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-0000
> 3: I1123 08:06:04.301954 20057 scheduler.cpp:739] Enqueuing event SUBSCRIBED received
from http://172.17.0.2:35090/master/api/v1/scheduler
> 3: I1123 08:06:04.302021 20052 process.cpp:3503] Handling HTTP event for process 'slave(784)'
with path: '/slave(784)/api/v1/resource_provider'
> 3: I1123 08:06:04.302435 20057 scheduler.cpp:739] Enqueuing event HEARTBEAT received
from http://172.17.0.2:35090/master/api/v1/scheduler
> 3: I1123 08:06:04.303020 20055 http.cpp:1185] HTTP POST for /slave(784)/api/v1/resource_provider
from 172.17.0.2:38202
> 3: I1123 08:06:04.303211 20047 hierarchical.cpp:1457] Performed allocation for 1 agents
in 1.549319ms
> 3: I1123 08:06:04.303767 20060 master.cpp:8142] Sending 1 offers to framework 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-0000
(default)
> 3: I1123 08:06:04.303828 20050 slave.cpp:6780] Handling resource provider message 'UPDATE_TOTAL_RESOURCES:
582a6138-5ac1-4c38-b407-576be39d0a82 disk[RAW]:200'
> 3: I1123 08:06:04.303941 20050 slave.cpp:6825] Forwarding new total resources cpus:2;
mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200
> 3: I1123 08:06:04.304744 20060 master.cpp:7078] Received update of agent 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-S0
at slave(784)@172.17.0.2:35090 (dce3e4c418cb) with total resources cpus:2; mem:1024; disk:1024;
ports:[31000-32000]; disk[RAW]:200
> 3: I1123 08:06:04.305366 20051 scheduler.cpp:739] Enqueuing event OFFERS received from
http://172.17.0.2:35090/master/api/v1/scheduler
> 3: I1123 08:06:04.305364 20060 master.cpp:7141] Removing offer 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-O0
with resources cpus(allocated: role):2; mem(allocated: role):1024; disk(allocated: role):1024;
ports(allocated: role):[31000-32000] on agent 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-S0 at slave(784)@172.17.0.2:35090
(dce3e4c418cb)
> 3: I1123 08:06:04.306197 20060 master.cpp:10063] Removing offer 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-O0
> 3: I1123 08:06:04.306350 20058 hierarchical.cpp:667] Agent 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-S0
(dce3e4c418cb) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000];
disk[RAW]:200
> 3: /mesos/src/tests/resource_provider_manager_tests.cpp:713: Failure
> 3: Value of: resources.empty()
> 3:   Actual: true
> 3: Expected: false
> 3: I1123 08:06:04.307636 20058 hierarchical.cpp:1132] Recovered cpus(allocated: role):2;
mem(allocated: role):1024; disk(allocated: role):1024; ports(allocated: role):[31000-32000]
(total: cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200, allocated: {}) on
agent 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-S0 from framework 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-0000
> 3: I1123 08:06:04.308148 20051 master.cpp:1425] Framework 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-0000
(default) disconnected
> 3: I1123 08:06:04.308176 20051 master.cpp:3333] Deactivating framework 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-0000
(default)
> 3: I1123 08:06:04.308253 20051 master.cpp:3310] Disconnecting framework 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-0000
(default)
> 3: I1123 08:06:04.308284 20051 master.cpp:1440] Giving framework 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-0000
(default) 0ns to failover
> 3: I1123 08:06:04.308549 20055 master.cpp:7974] Framework failover timeout, removing
framework 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-0000 (default)
> 3: I1123 08:06:04.308575 20055 master.cpp:8831] Removing framework 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-0000
(default)
> 3: I1123 08:06:04.308782 20038 slave.cpp:3270] Asked to shut down framework 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-0000
by master@172.17.0.2:35090
> 3: I1123 08:06:04.308811 20038 slave.cpp:3285] Cannot shut down unknown framework 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-0000
> 3: W1123 08:06:04.309376 20037 master.cpp:7988] Master returning resources offered to
framework 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-0000 because the framework has terminated or
is inactive
> 3: I1123 08:06:04.309382 20058 hierarchical.cpp:1457] Performed allocation for 1 agents
in 1.597792ms
> 3: I1123 08:06:04.309464 20058 hierarchical.cpp:419] Deactivated framework 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-0000
> 3: I1123 08:06:04.310418 20058 hierarchical.cpp:358] Removed framework 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-0000
> 3: I1123 08:06:04.310714 20058 hierarchical.cpp:1132] Recovered cpus(allocated: role):2;
mem(allocated: role):1024; disk(allocated: role):1024; ports(allocated: role):[31000-32000];
disk(allocated: role)[RAW]:200 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200,
allocated: {}) on agent 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-S0 from framework 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-0000
> 3: I1123 08:06:04.311563 20054 slave.cpp:883] Agent terminating
> 3: I1123 08:06:04.311776 20038 master.cpp:1311] Agent 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-S0
at slave(784)@172.17.0.2:35090 (dce3e4c418cb) disconnected
> 3: I1123 08:06:04.311800 20038 master.cpp:3370] Disconnecting agent 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-S0
at slave(784)@172.17.0.2:35090 (dce3e4c418cb)
> 3: I1123 08:06:04.311849 20038 master.cpp:3389] Deactivating agent 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-S0
at slave(784)@172.17.0.2:35090 (dce3e4c418cb)
> 3: I1123 08:06:04.311949 20058 hierarchical.cpp:697] Agent 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-S0
deactivated
> 3: I1123 08:06:04.318100 20036 master.cpp:1153] Master terminating
> 3: I1123 08:06:04.318877 20047 hierarchical.cpp:633] Removed agent 7c9d8e8c-3fb3-44c5-8505-488ada3e848e-S0
> 3: [  FAILED  ] ContentType/ResourceProviderManagerHttpApiTest.ConvertResources/1, where
> {noformat}



--
This message was sent by Atlassian JIRA
(v6.4.14#64029)

Mime
View raw message