You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2018/11/13 15:36:46 UTC
Build failed in Jenkins: Mesos-Reviewbot #23553
See <https://builds.apache.org/job/Mesos-Reviewbot/23553/display/redirect?page=changes>
Changes:
[bbannier] Added whitespace in libprocess README.
------------------------------------------
[...truncated 45.35 MB...]
I1113 15:22:22.340047 19630 scheduler.cpp:463] Ignoring disconnection attempt from stale connection
I1113 15:22:22.340181 19630 scheduler.cpp:538] New master detected at master@172.17.0.2:38327
I1113 15:22:22.340198 19610 master.cpp:1388] Framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000 (default) disconnected
I1113 15:22:22.340225 19630 scheduler.cpp:547] Waiting for 0ns before initiating a re-(connection) attempt with the master
I1113 15:22:22.340242 19610 master.cpp:3252] Deactivating framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000 (default)
I1113 15:22:22.340452 19619 hierarchical.cpp:418] Deactivated framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000
W1113 15:22:22.341181 19610 master.hpp:2605] Unable to send event to framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000 (default): connection closed
I1113 15:22:22.341219 19610 master.cpp:11486] Removing offer a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-O0
I1113 15:22:22.341284 19610 master.cpp:3229] Disconnecting framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000 (default)
I1113 15:22:22.341323 19610 master.cpp:1403] Giving framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000 (default) 1weeks to failover
I1113 15:22:22.341395 19615 hierarchical.cpp:1238] Recovered cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: {}) on agent a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-S0 from framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000
I1113 15:22:22.344389 19611 scheduler.cpp:429] Connected with the master at http://172.17.0.2:38327/master/api/v1/scheduler
I1113 15:22:22.353319 19623 scheduler.cpp:248] Sending SUBSCRIBE call to http://172.17.0.2:38327/master/api/v1/scheduler
I1113 15:22:22.354863 19630 process.cpp:3588] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1113 15:22:22.356667 19633 http.cpp:1182] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:54756
I1113 15:22:22.357095 19633 master.cpp:2524] Received subscription request for HTTP framework 'default'
I1113 15:22:22.357216 19633 master.cpp:2177] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I1113 15:22:22.357758 19620 master.cpp:2659] Subscribing framework 'default' with checkpointing disabled and capabilities [ MULTI_ROLE, RESERVATION_REFINEMENT ]
I1113 15:22:22.357838 19620 master.cpp:7783] Updating framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000 (default) with roles { * } suppressed
I1113 15:22:22.358281 19611 hierarchical.cpp:384] Activated framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000
I1113 15:22:22.358605 19611 hierarchical.cpp:1566] Performed allocation for 1 agents in 170290ns
W1113 15:22:22.358966 19632 slave.cpp:4062] Ignoring info update for framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000 because it does not exist
I1113 15:22:22.359467 19630 scheduler.cpp:845] Enqueuing event SUBSCRIBED received from http://172.17.0.2:38327/master/api/v1/scheduler
I1113 15:22:22.359967 19630 scheduler.cpp:845] Enqueuing event HEARTBEAT received from http://172.17.0.2:38327/master/api/v1/scheduler
I1113 15:22:22.362665 19621 hierarchical.cpp:1566] Performed allocation for 1 agents in 110174ns
I1113 15:22:22.363961 19619 scheduler.cpp:845] Enqueuing event HEARTBEAT received from http://172.17.0.2:38327/master/api/v1/scheduler
I1113 15:22:22.364697 19633 scheduler.cpp:248] Sending REVIVE call to http://172.17.0.2:38327/master/api/v1/scheduler
I1113 15:22:22.365964 19618 process.cpp:3588] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1113 15:22:22.367518 19620 http.cpp:1182] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:54754
I1113 15:22:22.367708 19620 master.cpp:5986] Processing REVIVE call for framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000 (default)
I1113 15:22:22.367866 19613 hierarchical.cpp:1387] Revived offers for roles { * } of framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000
I1113 15:22:22.369144 19613 hierarchical.cpp:1566] Performed allocation for 1 agents in 1.143533ms
I1113 15:22:22.369565 19614 master.cpp:9492] Sending offers [ a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-O1 ] to framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000 (default)
I1113 15:22:22.371232 19619 scheduler.cpp:845] Enqueuing event OFFERS received from http://172.17.0.2:38327/master/api/v1/scheduler
I1113 15:22:22.372929 19632 master.cpp:1388] Framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000 (default) disconnected
I1113 15:22:22.372958 19632 master.cpp:3252] Deactivating framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000 (default)
I1113 15:22:22.373055 19623 hierarchical.cpp:418] Deactivated framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000
W1113 15:22:22.373703 19632 master.hpp:2605] Unable to send event to framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000 (default): connection closed
I1113 15:22:22.373742 19632 master.cpp:11486] Removing offer a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-O1
I1113 15:22:22.373803 19632 master.cpp:3229] Disconnecting framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000 (default)
I1113 15:22:22.373843 19632 master.cpp:1403] Giving framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000 (default) 0ns to failover
I1113 15:22:22.373977 19613 hierarchical.cpp:1238] Recovered cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: {}) on agent a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-S0 from framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000
I1113 15:22:22.375257 19624 master.cpp:9284] Framework failover timeout, removing framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000 (default)
I1113 15:22:22.375286 19624 master.cpp:10221] Removing framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000 (default)
I1113 15:22:22.375449 19629 slave.cpp:3902] Asked to shut down framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000 by master@172.17.0.2:38327
I1113 15:22:22.375483 19629 slave.cpp:3917] Cannot shut down unknown framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000
I1113 15:22:22.375772 19610 hierarchical.cpp:357] Removed framework a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-0000
I1113 15:22:22.376137 19630 slave.cpp:915] Agent terminating
I1113 15:22:22.376891 19611 master.cpp:1273] Agent a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-S0 at slave(42)@172.17.0.2:38327 (20d493ac552e) disconnected
I1113 15:22:22.376922 19611 master.cpp:3289] Disconnecting agent a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-S0 at slave(42)@172.17.0.2:38327 (20d493ac552e)
I1113 15:22:22.376984 19611 master.cpp:3308] Deactivating agent a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-S0 at slave(42)@172.17.0.2:38327 (20d493ac552e)
I1113 15:22:22.377069 19632 hierarchical.cpp:801] Agent a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-S0 deactivated
I1113 15:22:22.384119 19619 master.cpp:1115] Master terminating
I1113 15:22:22.385021 19631 hierarchical.cpp:643] Removed agent a543e6fd-0fb5-4bdb-ba2b-d320e62701d2-S0
[ OK ] ContentType/SchedulerTest.NoOffersOnReregistrationWithAllRolesSuppressed/1 (779 ms)
[----------] 2 tests from ContentType/SchedulerTest (898 ms total)
[----------] 1 test from ContentType/AgentResourceProviderConfigApiTest
[ RUN ] ContentType/AgentResourceProviderConfigApiTest.AddInvalid/1
I1113 15:22:22.393522 19208 cluster.cpp:173] Creating default 'local' authorizer
I1113 15:22:22.395961 19611 master.cpp:413] Master 7982fb72-9ef3-421e-9bfb-b130d65c9fc3 (20d493ac552e) started on 172.17.0.2:38327
I1113 15:22:22.395985 19611 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" --authentication_v0_timeout="15secs" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/RlA4AV/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" --publish_per_framework_metrics="true" --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="/mesos/mesos-1.8.0/_inst/share/mesos/webui" --work_dir="/tmp/RlA4AV/master" --zk_session_timeout="10secs"
I1113 15:22:22.396304 19611 master.cpp:465] Master only allowing authenticated frameworks to register
I1113 15:22:22.396318 19611 master.cpp:471] Master only allowing authenticated agents to register
I1113 15:22:22.396328 19611 master.cpp:477] Master only allowing authenticated HTTP frameworks to register
I1113 15:22:22.396338 19611 credentials.hpp:37] Loading credentials for authentication from '/tmp/RlA4AV/credentials'
I1113 15:22:22.396569 19611 master.cpp:521] Using default 'crammd5' authenticator
I1113 15:22:22.396726 19611 http.cpp:1042] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I1113 15:22:22.396893 19611 http.cpp:1042] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I1113 15:22:22.397017 19611 http.cpp:1042] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I1113 15:22:22.397133 19611 master.cpp:602] Authorization enabled
I1113 15:22:22.397557 19612 hierarchical.cpp:175] Initialized hierarchical allocator process
I1113 15:22:22.397603 19630 whitelist_watcher.cpp:77] No whitelist given
I1113 15:22:22.400018 19626 master.cpp:2105] Elected as the leading master!
I1113 15:22:22.400053 19626 master.cpp:1660] Recovering from registrar
I1113 15:22:22.400202 19614 registrar.cpp:339] Recovering registrar
I1113 15:22:22.400926 19614 registrar.cpp:383] Successfully fetched the registry (0B) in 654848ns
I1113 15:22:22.401051 19614 registrar.cpp:487] Applied 1 operations in 43984ns; attempting to update the registry
I1113 15:22:22.401615 19614 registrar.cpp:544] Successfully updated the registry in 505088ns
I1113 15:22:22.401732 19614 registrar.cpp:416] Successfully recovered registrar
I1113 15:22:22.402168 19616 master.cpp:1774] Recovered 0 agents from the registry (135B); allowing 10mins for agents to reregister
I1113 15:22:22.402179 19622 hierarchical.cpp:215] Skipping recovery of hierarchical allocator: nothing to recover
W1113 15:22:22.406878 19208 process.cpp:2829] Attempted to spawn already running process files@172.17.0.2:38327
I1113 15:22:22.407835 19208 containerizer.cpp:305] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W1113 15:22:22.408336 19208 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W1113 15:22:22.408455 19208 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I1113 15:22:22.408489 19208 provisioner.cpp:298] Using default backend 'copy'
I1113 15:22:22.410312 19208 cluster.cpp:485] Creating default 'local' authorizer
I1113 15:22:22.411939 19616 slave.cpp:267] Mesos agent started on (43)@172.17.0.2:38327
I1113 15:22:22.411962 19616 slave.cpp:268] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/ContentType_AgentResourceProviderConfigApiTest_AddInvalid_1_xZWVej/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="false" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authentication_timeout_max="1mins" --authentication_timeout_min="5secs" --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_AddInvalid_1_xZWVej/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_AddInvalid_1_xZWVej/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_AddInvalid_1_xZWVej/fetch" --fetcher_cache_size="2GB" --fetcher_stall_timeout="1mins" --frameworks_home="/tmp/ContentType_AgentResourceProviderConfigApiTest_AddInvalid_1_xZWVej/frameworks" --gc_delay="1weeks" --gc_disk_headroom="0.1" --gc_non_executor_container_sandboxes="false" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/ContentType_AgentResourceProviderConfigApiTest_AddInvalid_1_xZWVej/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.8.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --memory_profiling="false" --network_cni_metrics="true" --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/RlA4AV/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_AddInvalid_1_xZWVej" --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_AddInvalid_1_odOZpC" --zk_session_timeout="10secs"
I1113 15:22:22.412344 19616 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentType_AgentResourceProviderConfigApiTest_AddInvalid_1_xZWVej/credential'
I1113 15:22:22.412487 19616 slave.cpp:300] Agent using credential for: test-principal
I1113 15:22:22.412508 19616 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentType_AgentResourceProviderConfigApiTest_AddInvalid_1_xZWVej/http_credentials'
I1113 15:22:22.412683 19616 http.cpp:1042] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1113 15:22:22.412962 19616 disk_profile_adaptor.cpp:80] Creating default disk profile adaptor module
I1113 15:22:22.414124 19616 slave.cpp:615] 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"}]
I1113 15:22:22.414307 19616 slave.cpp:623] Agent attributes: [ ]
I1113 15:22:22.414324 19616 slave.cpp:632] Agent hostname: 20d493ac552e
I1113 15:22:22.414471 19626 task_status_update_manager.cpp:181] Pausing sending task status updates
I1113 15:22:22.415719 19631 state.cpp:66] Recovering state from '/tmp/ContentType_AgentResourceProviderConfigApiTest_AddInvalid_1_odOZpC/meta'
I1113 15:22:22.415943 19619 slave.cpp:6915] Finished recovering checkpointed state from '/tmp/ContentType_AgentResourceProviderConfigApiTest_AddInvalid_1_odOZpC/meta', beginning agent recovery
I1113 15:22:22.416110 19628 task_status_update_manager.cpp:207] Recovering task status update manager
I1113 15:22:22.416379 19627 containerizer.cpp:727] Recovering Mesos containers
I1113 15:22:22.416684 19627 containerizer.cpp:1053] Recovering isolators
I1113 15:22:22.417201 19612 containerizer.cpp:1092] Recovering provisioner
I1113 15:22:22.417837 19611 provisioner.cpp:494] Provisioner recovery complete
I1113 15:22:22.418439 19619 composing.cpp:339] Finished recovering all containerizers
I1113 15:22:22.418576 19628 slave.cpp:7144] Recovering executors
I1113 15:22:22.418675 19628 slave.cpp:7297] Finished recovery
I1113 15:22:22.419404 19629 task_status_update_manager.cpp:181] Pausing sending task status updates
I1113 15:22:22.419435 19632 slave.cpp:1260] New master detected at master@172.17.0.2:38327
I1113 15:22:22.419554 19632 slave.cpp:1325] Detecting new master
I1113 15:22:22.422893 19617 slave.cpp:1352] Authenticating with master master@172.17.0.2:38327
I1113 15:22:22.422966 19617 slave.cpp:1361] Using default CRAM-MD5 authenticatee
I1113 15:22:22.423229 19625 authenticatee.cpp:121] Creating new client SASL connection
I1113 15:22:22.423513 19630 master.cpp:9677] Authenticating slave(43)@172.17.0.2:38327
I1113 15:22:22.423669 19620 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(83)@172.17.0.2:38327
I1113 15:22:22.423912 19612 authenticator.cpp:98] Creating new server SASL connection
I1113 15:22:22.424134 19610 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I1113 15:22:22.424161 19610 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I1113 15:22:22.424278 19623 authenticator.cpp:204] Received SASL authentication start
I1113 15:22:22.424343 19623 authenticator.cpp:326] Authentication requires more steps
I1113 15:22:22.424440 19611 authenticatee.cpp:259] Received SASL authentication step
I1113 15:22:22.424558 19613 authenticator.cpp:232] Received SASL authentication step
I1113 15:22:22.424595 19613 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '20d493ac552e' server FQDN: '20d493ac552e' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I1113 15:22:22.424612 19613 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I1113 15:22:22.424651 19613 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I1113 15:22:22.424674 19613 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '20d493ac552e' server FQDN: '20d493ac552e' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I1113 15:22:22.424687 19613 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I1113 15:22:22.424697 19613 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I1113 15:22:22.424715 19613 authenticator.cpp:318] Authentication success
I1113 15:22:22.424818 19626 authenticatee.cpp:299] Authentication success
I1113 15:22:22.424897 19618 master.cpp:9709] Successfully authenticated principal 'test-principal' at slave(43)@172.17.0.2:38327
I1113 15:22:22.424902 19624 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(83)@172.17.0.2:38327
I1113 15:22:22.425156 19631 slave.cpp:1452] Successfully authenticated with master master@172.17.0.2:38327
I1113 15:22:22.425452 19631 slave.cpp:1883] Will retry registration in 14.062607ms if necessary
I1113 15:22:22.425622 19633 master.cpp:6628] Received register agent message from slave(43)@172.17.0.2:38327 (20d493ac552e)
I1113 15:22:22.425859 19633 master.cpp:3986] Authorizing agent providing resources 'cpus:2; mem:1024; disk:1024; ports:[31000-32000]' with principal 'test-principal'
I1113 15:22:22.426410 19629 master.cpp:6695] Authorized registration of agent at slave(43)@172.17.0.2:38327 (20d493ac552e)
I1113 15:22:22.426494 19629 master.cpp:6810] Registering agent at slave(43)@172.17.0.2:38327 (20d493ac552e) with id 7982fb72-9ef3-421e-9bfb-b130d65c9fc3-S0
I1113 15:22:22.427014 19622 registrar.cpp:487] Applied 1 operations in 149676ns; attempting to update the registry
I1113 15:22:22.427609 19622 registrar.cpp:544] Successfully updated the registry in 526080ns
I1113 15:22:22.427770 19620 master.cpp:6858] Admitted agent 7982fb72-9ef3-421e-9bfb-b130d65c9fc3-S0 at slave(43)@172.17.0.2:38327 (20d493ac552e)
I1113 15:22:22.428782 19613 slave.cpp:1485] Registered with master master@172.17.0.2:38327; given agent ID 7982fb72-9ef3-421e-9bfb-b130d65c9fc3-S0
I1113 15:22:22.428848 19610 hierarchical.cpp:603] Added agent 7982fb72-9ef3-421e-9bfb-b130d65c9fc3-S0 (20d493ac552e) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I1113 15:22:22.428890 19615 task_status_update_manager.cpp:188] Resuming sending task status updates
I1113 15:22:22.429109 19610 hierarchical.cpp:1566] Performed allocation for 1 agents in 95246ns
I1113 15:22:22.429126 19613 slave.cpp:1505] Checkpointing SlaveInfo to '/tmp/ContentType_AgentResourceProviderConfigApiTest_AddInvalid_1_odOZpC/meta/slaves/7982fb72-9ef3-421e-9bfb-b130d65c9fc3-S0/slave.info'
I1113 15:22:22.429991 19613 slave.cpp:1554] Forwarding agent update {"operations":{},"resource_version_uuid":{"value":"OghmT31cQB+cp8+pz1LeYA=="},"slave_id":{"value":"7982fb72-9ef3-421e-9bfb-b130d65c9fc3-S0"},"update_oversubscribed_resources":false}
I1113 15:22:22.430140 19620 master.cpp:6903] Registered agent 7982fb72-9ef3-421e-9bfb-b130d65c9fc3-S0 at slave(43)@172.17.0.2:38327 (20d493ac552e) with cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I1113 15:22:22.430582 19620 master.cpp:7962] Ignoring update on agent 7982fb72-9ef3-421e-9bfb-b130d65c9fc3-S0 at slave(43)@172.17.0.2:38327 (20d493ac552e) as it reports no changes
I1113 15:22:22.432449 19625 process.cpp:3588] Handling HTTP event for process 'slave(43)' with path: '/slave(43)/api/v1'
I1113 15:22:22.433423 19618 http.cpp:1182] HTTP POST for /slave(43)/api/v1 from 172.17.0.2:54758
I1113 15:22:22.434701 19616 http.cpp:3241] Processing UPDATE_RESOURCE_PROVIDER_CONFIG call with type 'org.apache.mesos.rp.local.storage' and name 'test'
I1113 15:22:22.436079 19630 slave.cpp:915] Agent terminating
I1113 15:22:22.448446 19619 hierarchical.cpp:1566] Performed allocation for 1 agents in 115600ns
I1113 15:22:22.500319 19615 hierarchical.cpp:1566] Performed allocation for 1 agents in 167932ns
I1113 15:22:22.551302 19628 hierarchical.cpp:1566] Performed allocation for 1 agents in 134651ns
I1113 15:22:22.602798 19610 hierarchical.cpp:1566] Performed allocation for 1 agents in 85661ns
I1113 15:22:22.653477 19614 hierarchical.cpp:1566] Performed allocation for 1 agents in 69605ns
I1113 15:22:22.704200 19633 hierarchical.cpp:1566] Performed allocation for 1 agents in 81082ns
I1113 15:22:22.739377 19620 master.cpp:1273] Agent 7982fb72-9ef3-421e-9bfb-b130d65c9fc3-S0 at slave(43)@172.17.0.2:38327 (20d493ac552e) disconnected
I1113 15:22:22.739413 19620 master.cpp:3289] Disconnecting agent 7982fb72-9ef3-421e-9bfb-b130d65c9fc3-S0 at slave(43)@172.17.0.2:38327 (20d493ac552e)
I1113 15:22:22.739473 19620 master.cpp:3308] Deactivating agent 7982fb72-9ef3-421e-9bfb-b130d65c9fc3-S0 at slave(43)@172.17.0.2:38327 (20d493ac552e)
I1113 15:22:22.739601 19625 hierarchical.cpp:801] Agent 7982fb72-9ef3-421e-9bfb-b130d65c9fc3-S0 deactivated
I1113 15:22:22.746116 19208 master.cpp:1115] Master terminating
I1113 15:22:22.746670 19622 hierarchical.cpp:643] Removed agent 7982fb72-9ef3-421e-9bfb-b130d65c9fc3-S0
[ OK ] ContentType/AgentResourceProviderConfigApiTest.AddInvalid/1 (359 ms)
[----------] 1 test from ContentType/AgentResourceProviderConfigApiTest (360 ms total)
[----------] Global test environment tear-down
[==========] 85 tests from 68 test cases ran. (117335 ms total)
[ PASSED ] 84 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] ExamplesTest.DynamicReservationFramework
1 FAILED TEST
YOU HAVE 24 DISABLED TESTS
I1113 15:22:22.824455 19634 process.cpp:927] Stopped the socket accept loop
[FAIL]: 2 shard(s) have failed tests
make[4]: *** [check-local] Error 2
make[4]: Leaving directory `/mesos/mesos-1.8.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.8.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.8.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.8.0/_build'
make: *** [distcheck] Error 1
+ docker rmi --force mesos-1542118313-5955
Untagged: mesos-1542118313-5955:latest
Deleted: sha256:1b086f1b88ea1c85c80dce015cbce02fd02460f06ab8b2914e1187d385c38b2e
Deleted: sha256:8cee8a646dc0e3bbdb4f3e61405a57c7dd6209f83f436ca10a11b35f7a396951
Deleted: sha256:c5a025da8873490ae0bcc160510312555980996960ab5ef6ecdae616d1a65a09
Deleted: sha256:ff9e7ad141ecd807b1950c5e5dee5f9ea40faa2a9cd884af70229bec7e5ecf51
Deleted: sha256:129a4f3539243e0e93aaedeab08c250f3b1ddb1e3c44a7d032f3e32e17728f65
Deleted: sha256:fdc421ebc29da817db664523a948c66769f336170cb90c501f2b32387c40e0d6
Deleted: sha256:a664ee886c10c45f01e2c94075091bed801a3eee2131a17bea9d85df4bad4a67
Deleted: sha256:bde30f28c5f434af4558b16dffa8c8d5da9a7448c70c005b9a660da450593d9e
Deleted: sha256:fe59896fc67f1cb5df8c8bcde6c75b86b95702481801886d7fb11472debc2074
Deleted: sha256:8a37eb8b2ad8fe85d5caf3f0e17faa352790b6d870264eeee2eaa1c16b416f40
Deleted: sha256:85cf73c2c604426f8552f4ac2c1ef63d32687d56566f6fdcbf97eb3bd65a49ed
Deleted: sha256:d9c1096f26774ef2703ccb3caaf0418d4ce75b47046c9e63063b703b4dce5970
Deleted: sha256:463dd7adc1d5ff7f3f25cf32813e2bb23b0ac9ab2482c5bfa95b0aea038c7969
Deleted: sha256:af699732ba1cc2a2ff575c0b6e6eab273607ee2743bed9987c76a4fbc0e89292
Deleted: sha256:be334831781640a327b4ae6ab44789ea5873b3b0aaface25ea314ea3e69f724a
Deleted: sha256:67509b3b7636979a9ffe1c4daa5a62d37f02839eeab1bf4761fd36fa2261aaaa
Deleted: sha256:bfe98d5c1bfef56f043f6a1d254917d650a70534eae0572971eef35c8f89b1a8
Deleted: sha256:d9a6bae0bc76514a35e0920165e0c04353d1c223cbb909a6e98bb268f760a316
Deleted: sha256:f20f0cfb97510fb5bbc16f0c20493ef93359823d67d3c270935ef409a6c48bbf
Deleted: sha256:be8945fb0a2317344f000412d0459cb6f2bd1874f1a91739715fd487b76c209e
Deleted: sha256:25a044798511637ff9c2b7cf04baf9c85a5e64e78ce75b17c6114be0bf00ccc9
Deleted: sha256:548fbd714239e512d62e1f4762b90633fd14ddbb959ac558c93b1b2253199d0c
Deleted: sha256:7f8f87d8c0fed365add717e5d4ba37bf12bd707e4ca42b8b6b4627441418bd75
Deleted: sha256:c35c4bb10c3c6538f866dd9d542743ef80d777794835b853b51e3910c2a3b434
Deleted: sha256:f8cc3b603d362fc2f779c88c9c33dc865afbf9a398bc5699028b3ce0ccfab0fa
Deleted: sha256:8d0e3aa9be84529c987bc9d23bd5eb5ba84f1f58d8366cd937e99cf05964c7cd
Deleted: sha256:edabd1b416dcfcf187cab71b590760be8b2dbe9f4c5bd6d86aeca21911d256a3
Deleted: sha256:06d979071bf1c3df340c1ea87c3c07fa3866b851d23efec30001d873de21e30e
Deleted: sha256:7cb83e3a8213566de7c83331dee89b214e6013bfb3ebb7ce583c6f701bf187da
Deleted: sha256:142080e3e4ce71bef39c944819b03414cb4209ce05202ce114b7a99a323c6129
11-13-18_14:11:51 - Running <https://builds.apache.org/job/Mesos-Reviewbot/ws/support/verify-reviews.py>
Checking if review 69325 needs verification
Patch never verified, needs verification
Verifying review 69325
Applying review 69325
/usr/bin/python3 support/apply-reviews.py -n -r 69325
Traceback (most recent call last):
File "<https://builds.apache.org/job/Mesos-Reviewbot/ws/support/verify-reviews.py",> line 186, in verify_review
% (command, build_output)])
File "/usr/lib/python3.5/subprocess.py", line 581, in check_call
raise CalledProcessError(retcode, cmd)
subprocess.CalledProcessError: Command '['bash', '-c', "set -o pipefail; export OS='ubuntu:14.04' BUILDTOOL='autotools' COMPILER='gcc' CONFIGURATION='--verbose --disable-libtool-wrappers' ENVIRONMENT='GLOG_v=1 MESOS_VERBOSE=1'; ./support/docker-build.sh 2>&1 | tee build_69325"]' returned non-zero exit status 2
During handling of the above exception, another exception occurred:
Traceback (most recent call last):
File "<https://builds.apache.org/job/Mesos-Reviewbot/ws/support/verify-reviews.py",> line 294, in <module>
main()
File "<https://builds.apache.org/job/Mesos-Reviewbot/ws/support/verify-reviews.py",> line 288, in main
verify_review(review_request, handler)
File "<https://builds.apache.org/job/Mesos-Reviewbot/ws/support/verify-reviews.py",> line 201, in verify_review
output = open(build_output).read().decode(sys.stdout.encoding)
AttributeError: 'str' object has no attribute 'decode'
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos-Reviewbot #23557
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Reviewbot/23557/display/redirect?page=changes>
Build failed in Jenkins: Mesos-Reviewbot #23556
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Reviewbot/23556/display/redirect?page=changes>
Changes:
[vinodkone] Reverted xml output file location.
[vinodkone] Improved log messages in master when adding/removing tasks/executors.
------------------------------------------
[...truncated 40.20 MB...]
rm -f slave/containerizer/mesos/isolators/linux/.deps/.dirstamp
rm -f slave/containerizer/mesos/isolators/linux/.dirstamp
rm -f slave/containerizer/mesos/isolators/docker/*.o
rm -f slave/containerizer/mesos/isolators/namespaces/.deps/.dirstamp
rm -f slave/containerizer/mesos/isolators/docker/*.lo
rm -f slave/containerizer/mesos/isolators/namespaces/.dirstamp
rm -f slave/containerizer/mesos/isolators/docker/volume/*.o
rm -f slave/containerizer/mesos/isolators/network/.deps/.dirstamp
rm -f slave/containerizer/mesos/isolators/docker/volume/*.lo
rm -f slave/containerizer/mesos/isolators/network/.dirstamp
rm -f slave/containerizer/mesos/isolators/filesystem/*.o
rm -f slave/containerizer/mesos/isolators/network/cni/.deps/.dirstamp
rm -f slave/containerizer/mesos/isolators/filesystem/*.lo
rm -f slave/containerizer/mesos/isolators/network/cni/.dirstamp
rm -f slave/containerizer/mesos/isolators/gpu/*.o
rm -f slave/containerizer/mesos/isolators/network/cni/plugins/port_mapper/.deps/.dirstamp
rm -f slave/containerizer/mesos/isolators/gpu/*.lo
rm -f slave/containerizer/mesos/isolators/network/cni/plugins/port_mapper/.dirstamp
rm -f slave/containerizer/mesos/isolators/linux/*.o
rm -f slave/containerizer/mesos/isolators/posix/.deps/.dirstamp
rm -f slave/containerizer/mesos/isolators/linux/*.lo
rm -f slave/containerizer/mesos/isolators/posix/.dirstamp
rm -f slave/containerizer/mesos/isolators/namespaces/*.o
rm -f slave/containerizer/mesos/isolators/volume/.deps/.dirstamp
rm -f slave/containerizer/mesos/isolators/namespaces/*.lo
rm -f slave/containerizer/mesos/isolators/volume/.dirstamp
rm -f slave/containerizer/mesos/isolators/network/*.o
rm -f slave/containerizer/mesos/isolators/xfs/.deps/.dirstamp
rm -f slave/containerizer/mesos/isolators/network/*.lo
rm -f slave/containerizer/mesos/isolators/xfs/.dirstamp
rm -f slave/containerizer/mesos/isolators/network/cni/*.o
rm -f slave/containerizer/mesos/provisioner/.deps/.dirstamp
rm -f slave/containerizer/mesos/isolators/network/cni/*.lo
rm -f slave/containerizer/mesos/provisioner/.dirstamp
rm -f slave/containerizer/mesos/provisioner/appc/.deps/.dirstamp
rm -f slave/containerizer/mesos/isolators/network/cni/plugins/port_mapper/*.o
rm -f slave/containerizer/mesos/provisioner/appc/.dirstamp
rm -f slave/containerizer/mesos/isolators/network/cni/plugins/port_mapper/*.lo
rm -f slave/containerizer/mesos/provisioner/backends/.deps/.dirstamp
rm -f slave/containerizer/mesos/isolators/posix/*.o
rm -f slave/containerizer/mesos/provisioner/backends/.dirstamp
rm -f slave/containerizer/mesos/isolators/posix/*.lo
rm -f slave/containerizer/mesos/provisioner/docker/.deps/.dirstamp
rm -f slave/containerizer/mesos/isolators/volume/*.o
rm -f slave/containerizer/mesos/provisioner/docker/.dirstamp
rm -f slave/containerizer/mesos/isolators/volume/*.lo
rm -f slave/qos_controllers/.deps/.dirstamp
rm -f slave/containerizer/mesos/isolators/xfs/*.o
rm -f slave/qos_controllers/.dirstamp
rm -f slave/containerizer/mesos/isolators/xfs/*.lo
rm -f slave/resource_estimators/.deps/.dirstamp
rm -rf ../include/csi/.libs ../include/csi/_libs
rm -f slave/containerizer/mesos/provisioner/*.o
rm -f slave/resource_estimators/.dirstamp
rm -f state/.deps/.dirstamp
rm -f slave/containerizer/mesos/provisioner/*.lo
rm -rf ../include/mesos/.libs ../include/mesos/_libs
rm -f slave/containerizer/mesos/provisioner/appc/*.o
rm -f state/.dirstamp
rm -f slave/containerizer/mesos/provisioner/appc/*.lo
rm -f status_update_manager/.deps/.dirstamp
rm -rf ../include/mesos/agent/.libs ../include/mesos/agent/_libs
rm -f slave/containerizer/mesos/provisioner/backends/*.o
rm -f status_update_manager/.dirstamp
rm -rf ../include/mesos/allocator/.libs ../include/mesos/allocator/_libs
rm -f slave/containerizer/mesos/provisioner/backends/*.lo
rm -f tests/.deps/.dirstamp
rm -rf ../include/mesos/appc/.libs ../include/mesos/appc/_libs
rm -f slave/containerizer/mesos/provisioner/docker/*.o
rm -f tests/.dirstamp
rm -rf ../include/mesos/authentication/.libs ../include/mesos/authentication/_libs
rm -f tests/common/.deps/.dirstamp
rm -f slave/containerizer/mesos/provisioner/docker/*.lo
rm -f tests/common/.dirstamp
rm -rf ../include/mesos/authorizer/.libs ../include/mesos/authorizer/_libs
rm -f slave/qos_controllers/*.o
rm -f tests/containerizer/.deps/.dirstamp
rm -f slave/qos_controllers/*.lo
rm -rf ../include/mesos/docker/.libs ../include/mesos/docker/_libs
rm -f tests/containerizer/.dirstamp
rm -f slave/resource_estimators/*.o
rm -f uri/.deps/.dirstamp
rm -rf ../include/mesos/executor/.libs ../include/mesos/executor/_libs
rm -f slave/resource_estimators/*.lo
rm -f uri/.dirstamp
rm -rf ../include/mesos/fetcher/.libs ../include/mesos/fetcher/_libs
rm -f state/*.o
rm -f uri/fetchers/.deps/.dirstamp
rm -rf ../include/mesos/maintenance/.libs ../include/mesos/maintenance/_libs
rm -f uri/fetchers/.dirstamp
rm -f state/*.lo
rm -rf ../include/mesos/master/.libs ../include/mesos/master/_libs
rm -f usage/.deps/.dirstamp
rm -f status_update_manager/*.o
rm -f usage/.dirstamp
rm -f status_update_manager/*.lo
rm -rf ../include/mesos/module/.libs ../include/mesos/module/_libs
rm -f v1/.deps/.dirstamp
rm -f tests/*.o
rm -rf ../include/mesos/oci/.libs ../include/mesos/oci/_libs
rm -f v1/.dirstamp
rm -rf ../include/mesos/quota/.libs ../include/mesos/quota/_libs
rm -f version/.deps/.dirstamp
rm -rf ../include/mesos/resource_provider/.libs ../include/mesos/resource_provider/_libs
rm -f version/.dirstamp
rm -f watcher/.deps/.dirstamp
rm -rf ../include/mesos/scheduler/.libs ../include/mesos/scheduler/_libs
rm -f watcher/.dirstamp
rm -rf ../include/mesos/slave/.libs ../include/mesos/slave/_libs
rm -f zookeeper/.deps/.dirstamp
rm -rf ../include/mesos/state/.libs ../include/mesos/state/_libs
rm -f zookeeper/.dirstamp
rm -rf ../include/mesos/uri/.libs ../include/mesos/uri/_libs
rm -rf ../include/mesos/v1/.libs ../include/mesos/v1/_libs
rm -rf ../include/mesos/v1/agent/.libs ../include/mesos/v1/agent/_libs
rm -rf ../include/mesos/v1/allocator/.libs ../include/mesos/v1/allocator/_libs
rm -rf ../include/mesos/v1/executor/.libs ../include/mesos/v1/executor/_libs
rm -rf ../include/mesos/v1/maintenance/.libs ../include/mesos/v1/maintenance/_libs
rm -rf ../include/mesos/v1/master/.libs ../include/mesos/v1/master/_libs
rm -rf ../include/mesos/v1/quota/.libs ../include/mesos/v1/quota/_libs
rm -rf ../include/mesos/v1/resource_provider/.libs ../include/mesos/v1/resource_provider/_libs
rm -rf ../include/mesos/v1/scheduler/.libs ../include/mesos/v1/scheduler/_libs
rm -rf appc/.libs appc/_libs
rm -rf authentication/cram_md5/.libs authentication/cram_md5/_libs
rm -rf authentication/executor/.libs authentication/executor/_libs
rm -rf authentication/http/.libs authentication/http/_libs
rm -rf authorizer/.libs authorizer/_libs
rm -rf authorizer/local/.libs authorizer/local/_libs
rm -rf checks/.libs checks/_libs
rm -rf common/.libs common/_libs
rm -rf csi/.libs csi/_libs
rm -rf docker/.libs docker/_libs
rm -rf examples/.libs examples/_libs
rm -rf exec/.libs exec/_libs
rm -rf executor/.libs executor/_libs
rm -rf files/.libs files/_libs
rm -rf hdfs/.libs hdfs/_libs
rm -rf hook/.libs hook/_libs
rm -rf internal/.libs internal/_libs
rm -rf java/jni/.libs java/jni/_libs
rm -rf jvm/.libs jvm/_libs
rm -rf jvm/org/apache/.libs jvm/org/apache/_libs
rm -rf linux/.libs linux/_libs
rm -rf linux/routing/.libs linux/routing/_libs
rm -rf linux/routing/diagnosis/.libs linux/routing/diagnosis/_libs
rm -rf linux/routing/filter/.libs linux/routing/filter/_libs
rm -rf linux/routing/link/.libs linux/routing/link/_libs
rm -rf linux/routing/queueing/.libs linux/routing/queueing/_libs
rm -rf local/.libs local/_libs
rm -rf log/.libs log/_libs
rm -rf log/tool/.libs log/tool/_libs
rm -rf logging/.libs logging/_libs
rm -rf master/.libs master/_libs
rm -rf master/allocator/.libs master/allocator/_libs
rm -rf master/allocator/mesos/.libs master/allocator/mesos/_libs
rm -rf master/allocator/sorter/drf/.libs master/allocator/sorter/drf/_libs
rm -rf master/allocator/sorter/random/.libs master/allocator/sorter/random/_libs
rm -rf master/contender/.libs master/contender/_libs
rm -rf master/detector/.libs master/detector/_libs
rm -rf messages/.libs messages/_libs
rm -rf module/.libs module/_libs
rm -rf oci/.libs oci/_libs
rm -rf posix/.libs posix/_libs
rm -rf resource_provider/.libs resource_provider/_libs
rm -f tests/common/*.o
rm -f tests/containerizer/*.o
rm -rf resource_provider/storage/.libs resource_provider/storage/_libs
rm -rf sched/.libs sched/_libs
rm -rf scheduler/.libs scheduler/_libs
rm -rf secret/.libs secret/_libs
rm -rf slave/.libs slave/_libs
rm -rf slave/container_loggers/.libs slave/container_loggers/_libs
rm -rf slave/containerizer/.libs slave/containerizer/_libs
rm -f uri/*.o
rm -f uri/*.lo
rm -f uri/fetchers/*.o
rm -rf slave/containerizer/mesos/.libs slave/containerizer/mesos/_libs
rm -f uri/fetchers/*.lo
rm -f usage/*.o
rm -f usage/*.lo
rm -f v1/*.o
rm -f v1/*.lo
rm -f version/*.o
rm -f version/*.lo
rm -rf slave/containerizer/mesos/io/.libs slave/containerizer/mesos/io/_libs
rm -f watcher/*.o
rm -f watcher/*.lo
rm -f zookeeper/*.o
rm -f zookeeper/*.lo
rm -rf slave/containerizer/mesos/isolators/.libs slave/containerizer/mesos/isolators/_libs
rm -rf slave/containerizer/mesos/isolators/appc/.libs slave/containerizer/mesos/isolators/appc/_libs
rm -rf slave/containerizer/mesos/isolators/cgroups/.libs slave/containerizer/mesos/isolators/cgroups/_libs
rm -rf slave/containerizer/mesos/isolators/cgroups/subsystems/.libs slave/containerizer/mesos/isolators/cgroups/subsystems/_libs
rm -rf slave/containerizer/mesos/isolators/docker/.libs slave/containerizer/mesos/isolators/docker/_libs
rm -rf slave/containerizer/mesos/isolators/docker/volume/.libs slave/containerizer/mesos/isolators/docker/volume/_libs
rm -rf slave/containerizer/mesos/isolators/filesystem/.libs slave/containerizer/mesos/isolators/filesystem/_libs
rm -rf slave/containerizer/mesos/isolators/gpu/.libs slave/containerizer/mesos/isolators/gpu/_libs
rm -rf slave/containerizer/mesos/isolators/linux/.libs slave/containerizer/mesos/isolators/linux/_libs
rm -rf slave/containerizer/mesos/isolators/namespaces/.libs slave/containerizer/mesos/isolators/namespaces/_libs
rm -rf slave/containerizer/mesos/isolators/network/.libs slave/containerizer/mesos/isolators/network/_libs
rm -rf slave/containerizer/mesos/isolators/network/cni/.libs slave/containerizer/mesos/isolators/network/cni/_libs
rm -rf slave/containerizer/mesos/isolators/network/cni/plugins/port_mapper/.libs slave/containerizer/mesos/isolators/network/cni/plugins/port_mapper/_libs
rm -rf slave/containerizer/mesos/isolators/posix/.libs slave/containerizer/mesos/isolators/posix/_libs
rm -rf slave/containerizer/mesos/isolators/volume/.libs slave/containerizer/mesos/isolators/volume/_libs
rm -rf slave/containerizer/mesos/isolators/xfs/.libs slave/containerizer/mesos/isolators/xfs/_libs
rm -rf slave/containerizer/mesos/provisioner/.libs slave/containerizer/mesos/provisioner/_libs
rm -rf slave/containerizer/mesos/provisioner/appc/.libs slave/containerizer/mesos/provisioner/appc/_libs
rm -rf slave/containerizer/mesos/provisioner/backends/.libs slave/containerizer/mesos/provisioner/backends/_libs
rm -rf slave/containerizer/mesos/provisioner/docker/.libs slave/containerizer/mesos/provisioner/docker/_libs
rm -rf slave/qos_controllers/.libs slave/qos_controllers/_libs
rm -rf slave/resource_estimators/.libs slave/resource_estimators/_libs
rm -rf state/.libs state/_libs
rm -rf status_update_manager/.libs status_update_manager/_libs
rm -rf uri/.libs uri/_libs
rm -rf uri/fetchers/.libs uri/fetchers/_libs
rm -rf usage/.libs usage/_libs
rm -rf v1/.libs v1/_libs
rm -rf version/.libs version/_libs
rm -rf watcher/.libs watcher/_libs
rm -rf zookeeper/.libs zookeeper/_libs
rm -rf ../include/csi/.deps ../include/mesos/.deps ../include/mesos/agent/.deps ../include/mesos/allocator/.deps ../include/mesos/appc/.deps ../include/mesos/authentication/.deps ../include/mesos/authorizer/.deps ../include/mesos/docker/.deps ../include/mesos/executor/.deps ../include/mesos/fetcher/.deps ../include/mesos/maintenance/.deps ../include/mesos/master/.deps ../include/mesos/module/.deps ../include/mesos/oci/.deps ../include/mesos/quota/.deps ../include/mesos/resource_provider/.deps ../include/mesos/scheduler/.deps ../include/mesos/slave/.deps ../include/mesos/state/.deps ../include/mesos/uri/.deps ../include/mesos/v1/.deps ../include/mesos/v1/agent/.deps ../include/mesos/v1/allocator/.deps ../include/mesos/v1/executor/.deps ../include/mesos/v1/maintenance/.deps ../include/mesos/v1/master/.deps ../include/mesos/v1/quota/.deps ../include/mesos/v1/resource_provider/.deps ../include/mesos/v1/scheduler/.deps appc/.deps authentication/cram_md5/.deps authentication/executor/.deps authentication/http/.deps authorizer/.deps authorizer/local/.deps checks/.deps cli/.deps common/.deps csi/.deps docker/.deps examples/.deps exec/.deps executor/.deps files/.deps hdfs/.deps hook/.deps internal/.deps java/jni/.deps jvm/.deps jvm/org/apache/.deps launcher/.deps linux/.deps linux/routing/.deps linux/routing/diagnosis/.deps linux/routing/filter/.deps linux/routing/link/.deps linux/routing/queueing/.deps local/.deps log/.deps log/tool/.deps logging/.deps master/.deps master/allocator/.deps master/allocator/mesos/.deps master/allocator/sorter/drf/.deps master/allocator/sorter/random/.deps master/contender/.deps master/detector/.deps messages/.deps module/.deps oci/.deps posix/.deps resource_provider/.deps resource_provider/storage/.deps sched/.deps scheduler/.deps secret/.deps slave/.deps slave/container_loggers/.deps slave/containerizer/.deps slave/containerizer/mesos/.deps slave/containerizer/mesos/io/.deps slave/containerizer/mesos/isolators/.deps slave/containerizer/mesos/isolators/appc/.deps slave/containerizer/mesos/isolators/cgroups/.deps slave/containerizer/mesos/isolators/cgroups/subsystems/.deps slave/containerizer/mesos/isolators/docker/.deps slave/containerizer/mesos/isolators/docker/volume/.deps slave/containerizer/mesos/isolators/filesystem/.deps slave/containerizer/mesos/isolators/gpu/.deps slave/containerizer/mesos/isolators/linux/.deps slave/containerizer/mesos/isolators/namespaces/.deps slave/containerizer/mesos/isolators/network/.deps slave/containerizer/mesos/isolators/network/cni/.deps slave/containerizer/mesos/isolators/network/cni/plugins/port_mapper/.deps slave/containerizer/mesos/isolators/posix/.deps slave/containerizer/mesos/isolators/volume/.deps slave/containerizer/mesos/isolators/xfs/.deps slave/containerizer/mesos/provisioner/.deps slave/containerizer/mesos/provisioner/appc/.deps slave/containerizer/mesos/provisioner/backends/.deps slave/containerizer/mesos/provisioner/docker/.deps slave/qos_controllers/.deps slave/resource_estimators/.deps state/.deps status_update_manager/.deps tests/.deps tests/common/.deps tests/containerizer/.deps uri/.deps uri/fetchers/.deps usage/.deps v1/.deps version/.deps watcher/.deps zookeeper/.deps
rm -f Makefile
make[2]: Leaving directory '/tmp/SRC/build/mesos-1.8.0/_build/sub/src'
rm -f config.status config.cache config.log configure.lineno config.status.lineno
rm -f Makefile
ERROR: files left in build directory after distclean:
./src/test_detail.xml
./3rdparty/libprocess/test_detail.xml
./3rdparty/stout/test_detail.xml
Makefile:1065: recipe for target 'distcleancheck' failed
make[1]: *** [distcleancheck] Error 1
make[1]: Leaving directory '/tmp/SRC/build/mesos-1.8.0/_build/sub'
Makefile:992: recipe for target 'distcheck' failed
make: *** [distcheck] Error 1
Untagged: mesos/mesos-build:ubuntu-16.04
Untagged: mesos/mesos-build@sha256:83c14243c5d62800296f0932aba58830702219635602b5f4c7f1dc42a4f3da7f
Deleted: sha256:af856ba077babf2b698088b9f3f09c7847b004bb7e4da112c65dc6eb0055adaf
Deleted: sha256:6d42966178cfdfdcb5ff737ee339ae1d12becc1cdf544c32eb6654f7b7010532
Deleted: sha256:562fe6af5a3883058be9c784a839392215ed4185a21d21f1d99df0d17f3ae6e7
Deleted: sha256:0dcdfbe322a4f332f73ac70905d557300ec6dae3bd19586758772c750c7b4a19
Deleted: sha256:c66652d605f01094e2db53d62505dbd524e076d5aa69b89d5e620003803eb149
Deleted: sha256:a2cf79bfb9593c05fd7142ddb49afef77ea4ad5d2464e841f09fe62ffee396e0
Deleted: sha256:f7a904214b390f39d98573882f631dc908df8b2b540cf04e1062f8182c1efffd
Deleted: sha256:ce1f6fcaa83dfce189d76e08f184085732eab4eeb2562d2399953958405c5bec
Deleted: sha256:cce92fda689ab9033f0b8db214bc63edd1ae3e05831a0f3a9418976d7dc7ccdd
Deleted: sha256:d22094bbd65447c59a42c580eaa3a44cee9cd855f00905f59409be21bcefc745
Deleted: sha256:b8976847450013f3eb5e9a81a5778f73ed7bef67e6393049712ef17102b4b7b7
Deleted: sha256:b8c891f0ffec910a12757d733b178e3f62d81dbbde2b31d3b754071c416108ed
Build step 'Execute shell' marked build as failure
Build failed in Jenkins: Mesos-Reviewbot #23555
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Reviewbot/23555/display/redirect?page=changes>
Changes:
[josephwu] Fixed flaky agent reconfiguration test.
[josephwu] Added MESOS-7574 to 1.5.3, 1.6.2, and 1.7.1 CHANGELOGs.
------------------------------------------
[...truncated 45.73 MB...]
I1115 00:12:49.381837 19400 hierarchical.cpp:1566] Performed allocation for 1 agents in 116798ns
W1115 00:12:49.381990 19404 slave.cpp:4062] Ignoring info update for framework 9a3a9e7a-5e7f-43ad-a3f1-1cbc0bb4bd67-0000 because it does not exist
I1115 00:12:49.382344 19406 scheduler.cpp:845] Enqueuing event SUBSCRIBED received from http://172.17.0.2:37409/master/api/v1/scheduler
I1115 00:12:49.382782 19406 scheduler.cpp:845] Enqueuing event HEARTBEAT received from http://172.17.0.2:37409/master/api/v1/scheduler
I1115 00:12:49.391796 19420 hierarchical.cpp:1566] Performed allocation for 1 agents in 100306ns
I1115 00:12:49.393107 19413 scheduler.cpp:845] Enqueuing event HEARTBEAT received from http://172.17.0.2:37409/master/api/v1/scheduler
I1115 00:12:49.393823 19406 scheduler.cpp:248] Sending REVIVE call to http://172.17.0.2:37409/master/api/v1/scheduler
I1115 00:12:49.394857 19408 process.cpp:3588] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1115 00:12:49.396066 19407 http.cpp:1182] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:34892
I1115 00:12:49.396170 19407 master.cpp:5986] Processing REVIVE call for framework 9a3a9e7a-5e7f-43ad-a3f1-1cbc0bb4bd67-0000 (default)
I1115 00:12:49.396320 19404 hierarchical.cpp:1387] Revived offers for roles { * } of framework 9a3a9e7a-5e7f-43ad-a3f1-1cbc0bb4bd67-0000
I1115 00:12:49.397286 19404 hierarchical.cpp:1566] Performed allocation for 1 agents in 849554ns
I1115 00:12:49.397637 19399 master.cpp:9531] Sending offers [ 9a3a9e7a-5e7f-43ad-a3f1-1cbc0bb4bd67-O1 ] to framework 9a3a9e7a-5e7f-43ad-a3f1-1cbc0bb4bd67-0000 (default)
I1115 00:12:49.398792 19413 scheduler.cpp:845] Enqueuing event OFFERS received from http://172.17.0.2:37409/master/api/v1/scheduler
I1115 00:12:49.406034 19405 master.cpp:1388] Framework 9a3a9e7a-5e7f-43ad-a3f1-1cbc0bb4bd67-0000 (default) disconnected
I1115 00:12:49.406062 19405 master.cpp:3252] Deactivating framework 9a3a9e7a-5e7f-43ad-a3f1-1cbc0bb4bd67-0000 (default)
I1115 00:12:49.406158 19402 hierarchical.cpp:418] Deactivated framework 9a3a9e7a-5e7f-43ad-a3f1-1cbc0bb4bd67-0000
W1115 00:12:49.406554 19405 master.hpp:2605] Unable to send event to framework 9a3a9e7a-5e7f-43ad-a3f1-1cbc0bb4bd67-0000 (default): connection closed
I1115 00:12:49.406584 19405 master.cpp:11525] Removing offer 9a3a9e7a-5e7f-43ad-a3f1-1cbc0bb4bd67-O1
I1115 00:12:49.406622 19405 master.cpp:3229] Disconnecting framework 9a3a9e7a-5e7f-43ad-a3f1-1cbc0bb4bd67-0000 (default)
I1115 00:12:49.406648 19405 master.cpp:1403] Giving framework 9a3a9e7a-5e7f-43ad-a3f1-1cbc0bb4bd67-0000 (default) 0ns to failover
I1115 00:12:49.406785 19404 hierarchical.cpp:1238] Recovered cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: {}) on agent 9a3a9e7a-5e7f-43ad-a3f1-1cbc0bb4bd67-S0 from framework 9a3a9e7a-5e7f-43ad-a3f1-1cbc0bb4bd67-0000
I1115 00:12:49.408004 19397 master.cpp:9323] Framework failover timeout, removing framework 9a3a9e7a-5e7f-43ad-a3f1-1cbc0bb4bd67-0000 (default)
I1115 00:12:49.408033 19397 master.cpp:10260] Removing framework 9a3a9e7a-5e7f-43ad-a3f1-1cbc0bb4bd67-0000 (default)
I1115 00:12:49.408162 19396 slave.cpp:3902] Asked to shut down framework 9a3a9e7a-5e7f-43ad-a3f1-1cbc0bb4bd67-0000 by master@172.17.0.2:37409
I1115 00:12:49.408191 19396 slave.cpp:3917] Cannot shut down unknown framework 9a3a9e7a-5e7f-43ad-a3f1-1cbc0bb4bd67-0000
I1115 00:12:49.408486 19396 hierarchical.cpp:357] Removed framework 9a3a9e7a-5e7f-43ad-a3f1-1cbc0bb4bd67-0000
I1115 00:12:49.408816 19219 slave.cpp:915] Agent terminating
I1115 00:12:49.409514 19407 master.cpp:1273] Agent 9a3a9e7a-5e7f-43ad-a3f1-1cbc0bb4bd67-S0 at slave(44)@172.17.0.2:37409 (1fedc39b9816) disconnected
I1115 00:12:49.409543 19407 master.cpp:3289] Disconnecting agent 9a3a9e7a-5e7f-43ad-a3f1-1cbc0bb4bd67-S0 at slave(44)@172.17.0.2:37409 (1fedc39b9816)
I1115 00:12:49.409598 19407 master.cpp:3308] Deactivating agent 9a3a9e7a-5e7f-43ad-a3f1-1cbc0bb4bd67-S0 at slave(44)@172.17.0.2:37409 (1fedc39b9816)
I1115 00:12:49.409687 19399 hierarchical.cpp:801] Agent 9a3a9e7a-5e7f-43ad-a3f1-1cbc0bb4bd67-S0 deactivated
I1115 00:12:49.418069 19219 master.cpp:1115] Master terminating
I1115 00:12:49.418565 19410 hierarchical.cpp:643] Removed agent 9a3a9e7a-5e7f-43ad-a3f1-1cbc0bb4bd67-S0
[ OK ] ContentType/SchedulerTest.NoOffersOnReregistrationWithAllRolesSuppressed/0 (436 ms)
[----------] 2 tests from ContentType/SchedulerTest (481 ms total)
[----------] 1 test from ContentType/AgentResourceProviderConfigApiTest
[ RUN ] ContentType/AgentResourceProviderConfigApiTest.AddInvalid/0
I1115 00:12:49.430706 19219 cluster.cpp:173] Creating default 'local' authorizer
I1115 00:12:49.434628 19404 master.cpp:413] Master fbe92b6f-7bb1-469d-a424-d2925a7ec0a9 (1fedc39b9816) started on 172.17.0.2:37409
I1115 00:12:49.434653 19404 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" --authentication_v0_timeout="15secs" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/e7Cqbr/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" --publish_per_framework_metrics="true" --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="/mesos/mesos-1.8.0/_inst/share/mesos/webui" --work_dir="/tmp/e7Cqbr/master" --zk_session_timeout="10secs"
I1115 00:12:49.434973 19404 master.cpp:465] Master only allowing authenticated frameworks to register
I1115 00:12:49.434984 19404 master.cpp:471] Master only allowing authenticated agents to register
I1115 00:12:49.434993 19404 master.cpp:477] Master only allowing authenticated HTTP frameworks to register
I1115 00:12:49.435003 19404 credentials.hpp:37] Loading credentials for authentication from '/tmp/e7Cqbr/credentials'
I1115 00:12:49.435298 19404 master.cpp:521] Using default 'crammd5' authenticator
I1115 00:12:49.435456 19404 http.cpp:1042] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I1115 00:12:49.435603 19404 http.cpp:1042] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I1115 00:12:49.435724 19404 http.cpp:1042] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I1115 00:12:49.435839 19404 master.cpp:602] Authorization enabled
I1115 00:12:49.436256 19406 whitelist_watcher.cpp:77] No whitelist given
I1115 00:12:49.436331 19409 hierarchical.cpp:175] Initialized hierarchical allocator process
I1115 00:12:49.438810 19411 master.cpp:2105] Elected as the leading master!
I1115 00:12:49.438875 19411 master.cpp:1660] Recovering from registrar
I1115 00:12:49.439136 19412 registrar.cpp:339] Recovering registrar
I1115 00:12:49.439910 19412 registrar.cpp:383] Successfully fetched the registry (0B) in 688128ns
I1115 00:12:49.440099 19412 registrar.cpp:487] Applied 1 operations in 58165ns; attempting to update the registry
I1115 00:12:49.440770 19412 registrar.cpp:544] Successfully updated the registry in 594944ns
I1115 00:12:49.440912 19412 registrar.cpp:416] Successfully recovered registrar
I1115 00:12:49.441407 19401 master.cpp:1774] Recovered 0 agents from the registry (135B); allowing 10mins for agents to reregister
I1115 00:12:49.441455 19413 hierarchical.cpp:215] Skipping recovery of hierarchical allocator: nothing to recover
W1115 00:12:49.446341 19219 process.cpp:2829] Attempted to spawn already running process files@172.17.0.2:37409
I1115 00:12:49.447365 19219 containerizer.cpp:305] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W1115 00:12:49.447896 19219 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W1115 00:12:49.448021 19219 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I1115 00:12:49.448056 19219 provisioner.cpp:298] Using default backend 'copy'
I1115 00:12:49.449913 19219 cluster.cpp:485] Creating default 'local' authorizer
I1115 00:12:49.451593 19401 slave.cpp:267] Mesos agent started on (45)@172.17.0.2:37409
I1115 00:12:49.451649 19401 slave.cpp:268] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/ContentType_AgentResourceProviderConfigApiTest_AddInvalid_0_ArdCaR/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="false" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authentication_timeout_max="1mins" --authentication_timeout_min="5secs" --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_AddInvalid_0_ArdCaR/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_AddInvalid_0_ArdCaR/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_AddInvalid_0_ArdCaR/fetch" --fetcher_cache_size="2GB" --fetcher_stall_timeout="1mins" --frameworks_home="/tmp/ContentType_AgentResourceProviderConfigApiTest_AddInvalid_0_ArdCaR/frameworks" --gc_delay="1weeks" --gc_disk_headroom="0.1" --gc_non_executor_container_sandboxes="false" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/ContentType_AgentResourceProviderConfigApiTest_AddInvalid_0_ArdCaR/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.8.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --memory_profiling="false" --network_cni_metrics="true" --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/e7Cqbr/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_AddInvalid_0_ArdCaR" --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_AddInvalid_0_alG0aE" --zk_session_timeout="10secs"
I1115 00:12:49.452220 19401 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentType_AgentResourceProviderConfigApiTest_AddInvalid_0_ArdCaR/credential'
I1115 00:12:49.452458 19401 slave.cpp:300] Agent using credential for: test-principal
I1115 00:12:49.452486 19401 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentType_AgentResourceProviderConfigApiTest_AddInvalid_0_ArdCaR/http_credentials'
I1115 00:12:49.452723 19401 http.cpp:1042] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1115 00:12:49.453091 19401 disk_profile_adaptor.cpp:80] Creating default disk profile adaptor module
I1115 00:12:49.454566 19401 slave.cpp:615] 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"}]
I1115 00:12:49.454802 19401 slave.cpp:623] Agent attributes: [ ]
I1115 00:12:49.454828 19401 slave.cpp:632] Agent hostname: 1fedc39b9816
I1115 00:12:49.455015 19411 task_status_update_manager.cpp:181] Pausing sending task status updates
I1115 00:12:49.456521 19402 state.cpp:66] Recovering state from '/tmp/ContentType_AgentResourceProviderConfigApiTest_AddInvalid_0_alG0aE/meta'
I1115 00:12:49.456739 19417 slave.cpp:6915] Finished recovering checkpointed state from '/tmp/ContentType_AgentResourceProviderConfigApiTest_AddInvalid_0_alG0aE/meta', beginning agent recovery
I1115 00:12:49.456904 19405 task_status_update_manager.cpp:207] Recovering task status update manager
I1115 00:12:49.457271 19399 containerizer.cpp:727] Recovering Mesos containers
I1115 00:12:49.457583 19399 containerizer.cpp:1053] Recovering isolators
I1115 00:12:49.458168 19406 containerizer.cpp:1092] Recovering provisioner
I1115 00:12:49.459213 19400 provisioner.cpp:494] Provisioner recovery complete
I1115 00:12:49.460130 19417 composing.cpp:339] Finished recovering all containerizers
I1115 00:12:49.460333 19405 slave.cpp:7144] Recovering executors
I1115 00:12:49.460469 19405 slave.cpp:7297] Finished recovery
I1115 00:12:49.461182 19409 slave.cpp:1260] New master detected at master@172.17.0.2:37409
I1115 00:12:49.461210 19420 task_status_update_manager.cpp:181] Pausing sending task status updates
I1115 00:12:49.461297 19409 slave.cpp:1325] Detecting new master
I1115 00:12:49.465596 19399 slave.cpp:1352] Authenticating with master master@172.17.0.2:37409
I1115 00:12:49.465680 19399 slave.cpp:1361] Using default CRAM-MD5 authenticatee
I1115 00:12:49.465939 19414 authenticatee.cpp:121] Creating new client SASL connection
I1115 00:12:49.466214 19404 master.cpp:9716] Authenticating slave(45)@172.17.0.2:37409
I1115 00:12:49.466380 19412 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(82)@172.17.0.2:37409
I1115 00:12:49.466753 19398 authenticator.cpp:98] Creating new server SASL connection
I1115 00:12:49.466989 19406 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I1115 00:12:49.467020 19406 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I1115 00:12:49.467123 19407 authenticator.cpp:204] Received SASL authentication start
I1115 00:12:49.467185 19407 authenticator.cpp:326] Authentication requires more steps
I1115 00:12:49.467278 19407 authenticatee.cpp:259] Received SASL authentication step
I1115 00:12:49.467375 19407 authenticator.cpp:232] Received SASL authentication step
I1115 00:12:49.467403 19407 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '1fedc39b9816' server FQDN: '1fedc39b9816' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I1115 00:12:49.467418 19407 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I1115 00:12:49.467453 19407 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I1115 00:12:49.467474 19407 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '1fedc39b9816' server FQDN: '1fedc39b9816' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I1115 00:12:49.467487 19407 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I1115 00:12:49.467499 19407 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I1115 00:12:49.467514 19407 authenticator.cpp:318] Authentication success
I1115 00:12:49.467665 19397 authenticatee.cpp:299] Authentication success
I1115 00:12:49.467782 19396 master.cpp:9748] Successfully authenticated principal 'test-principal' at slave(45)@172.17.0.2:37409
I1115 00:12:49.467854 19407 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(82)@172.17.0.2:37409
I1115 00:12:49.468013 19401 slave.cpp:1452] Successfully authenticated with master master@172.17.0.2:37409
I1115 00:12:49.468408 19401 slave.cpp:1883] Will retry registration in 13.076368ms if necessary
I1115 00:12:49.468586 19415 master.cpp:6628] Received register agent message from slave(45)@172.17.0.2:37409 (1fedc39b9816)
I1115 00:12:49.468855 19415 master.cpp:3986] Authorizing agent providing resources 'cpus:2; mem:1024; disk:1024; ports:[31000-32000]' with principal 'test-principal'
I1115 00:12:49.469486 19420 master.cpp:6695] Authorized registration of agent at slave(45)@172.17.0.2:37409 (1fedc39b9816)
I1115 00:12:49.469565 19420 master.cpp:6810] Registering agent at slave(45)@172.17.0.2:37409 (1fedc39b9816) with id fbe92b6f-7bb1-469d-a424-d2925a7ec0a9-S0
I1115 00:12:49.470136 19409 registrar.cpp:487] Applied 1 operations in 196513ns; attempting to update the registry
I1115 00:12:49.470710 19409 registrar.cpp:544] Successfully updated the registry in 513792ns
I1115 00:12:49.470924 19409 master.cpp:6858] Admitted agent fbe92b6f-7bb1-469d-a424-d2925a7ec0a9-S0 at slave(45)@172.17.0.2:37409 (1fedc39b9816)
I1115 00:12:49.471518 19409 master.cpp:6903] Registered agent fbe92b6f-7bb1-469d-a424-d2925a7ec0a9-S0 at slave(45)@172.17.0.2:37409 (1fedc39b9816) with cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I1115 00:12:49.471716 19400 slave.cpp:1485] Registered with master master@172.17.0.2:37409; given agent ID fbe92b6f-7bb1-469d-a424-d2925a7ec0a9-S0
I1115 00:12:49.471781 19406 hierarchical.cpp:603] Added agent fbe92b6f-7bb1-469d-a424-d2925a7ec0a9-S0 (1fedc39b9816) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I1115 00:12:49.471814 19410 task_status_update_manager.cpp:188] Resuming sending task status updates
I1115 00:12:49.472012 19406 hierarchical.cpp:1566] Performed allocation for 1 agents in 82949ns
I1115 00:12:49.472021 19400 slave.cpp:1505] Checkpointing SlaveInfo to '/tmp/ContentType_AgentResourceProviderConfigApiTest_AddInvalid_0_alG0aE/meta/slaves/fbe92b6f-7bb1-469d-a424-d2925a7ec0a9-S0/slave.info'
I1115 00:12:49.472964 19400 slave.cpp:1554] Forwarding agent update {"operations":{},"resource_providers":{},"resource_version_uuid":{"value":"UmTdoVfuRNeh3IPpL4odmg=="},"slave_id":{"value":"fbe92b6f-7bb1-469d-a424-d2925a7ec0a9-S0"},"update_oversubscribed_resources":false}
I1115 00:12:49.473486 19400 master.cpp:7962] Ignoring update on agent fbe92b6f-7bb1-469d-a424-d2925a7ec0a9-S0 at slave(45)@172.17.0.2:37409 (1fedc39b9816) as it reports no changes
I1115 00:12:49.475210 19414 process.cpp:3588] Handling HTTP event for process 'slave(45)' with path: '/slave(45)/api/v1'
I1115 00:12:49.476276 19417 http.cpp:1182] HTTP POST for /slave(45)/api/v1 from 172.17.0.2:34896
I1115 00:12:49.477630 19397 http.cpp:3241] Processing UPDATE_RESOURCE_PROVIDER_CONFIG call with type 'org.apache.mesos.rp.local.storage' and name 'test'
I1115 00:12:49.479588 19219 slave.cpp:915] Agent terminating
I1115 00:12:49.487282 19411 hierarchical.cpp:1566] Performed allocation for 1 agents in 67681ns
I1115 00:12:49.537729 19417 hierarchical.cpp:1566] Performed allocation for 1 agents in 65657ns
I1115 00:12:49.588376 19410 hierarchical.cpp:1566] Performed allocation for 1 agents in 75805ns
I1115 00:12:49.639806 19397 hierarchical.cpp:1566] Performed allocation for 1 agents in 76757ns
I1115 00:12:49.690742 19406 hierarchical.cpp:1566] Performed allocation for 1 agents in 120818ns
I1115 00:12:49.742198 19407 hierarchical.cpp:1566] Performed allocation for 1 agents in 120152ns
I1115 00:12:49.793000 19408 hierarchical.cpp:1566] Performed allocation for 1 agents in 66438ns
I1115 00:12:49.844476 19405 hierarchical.cpp:1566] Performed allocation for 1 agents in 65294ns
I1115 00:12:49.884436 19399 master.cpp:1273] Agent fbe92b6f-7bb1-469d-a424-d2925a7ec0a9-S0 at slave(45)@172.17.0.2:37409 (1fedc39b9816) disconnected
I1115 00:12:49.884474 19399 master.cpp:3289] Disconnecting agent fbe92b6f-7bb1-469d-a424-d2925a7ec0a9-S0 at slave(45)@172.17.0.2:37409 (1fedc39b9816)
I1115 00:12:49.884531 19399 master.cpp:3308] Deactivating agent fbe92b6f-7bb1-469d-a424-d2925a7ec0a9-S0 at slave(45)@172.17.0.2:37409 (1fedc39b9816)
I1115 00:12:49.884639 19403 hierarchical.cpp:801] Agent fbe92b6f-7bb1-469d-a424-d2925a7ec0a9-S0 deactivated
I1115 00:12:49.891301 19219 master.cpp:1115] Master terminating
I1115 00:12:49.891891 19399 hierarchical.cpp:643] Removed agent fbe92b6f-7bb1-469d-a424-d2925a7ec0a9-S0
[ OK ] ContentType/AgentResourceProviderConfigApiTest.AddInvalid/0 (467 ms)
[----------] 1 test from ContentType/AgentResourceProviderConfigApiTest (468 ms total)
[----------] Global test environment tear-down
[==========] 85 tests from 66 test cases ran. (122312 ms total)
[ PASSED ] 84 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] ExamplesTest.DynamicReservationFramework
1 FAILED TEST
YOU HAVE 24 DISABLED TESTS
I1115 00:12:49.960052 19423 process.cpp:927] Stopped the socket accept loop
[FAIL]: 2 shard(s) have failed tests
make[4]: *** [check-local] Error 2
make[4]: Leaving directory `/mesos/mesos-1.8.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.8.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.8.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.8.0/_build'
make: *** [distcheck] Error 1
+ docker rmi --force mesos-1542236627-950
Untagged: mesos-1542236627-950:latest
Deleted: sha256:69742740275e85236d3e1657176c8fadedb96da88b55cd4f72881d0cd6612bb7
Deleted: sha256:67ef4c9c5bca050de2afa51b976bd0176321c51e8d8e0eb36a99226fdf0b46a8
Deleted: sha256:e9e0627f2d7a8a40de9a3fef46e40ccac065877608c1a7006aa3e18c17fd362c
Deleted: sha256:a85ef0437431ef95ed8a5b47eb2d05ea37f3269cf96010db872d32418b10aac5
Deleted: sha256:272fc37e9953785b36d848551ef0ff5aa19e1cdd7b2e5b0501530d7fe0cf5e0b
Deleted: sha256:04657c386b68dfc52231d012e9c166c6c68ce865d893235cda2521d7338fe281
Deleted: sha256:f00e9cda53dbbf7bf81a403393822bd421c9b92f42fdffb7950d6c6a6b2b70b2
Deleted: sha256:00dd392df0b187d757ac9ac5d9963ec4477b0795aa678f7073e629d72d58e583
Deleted: sha256:22a0030512ad25c8716d540ea565667958400257f3f55e6651a91db784b602f5
Deleted: sha256:5d5becdc775ba0b14bc28bb1e6a5afce92e4835a231b7d88d6e5e7c76f569a4d
Deleted: sha256:cebb4802466537cebb16e58f46f8efbdc3a7d4176e5703f48387e545c6052dba
Deleted: sha256:4436f47e329b61ff44d52cdfb8d4cd596b9181b3a0c89816aa2951c90eb2e38c
Deleted: sha256:36538b3b7bc6c8b899dea018e32a40778bde5d1b8237e67c52edc37fa946b651
Deleted: sha256:26b85a760bc32693514ae0a54ab1e77842ad6a1bdf722c30ffe0014dd5cfc0d9
Deleted: sha256:dd091b17aa88954a388037b2db291dc11ec13f1e0423bf8a3b4e2a95bfd470c3
Deleted: sha256:70b08afae4ec0114cbef72fa35d27ef3bd3638280c8d40226bb744b11ddc56d4
Deleted: sha256:cafdb0f5e0eea19489cb44398110eb0a54184b3a96e6847cbfa19cd8436e03f5
Deleted: sha256:e8b4c8a3f9f8dfbed4305939d06fd7b809aa3204f011a244f0cc48a5d1a2cdc9
Deleted: sha256:24bc895a1ff17c612a1788e1362997a66b1f4bce062c3616c78b6ad7595c1a6c
Deleted: sha256:089cad9b520e47277f2e660fb02af1d9c614974bcd0c61d6fbf5cb9442a726a7
Deleted: sha256:07065d80b0562fefd7aacd2b4eb50f4c9f38e99c7ed9a6b9053c573a05168b22
Deleted: sha256:0be917ae9d8e6e07596a7943c4eca8424ad8f1bd4f6099d45dbd7a4ce47324a4
Deleted: sha256:dc5afa788d65d4e98e0184fdde84e8a4d48f4d7dabc122fee7b99499d077b971
Deleted: sha256:3abacd5fa2781785bebba924011f80d204c83aa3fb9e97529132dce1b25bb095
Deleted: sha256:355a5efe63e3d45c70abdab6f699618ff8cb80e0319ed51ad2a99a6c4a706ec3
Deleted: sha256:c593384c68d0591264e863b3109409d13c151348a1d7f3a34a01353f0522047e
Deleted: sha256:a9adf0b226609dc2b3f566e91be873804488b688dce6d550f235687f1213d76a
Deleted: sha256:56aacd9146db4cba35766cf9d92a2795236f1d104edd69e1f9667958863ac534
Deleted: sha256:0a420c716d76908a4952e5f7c0ea77a57dc61e66b2d02dcf800c947db9b9510a
Deleted: sha256:a12dbc6a614ea9eaecd5162167384c3679595797ebc48e351605096d91c286c2
11-14-18_23:03:40 - Running <https://builds.apache.org/job/Mesos-Reviewbot/ws/support/verify-reviews.py>
Checking if review 67844 needs verification
Skipping blocking review 67844
Checking if review 68016 needs verification
Skipping blocking review 68016
Checking if review 68017 needs verification
Skipping blocking review 68017
Checking if review 68018 needs verification
Skipping blocking review 68018
Checking if review 68019 needs verification
Skipping blocking review 68019
Checking if review 68020 needs verification
Skipping blocking review 68020
Checking if review 68021 needs verification
Skipping blocking review 68021
Checking if review 69338 needs verification
Patch never verified, needs verification
Dependent review: https://reviews.apache.org/api/review-requests/69337/
Verifying review 69338
Dependent review: https://reviews.apache.org/api/review-requests/69337/
Applying review 69337
/usr/bin/python3 support/apply-reviews.py -n -r 69337
Applying review 69338
/usr/bin/python3 support/apply-reviews.py -n -r 69338
Traceback (most recent call last):
File "<https://builds.apache.org/job/Mesos-Reviewbot/ws/support/verify-reviews.py",> line 186, in verify_review
% (command, build_output)])
File "/usr/lib/python3.5/subprocess.py", line 581, in check_call
raise CalledProcessError(retcode, cmd)
subprocess.CalledProcessError: Command '['bash', '-c', "set -o pipefail; export OS='ubuntu:14.04' BUILDTOOL='autotools' COMPILER='gcc' CONFIGURATION='--verbose --disable-libtool-wrappers' ENVIRONMENT='GLOG_v=1 MESOS_VERBOSE=1'; ./support/docker-build.sh 2>&1 | tee build_69338"]' returned non-zero exit status 2
During handling of the above exception, another exception occurred:
Traceback (most recent call last):
File "<https://builds.apache.org/job/Mesos-Reviewbot/ws/support/verify-reviews.py",> line 294, in <module>
main()
File "<https://builds.apache.org/job/Mesos-Reviewbot/ws/support/verify-reviews.py",> line 288, in main
verify_review(review_request, handler)
File "<https://builds.apache.org/job/Mesos-Reviewbot/ws/support/verify-reviews.py",> line 201, in verify_review
output = open(build_output).read().decode(sys.stdout.encoding)
AttributeError: 'str' object has no attribute 'decode'
Build step 'Execute shell' marked build as failure
Build failed in Jenkins: Mesos-Reviewbot #23554
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Reviewbot/23554/display/redirect?page=changes>
Changes:
[josephwu] Added validation of cache files to the URI Fetcher.
[josephwu] Added `FetcherCacheTest.LocalCachedMissing` test.
------------------------------------------
[...truncated 44.10 MB...]
I1114 22:09:43.594451 19286 slave.cpp:1452] Successfully authenticated with master master@172.17.0.2:34836
I1114 22:09:43.594768 19286 slave.cpp:1883] Will retry registration in 10.193338ms if necessary
I1114 22:09:43.595896 19315 master.cpp:9946] Adding framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 (default) with roles { } suppressed
I1114 22:09:43.596544 19333 hierarchical.cpp:304] Added framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000
I1114 22:09:43.596698 19315 master.cpp:9748] Successfully authenticated principal 'test-principal' at slave(43)@172.17.0.2:34836
I1114 22:09:43.596855 19333 hierarchical.cpp:1566] Performed allocation for 0 agents in 99291ns
I1114 22:09:43.596961 19315 master.cpp:6628] Received register agent message from slave(43)@172.17.0.2:34836 (69059e169117)
I1114 22:09:43.597234 19315 master.cpp:3986] Authorizing agent providing resources 'cpus:2; mem:1024; disk:1024; ports:[31000-32000]' with principal 'test-principal'
I1114 22:09:43.597491 19339 scheduler.cpp:845] Enqueuing event SUBSCRIBED received from http://172.17.0.2:34836/master/api/v1/scheduler
I1114 22:09:43.597865 19297 master.cpp:6695] Authorized registration of agent at slave(43)@172.17.0.2:34836 (69059e169117)
I1114 22:09:43.597944 19297 master.cpp:6810] Registering agent at slave(43)@172.17.0.2:34836 (69059e169117) with id 677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0
I1114 22:09:43.598173 19297 scheduler.cpp:845] Enqueuing event HEARTBEAT received from http://172.17.0.2:34836/master/api/v1/scheduler
I1114 22:09:43.598596 19244 registrar.cpp:487] Applied 1 operations in 224889ns; attempting to update the registry
I1114 22:09:43.599261 19280 registrar.cpp:544] Successfully updated the registry in 590848ns
I1114 22:09:43.599447 19357 master.cpp:6858] Admitted agent 677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0 at slave(43)@172.17.0.2:34836 (69059e169117)
I1114 22:09:43.600116 19357 master.cpp:6903] Registered agent 677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0 at slave(43)@172.17.0.2:34836 (69059e169117) with cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I1114 22:09:43.600144 19327 slave.cpp:1485] Registered with master master@172.17.0.2:34836; given agent ID 677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0
I1114 22:09:43.600278 19250 task_status_update_manager.cpp:188] Resuming sending task status updates
I1114 22:09:43.600486 19327 slave.cpp:1505] Checkpointing SlaveInfo to '/tmp/ContentType_SchedulerTest_ShutdownExecutor_1_xH1gKS/meta/slaves/677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0/slave.info'
I1114 22:09:43.600513 19292 hierarchical.cpp:603] Added agent 677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0 (69059e169117) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I1114 22:09:43.601372 19327 slave.cpp:1554] Forwarding agent update {"operations":{},"resource_providers":{},"resource_version_uuid":{"value":"6RtV+mLHQ8yf1Sh1imvSKg=="},"slave_id":{"value":"677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0"},"update_oversubscribed_resources":false}
I1114 22:09:43.601878 19286 master.cpp:7962] Ignoring update on agent 677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0 at slave(43)@172.17.0.2:34836 (69059e169117) as it reports no changes
I1114 22:09:43.601894 19292 hierarchical.cpp:1566] Performed allocation for 1 agents in 1.200399ms
I1114 22:09:43.602355 19286 master.cpp:9531] Sending offers [ 677fdc61-af04-44a3-8c36-bbc9d6d7f058-O0 ] to framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 (default)
I1114 22:09:43.604347 19303 scheduler.cpp:845] Enqueuing event OFFERS received from http://172.17.0.2:34836/master/api/v1/scheduler
I1114 22:09:43.606617 19339 scheduler.cpp:248] Sending ACCEPT call to http://172.17.0.2:34836/master/api/v1/scheduler
I1114 22:09:43.608229 19216 process.cpp:3588] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1114 22:09:43.609783 19224 http.cpp:1182] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:51410
I1114 22:09:43.611459 19224 master.cpp:11525] Removing offer 677fdc61-af04-44a3-8c36-bbc9d6d7f058-O0
I1114 22:09:43.611994 19224 master.cpp:4489] Processing ACCEPT call for offers: [ 677fdc61-af04-44a3-8c36-bbc9d6d7f058-O0 ] on agent 677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0 at slave(43)@172.17.0.2:34836 (69059e169117) for framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 (default)
I1114 22:09:43.612109 19224 master.cpp:3563] Authorizing framework principal 'test-principal' to launch task 26027660-f8a6-46d6-a48f-2d58c0c341f5
W1114 22:09:43.614296 19224 validation.cpp:1452] Executor 'default' for task '26027660-f8a6-46d6-a48f-2d58c0c341f5' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W1114 22:09:43.614336 19224 validation.cpp:1464] Executor 'default' for task '26027660-f8a6-46d6-a48f-2d58c0c341f5' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I1114 22:09:43.614977 19224 master.cpp:12272] Adding task 26027660-f8a6-46d6-a48f-2d58c0c341f5 with resources cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] on agent 677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0 at slave(43)@172.17.0.2:34836 (69059e169117)
I1114 22:09:43.615523 19224 master.cpp:5461] Launching task 26027660-f8a6-46d6-a48f-2d58c0c341f5 of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 (default) with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] on agent 677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0 at slave(43)@172.17.0.2:34836 (69059e169117) on new executor
I1114 22:09:43.616911 19268 slave.cpp:2020] Got assigned task '26027660-f8a6-46d6-a48f-2d58c0c341f5' for framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000
I1114 22:09:43.618608 19268 slave.cpp:2394] Authorizing task '26027660-f8a6-46d6-a48f-2d58c0c341f5' for framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000
I1114 22:09:43.618693 19268 slave.cpp:8474] Authorizing framework principal 'test-principal' to launch task 26027660-f8a6-46d6-a48f-2d58c0c341f5
I1114 22:09:43.620765 19250 slave.cpp:2837] Launching task '26027660-f8a6-46d6-a48f-2d58c0c341f5' for framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000
I1114 22:09:43.620843 19250 paths.cpp:752] Creating sandbox '/tmp/ContentType_SchedulerTest_ShutdownExecutor_1_xH1gKS/slaves/677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0/frameworks/677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000/executors/default/runs/1b151080-5a0a-4b06-84d2-4398f7e597c6' for user 'mesos'
I1114 22:09:43.621510 19250 slave.cpp:9002] Launching executor 'default' of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 with resources [] in work directory '/tmp/ContentType_SchedulerTest_ShutdownExecutor_1_xH1gKS/slaves/677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0/frameworks/677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000/executors/default/runs/1b151080-5a0a-4b06-84d2-4398f7e597c6'
I1114 22:09:43.622010 19250 slave.cpp:3515] Launching container 1b151080-5a0a-4b06-84d2-4398f7e597c6 for executor 'default' of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000
I1114 22:09:43.622490 19250 slave.cpp:3034] Queued task '26027660-f8a6-46d6-a48f-2d58c0c341f5' for executor 'default' of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000
I1114 22:09:43.622576 19250 slave.cpp:994] Successfully attached '/tmp/ContentType_SchedulerTest_ShutdownExecutor_1_xH1gKS/slaves/677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0/frameworks/677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000/executors/default/runs/1b151080-5a0a-4b06-84d2-4398f7e597c6' to virtual path '/tmp/ContentType_SchedulerTest_ShutdownExecutor_1_xH1gKS/slaves/677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0/frameworks/677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000/executors/default/runs/latest'
I1114 22:09:43.622619 19250 slave.cpp:994] Successfully attached '/tmp/ContentType_SchedulerTest_ShutdownExecutor_1_xH1gKS/slaves/677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0/frameworks/677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000/executors/default/runs/1b151080-5a0a-4b06-84d2-4398f7e597c6' to virtual path '/frameworks/677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000/executors/default/runs/latest'
I1114 22:09:43.622655 19250 slave.cpp:994] Successfully attached '/tmp/ContentType_SchedulerTest_ShutdownExecutor_1_xH1gKS/slaves/677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0/frameworks/677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000/executors/default/runs/1b151080-5a0a-4b06-84d2-4398f7e597c6' to virtual path '/tmp/ContentType_SchedulerTest_ShutdownExecutor_1_xH1gKS/slaves/677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0/frameworks/677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000/executors/default/runs/1b151080-5a0a-4b06-84d2-4398f7e597c6'
I1114 22:09:43.623533 19216 executor.cpp:201] Version: 1.8.0
W1114 22:09:43.623596 19216 process.cpp:2829] Attempted to spawn already running process version@172.17.0.2:34836
I1114 22:09:43.626214 19333 executor.cpp:426] Connected with the agent
I1114 22:09:43.626853 19357 executor.cpp:323] Sending SUBSCRIBE call to http://172.17.0.2:34836/slave(43)/api/v1/executor
I1114 22:09:43.627696 19256 process.cpp:3588] Handling HTTP event for process 'slave(43)' with path: '/slave(43)/api/v1/executor'
I1114 22:09:43.629103 19321 http.cpp:1182] HTTP POST for /slave(43)/api/v1/executor from 172.17.0.2:51414
I1114 22:09:43.629294 19321 slave.cpp:4613] Received Subscribe request for HTTP executor 'default' of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000
I1114 22:09:43.630946 19303 slave.cpp:3247] Sending queued task '26027660-f8a6-46d6-a48f-2d58c0c341f5' to executor 'default' of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 (via HTTP)
I1114 22:09:43.632360 19309 executor.cpp:741] Enqueuing event SUBSCRIBED received from http://172.17.0.2:34836/slave(43)/api/v1/executor
I1114 22:09:43.633123 19309 executor.cpp:741] Enqueuing event LAUNCH received from http://172.17.0.2:34836/slave(43)/api/v1/executor
I1114 22:09:43.633951 19250 executor.cpp:323] Sending UPDATE call to http://172.17.0.2:34836/slave(43)/api/v1/executor
I1114 22:09:43.634860 19244 process.cpp:3588] Handling HTTP event for process 'slave(43)' with path: '/slave(43)/api/v1/executor'
I1114 22:09:43.636368 19303 http.cpp:1182] HTTP POST for /slave(43)/api/v1/executor from 172.17.0.2:51416
I1114 22:09:43.636507 19303 slave.cpp:5275] Handling status update TASK_FINISHED (Status UUID: cab82e8d-57cc-4103-a431-5b537649c954) for task 26027660-f8a6-46d6-a48f-2d58c0c341f5 of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000
I1114 22:09:43.637737 19256 task_status_update_manager.cpp:328] Received task status update TASK_FINISHED (Status UUID: cab82e8d-57cc-4103-a431-5b537649c954) for task 26027660-f8a6-46d6-a48f-2d58c0c341f5 of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000
I1114 22:09:43.637794 19256 task_status_update_manager.cpp:507] Creating StatusUpdate stream for task 26027660-f8a6-46d6-a48f-2d58c0c341f5 of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000
I1114 22:09:43.638545 19256 task_status_update_manager.cpp:383] Forwarding task status update TASK_FINISHED (Status UUID: cab82e8d-57cc-4103-a431-5b537649c954) for task 26027660-f8a6-46d6-a48f-2d58c0c341f5 of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 to the agent
I1114 22:09:43.638761 19232 slave.cpp:5767] Forwarding the update TASK_FINISHED (Status UUID: cab82e8d-57cc-4103-a431-5b537649c954) for task 26027660-f8a6-46d6-a48f-2d58c0c341f5 of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 to master@172.17.0.2:34836
I1114 22:09:43.639003 19232 slave.cpp:5660] Task status update manager successfully handled status update TASK_FINISHED (Status UUID: cab82e8d-57cc-4103-a431-5b537649c954) for task 26027660-f8a6-46d6-a48f-2d58c0c341f5 of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000
I1114 22:09:43.639279 19216 master.cpp:8437] Status update TASK_FINISHED (Status UUID: cab82e8d-57cc-4103-a431-5b537649c954) for task 26027660-f8a6-46d6-a48f-2d58c0c341f5 of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 from agent 677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0 at slave(43)@172.17.0.2:34836 (69059e169117)
I1114 22:09:43.639348 19216 master.cpp:8494] Forwarding status update TASK_FINISHED (Status UUID: cab82e8d-57cc-4103-a431-5b537649c954) for task 26027660-f8a6-46d6-a48f-2d58c0c341f5 of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000
I1114 22:09:43.639942 19216 master.cpp:10995] Updating the state of task 26027660-f8a6-46d6-a48f-2d58c0c341f5 of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 (latest state: TASK_FINISHED, status update state: TASK_FINISHED)
I1114 22:09:43.640558 19292 executor.cpp:741] Enqueuing event ACKNOWLEDGED received from http://172.17.0.2:34836/slave(43)/api/v1/executor
I1114 22:09:43.641247 19280 scheduler.cpp:845] Enqueuing event UPDATE received from http://172.17.0.2:34836/master/api/v1/scheduler
I1114 22:09:43.641273 19286 hierarchical.cpp:1238] Recovered cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: {}) on agent 677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0 from framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000
I1114 22:09:43.642413 19216 scheduler.cpp:248] Sending SHUTDOWN call to http://172.17.0.2:34836/master/api/v1/scheduler
I1114 22:09:43.643687 19224 process.cpp:3588] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1114 22:09:43.682978 19339 http.cpp:1182] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:51410
I1114 22:09:43.683451 19339 master.cpp:8732] Processing SHUTDOWN call for executor 'default' of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 (default) on agent 677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0
I1114 22:09:43.684002 19339 slave.cpp:6578] Asked to shut down executor 'default' of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 by master@172.17.0.2:34836
I1114 22:09:43.684072 19339 slave.cpp:6646] Shutting down executor 'default' of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 (via HTTP)
I1114 22:09:43.685212 19321 executor.cpp:741] Enqueuing event SHUTDOWN received from http://172.17.0.2:34836/slave(43)/api/v1/executor
I1114 22:09:43.686719 19333 slave.cpp:6295] Executor 'default' of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 exited with status 0
I1114 22:09:43.687211 19244 master.cpp:8680] Executor 'default' of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 on agent 677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0 at slave(43)@172.17.0.2:34836 (69059e169117): exited with status 0
I1114 22:09:43.687285 19244 master.cpp:11124] Removing executor 'default' with resources [] of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 on agent 677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0 at slave(43)@172.17.0.2:34836 (69059e169117)
I1114 22:09:43.688776 19292 scheduler.cpp:845] Enqueuing event FAILURE received from http://172.17.0.2:34836/master/api/v1/scheduler
I1114 22:09:43.691171 19262 master.cpp:1388] Framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 (default) disconnected
I1114 22:09:43.691200 19262 master.cpp:3252] Deactivating framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 (default)
I1114 22:09:43.691277 19262 master.cpp:3229] Disconnecting framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 (default)
I1114 22:09:43.691309 19262 master.cpp:1403] Giving framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 (default) 0ns to failover
I1114 22:09:43.691342 19274 hierarchical.cpp:418] Deactivated framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000
I1114 22:09:43.692731 19297 master.cpp:9323] Framework failover timeout, removing framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 (default)
I1114 22:09:43.692764 19297 master.cpp:10260] Removing framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 (default)
I1114 22:09:43.692914 19292 slave.cpp:3902] Asked to shut down framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 by master@172.17.0.2:34836
I1114 22:09:43.692955 19292 slave.cpp:3927] Shutting down framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000
I1114 22:09:43.692950 19297 master.cpp:10995] Updating the state of task 26027660-f8a6-46d6-a48f-2d58c0c341f5 of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 (latest state: TASK_FINISHED, status update state: TASK_KILLED)
I1114 22:09:43.693014 19292 slave.cpp:6393] Cleaning up executor 'default' of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 (via HTTP)
I1114 22:09:43.693114 19297 master.cpp:11093] Removing task 26027660-f8a6-46d6-a48f-2d58c0c341f5 with resources cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000 on agent 677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0 at slave(43)@172.17.0.2:34836 (69059e169117)
I1114 22:09:43.693687 19297 gc.cpp:95] Scheduling '/tmp/ContentType_SchedulerTest_ShutdownExecutor_1_xH1gKS/slaves/677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0/frameworks/677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000/executors/default/runs/1b151080-5a0a-4b06-84d2-4398f7e597c6' for gc 6.99999200970963days in the future
I1114 22:09:43.693892 19297 gc.cpp:95] Scheduling '/tmp/ContentType_SchedulerTest_ShutdownExecutor_1_xH1gKS/slaves/677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0/frameworks/677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000/executors/default' for gc 6.99999200970963days in the future
I1114 22:09:43.694164 19309 hierarchical.cpp:357] Removed framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000
I1114 22:09:43.694279 19292 slave.cpp:6522] Cleaning up framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000
I1114 22:09:43.694397 19280 task_status_update_manager.cpp:289] Closing task status update streams for framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000
I1114 22:09:43.694453 19280 task_status_update_manager.cpp:538] Cleaning up status update stream for task 26027660-f8a6-46d6-a48f-2d58c0c341f5 of framework 677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000
I1114 22:09:43.694516 19292 gc.cpp:95] Scheduling '/tmp/ContentType_SchedulerTest_ShutdownExecutor_1_xH1gKS/slaves/677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0/frameworks/677fdc61-af04-44a3-8c36-bbc9d6d7f058-0000' for gc 6.99999200970963days in the future
I1114 22:09:44.558197 19202 slave.cpp:915] Agent terminating
I1114 22:09:44.559170 19232 master.cpp:1273] Agent 677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0 at slave(43)@172.17.0.2:34836 (69059e169117) disconnected
I1114 22:09:44.559211 19232 master.cpp:3289] Disconnecting agent 677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0 at slave(43)@172.17.0.2:34836 (69059e169117)
I1114 22:09:44.559295 19232 master.cpp:3308] Deactivating agent 677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0 at slave(43)@172.17.0.2:34836 (69059e169117)
I1114 22:09:44.559509 19345 hierarchical.cpp:801] Agent 677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0 deactivated
I1114 22:09:44.566838 19315 hierarchical.cpp:1566] Performed allocation for 1 agents in 107874ns
I1114 22:09:44.571458 19286 master.cpp:1115] Master terminating
I1114 22:09:44.572343 19333 hierarchical.cpp:643] Removed agent 677fdc61-af04-44a3-8c36-bbc9d6d7f058-S0
[ OK ] ContentType/SchedulerTest.ShutdownExecutor/1 (1019 ms)
[----------] 1 test from ContentType/SchedulerTest (1021 ms total)
[----------] 1 test from Endpoint/SlaveEndpointTest
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I1114 22:09:44.584772 19202 containerizer.cpp:305] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W1114 22:09:44.585273 19202 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W1114 22:09:44.585394 19202 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I1114 22:09:44.585429 19202 provisioner.cpp:298] Using default backend 'copy'
I1114 22:09:44.587343 19202 cluster.cpp:485] Creating default 'local' authorizer
I1114 22:09:44.589116 19351 slave.cpp:267] Mesos agent started on (44)@172.17.0.2:34836
I1114 22:09:44.589149 19351 slave.cpp:268] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_CPqVOM/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="false" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authentication_timeout_max="1mins" --authentication_timeout_min="5secs" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_CPqVOM/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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_CPqVOM/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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_CPqVOM/fetch" --fetcher_cache_size="2GB" --fetcher_stall_timeout="1mins" --frameworks_home="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_CPqVOM/frameworks" --gc_delay="1weeks" --gc_disk_headroom="0.1" --gc_non_executor_container_sandboxes="false" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_CPqVOM/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.8.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --memory_profiling="false" --network_cni_metrics="true" --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" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_CPqVOM" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_FhXo0W" --zk_session_timeout="10secs"
I1114 22:09:44.589830 19351 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_CPqVOM/credential'
I1114 22:09:44.590077 19351 slave.cpp:300] Agent using credential for: test-principal
I1114 22:09:44.590107 19351 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_CPqVOM/http_credentials'
I1114 22:09:44.590401 19351 http.cpp:1042] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1114 22:09:44.590742 19351 disk_profile_adaptor.cpp:80] Creating default disk profile adaptor module
I1114 22:09:44.592074 19351 slave.cpp:615] 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"}]
I1114 22:09:44.592396 19351 slave.cpp:623] Agent attributes: [ ]
I1114 22:09:44.592417 19351 slave.cpp:632] Agent hostname: 69059e169117
I1114 22:09:44.592604 19315 task_status_update_manager.cpp:181] Pausing sending task status updates
I1114 22:09:44.594130 19238 state.cpp:66] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_FhXo0W/meta'
I1114 22:09:44.594317 19250 slave.cpp:6915] Finished recovering checkpointed state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_FhXo0W/meta', beginning agent recovery
I1114 22:09:44.594441 19238 task_status_update_manager.cpp:207] Recovering task status update manager
I1114 22:09:44.594717 19339 containerizer.cpp:727] Recovering Mesos containers
I1114 22:09:44.595026 19339 containerizer.cpp:1053] Recovering isolators
I1114 22:09:44.595568 19280 containerizer.cpp:1092] Recovering provisioner
I1114 22:09:44.596216 19345 provisioner.cpp:494] Provisioner recovery complete
I1114 22:09:44.596890 19238 composing.cpp:339] Finished recovering all containerizers
I1114 22:09:44.597055 19327 slave.cpp:7144] Recovering executors
I1114 22:09:44.597216 19327 slave.cpp:7297] Finished recovery
I1114 22:09:44.600417 19232 process.cpp:3588] Handling HTTP event for process 'slave(44)' with path: '/slave(44)/containers'
I1114 22:09:44.602010 19351 http.cpp:1182] HTTP GET for /slave(44)/containers from 172.17.0.2:51454
I1114 22:09:44.602090 19351 http.cpp:1019] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I1114 22:09:44.604225 19297 http.cpp:1199] HTTP GET for /slave(44)/containers from 172.17.0.2:51454: '200 OK' after 4.13005ms
I1114 22:09:44.605762 19345 slave.cpp:915] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (34 ms)
[----------] 1 test from Endpoint/SlaveEndpointTest (42 ms total)
[----------] Global test environment tear-down
[==========] 85 tests from 67 test cases ran. (112433 ms total)
[ PASSED ] 84 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] SlaveRecoveryTest/0.PingTimeoutDuringRecovery, where TypeParam = mesos::internal::slave::MesosContainerizer
1 FAILED TEST
YOU HAVE 24 DISABLED TESTS
I1114 22:09:44.707422 19361 process.cpp:927] Stopped the socket accept loop
[FAIL]: 1 shard(s) have failed tests
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.8.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.8.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.8.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.8.0/_build'
make: *** [distcheck] Error 1
+ docker rmi --force mesos-1542229247-16421
Untagged: mesos-1542229247-16421:latest
Deleted: sha256:d968b7ad25552bd3d1d97f9dd3e62962d13e1bb0ac052f3c457645dc056a57f9
Deleted: sha256:4d81ea897b747e9b1c1512b8efa2c53b59da5e34d1882e8b3fe5b038bf1cceed
Deleted: sha256:f95d786d79700e1b1bf799b7f8d2440a846eac6ce8b6c7d8978f6b35cd2c0c28
Deleted: sha256:18cc78cdee91b80507d0b8f3114d77065ddb168ca96a88d986913758f6e78af3
Deleted: sha256:96fdb068ad7657d1bf09fa6b9b4c029da0a2c478da3ffbaae94e046d6db2165e
Deleted: sha256:22addf5942e5dca281e8b865a6b03b563eee82095e1e8b1f0bd18d37d761cb42
Deleted: sha256:32d376a524eadad91b2e4e1695aaf64e3039548dd8bf41b0869fad100305ced9
Deleted: sha256:fee9243ba66a0eab7b01017b740aaf88b979203c800fad61aa3395cc026b53fa
Deleted: sha256:7490a4b035855a854ccc1a91ded35f7a63f613edc42984d64cbcd8905a7e4e5b
Deleted: sha256:60c9e1223ce13acd0824a88222f1e340960f404e51dba62b73a0c7beb866a36a
Deleted: sha256:23285b6938ff4a5656a32464516cfe751f08baf3bba38d2108334daf3e881afa
Deleted: sha256:87e8aa99c2f7343fbb333e61752c8b7b9d31101f3d14f8ffa54ec75c5c5a2d84
Deleted: sha256:19be374edbc5dd74ccc379f7e6e3f3d792e3132fb45360ad59c3bbf267184fc4
Deleted: sha256:e98a0a5c3ac218806fa89c16dbfb98c175270b09ea7b1fb67ffd7b7648dd1182
Deleted: sha256:fe311341354acbd2bbf2d476a959131b6b8ebe7b98c774354a17fe99b84616d9
Deleted: sha256:7f168c0787fed657c3c2d14b074c3e8b72448a317de402c27572b59ec69a6a38
Deleted: sha256:5b81481a7bdc89491d060fb4daed3ceb7cb68c5735a72ad24123335df2425bbc
Deleted: sha256:a48d82a3d662474129f5e32a14ae78309aa9bbcdbae8c7815c82bb2158ee5887
Deleted: sha256:c3e93895fced09ee91f84bef0e28c77432120deead1bd3aa4d29d2bb9b00626c
Deleted: sha256:58454fcc06334c5fcff67a265a267bdec18d4cb4d3181404036e10f7de9d4c85
Deleted: sha256:c6c8e22286ab913148109e7f8ff428065fbdc589b33cf93dc7aefab271336d85
Deleted: sha256:53972ac5b181d44b8dccf047e8cc0288d0532d4a7e922993eb514f065d3e07d4
Deleted: sha256:7431a29c984a53c6e8a1f806c1bd8eb61416f8de9c14b8c7a10f5209bb5341bb
Deleted: sha256:5d081061166a8979591a2641577b02b889cd572df7d48ad669dd275efea09bc8
Deleted: sha256:c3477b6b47695ec244541879ca3103372eaedcd8ff45812b3bc45bb4c5dfe48d
Deleted: sha256:54d523e5c5b61577f37f6ec441c3064a2261b34003e147f3f938dbd03a0d421a
Deleted: sha256:fd8c23a60c35f8cb328b52c99c786877f9ce1d1845d6c29086c76e1b332c86f8
Deleted: sha256:c287d3b20bb169e02db83a4f1bd67bffff10756fec6e156f03cb11ddae90f592
Deleted: sha256:443027dd2fe1c40b947cd828a03f3a6974c82b9523f1150d60ec35229091ae94
Deleted: sha256:a28645530ce559f940d380f7b5df91b385f8c29a633e8f9626bc9e350994418f
11-14-18_21:00:44 - Running <https://builds.apache.org/job/Mesos-Reviewbot/ws/support/verify-reviews.py>
Checking if review 69157 needs verification
Skipping blocking review 69157
Checking if review 69337 needs verification
Skipping blocking review 69337
Checking if review 67844 needs verification
Skipping blocking review 67844
Checking if review 68016 needs verification
Skipping blocking review 68016
Checking if review 68017 needs verification
Skipping blocking review 68017
Checking if review 68018 needs verification
Skipping blocking review 68018
Checking if review 68019 needs verification
Skipping blocking review 68019
Checking if review 68020 needs verification
Skipping blocking review 68020
Checking if review 68021 needs verification
Skipping blocking review 68021
Checking if review 69338 needs verification
Patch never verified, needs verification
Dependent review: https://reviews.apache.org/api/review-requests/69337/
Verifying review 69338
Dependent review: https://reviews.apache.org/api/review-requests/69337/
Applying review 69337
/usr/bin/python3 support/apply-reviews.py -n -r 69337
Applying review 69338
/usr/bin/python3 support/apply-reviews.py -n -r 69338
Traceback (most recent call last):
File "<https://builds.apache.org/job/Mesos-Reviewbot/ws/support/verify-reviews.py",> line 186, in verify_review
% (command, build_output)])
File "/usr/lib/python3.5/subprocess.py", line 581, in check_call
raise CalledProcessError(retcode, cmd)
subprocess.CalledProcessError: Command '['bash', '-c', "set -o pipefail; export OS='ubuntu:14.04' BUILDTOOL='autotools' COMPILER='gcc' CONFIGURATION='--verbose --disable-libtool-wrappers' ENVIRONMENT='GLOG_v=1 MESOS_VERBOSE=1'; ./support/docker-build.sh 2>&1 | tee build_69338"]' returned non-zero exit status 2
During handling of the above exception, another exception occurred:
Traceback (most recent call last):
File "<https://builds.apache.org/job/Mesos-Reviewbot/ws/support/verify-reviews.py",> line 294, in <module>
main()
File "<https://builds.apache.org/job/Mesos-Reviewbot/ws/support/verify-reviews.py",> line 288, in main
verify_review(review_request, handler)
File "<https://builds.apache.org/job/Mesos-Reviewbot/ws/support/verify-reviews.py",> line 201, in verify_review
output = open(build_output).read().decode(sys.stdout.encoding)
AttributeError: 'str' object has no attribute 'decode'
Build step 'Execute shell' marked build as failure