See <https://builds.apache.org/job/Mesos-Reviewbot/23065/display/redirect?page=changes>
Changes: [chhsiao] Updated the 1.7.0 CHANGELOG. [yujie.jay] Call any function in a specified namespace. ------------------------------------------ [...truncated 37.71 MB...] I0814 01:44:29.110507 28180 master.cpp:471] Master only allowing authenticated agents to register I0814 01:44:29.110517 28180 master.cpp:477] Master only allowing authenticated HTTP frameworks to register I0814 01:44:29.110527 28180 credentials.hpp:37] Loading credentials for authentication from '/tmp/u8o2Y8/credentials' I0814 01:44:29.110787 28180 master.cpp:521] Using default 'crammd5' authenticator I0814 01:44:29.110956 28180 http.cpp:977] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I0814 01:44:29.111135 28180 http.cpp:977] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I0814 01:44:29.111289 28180 http.cpp:977] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I0814 01:44:29.111436 28180 master.cpp:602] Authorization enabled I0814 01:44:29.111841 28164 hierarchical.cpp:182] Initialized hierarchical allocator process I0814 01:44:29.111842 28182 whitelist_watcher.cpp:77] No whitelist given I0814 01:44:29.115139 28170 master.cpp:2083] Elected as the leading master! I0814 01:44:29.115171 28170 master.cpp:1638] Recovering from registrar I0814 01:44:29.115327 28169 registrar.cpp:339] Recovering registrar I0814 01:44:29.115954 28169 registrar.cpp:383] Successfully fetched the registry (0B) in 588800ns I0814 01:44:29.116065 28169 registrar.cpp:487] Applied 1 operations in 32348ns; attempting to update the registry I0814 01:44:29.116605 28169 registrar.cpp:544] Successfully updated the registry in 488960ns I0814 01:44:29.116732 28169 registrar.cpp:416] Successfully recovered registrar I0814 01:44:29.117163 28177 master.cpp:1752] Recovered 0 agents from the registry (135B); allowing 10mins for agents to reregister I0814 01:44:29.117224 28165 hierarchical.cpp:220] Skipping recovery of hierarchical allocator: nothing to recover W0814 01:44:29.122092 28160 process.cpp:2810] Attempted to spawn already running process [email protected]:34912 I0814 01:44:29.123041 28160 containerizer.cpp:300] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni } W0814 01:44:29.123579 28160 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges W0814 01:44:29.123603 28160 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges I0814 01:44:29.123631 28160 provisioner.cpp:298] Using default backend 'copy' I0814 01:44:29.125620 28160 cluster.cpp:479] Creating default 'local' authorizer I0814 01:44:29.127522 28165 slave.cpp:268] Mesos agent started on (1017)@172.17.0.2:34912 I0814 01:44:29.127549 28165 slave.cpp:269] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_0_icDJpq/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_destroy_timeout="1mins" --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_icDJpq/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_icDJpq/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_icDJpq/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_icDJpq/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/u8o2Y8/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_icDJpq" --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_UNCnHM" --zk_session_timeout="10secs" I0814 01:44:29.128177 28165 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_0_icDJpq/credential' I0814 01:44:29.128396 28165 slave.cpp:301] Agent using credential for: test-principal I0814 01:44:29.128427 28165 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_0_icDJpq/http_credentials' I0814 01:44:29.128707 28165 http.cpp:977] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0814 01:44:29.129097 28165 disk_profile_adaptor.cpp:80] Creating default disk profile adaptor module I0814 01:44:29.130240 28165 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"}] I0814 01:44:29.130439 28165 slave.cpp:624] Agent attributes: [ ] I0814 01:44:29.130457 28165 slave.cpp:633] Agent hostname: ad7c0c894c54 I0814 01:44:29.130579 28170 task_status_update_manager.cpp:181] Pausing sending task status updates I0814 01:44:29.131788 28181 state.cpp:66] Recovering state from '/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_0_UNCnHM/meta' I0814 01:44:29.131985 28172 slave.cpp:6906] Finished recovering checkpointed state from '/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_0_UNCnHM/meta', beginning agent recovery I0814 01:44:29.132133 28173 task_status_update_manager.cpp:207] Recovering task status update manager I0814 01:44:29.132381 28176 containerizer.cpp:718] Recovering Mesos containers I0814 01:44:29.132658 28176 containerizer.cpp:1025] Recovering isolators I0814 01:44:29.133144 28171 containerizer.cpp:1064] Recovering provisioner I0814 01:44:29.133725 28161 provisioner.cpp:494] Provisioner recovery complete I0814 01:44:29.134275 28172 composing.cpp:339] Finished recovering all containerizers I0814 01:44:29.134379 28173 slave.cpp:7135] Recovering executors I0814 01:44:29.134472 28173 slave.cpp:7288] Finished recovery I0814 01:44:29.135124 28178 task_status_update_manager.cpp:181] Pausing sending task status updates I0814 01:44:29.135156 28182 slave.cpp:1255] New master detected at [email protected]:34912 I0814 01:44:29.135267 28182 slave.cpp:1310] Detecting new master I0814 01:44:29.140525 28164 slave.cpp:1337] Authenticating with master [email protected]:34912 I0814 01:44:29.140605 28164 slave.cpp:1346] Using default CRAM-MD5 authenticatee I0814 01:44:29.140852 28183 authenticatee.cpp:121] Creating new client SASL connection I0814 01:44:29.141118 28176 master.cpp:9604] Authenticating slave(1017)@172.17.0.2:34912 I0814 01:44:29.141245 28162 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1765)@172.17.0.2:34912 I0814 01:44:29.141487 28171 authenticator.cpp:98] Creating new server SASL connection I0814 01:44:29.141674 28180 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0814 01:44:29.141706 28180 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0814 01:44:29.141835 28177 authenticator.cpp:204] Received SASL authentication start I0814 01:44:29.141913 28177 authenticator.cpp:326] Authentication requires more steps I0814 01:44:29.142045 28184 authenticatee.cpp:259] Received SASL authentication step I0814 01:44:29.142180 28175 authenticator.cpp:232] Received SASL authentication step I0814 01:44:29.142217 28175 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'ad7c0c894c54' server FQDN: 'ad7c0c894c54' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0814 01:44:29.142236 28175 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0814 01:44:29.142290 28175 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0814 01:44:29.142340 28175 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'ad7c0c894c54' server FQDN: 'ad7c0c894c54' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0814 01:44:29.142359 28175 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0814 01:44:29.142369 28175 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0814 01:44:29.142385 28175 authenticator.cpp:318] Authentication success I0814 01:44:29.142470 28161 authenticatee.cpp:299] Authentication success I0814 01:44:29.142552 28174 master.cpp:9627] Successfully authenticated principal 'test-principal' at slave(1017)@172.17.0.2:34912 I0814 01:44:29.142612 28161 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1765)@172.17.0.2:34912 I0814 01:44:29.142777 28181 slave.cpp:1429] Successfully authenticated with master [email protected]:34912 I0814 01:44:29.143149 28181 slave.cpp:1874] Will retry registration in 5.849731ms if necessary I0814 01:44:29.143291 28179 master.cpp:6562] Received register agent message from slave(1017)@172.17.0.2:34912 (ad7c0c894c54) I0814 01:44:29.143566 28179 master.cpp:3921] Authorizing agent providing resources 'cpus:2; mem:1024; disk:1024; ports:[31000-32000]' with principal 'test-principal' I0814 01:44:29.144076 28178 master.cpp:6629] Authorized registration of agent at slave(1017)@172.17.0.2:34912 (ad7c0c894c54) I0814 01:44:29.144158 28178 master.cpp:6744] Registering agent at slave(1017)@172.17.0.2:34912 (ad7c0c894c54) with id ca38e636-4937-4a79-b655-2353185575ad-S0 I0814 01:44:29.144973 28168 registrar.cpp:487] Applied 1 operations in 368347ns; attempting to update the registry I0814 01:44:29.145759 28168 registrar.cpp:544] Successfully updated the registry in 703744ns I0814 01:44:29.145951 28171 master.cpp:6792] Admitted agent ca38e636-4937-4a79-b655-2353185575ad-S0 at slave(1017)@172.17.0.2:34912 (ad7c0c894c54) I0814 01:44:29.146566 28171 master.cpp:6837] Registered agent ca38e636-4937-4a79-b655-2353185575ad-S0 at slave(1017)@172.17.0.2:34912 (ad7c0c894c54) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] I0814 01:44:29.146749 28177 slave.cpp:1476] Registered with master [email protected]:34912; given agent ID ca38e636-4937-4a79-b655-2353185575ad-S0 I0814 01:44:29.146849 28174 task_status_update_manager.cpp:188] Resuming sending task status updates I0814 01:44:29.147076 28184 hierarchical.cpp:601] Added agent ca38e636-4937-4a79-b655-2353185575ad-S0 (ad7c0c894c54) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {}) I0814 01:44:29.147109 28177 slave.cpp:1496] Checkpointing SlaveInfo to '/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_0_UNCnHM/meta/slaves/ca38e636-4937-4a79-b655-2353185575ad-S0/slave.info' I0814 01:44:29.147332 28184 hierarchical.cpp:1564] Performed allocation for 1 agents in 106118ns I0814 01:44:29.148051 28177 slave.cpp:1545] Forwarding agent update {"operations":{},"resource_version_uuid":{"value":"Jdw/AkTaTQmjBTv+xVHIJQ=="},"slave_id":{"value":"ca38e636-4937-4a79-b655-2353185575ad-S0"},"update_oversubscribed_resources":false} I0814 01:44:29.148695 28173 master.cpp:7896] Ignoring update on agent ca38e636-4937-4a79-b655-2353185575ad-S0 at slave(1017)@172.17.0.2:34912 (ad7c0c894c54) as it reports no changes I0814 01:44:29.149880 28176 process.cpp:3569] Handling HTTP event for process 'slave(1017)' with path: '/slave(1017)/api/v1' I0814 01:44:29.150764 28170 http.cpp:1117] HTTP POST for /slave(1017)/api/v1 from 172.17.0.2:45920 I0814 01:44:29.151785 28175 http.cpp:3311] Processing REMOVE_RESOURCE_PROVIDER_CONFIG call with type 'org.apache.mesos.rp.local.storage' and name 'test' I0814 01:44:29.153332 28180 slave.cpp:910] Agent terminating I0814 01:44:29.162536 28175 hierarchical.cpp:1564] Performed allocation for 1 agents in 84641ns I0814 01:44:29.213482 28184 hierarchical.cpp:1564] Performed allocation for 1 agents in 120135ns I0814 01:44:29.265099 28179 hierarchical.cpp:1564] Performed allocation for 1 agents in 87767ns I0814 01:44:29.265848 28182 master.cpp:1251] Agent ca38e636-4937-4a79-b655-2353185575ad-S0 at slave(1017)@172.17.0.2:34912 (ad7c0c894c54) disconnected I0814 01:44:29.265883 28182 master.cpp:3267] Disconnecting agent ca38e636-4937-4a79-b655-2353185575ad-S0 at slave(1017)@172.17.0.2:34912 (ad7c0c894c54) I0814 01:44:29.265952 28182 master.cpp:3286] Deactivating agent ca38e636-4937-4a79-b655-2353185575ad-S0 at slave(1017)@172.17.0.2:34912 (ad7c0c894c54) I0814 01:44:29.266084 28162 hierarchical.cpp:795] Agent ca38e636-4937-4a79-b655-2353185575ad-S0 deactivated I0814 01:44:29.273252 28168 master.cpp:1093] Master terminating I0814 01:44:29.273936 28162 hierarchical.cpp:637] Removed agent ca38e636-4937-4a79-b655-2353185575ad-S0 [ OK ] ContentType/AgentResourceProviderConfigApiTest.IdempotentRemove/0 (173 ms) [ RUN ] ContentType/AgentResourceProviderConfigApiTest.IdempotentRemove/1 I0814 01:44:29.280649 28160 cluster.cpp:173] Creating default 'local' authorizer I0814 01:44:29.283241 28162 master.cpp:413] Master f403af98-7f63-48ad-8a88-f4ab060d9282 (ad7c0c894c54) started on 172.17.0.2:34912 I0814 01:44:29.283263 28162 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/KnzM2l/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/KnzM2l/master" --zk_session_timeout="10secs" I0814 01:44:29.283608 28162 master.cpp:465] Master only allowing authenticated frameworks to register I0814 01:44:29.283630 28162 master.cpp:471] Master only allowing authenticated agents to register I0814 01:44:29.283646 28162 master.cpp:477] Master only allowing authenticated HTTP frameworks to register I0814 01:44:29.283663 28162 credentials.hpp:37] Loading credentials for authentication from '/tmp/KnzM2l/credentials' I0814 01:44:29.283901 28162 master.cpp:521] Using default 'crammd5' authenticator I0814 01:44:29.284070 28162 http.cpp:977] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I0814 01:44:29.284265 28162 http.cpp:977] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I0814 01:44:29.284399 28162 http.cpp:977] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I0814 01:44:29.284533 28162 master.cpp:602] Authorization enabled I0814 01:44:29.284981 28182 hierarchical.cpp:182] Initialized hierarchical allocator process I0814 01:44:29.285017 28176 whitelist_watcher.cpp:77] No whitelist given I0814 01:44:29.287555 28183 master.cpp:2083] Elected as the leading master! I0814 01:44:29.287585 28183 master.cpp:1638] Recovering from registrar I0814 01:44:29.287729 28165 registrar.cpp:339] Recovering registrar I0814 01:44:29.288338 28165 registrar.cpp:383] Successfully fetched the registry (0B) in 567808ns I0814 01:44:29.288447 28165 registrar.cpp:487] Applied 1 operations in 32662ns; attempting to update the registry I0814 01:44:29.288969 28165 registrar.cpp:544] Successfully updated the registry in 470016ns I0814 01:44:29.289085 28165 registrar.cpp:416] Successfully recovered registrar I0814 01:44:29.289522 28178 hierarchical.cpp:220] Skipping recovery of hierarchical allocator: nothing to recover I0814 01:44:29.289521 28180 master.cpp:1752] Recovered 0 agents from the registry (135B); allowing 10mins for agents to reregister W0814 01:44:29.294442 28160 process.cpp:2810] Attempted to spawn already running process [email protected]:34912 I0814 01:44:29.295373 28160 containerizer.cpp:300] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni } W0814 01:44:29.295922 28160 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges W0814 01:44:29.295948 28160 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges I0814 01:44:29.295974 28160 provisioner.cpp:298] Using default backend 'copy' I0814 01:44:29.298022 28160 cluster.cpp:479] Creating default 'local' authorizer I0814 01:44:29.300436 28180 slave.cpp:268] Mesos agent started on (1018)@172.17.0.2:34912 I0814 01:44:29.300454 28180 slave.cpp:269] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_1_jEHNiE/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_destroy_timeout="1mins" --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_jEHNiE/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_jEHNiE/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_jEHNiE/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_jEHNiE/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/KnzM2l/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_jEHNiE" --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_iGKMa0" --zk_session_timeout="10secs" I0814 01:44:29.300889 28180 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_1_jEHNiE/credential' I0814 01:44:29.301033 28180 slave.cpp:301] Agent using credential for: test-principal I0814 01:44:29.301061 28180 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_1_jEHNiE/http_credentials' I0814 01:44:29.301270 28180 http.cpp:977] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0814 01:44:29.301595 28180 disk_profile_adaptor.cpp:80] Creating default disk profile adaptor module I0814 01:44:29.302767 28180 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"}] I0814 01:44:29.302966 28180 slave.cpp:624] Agent attributes: [ ] I0814 01:44:29.302983 28180 slave.cpp:633] Agent hostname: ad7c0c894c54 I0814 01:44:29.303117 28183 task_status_update_manager.cpp:181] Pausing sending task status updates I0814 01:44:29.304358 28164 state.cpp:66] Recovering state from '/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_1_iGKMa0/meta' I0814 01:44:29.304529 28184 slave.cpp:6906] Finished recovering checkpointed state from '/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_1_iGKMa0/meta', beginning agent recovery I0814 01:44:29.304672 28181 task_status_update_manager.cpp:207] Recovering task status update manager I0814 01:44:29.304965 28167 containerizer.cpp:718] Recovering Mesos containers I0814 01:44:29.305263 28167 containerizer.cpp:1025] Recovering isolators I0814 01:44:29.305836 28174 containerizer.cpp:1064] Recovering provisioner I0814 01:44:29.306419 28175 provisioner.cpp:494] Provisioner recovery complete I0814 01:44:29.307041 28184 composing.cpp:339] Finished recovering all containerizers I0814 01:44:29.307160 28181 slave.cpp:7135] Recovering executors I0814 01:44:29.307304 28181 slave.cpp:7288] Finished recovery I0814 01:44:29.308007 28165 task_status_update_manager.cpp:181] Pausing sending task status updates I0814 01:44:29.308043 28173 slave.cpp:1255] New master detected at [email protected]:34912 I0814 01:44:29.308109 28173 slave.cpp:1310] Detecting new master I0814 01:44:29.317258 28176 slave.cpp:1337] Authenticating with master [email protected]:34912 I0814 01:44:29.317345 28176 slave.cpp:1346] Using default CRAM-MD5 authenticatee I0814 01:44:29.317587 28169 authenticatee.cpp:121] Creating new client SASL connection I0814 01:44:29.317831 28167 master.cpp:9604] Authenticating slave(1018)@172.17.0.2:34912 I0814 01:44:29.317946 28171 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1766)@172.17.0.2:34912 I0814 01:44:29.318178 28182 authenticator.cpp:98] Creating new server SASL connection I0814 01:44:29.318362 28174 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0814 01:44:29.318392 28174 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0814 01:44:29.318503 28162 authenticator.cpp:204] Received SASL authentication start I0814 01:44:29.318572 28162 authenticator.cpp:326] Authentication requires more steps I0814 01:44:29.318680 28166 authenticatee.cpp:259] Received SASL authentication step I0814 01:44:29.318800 28175 authenticator.cpp:232] Received SASL authentication step I0814 01:44:29.318835 28175 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'ad7c0c894c54' server FQDN: 'ad7c0c894c54' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0814 01:44:29.318861 28175 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0814 01:44:29.318913 28175 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0814 01:44:29.318945 28175 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'ad7c0c894c54' server FQDN: 'ad7c0c894c54' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0814 01:44:29.318964 28175 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0814 01:44:29.318981 28175 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0814 01:44:29.319007 28175 authenticator.cpp:318] Authentication success I0814 01:44:29.319106 28183 authenticatee.cpp:299] Authentication success I0814 01:44:29.319161 28170 master.cpp:9627] Successfully authenticated principal 'test-principal' at slave(1018)@172.17.0.2:34912 I0814 01:44:29.319218 28180 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1766)@172.17.0.2:34912 I0814 01:44:29.319425 28179 slave.cpp:1429] Successfully authenticated with master [email protected]:34912 I0814 01:44:29.319782 28179 slave.cpp:1874] Will retry registration in 12.503807ms if necessary I0814 01:44:29.319968 28177 master.cpp:6562] Received register agent message from slave(1018)@172.17.0.2:34912 (ad7c0c894c54) I0814 01:44:29.320283 28177 master.cpp:3921] Authorizing agent providing resources 'cpus:2; mem:1024; disk:1024; ports:[31000-32000]' with principal 'test-principal' I0814 01:44:29.320818 28165 master.cpp:6629] Authorized registration of agent at slave(1018)@172.17.0.2:34912 (ad7c0c894c54) I0814 01:44:29.320899 28165 master.cpp:6744] Registering agent at slave(1018)@172.17.0.2:34912 (ad7c0c894c54) with id f403af98-7f63-48ad-8a88-f4ab060d9282-S0 I0814 01:44:29.321501 28168 registrar.cpp:487] Applied 1 operations in 211521ns; attempting to update the registry I0814 01:44:29.322141 28168 registrar.cpp:544] Successfully updated the registry in 576768ns I0814 01:44:29.322286 28182 master.cpp:6792] Admitted agent f403af98-7f63-48ad-8a88-f4ab060d9282-S0 at slave(1018)@172.17.0.2:34912 (ad7c0c894c54) I0814 01:44:29.322887 28182 master.cpp:6837] Registered agent f403af98-7f63-48ad-8a88-f4ab060d9282-S0 at slave(1018)@172.17.0.2:34912 (ad7c0c894c54) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] I0814 01:44:29.323056 28162 slave.cpp:1476] Registered with master [email protected]:34912; given agent ID f403af98-7f63-48ad-8a88-f4ab060d9282-S0 I0814 01:44:29.323160 28164 task_status_update_manager.cpp:188] Resuming sending task status updates I0814 01:44:29.323292 28166 hierarchical.cpp:601] Added agent f403af98-7f63-48ad-8a88-f4ab060d9282-S0 (ad7c0c894c54) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {}) I0814 01:44:29.323441 28162 slave.cpp:1496] Checkpointing SlaveInfo to '/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentRemove_1_iGKMa0/meta/slaves/f403af98-7f63-48ad-8a88-f4ab060d9282-S0/slave.info' I0814 01:44:29.323530 28166 hierarchical.cpp:1564] Performed allocation for 1 agents in 90513ns I0814 01:44:29.324403 28162 slave.cpp:1545] Forwarding agent update {"operations":{},"resource_version_uuid":{"value":"c/3OHD6PTuGCn4ZS93YFUg=="},"slave_id":{"value":"f403af98-7f63-48ad-8a88-f4ab060d9282-S0"},"update_oversubscribed_resources":false} I0814 01:44:29.325080 28173 master.cpp:7896] Ignoring update on agent f403af98-7f63-48ad-8a88-f4ab060d9282-S0 at slave(1018)@172.17.0.2:34912 (ad7c0c894c54) as it reports no changes I0814 01:44:29.326192 28171 process.cpp:3569] Handling HTTP event for process 'slave(1018)' with path: '/slave(1018)/api/v1' I0814 01:44:29.327081 28170 http.cpp:1117] HTTP POST for /slave(1018)/api/v1 from 172.17.0.2:45924 I0814 01:44:29.328115 28172 http.cpp:3311] Processing REMOVE_RESOURCE_PROVIDER_CONFIG call with type 'org.apache.mesos.rp.local.storage' and name 'test' I0814 01:44:29.329598 28168 slave.cpp:910] Agent terminating I0814 01:44:29.335714 28170 hierarchical.cpp:1564] Performed allocation for 1 agents in 92636ns I0814 01:44:29.387312 28182 hierarchical.cpp:1564] Performed allocation for 1 agents in 86175ns I0814 01:44:29.438349 28172 hierarchical.cpp:1564] Performed allocation for 1 agents in 125713ns I0814 01:44:29.489975 28161 hierarchical.cpp:1564] Performed allocation for 1 agents in 133502ns I0814 01:44:29.490815 28177 master.cpp:1251] Agent f403af98-7f63-48ad-8a88-f4ab060d9282-S0 at slave(1018)@172.17.0.2:34912 (ad7c0c894c54) disconnected I0814 01:44:29.490851 28177 master.cpp:3267] Disconnecting agent f403af98-7f63-48ad-8a88-f4ab060d9282-S0 at slave(1018)@172.17.0.2:34912 (ad7c0c894c54) I0814 01:44:29.490921 28177 master.cpp:3286] Deactivating agent f403af98-7f63-48ad-8a88-f4ab060d9282-S0 at slave(1018)@172.17.0.2:34912 (ad7c0c894c54) I0814 01:44:29.491158 28171 hierarchical.cpp:795] Agent f403af98-7f63-48ad-8a88-f4ab060d9282-S0 deactivated I0814 01:44:29.497725 28160 master.cpp:1093] Master terminating I0814 01:44:29.498800 28180 hierarchical.cpp:637] Removed agent f403af98-7f63-48ad-8a88-f4ab060d9282-S0 [ OK ] ContentType/AgentResourceProviderConfigApiTest.IdempotentRemove/1 (224 ms) [----------] 4 tests from ContentType/AgentResourceProviderConfigApiTest (818 ms total) [----------] Global test environment tear-down [==========] 1996 tests from 205 test cases ran. (965183 ms total) [ PASSED ] 1995 tests. [ FAILED ] 1 test, listed below: [ FAILED ] PersistentVolumeEndpointsTest.EndpointCreateThenOfferRemove 1 FAILED TEST YOU HAVE 21 DISABLED TESTS I0814 01:44:29.591593 28185 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 Build step 'Execute shell' marked build as failure
