mesos-builds mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Jenkins Server <jenk...@builds.apache.org>
Subject Build failed in Jenkins: Mesos-Reviewbot #23023
Date Wed, 08 Aug 2018 22:27:49 GMT
See <https://builds.apache.org/job/Mesos-Reviewbot/23023/display/redirect>

------------------------------------------
[...truncated 37.72 MB...]
I0808 22:27:36.987054 28235 hierarchical.cpp:182] Initialized hierarchical allocator process
I0808 22:27:36.987257 28247 whitelist_watcher.cpp:77] No whitelist given
I0808 22:27:36.993458 28224 master.cpp:2083] Elected as the leading master!
I0808 22:27:36.994062 28224 master.cpp:1638] Recovering from registrar
I0808 22:27:36.994982 28229 registrar.cpp:339] Recovering registrar
I0808 22:27:36.996410 28229 registrar.cpp:383] Successfully fetched the registry (0B) in 835840ns
I0808 22:27:36.996798 28229 registrar.cpp:487] Applied 1 operations in 56862ns; attempting
to update the registry
I0808 22:27:36.997885 28229 registrar.cpp:544] Successfully updated the registry in 997120ns
I0808 22:27:36.998054 28229 registrar.cpp:416] Successfully recovered registrar
I0808 22:27:36.998750 28225 master.cpp:1752] Recovered 0 agents from the registry (135B);
allowing 10mins for agents to reregister
I0808 22:27:36.999469 28230 hierarchical.cpp:220] Skipping recovery of hierarchical allocator:
nothing to recover
W0808 22:27:37.010089 28223 process.cpp:2810] Attempted to spawn already running process files@172.17.0.2:43582
I0808 22:27:37.012176 28223 containerizer.cpp:300] Using isolation { environment_secret, posix/cpu,
posix/mem, filesystem/posix, network/cni }
W0808 22:27:37.013402 28223 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires
root privileges
W0808 22:27:37.013522 28223 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires
root privileges
I0808 22:27:37.013728 28223 provisioner.cpp:298] Using default backend 'copy'
I0808 22:27:37.017735 28223 cluster.cpp:479] Creating default 'local' authorizer
I0808 22:27:37.022929 28244 slave.cpp:268] Mesos agent started on (1020)@172.17.0.2:43582
I0808 22:27:37.023653 28244 slave.cpp:269] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"
--appc_store_dir="/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_0_UXasjQ/store/appc"
--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_AgentResourceProviderConfigApiTest_IdempotentRemove_0_UXasjQ/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_AgentResourceProviderConfigApiTest_IdempotentRemove_0_UXasjQ/store/docker"
--docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false"
--executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs"
--fetcher_cache_dir="/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_0_UXasjQ/fetch"
--fetcher_cache_size="2GB" --fetcher_stall_timeout="1mins" --frameworks_home="" --gc_delay="1weeks"
--gc_disk_headroom="0.1" --help="false" --hostname_lookup="true" --http_command_executor="false"
--http_credentials="/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_0_UXasjQ/http_credentials"
--http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem"
--launcher="posix" --launcher_dir="/tmp/SRC/build/mesos-1.7.0/_build/sub/src" --logbufsecs="0"
--logging_level="INFO" --max_completed_executors_per_framework="150" --memory_profiling="false"
--oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins"
--port="5051" --qos_correction_interval_min="0ns" --quiet="false" --reconfiguration_policy="equal"
--recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resource_provider_config_dir="/tmp/rBNY7Z/resource_provider_configs"
--resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true"
--runtime_dir="/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_0_UXasjQ"
--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_AgentResourceProviderConfigApiTest_IdempotentRemove_0_aeJHdV"
--zk_session_timeout="10secs"
I0808 22:27:37.025041 28244 credentials.hpp:86] Loading credential for authentication from
'/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_0_UXasjQ/credential'
I0808 22:27:37.025774 28244 slave.cpp:301] Agent using credential for: test-principal
I0808 22:27:37.026237 28244 credentials.hpp:37] Loading credentials for authentication from
'/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_0_UXasjQ/http_credentials'
I0808 22:27:37.027034 28244 http.cpp:979] Creating default 'basic' HTTP authenticator for
realm 'mesos-agent-readonly'
I0808 22:27:37.028060 28244 disk_profile_adaptor.cpp:80] Creating default disk profile adaptor
module
I0808 22:27:37.030812 28244 slave.cpp:616] 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"}]
I0808 22:27:37.032490 28244 slave.cpp:624] Agent attributes: [  ]
I0808 22:27:37.033380 28244 slave.cpp:633] Agent hostname: 2e97a976aa34
I0808 22:27:37.034982 28224 task_status_update_manager.cpp:181] Pausing sending task status
updates
I0808 22:27:37.039304 28240 state.cpp:66] Recovering state from '/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_0_aeJHdV/meta'
I0808 22:27:37.040258 28228 slave.cpp:6906] Finished recovering checkpointed state from '/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_0_aeJHdV/meta',
beginning agent recovery
I0808 22:27:37.040886 28244 hierarchical.cpp:1564] Performed allocation for 0 agents in 103909ns
I0808 22:27:37.041044 28229 task_status_update_manager.cpp:207] Recovering task status update
manager
I0808 22:27:37.042927 28226 containerizer.cpp:718] Recovering Mesos containers
I0808 22:27:37.044124 28226 containerizer.cpp:1025] Recovering isolators
I0808 22:27:37.046205 28226 containerizer.cpp:1064] Recovering provisioner
I0808 22:27:37.047675 28232 provisioner.cpp:494] Provisioner recovery complete
I0808 22:27:37.050228 28233 composing.cpp:339] Finished recovering all containerizers
I0808 22:27:37.050936 28227 slave.cpp:7135] Recovering executors
I0808 22:27:37.051578 28227 slave.cpp:7288] Finished recovery
I0808 22:27:37.053861 28227 slave.cpp:1255] New master detected at master@172.17.0.2:43582
I0808 22:27:37.054623 28227 slave.cpp:1310] Detecting new master
I0808 22:27:37.054154 28247 task_status_update_manager.cpp:181] Pausing sending task status
updates
I0808 22:27:37.062928 28234 slave.cpp:1337] Authenticating with master master@172.17.0.2:43582
I0808 22:27:37.063663 28234 slave.cpp:1346] Using default CRAM-MD5 authenticatee
I0808 22:27:37.064707 28234 authenticatee.cpp:121] Creating new client SASL connection
I0808 22:27:37.065574 28238 master.cpp:9604] Authenticating slave(1020)@172.17.0.2:43582
I0808 22:27:37.066128 28238 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1765)@172.17.0.2:43582
I0808 22:27:37.067065 28238 authenticator.cpp:98] Creating new server SASL connection
I0808 22:27:37.068101 28238 authenticatee.cpp:213] Received SASL authentication mechanisms:
CRAM-MD5
I0808 22:27:37.068392 28238 authenticatee.cpp:239] Attempting to authenticate with mechanism
'CRAM-MD5'
I0808 22:27:37.068711 28238 authenticator.cpp:204] Received SASL authentication start
I0808 22:27:37.068845 28238 authenticator.cpp:326] Authentication requires more steps
I0808 22:27:37.069028 28238 authenticatee.cpp:259] Received SASL authentication step
I0808 22:27:37.069242 28245 authenticator.cpp:232] Received SASL authentication step
I0808 22:27:37.069293 28245 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: '2e97a976aa34' server FQDN: '2e97a976aa34' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0808 22:27:37.069326 28245 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0808 22:27:37.069406 28245 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0808 22:27:37.069463 28245 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: '2e97a976aa34' server FQDN: '2e97a976aa34' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0808 22:27:37.069492 28245 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since
SASL_AUXPROP_AUTHZID == true
I0808 22:27:37.069514 28245 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5'
since SASL_AUXPROP_AUTHZID == true
I0808 22:27:37.069547 28245 authenticator.cpp:318] Authentication success
I0808 22:27:37.069986 28228 master.cpp:9627] Successfully authenticated principal 'test-principal'
at slave(1020)@172.17.0.2:43582
I0808 22:27:37.070319 28245 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1765)@172.17.0.2:43582
I0808 22:27:37.070009 28238 authenticatee.cpp:299] Authentication success
I0808 22:27:37.072820 28241 slave.cpp:1429] Successfully authenticated with master master@172.17.0.2:43582
I0808 22:27:37.074034 28237 master.cpp:6562] Received register agent message from slave(1020)@172.17.0.2:43582
(2e97a976aa34)
I0808 22:27:37.074658 28237 master.cpp:3921] Authorizing agent providing resources 'cpus:2;
mem:1024; disk:1024; ports:[31000-32000]' with principal 'test-principal'
I0808 22:27:37.075989 28243 master.cpp:6629] Authorized registration of agent at slave(1020)@172.17.0.2:43582
(2e97a976aa34)
I0808 22:27:37.076067 28241 slave.cpp:1874] Will retry registration in 5.734621ms if necessary
I0808 22:27:37.076156 28243 master.cpp:6744] Registering agent at slave(1020)@172.17.0.2:43582
(2e97a976aa34) with id bb6e6f49-84fe-49fe-a2ca-f37c4dca05b3-S0
I0808 22:27:37.077518 28243 registrar.cpp:487] Applied 1 operations in 451127ns; attempting
to update the registry
I0808 22:27:37.079299 28229 registrar.cpp:544] Successfully updated the registry in 1.351168ms
I0808 22:27:37.079792 28236 master.cpp:6792] Admitted agent bb6e6f49-84fe-49fe-a2ca-f37c4dca05b3-S0
at slave(1020)@172.17.0.2:43582 (2e97a976aa34)
I0808 22:27:37.081441 28236 master.cpp:6837] Registered agent bb6e6f49-84fe-49fe-a2ca-f37c4dca05b3-S0
at slave(1020)@172.17.0.2:43582 (2e97a976aa34) with cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0808 22:27:37.083034 28225 hierarchical.cpp:601] Added agent bb6e6f49-84fe-49fe-a2ca-f37c4dca05b3-S0
(2e97a976aa34) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0808 22:27:37.083892 28225 hierarchical.cpp:1564] Performed allocation for 1 agents in 220876ns
I0808 22:27:37.083915 28246 slave.cpp:1476] Registered with master master@172.17.0.2:43582;
given agent ID bb6e6f49-84fe-49fe-a2ca-f37c4dca05b3-S0
I0808 22:27:37.088275 28239 task_status_update_manager.cpp:188] Resuming sending task status
updates
I0808 22:27:37.088691 28246 slave.cpp:1496] Checkpointing SlaveInfo to '/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_0_aeJHdV/meta/slaves/bb6e6f49-84fe-49fe-a2ca-f37c4dca05b3-S0/slave.info'
I0808 22:27:37.091507 28246 slave.cpp:1545] Forwarding agent update {"operations":{},"resource_version_uuid":{"value":"k+m7gyrXQ0yoBatmjBED+Q=="},"slave_id":{"value":"bb6e6f49-84fe-49fe-a2ca-f37c4dca05b3-S0"},"update_oversubscribed_resources":false}
I0808 22:27:37.093485 28247 master.cpp:7896] Ignoring update on agent bb6e6f49-84fe-49fe-a2ca-f37c4dca05b3-S0
at slave(1020)@172.17.0.2:43582 (2e97a976aa34) as it reports no changes
I0808 22:27:37.094933 28232 process.cpp:3569] Handling HTTP event for process 'slave(1020)'
with path: '/slave(1020)/api/v1'
I0808 22:27:37.097219 28245 hierarchical.cpp:1564] Performed allocation for 1 agents in 212619ns
I0808 22:27:37.097594 28225 http.cpp:1119] HTTP POST for /slave(1020)/api/v1 from 172.17.0.2:38574
I0808 22:27:37.101419 28233 http.cpp:3311] Processing REMOVE_RESOURCE_PROVIDER_CONFIG call
with type 'org.apache.mesos.rp.local.storage' and name 'test'
I0808 22:27:37.108511 28223 slave.cpp:910] Agent terminating
I0808 22:27:37.149104 28239 hierarchical.cpp:1564] Performed allocation for 1 agents in 219898ns
I0808 22:27:37.201694 28225 hierarchical.cpp:1564] Performed allocation for 1 agents in 272950ns
I0808 22:27:37.209048 28233 master.cpp:1251] Agent bb6e6f49-84fe-49fe-a2ca-f37c4dca05b3-S0
at slave(1020)@172.17.0.2:43582 (2e97a976aa34) disconnected
I0808 22:27:37.209800 28233 master.cpp:3267] Disconnecting agent bb6e6f49-84fe-49fe-a2ca-f37c4dca05b3-S0
at slave(1020)@172.17.0.2:43582 (2e97a976aa34)
I0808 22:27:37.210583 28233 master.cpp:3286] Deactivating agent bb6e6f49-84fe-49fe-a2ca-f37c4dca05b3-S0
at slave(1020)@172.17.0.2:43582 (2e97a976aa34)
I0808 22:27:37.211520 28233 hierarchical.cpp:795] Agent bb6e6f49-84fe-49fe-a2ca-f37c4dca05b3-S0
deactivated
I0808 22:27:37.254724 28224 hierarchical.cpp:1564] Performed allocation for 1 agents in 202402ns
I0808 22:27:37.279865 28223 master.cpp:1093] Master terminating
I0808 22:27:37.281266 28247 hierarchical.cpp:637] Removed agent bb6e6f49-84fe-49fe-a2ca-f37c4dca05b3-S0
I0808 22:27:37.307305 28241 hierarchical.cpp:1564] Performed allocation for 0 agents in 103566ns
[       OK ] ContentType/AgentResourceProviderConfigApiTest.IdempotentRemove/0 (346 ms)
[ RUN      ] ContentType/AgentResourceProviderConfigApiTest.IdempotentRemove/1
I0808 22:27:37.316725 28223 cluster.cpp:173] Creating default 'local' authorizer
I0808 22:27:37.329110 28226 master.cpp:413] Master 2f732b52-c516-462a-bf41-de2515f564fa (2e97a976aa34)
started on 172.17.0.2:43582
I0808 22:27:37.329447 28226 master.cpp:416] Flags at startup: --acls="" --agent_ping_timeout="15secs"
--agent_reregister_timeout="10mins" --allocation_interval="50ms" --allocator="hierarchical"
--authenticate_agents="true" --authenticate_frameworks="true" --authenticate_http_frameworks="true"
--authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticators="crammd5"
--authorizers="local" --credentials="/tmp/f7mYAC/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" --memory_profiling="false"
--min_allocatable_resources="cpus:0.01|mem:32" --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"
--require_agent_domain="false" --role_sorter="drf" --root_submissions="true" --version="false"
--webui_dir="/tmp/SRC/build/mesos-1.7.0/_inst/share/mesos/webui" --work_dir="/tmp/f7mYAC/master"
--zk_session_timeout="10secs"
I0808 22:27:37.330363 28226 master.cpp:465] Master only allowing authenticated frameworks
to register
I0808 22:27:37.330543 28226 master.cpp:471] Master only allowing authenticated agents to register
I0808 22:27:37.330715 28226 master.cpp:477] Master only allowing authenticated HTTP frameworks
to register
I0808 22:27:37.330898 28226 credentials.hpp:37] Loading credentials for authentication from
'/tmp/f7mYAC/credentials'
I0808 22:27:37.331528 28226 master.cpp:521] Using default 'crammd5' authenticator
I0808 22:27:37.332047 28226 http.cpp:979] Creating default 'basic' HTTP authenticator for
realm 'mesos-master-readonly'
I0808 22:27:37.332581 28226 http.cpp:979] Creating default 'basic' HTTP authenticator for
realm 'mesos-master-readwrite'
I0808 22:27:37.332988 28226 http.cpp:979] Creating default 'basic' HTTP authenticator for
realm 'mesos-master-scheduler'
I0808 22:27:37.333379 28226 master.cpp:602] Authorization enabled
I0808 22:27:37.334879 28237 whitelist_watcher.cpp:77] No whitelist given
I0808 22:27:37.335469 28241 hierarchical.cpp:182] Initialized hierarchical allocator process
I0808 22:27:37.342969 28244 master.cpp:2083] Elected as the leading master!
I0808 22:27:37.343791 28244 master.cpp:1638] Recovering from registrar
I0808 22:27:37.344671 28244 registrar.cpp:339] Recovering registrar
I0808 22:27:37.346181 28244 registrar.cpp:383] Successfully fetched the registry (0B) in 989184ns
I0808 22:27:37.346879 28244 registrar.cpp:487] Applied 1 operations in 75427ns; attempting
to update the registry
I0808 22:27:37.348206 28244 registrar.cpp:544] Successfully updated the registry in 744192ns
I0808 22:27:37.348855 28244 registrar.cpp:416] Successfully recovered registrar
I0808 22:27:37.350000 28244 master.cpp:1752] Recovered 0 agents from the registry (135B);
allowing 10mins for agents to reregister
I0808 22:27:37.350217 28239 hierarchical.cpp:220] Skipping recovery of hierarchical allocator:
nothing to recover
W0808 22:27:37.365995 28223 process.cpp:2810] Attempted to spawn already running process files@172.17.0.2:43582
I0808 22:27:37.373339 28223 containerizer.cpp:300] Using isolation { environment_secret, posix/cpu,
posix/mem, filesystem/posix, network/cni }
W0808 22:27:37.374795 28223 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires
root privileges
W0808 22:27:37.375278 28223 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires
root privileges
I0808 22:27:37.375742 28223 provisioner.cpp:298] Using default backend 'copy'
I0808 22:27:37.379845 28223 cluster.cpp:479] Creating default 'local' authorizer
I0808 22:27:37.385026 28231 slave.cpp:268] Mesos agent started on (1021)@172.17.0.2:43582
I0808 22:27:37.385738 28231 slave.cpp:269] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"
--appc_store_dir="/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_1_6GCApu/store/appc"
--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_AgentResourceProviderConfigApiTest_IdempotentRemove_1_6GCApu/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_AgentResourceProviderConfigApiTest_IdempotentRemove_1_6GCApu/store/docker"
--docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false"
--executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs"
--fetcher_cache_dir="/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_1_6GCApu/fetch"
--fetcher_cache_size="2GB" --fetcher_stall_timeout="1mins" --frameworks_home="" --gc_delay="1weeks"
--gc_disk_headroom="0.1" --help="false" --hostname_lookup="true" --http_command_executor="false"
--http_credentials="/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_1_6GCApu/http_credentials"
--http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem"
--launcher="posix" --launcher_dir="/tmp/SRC/build/mesos-1.7.0/_build/sub/src" --logbufsecs="0"
--logging_level="INFO" --max_completed_executors_per_framework="150" --memory_profiling="false"
--oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins"
--port="5051" --qos_correction_interval_min="0ns" --quiet="false" --reconfiguration_policy="equal"
--recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resource_provider_config_dir="/tmp/f7mYAC/resource_provider_configs"
--resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true"
--runtime_dir="/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_1_6GCApu"
--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_AgentResourceProviderConfigApiTest_IdempotentRemove_1_gYEgvy"
--zk_session_timeout="10secs"
I0808 22:27:37.387460 28231 credentials.hpp:86] Loading credential for authentication from
'/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_1_6GCApu/credential'
I0808 22:27:37.387960 28231 slave.cpp:301] Agent using credential for: test-principal
I0808 22:27:37.388149 28231 credentials.hpp:37] Loading credentials for authentication from
'/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_1_6GCApu/http_credentials'
I0808 22:27:37.388702 28231 http.cpp:979] Creating default 'basic' HTTP authenticator for
realm 'mesos-agent-readonly'
I0808 22:27:37.389492 28231 disk_profile_adaptor.cpp:80] Creating default disk profile adaptor
module
I0808 22:27:37.391842 28231 slave.cpp:616] 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"}]
I0808 22:27:37.392405 28231 slave.cpp:624] Agent attributes: [  ]
I0808 22:27:37.392587 28231 slave.cpp:633] Agent hostname: 2e97a976aa34
I0808 22:27:37.394991 28234 task_status_update_manager.cpp:181] Pausing sending task status
updates
I0808 22:27:37.388223 28241 hierarchical.cpp:1564] Performed allocation for 0 agents in 95938ns
I0808 22:27:37.398948 28240 state.cpp:66] Recovering state from '/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_1_gYEgvy/meta'
I0808 22:27:37.399559 28242 slave.cpp:6906] Finished recovering checkpointed state from '/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_1_gYEgvy/meta',
beginning agent recovery
I0808 22:27:37.400106 28242 task_status_update_manager.cpp:207] Recovering task status update
manager
I0808 22:27:37.400897 28240 containerizer.cpp:718] Recovering Mesos containers
I0808 22:27:37.401597 28240 containerizer.cpp:1025] Recovering isolators
I0808 22:27:37.403122 28245 containerizer.cpp:1064] Recovering provisioner
I0808 22:27:37.404579 28245 provisioner.cpp:494] Provisioner recovery complete
I0808 22:27:37.406518 28236 composing.cpp:339] Finished recovering all containerizers
I0808 22:27:37.407116 28238 slave.cpp:7135] Recovering executors
I0808 22:27:37.407507 28238 slave.cpp:7288] Finished recovery
I0808 22:27:37.409446 28238 slave.cpp:1255] New master detected at master@172.17.0.2:43582
I0808 22:27:37.409634 28239 task_status_update_manager.cpp:181] Pausing sending task status
updates
I0808 22:27:37.410228 28238 slave.cpp:1310] Detecting new master
I0808 22:27:37.422965 28237 slave.cpp:1337] Authenticating with master master@172.17.0.2:43582
I0808 22:27:37.423655 28237 slave.cpp:1346] Using default CRAM-MD5 authenticatee
I0808 22:27:37.424551 28237 authenticatee.cpp:121] Creating new client SASL connection
I0808 22:27:37.425303 28240 master.cpp:9604] Authenticating slave(1021)@172.17.0.2:43582
I0808 22:27:37.425691 28232 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1766)@172.17.0.2:43582
I0808 22:27:37.426443 28232 authenticator.cpp:98] Creating new server SASL connection
I0808 22:27:37.426931 28244 authenticatee.cpp:213] Received SASL authentication mechanisms:
CRAM-MD5
I0808 22:27:37.427151 28244 authenticatee.cpp:239] Attempting to authenticate with mechanism
'CRAM-MD5'
I0808 22:27:37.427527 28247 authenticator.cpp:204] Received SASL authentication start
I0808 22:27:37.427822 28247 authenticator.cpp:326] Authentication requires more steps
I0808 22:27:37.428165 28244 authenticatee.cpp:259] Received SASL authentication step
I0808 22:27:37.428522 28244 authenticator.cpp:232] Received SASL authentication step
I0808 22:27:37.428722 28244 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: '2e97a976aa34' server FQDN: '2e97a976aa34' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0808 22:27:37.428902 28244 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0808 22:27:37.429162 28244 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0808 22:27:37.429364 28244 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: '2e97a976aa34' server FQDN: '2e97a976aa34' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0808 22:27:37.429592 28244 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since
SASL_AUXPROP_AUTHZID == true
I0808 22:27:37.429760 28244 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5'
since SASL_AUXPROP_AUTHZID == true
I0808 22:27:37.429940 28244 authenticator.cpp:318] Authentication success
I0808 22:27:37.430363 28242 authenticatee.cpp:299] Authentication success
I0808 22:27:37.430727 28224 master.cpp:9627] Successfully authenticated principal 'test-principal'
at slave(1021)@172.17.0.2:43582
I0808 22:27:37.430938 28227 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1766)@172.17.0.2:43582
I0808 22:27:37.431180 28242 slave.cpp:1429] Successfully authenticated with master master@172.17.0.2:43582
I0808 22:27:37.433326 28242 slave.cpp:1874] Will retry registration in 14.026495ms if necessary
I0808 22:27:37.434253 28224 master.cpp:6562] Received register agent message from slave(1021)@172.17.0.2:43582
(2e97a976aa34)
I0808 22:27:37.435183 28224 master.cpp:3921] Authorizing agent providing resources 'cpus:2;
mem:1024; disk:1024; ports:[31000-32000]' with principal 'test-principal'
I0808 22:27:37.437258 28224 master.cpp:6629] Authorized registration of agent at slave(1021)@172.17.0.2:43582
(2e97a976aa34)
I0808 22:27:37.437816 28224 master.cpp:6744] Registering agent at slave(1021)@172.17.0.2:43582
(2e97a976aa34) with id 2f732b52-c516-462a-bf41-de2515f564fa-S0
I0808 22:27:37.439215 28238 registrar.cpp:487] Applied 1 operations in 417982ns; attempting
to update the registry
I0808 22:27:37.441035 28238 registrar.cpp:544] Successfully updated the registry in 1.282048ms
I0808 22:27:37.441900 28224 master.cpp:6792] Admitted agent 2f732b52-c516-462a-bf41-de2515f564fa-S0
at slave(1021)@172.17.0.2:43582 (2e97a976aa34)
I0808 22:27:37.443459 28224 master.cpp:6837] Registered agent 2f732b52-c516-462a-bf41-de2515f564fa-S0
at slave(1021)@172.17.0.2:43582 (2e97a976aa34) with cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0808 22:27:37.444322 28224 slave.cpp:1476] Registered with master master@172.17.0.2:43582;
given agent ID 2f732b52-c516-462a-bf41-de2515f564fa-S0
I0808 22:27:37.444459 28232 hierarchical.cpp:601] Added agent 2f732b52-c516-462a-bf41-de2515f564fa-S0
(2e97a976aa34) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0808 22:27:37.444905 28244 task_status_update_manager.cpp:188] Resuming sending task status
updates
I0808 22:27:37.445559 28232 hierarchical.cpp:1564] Performed allocation for 1 agents in 147631ns
I0808 22:27:37.445574 28224 slave.cpp:1496] Checkpointing SlaveInfo to '/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_1_gYEgvy/meta/slaves/2f732b52-c516-462a-bf41-de2515f564fa-S0/slave.info'
I0808 22:27:37.448282 28224 slave.cpp:1545] Forwarding agent update {"operations":{},"resource_version_uuid":{"value":"pA8GuTyLQF6ewGXHoRsbsg=="},"slave_id":{"value":"2f732b52-c516-462a-bf41-de2515f564fa-S0"},"update_oversubscribed_resources":false}
I0808 22:27:37.449789 28235 master.cpp:7896] Ignoring update on agent 2f732b52-c516-462a-bf41-de2515f564fa-S0
at slave(1021)@172.17.0.2:43582 (2e97a976aa34) as it reports no changes
I0808 22:27:37.450716 28235 hierarchical.cpp:1564] Performed allocation for 1 agents in 161501ns
I0808 22:27:37.454387 28225 process.cpp:3569] Handling HTTP event for process 'slave(1021)'
with path: '/slave(1021)/api/v1'
I0808 22:27:37.456831 28225 http.cpp:1119] HTTP POST for /slave(1021)/api/v1 from 172.17.0.2:38576
I0808 22:27:37.464468 28232 http.cpp:3311] Processing REMOVE_RESOURCE_PROVIDER_CONFIG call
with type 'org.apache.mesos.rp.local.storage' and name 'test'
I0808 22:27:37.469139 28223 slave.cpp:910] Agent terminating
I0808 22:27:37.503877 28236 hierarchical.cpp:1564] Performed allocation for 1 agents in 192712ns
I0808 22:27:37.555778 28226 hierarchical.cpp:1564] Performed allocation for 1 agents in 189505ns
I0808 22:27:37.587236 28239 master.cpp:1251] Agent 2f732b52-c516-462a-bf41-de2515f564fa-S0
at slave(1021)@172.17.0.2:43582 (2e97a976aa34) disconnected
I0808 22:27:37.587414 28239 master.cpp:3267] Disconnecting agent 2f732b52-c516-462a-bf41-de2515f564fa-S0
at slave(1021)@172.17.0.2:43582 (2e97a976aa34)
I0808 22:27:37.587610 28239 master.cpp:3286] Deactivating agent 2f732b52-c516-462a-bf41-de2515f564fa-S0
at slave(1021)@172.17.0.2:43582 (2e97a976aa34)
I0808 22:27:37.588214 28231 hierarchical.cpp:795] Agent 2f732b52-c516-462a-bf41-de2515f564fa-S0
deactivated
I0808 22:27:37.607195 28226 hierarchical.cpp:1564] Performed allocation for 1 agents in 166851ns
I0808 22:27:37.612200 28233 master.cpp:1093] Master terminating
I0808 22:27:37.613865 28226 hierarchical.cpp:637] Removed agent 2f732b52-c516-462a-bf41-de2515f564fa-S0
[       OK ] ContentType/AgentResourceProviderConfigApiTest.IdempotentRemove/1 (309 ms)
[----------] 4 tests from ContentType/AgentResourceProviderConfigApiTest (1399 ms total)

[----------] Global test environment tear-down
[==========] 1999 tests from 205 test cases ran. (935794 ms total)
[  PASSED  ] 1995 tests.
[  FAILED  ] 4 tests, listed below:
[  FAILED  ] SlaveTest.StatisticsEndpointAuthentication
[  FAILED  ] Endpoint/SlaveEndpointTest.AuthorizedRequest/1, where GetParam() = "monitor/statistics.json"
[  FAILED  ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1, where GetParam() = "monitor/statistics.json"
[  FAILED  ] Endpoint/SlaveEndpointTest.NoAuthorizer/1, where GetParam() = "monitor/statistics.json"

 4 FAILED TESTS
  YOU HAVE 21 DISABLED TESTS

I0808 22:27:37.755311 28248 process.cpp:926] Stopped the socket accept loop
Makefile:14811: recipe for target 'check-local' failed
make[4]: *** [check-local] Error 1
make[4]: Leaving directory '/tmp/SRC/build/mesos-1.7.0/_build/sub/src'
Makefile:13921: recipe for target 'check-am' failed
make[3]: *** [check-am] Error 2
make[3]: Leaving directory '/tmp/SRC/build/mesos-1.7.0/_build/sub/src'
Makefile:13925: recipe for target 'check' failed
make[2]: *** [check] Error 2
make[2]: Leaving directory '/tmp/SRC/build/mesos-1.7.0/_build/sub/src'
Makefile:776: recipe for target 'check-recursive' failed
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory '/tmp/SRC/build/mesos-1.7.0/_build/sub'
Makefile:982: recipe for target 'distcheck' failed
make: *** [distcheck] Error 1
Untagged: mesos/mesos-build:ubuntu-16.04
Untagged: mesos/mesos-build@sha256:8685ea3c3e17663e4a1764d08df701102b4e9286c6c1a7116afccbe382777290
Deleted: sha256:4ecb5a128921ae9aad805a57a0e4d24dbcfbe84b09304997c7e2798819aa155a
Deleted: sha256:91a3c8a13a99414ff67baa2d1c6a6a82b43c237327a78d7f815414e155578ac1
Deleted: sha256:d05373b7ffe6961840e0962d4b16df22a14b1bbba3416f5aee58b579f08a2bcd
Deleted: sha256:db96690681268d3c4fdd48cd5edc2ca128c6b2493c67333983b63119622cc485
Deleted: sha256:70f40beaddd4e8dc15479d4f78d75b121fd4428c7bb29319a0fae0babd257e37
Deleted: sha256:77e6ddba346d8ad1e436256f6373dede5af4002006981b7d4116c561c759cefa
Deleted: sha256:8db758ab2fdb54da0aec53aeac876934337e6170f5a8c8872b3d4171e3d465b7
Deleted: sha256:a7fc6b405fe8ef71edfa6163d1dc9f1cb1df426049eefaa7d388e9df21a061ad
Deleted: sha256:5a3e35538f7f2e2727c8ac92f08c30002b9e8a77737de0dab91244344d59f69b
Deleted: sha256:ff986b10a018b48074e6d3a68b39aad8ccc002cdad912d4148c0f92b3729323e
Error response from daemon: conflict: unable to delete e804ecae6ec0 (cannot be forced) - image
is being used by running container 2b7fcd14c5b1
Build step 'Execute shell' marked build as failure

Mime
View raw message