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 2019/01/29 01:52:13 UTC
Build failed in Jenkins: Mesos-Reviewbot #23674
See <https://builds.apache.org/job/Mesos-Reviewbot/23674/display/redirect?page=changes>
Changes:
[songzihao1990] Fixed target versions on release.yml.
[vinodkone] Updated text in website downloads page.
[vinodkone] Minor typo fix in downloads page.
------------------------------------------
[...truncated 48.73 MB...]
I0129 01:37:52.619637 19679 replica.cpp:695] Replica received learned notice for position 3 from log-network(6)@172.17.0.2:40934
I0129 01:37:52.650606 19666 slave.cpp:1894] Will retry registration in 292.755457ms if necessary
I0129 01:37:52.650882 19686 master.cpp:6702] Ignoring register agent message from slave(39)@172.17.0.2:40934 (0c2f4d21d53a) as registration is already in progress
I0129 01:37:52.812378 19679 leveldb.cpp:347] Persisting action (441 bytes) to leveldb took 192.691321ms
I0129 01:37:52.812446 19679 replica.cpp:712] Persisted action APPEND at position 3
I0129 01:37:52.813597 19627 registrar.cpp:544] Successfully updated the registry in 332.602112ms
I0129 01:37:52.813786 19646 master.cpp:6939] Admitted agent 4dffa5dd-3ba7-4174-b1da-31dffa152894-S0 at slave(39)@172.17.0.2:40934 (0c2f4d21d53a)
I0129 01:37:52.813846 19627 log.cpp:597] Attempting to truncate the log to 3
I0129 01:37:52.813993 19696 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 4
I0129 01:37:52.814761 19646 master.cpp:6984] Registered agent 4dffa5dd-3ba7-4174-b1da-31dffa152894-S0 at slave(39)@172.17.0.2:40934 (0c2f4d21d53a) with cpus(reservations: [(STATIC,foo)]):1; cpus:2; mem(reservations: [(STATIC,foo)]):1024; mem:1024; disk(reservations: [(STATIC,foo)]):1024; disk:1024; ports:[31000-32000]
I0129 01:37:52.814903 19676 slave.cpp:1494] Registered with master master@172.17.0.2:40934; given agent ID 4dffa5dd-3ba7-4174-b1da-31dffa152894-S0
I0129 01:37:52.815037 19666 task_status_update_manager.cpp:188] Resuming sending task status updates
I0129 01:37:52.815141 19638 hierarchical.cpp:604] Added agent 4dffa5dd-3ba7-4174-b1da-31dffa152894-S0 (0c2f4d21d53a) with cpus(reservations: [(STATIC,foo)]):1; cpus:2; mem(reservations: [(STATIC,foo)]):1024; mem:1024; disk(reservations: [(STATIC,foo)]):1024; disk:1024; ports:[31000-32000] (allocated: {})
I0129 01:37:52.815189 19673 replica.cpp:541] Replica received write request for position 4 from __req_res__(107)@172.17.0.2:40934
I0129 01:37:52.815205 19676 slave.cpp:1515] Checkpointing SlaveInfo to '/tmp/ContentType_MasterAPITest_GetRecoveredAgents_1_uHFdKi/meta/slaves/4dffa5dd-3ba7-4174-b1da-31dffa152894-S0/slave.info'
I0129 01:37:52.815505 19638 hierarchical.cpp:1558] Performed allocation for 1 agents in 169154ns
I0129 01:37:52.815696 19686 status_update_manager_process.hpp:385] Resuming operation status update manager
I0129 01:37:52.816427 19676 slave.cpp:1564] Forwarding agent update {"operations":{},"resource_providers":{},"resource_version_uuid":{"value":"NJ0fdmgSSqCZ1wsDzs1fZA=="},"slave_id":{"value":"4dffa5dd-3ba7-4174-b1da-31dffa152894-S0"},"update_oversubscribed_resources":false}
I0129 01:37:52.817023 19690 master.cpp:8043] Ignoring update on agent 4dffa5dd-3ba7-4174-b1da-31dffa152894-S0 at slave(39)@172.17.0.2:40934 (0c2f4d21d53a) as it reports no changes
I0129 01:37:52.818960 19646 process.cpp:3588] Handling HTTP event for process 'master' with path: '/master/reserve'
I0129 01:37:52.820853 19638 http.cpp:1105] HTTP POST for /master/reserve from 172.17.0.2:51922
I0129 01:37:52.822106 19638 master.cpp:3614] Authorizing principal 'test-principal' to reserve resources 'cpus(reservations: [(DYNAMIC,bar,test-principal)]):1; mem(reservations: [(DYNAMIC,bar,test-principal)]):12'
I0129 01:37:52.825875 19627 master.cpp:11636] Sending operation '' (uuid: 65201880-f706-4fea-9d62-143711e31715) to agent 4dffa5dd-3ba7-4174-b1da-31dffa152894-S0 at slave(39)@172.17.0.2:40934 (0c2f4d21d53a)
I0129 01:37:52.826300 19696 slave.cpp:4203] Ignoring new checkpointed resources and operations identical to the current version
I0129 01:37:52.826812 19696 slave.cpp:8368] Updating the state of operation with no ID (uuid: 65201880-f706-4fea-9d62-143711e31715) for an operation API call (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED)
I0129 01:37:52.828488 19696 slave.cpp:4279] Updated checkpointed resources from {} to cpus(reservations: [(DYNAMIC,bar,test-principal)]):1; mem(reservations: [(DYNAMIC,bar,test-principal)]):12
I0129 01:37:52.828585 19696 slave.cpp:4287] Updated checkpointed operations from [ ] to [ 65201880-f706-4fea-9d62-143711e31715 (RESERVE, latest state: OPERATION_FINISHED) ]
I0129 01:37:52.828841 19696 status_update_manager_process.hpp:152] Received operation status update OPERATION_FINISHED (Status UUID: bfee8f4d-cffd-462f-8f82-da20106d18b0) for operation UUID 65201880-f706-4fea-9d62-143711e31715 on agent 4dffa5dd-3ba7-4174-b1da-31dffa152894-S0
I0129 01:37:52.828912 19696 status_update_manager_process.hpp:414] Creating operation status update stream 65201880-f706-4fea-9d62-143711e31715 checkpoint=true
I0129 01:37:52.829227 19696 status_update_manager_process.hpp:929] Checkpointing UPDATE for operation status update OPERATION_FINISHED (Status UUID: bfee8f4d-cffd-462f-8f82-da20106d18b0) for operation UUID 65201880-f706-4fea-9d62-143711e31715 on agent 4dffa5dd-3ba7-4174-b1da-31dffa152894-S0
I0129 01:37:52.829568 19698 process.cpp:3588] Handling HTTP event for process 'master' with path: '/master/api/v1'
I0129 01:37:52.831374 19666 http.cpp:1105] HTTP POST for /master/api/v1 from 172.17.0.2:51924
I0129 01:37:52.831521 19666 http.cpp:260] Processing call GET_AGENTS
I0129 01:37:52.837947 19295 master.cpp:1109] Master terminating
I0129 01:37:52.838717 19676 slave.cpp:6083] Got exited event for master@172.17.0.2:40934
W0129 01:37:52.838750 19676 slave.cpp:6088] Master disconnected! Waiting for a new master to be elected
I0129 01:37:52.839099 19627 hierarchical.cpp:644] Removed agent 4dffa5dd-3ba7-4174-b1da-31dffa152894-S0
I0129 01:37:53.069370 19673 leveldb.cpp:347] Persisting action (16 bytes) to leveldb took 254.111994ms
I0129 01:37:53.069432 19673 replica.cpp:712] Persisted action TRUNCATE at position 4
I0129 01:37:53.071234 19295 slave.cpp:923] Agent terminating
I0129 01:37:53.182629 19696 status_update_manager_process.hpp:528] Forwarding operation status update OPERATION_FINISHED (Status UUID: bfee8f4d-cffd-462f-8f82-da20106d18b0) for operation UUID 65201880-f706-4fea-9d62-143711e31715 on agent 4dffa5dd-3ba7-4174-b1da-31dffa152894-S0
I0129 01:37:53.792286 19295 cluster.cpp:174] Creating default 'local' authorizer
I0129 01:37:54.488121 19295 leveldb.cpp:174] Opened db in 695.365552ms
I0129 01:37:55.309044 19295 leveldb.cpp:181] Compacted db in 820.86495ms
I0129 01:37:55.309130 19295 leveldb.cpp:196] Created db iterator in 35139ns
I0129 01:37:55.309177 19295 leveldb.cpp:202] Seeked to beginning of db in 30022ns
I0129 01:37:55.309325 19295 leveldb.cpp:277] Iterated through 5 keys in the db in 130951ns
I0129 01:37:55.309396 19295 replica.cpp:795] Replica recovered with log positions 1 -> 4 with 0 holes and 1 unlearned
I0129 01:37:55.310025 19700 recover.cpp:437] Starting replica recovery
I0129 01:37:55.310478 19676 recover.cpp:468] Replica is in VOTING status
I0129 01:37:55.310747 19676 recover.cpp:447] Recover process terminated
I0129 01:37:55.312645 19646 master.cpp:414] Master 37ade2c2-5292-4542-b7ae-b70925e15dff (0c2f4d21d53a) started on 172.17.0.2:40934
I0129 01:37:55.312675 19646 master.cpp:417] Flags at startup: --acls="view_roles {
principals {
values: "test-principal"
}
roles {
type: ANY
}
}
" --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="1000secs" --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/Psev1U/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_operator_event_stream_subscribers="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="replicated_log" --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/Psev1U/master" --zk_session_timeout="10secs"
I0129 01:37:55.313050 19646 master.cpp:466] Master only allowing authenticated frameworks to register
I0129 01:37:55.313068 19646 master.cpp:472] Master only allowing authenticated agents to register
I0129 01:37:55.313081 19646 master.cpp:478] Master only allowing authenticated HTTP frameworks to register
I0129 01:37:55.313096 19646 credentials.hpp:37] Loading credentials for authentication from '/tmp/Psev1U/credentials'
I0129 01:37:55.313344 19646 master.cpp:522] Using default 'crammd5' authenticator
I0129 01:37:55.313505 19646 http.cpp:965] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0129 01:37:55.313678 19646 http.cpp:965] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0129 01:37:55.313808 19646 http.cpp:965] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0129 01:37:55.313930 19646 master.cpp:603] Authorization enabled
I0129 01:37:55.314262 19684 hierarchical.cpp:176] Initialized hierarchical allocator process
I0129 01:37:55.314282 19670 whitelist_watcher.cpp:77] No whitelist given
I0129 01:37:55.316803 19692 master.cpp:2083] Elected as the leading master!
I0129 01:37:55.316838 19692 master.cpp:1638] Recovering from registrar
I0129 01:37:55.316992 19676 registrar.cpp:339] Recovering registrar
I0129 01:37:55.317664 19696 log.cpp:554] Attempting to start the writer
I0129 01:37:55.319033 19633 replica.cpp:497] Replica received implicit promise request from __req_res__(108)@172.17.0.2:40934 with proposal 2
I0129 01:37:55.427820 19633 leveldb.cpp:310] Persisting metadata (8 bytes) to leveldb took 108.730667ms
I0129 01:37:55.427911 19633 replica.cpp:344] Persisted promised to 2
I0129 01:37:55.428898 19692 coordinator.cpp:238] Coordinator attempting to fill missing positions
I0129 01:37:55.430387 19688 replica.cpp:391] Replica received explicit promise request from __req_res__(109)@172.17.0.2:40934 for position 4 with proposal 3
I0129 01:37:55.430516 19688 leveldb.cpp:460] Reading position from leveldb took 82825ns
I0129 01:37:55.637531 19688 leveldb.cpp:347] Persisting action (16 bytes) to leveldb took 206.947488ms
I0129 01:37:55.637616 19688 replica.cpp:712] Persisted action TRUNCATE at position 4
I0129 01:37:55.639102 19662 replica.cpp:541] Replica received write request for position 4 from __req_res__(110)@172.17.0.2:40934
I0129 01:37:55.639223 19662 leveldb.cpp:460] Reading position from leveldb took 55162ns
I0129 01:37:55.815673 19662 leveldb.cpp:347] Persisting action (16 bytes) to leveldb took 176.374805ms
I0129 01:37:55.815747 19662 replica.cpp:712] Persisted action TRUNCATE at position 4
I0129 01:37:55.816596 19679 replica.cpp:695] Replica received learned notice for position 4 from log-network(7)@172.17.0.2:40934
I0129 01:37:56.025732 19679 leveldb.cpp:347] Persisting action (18 bytes) to leveldb took 209.07771ms
I0129 01:37:56.025867 19679 leveldb.cpp:423] Deleting ~2 keys from leveldb took 68913ns
I0129 01:37:56.025897 19679 replica.cpp:712] Persisted action TRUNCATE at position 4
I0129 01:37:56.026641 19700 log.cpp:570] Writer started with ending position 4
I0129 01:37:56.028738 19662 leveldb.cpp:460] Reading position from leveldb took 192171ns
I0129 01:37:56.028918 19662 leveldb.cpp:460] Reading position from leveldb took 28992ns
I0129 01:37:56.031430 19686 registrar.cpp:383] Successfully fetched the registry (381B) in 714.379264ms
I0129 01:37:56.031574 19686 registrar.cpp:487] Applied 1 operations in 53615ns; attempting to update the registry
I0129 01:37:56.032346 19688 log.cpp:578] Attempting to append 420 bytes to the log
I0129 01:37:56.032538 19682 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 5
I0129 01:37:56.033421 19684 replica.cpp:541] Replica received write request for position 5 from __req_res__(111)@172.17.0.2:40934
I0129 01:37:56.277783 19684 leveldb.cpp:347] Persisting action (439 bytes) to leveldb took 244.304738ms
I0129 01:37:56.277863 19684 replica.cpp:712] Persisted action APPEND at position 5
I0129 01:37:56.278914 19676 replica.cpp:695] Replica received learned notice for position 5 from log-network(7)@172.17.0.2:40934
I0129 01:37:56.476581 19676 leveldb.cpp:347] Persisting action (441 bytes) to leveldb took 197.618939ms
I0129 01:37:56.476672 19676 replica.cpp:712] Persisted action APPEND at position 5
I0129 01:37:56.478266 19638 registrar.cpp:544] Successfully updated the registry in 446.581248ms
I0129 01:37:56.478282 19670 log.cpp:597] Attempting to truncate the log to 5
I0129 01:37:56.478466 19679 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 6
I0129 01:37:56.478991 19638 registrar.cpp:416] Successfully recovered registrar
I0129 01:37:56.479604 19698 replica.cpp:541] Replica received write request for position 6 from __req_res__(112)@172.17.0.2:40934
I0129 01:37:56.480034 19627 master.cpp:1752] Recovered 1 agents from the registry (381B); allowing 10mins for agents to reregister
I0129 01:37:56.480054 19673 hierarchical.cpp:216] Skipping recovery of hierarchical allocator: nothing to recover
I0129 01:37:56.686116 19698 leveldb.cpp:347] Persisting action (16 bytes) to leveldb took 206.448391ms
I0129 01:37:56.686198 19698 replica.cpp:712] Persisted action TRUNCATE at position 6
I0129 01:37:56.687219 19688 replica.cpp:695] Replica received learned notice for position 6 from log-network(7)@172.17.0.2:40934
I0129 01:37:56.909584 19688 leveldb.cpp:347] Persisting action (18 bytes) to leveldb took 222.307404ms
I0129 01:37:56.909775 19688 leveldb.cpp:423] Deleting ~2 keys from leveldb took 94282ns
I0129 01:37:56.909819 19688 replica.cpp:712] Persisted action TRUNCATE at position 6
I0129 01:37:56.914134 19638 process.cpp:3588] Handling HTTP event for process 'master' with path: '/master/api/v1'
I0129 01:37:56.915802 19690 http.cpp:1105] HTTP POST for /master/api/v1 from 172.17.0.2:52242
I0129 01:37:56.915958 19690 http.cpp:260] Processing call GET_AGENTS
W0129 01:37:56.922305 19295 process.cpp:2829] Attempted to spawn already running process files@172.17.0.2:40934
I0129 01:37:56.923336 19295 containerizer.cpp:309] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W0129 01:37:56.923770 19295 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0129 01:37:56.923883 19295 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0129 01:37:56.923918 19295 provisioner.cpp:298] Using default backend 'copy'
I0129 01:37:56.926172 19295 cluster.cpp:486] Creating default 'local' authorizer
I0129 01:37:56.928333 19684 slave.cpp:269] Mesos agent started on (40)@172.17.0.2:40934
I0129 01:37:56.928360 19684 slave.cpp:270] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Psev1U/Uj1Ib4/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/Psev1U/Uj1Ib4/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/Psev1U/Uj1Ib4/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/Psev1U/Uj1Ib4/fetch" --fetcher_cache_size="2GB" --fetcher_stall_timeout="1mins" --frameworks_home="/tmp/Psev1U/Uj1Ib4/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/Psev1U/Uj1Ib4/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" --network_cni_root_dir_persist="false" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --reconfiguration_policy="equal" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus(foo):1;cpus(*):2;gpus(*):0;mem(foo):1024;mem(*):1024;disk(foo):1024;disk(*):1024;ports(*):[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/ContentType_MasterAPITest_GetRecoveredAgents_1_wQRXsG" --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_MasterAPITest_GetRecoveredAgents_1_uHFdKi" --zk_session_timeout="10secs"
I0129 01:37:56.928819 19684 credentials.hpp:86] Loading credential for authentication from '/tmp/Psev1U/Uj1Ib4/credential'
I0129 01:37:56.928963 19684 slave.cpp:302] Agent using credential for: test-principal
I0129 01:37:56.928990 19684 credentials.hpp:37] Loading credentials for authentication from '/tmp/Psev1U/Uj1Ib4/http_credentials'
I0129 01:37:56.929188 19684 http.cpp:965] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0129 01:37:56.929550 19684 disk_profile_adaptor.cpp:80] Creating default disk profile adaptor module
I0129 01:37:56.931303 19684 slave.cpp:617] Agent resources: [{"name":"cpus","reservations":[{"role":"foo","type":"STATIC"}],"scalar":{"value":1.0},"type":"SCALAR"},{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","reservations":[{"role":"foo","type":"STATIC"}],"scalar":{"value":1024.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","reservations":[{"role":"foo","type":"STATIC"}],"scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0129 01:37:56.931677 19684 slave.cpp:625] Agent attributes: [ ]
I0129 01:37:56.931695 19684 slave.cpp:634] Agent hostname: 0c2f4d21d53a
I0129 01:37:56.931813 19627 status_update_manager_process.hpp:379] Pausing operation status update manager
I0129 01:37:56.931826 19638 task_status_update_manager.cpp:181] Pausing sending task status updates
I0129 01:37:56.933225 19666 state.cpp:67] Recovering state from '/tmp/ContentType_MasterAPITest_GetRecoveredAgents_1_uHFdKi/meta'
I0129 01:37:56.936779 19676 slave.cpp:7099] Finished recovering checkpointed state from '/tmp/ContentType_MasterAPITest_GetRecoveredAgents_1_uHFdKi/meta', beginning agent recovery
I0129 01:37:56.937973 19642 task_status_update_manager.cpp:207] Recovering task status update manager
I0129 01:37:56.938450 19670 containerizer.cpp:735] Recovering Mesos containers
I0129 01:37:56.938810 19670 containerizer.cpp:1061] Recovering isolators
I0129 01:37:56.939373 19673 containerizer.cpp:1100] Recovering provisioner
I0129 01:37:56.939999 19638 provisioner.cpp:494] Provisioner recovery complete
I0129 01:37:56.940675 19642 composing.cpp:339] Finished recovering all containerizers
F0129 01:37:56.940877 19646 slave.cpp:7335] Check failed: operation.has_framework_id()
*** Check failure stack trace: ***
@ 0x2ade74959e86 google::LogMessage::Fail()
@ 0x2ade74959dd2 google::LogMessage::SendToLog()
@ 0x2ade749597d4 google::LogMessage::Flush()
@ 0x2ade7495c6e8 google::LogMessageFatal::~LogMessageFatal()
@ 0x2ade7356a3ba mesos::internal::slave::Slave::_recoverOperations()
@ 0x2ade735eac1f _ZZN7process8dispatchIN5mesos8internal26StatusUpdateManagerProcessIN2id4UUIDENS2_27UpdateOperationStatusRecordENS2_28UpdateOperationStatusMessageEE5StateENS2_5slave5SlaveERK6OptionINSA_5state10SlaveStateEESH_EENS_6FutureIT_EERKNS_3PIDIT0_EEMSM_FSK_T1_EOT2_ENKUlSt10unique_ptrINS_7PromiseIS9_EESt14default_deleteISX_EEOSF_PNS_11ProcessBaseEE_clES10_S11_S13_
@ 0x2ade73692ce6 _ZN5cpp176invokeIZN7process8dispatchIN5mesos8internal26StatusUpdateManagerProcessIN2id4UUIDENS4_27UpdateOperationStatusRecordENS4_28UpdateOperationStatusMessageEE5StateENS4_5slave5SlaveERK6OptionINSC_5state10SlaveStateEESJ_EENS1_6FutureIT_EERKNS1_3PIDIT0_EEMSO_FSM_T1_EOT2_EUlSt10unique_ptrINS1_7PromiseISB_EESt14default_deleteISZ_EEOSH_PNS1_11ProcessBaseEE_IS12_SH_S15_EEEDTclcl7forwardISL_Efp_Espcl7forwardIT0_Efp0_EEEOSL_DpOS17_
@ 0x2ade7368a891 _ZN6lambda8internal7PartialIZN7process8dispatchIN5mesos8internal26StatusUpdateManagerProcessIN2id4UUIDENS5_27UpdateOperationStatusRecordENS5_28UpdateOperationStatusMessageEE5StateENS5_5slave5SlaveERK6OptionINSD_5state10SlaveStateEESK_EENS2_6FutureIT_EERKNS2_3PIDIT0_EEMSP_FSN_T1_EOT2_EUlSt10unique_ptrINS2_7PromiseISC_EESt14default_deleteIS10_EEOSI_PNS2_11ProcessBaseEE_JS13_SI_St12_PlaceholderILi1EEEE13invoke_expandIS17_St5tupleIJS13_SI_S19_EES1C_IJOS16_EEJLm0ELm1ELm2EEEEDTcl6invokecl7forwardIT_Efp_Espcl6expandcl3getIXT2_EEcl7forwardIT0_Efp0_EEcl7forwardIT1_Efp2_EEEEOS1G_OS1H_N5cpp1416integer_sequenceImJXspT2_EEEEOS1I_
@ 0x2ade736856bb _ZNO6lambda8internal7PartialIZN7process8dispatchIN5mesos8internal26StatusUpdateManagerProcessIN2id4UUIDENS5_27UpdateOperationStatusRecordENS5_28UpdateOperationStatusMessageEE5StateENS5_5slave5SlaveERK6OptionINSD_5state10SlaveStateEESK_EENS2_6FutureIT_EERKNS2_3PIDIT0_EEMSP_FSN_T1_EOT2_EUlSt10unique_ptrINS2_7PromiseISC_EESt14default_deleteIS10_EEOSI_PNS2_11ProcessBaseEE_IS13_SI_St12_PlaceholderILi1EEEEclIIS16_EEEDTcl13invoke_expandcl4movedtdefpT1fEcl4movedtdefpT10bound_argsEcvN5cpp1416integer_sequenceImILm0ELm1ELm2EEEE_Ecl16forward_as_tuplespcl7forwardIT_Efp_EEEEDpOS1F_
@ 0x2ade7368261b _ZN5cpp176invokeIN6lambda8internal7PartialIZN7process8dispatchIN5mesos8internal26StatusUpdateManagerProcessIN2id4UUIDENS7_27UpdateOperationStatusRecordENS7_28UpdateOperationStatusMessageEE5StateENS7_5slave5SlaveERK6OptionINSF_5state10SlaveStateEESM_EENS4_6FutureIT_EERKNS4_3PIDIT0_EEMSR_FSP_T1_EOT2_EUlSt10unique_ptrINS4_7PromiseISE_EESt14default_deleteIS12_EEOSK_PNS4_11ProcessBaseEE_JS15_SK_St12_PlaceholderILi1EEEEEJS18_EEEDTclcl7forwardISO_Efp_Espcl7forwardIT0_Efp0_EEEOSO_DpOS1D_
@ 0x2ade73680003 _ZN6lambda8internal6InvokeIvEclINS0_7PartialIZN7process8dispatchIN5mesos8internal26StatusUpdateManagerProcessIN2id4UUIDENS8_27UpdateOperationStatusRecordENS8_28UpdateOperationStatusMessageEE5StateENS8_5slave5SlaveERK6OptionINSG_5state10SlaveStateEESN_EENS5_6FutureIT_EERKNS5_3PIDIT0_EEMSS_FSQ_T1_EOT2_EUlSt10unique_ptrINS5_7PromiseISF_EESt14default_deleteIS13_EEOSL_PNS5_11ProcessBaseEE_JS16_SL_St12_PlaceholderILi1EEEEEJS19_EEEvOSP_DpOT0_
@ 0x2ade7367d661 _ZNO6lambda12CallableOnceIFvPN7process11ProcessBaseEEE10CallableFnINS_8internal7PartialIZNS1_8dispatchIN5mesos8internal26StatusUpdateManagerProcessIN2id4UUIDENSB_27UpdateOperationStatusRecordENSB_28UpdateOperationStatusMessageEE5StateENSB_5slave5SlaveERK6OptionINSJ_5state10SlaveStateEESQ_EENS1_6FutureIT_EERKNS1_3PIDIT0_EEMSV_FST_T1_EOT2_EUlSt10unique_ptrINS1_7PromiseISI_EESt14default_deleteIS16_EEOSO_S3_E_IS19_SO_St12_PlaceholderILi1EEEEEEclEOS3_
@ 0x2ade7487e991 _ZNO6lambda12CallableOnceIFvPN7process11ProcessBaseEEEclES3_
@ 0x2ade748483c1 process::ProcessBase::consume()
@ 0x2ade7486c6e4 _ZNO7process13DispatchEvent7consumeEPNS_13EventConsumerE
@ 0x555924eb6a78 process::ProcessBase::serve()
@ 0x2ade7484569e process::ProcessManager::resume()
@ 0x2ade74841b18 _ZZN7process14ProcessManager12init_threadsEvENKUlvE_clEv
@ 0x2ade74867530 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
@ 0x2ade74866851 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEclEv
@ 0x2ade74865a10 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEE6_M_runEv
@ 0x2ade7773fa60 (unknown)
@ 0x2ade77eb6184 start_thread
@ 0x2ade781ca03d (unknown)
[FAIL]: 3 shard(s) have failed tests
make[4]: *** [check-local] Error 3
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-1548721474-15268
Untagged: mesos-1548721474-15268:latest
Deleted: sha256:cefa3e2533920d0e77401059fae22b792c17ddbfccdf468797ec70efb33971bd
Deleted: sha256:c6bf8d7ef5603290a8823993acd824d43cdb9ac8d34f6b971b164854dd2a9f70
Deleted: sha256:b8574bbb126448cb78f79d1cbb5fd71ebe40048e0547ac446d8c1f65282c2952
Deleted: sha256:bf05e625f95cb3a0b2b582b5f3474cdf0878f928272018fa7ad588c763224707
Deleted: sha256:fb4e13d882f4917c314cdb0e7e35573923c76d462f2dfc21a5aa2f45d663dd36
Deleted: sha256:24a3e5e3027f6a98a551bc2af39a8ab32bc1c80f4998dd516071c3f54b896b2e
Deleted: sha256:69e20e41fe68dc530e33c1f215da6fcef26a3c6e1bb45d1a5146745d1f503567
Deleted: sha256:80f393a0409900f565e212ac0e431e6d21cfe5915dc352e16496f73fc8a06a66
Deleted: sha256:765dfa864dfbc0e7c1da7dbb55a15b2641e1aed8ebcc9b6868e3d1e09bd5edc2
Deleted: sha256:af09af0ee34ed49cb007e98f4f75501c0de811c3b82f8d516de3e16472efd1bd
Deleted: sha256:a40d10e8a259785cdef38659bc9bc6e4e67100c69d81fee5aee9d19ec2613ecf
Deleted: sha256:63bee5f2fde147445b5627cd9a09f13a76558a676d08470182f2b1a1b59134f7
Deleted: sha256:3c5ef8c2f29c1754e9e5991115f73fb92ac79284c01c13853a49c689c9f1d8e2
Deleted: sha256:ee7bc76c3a0feaa228834456ece5d5d2ee2a42fbd91dd23d160e1a148355c91e
Deleted: sha256:c1190f80a925974a099bf70b4745a8d1f6e09163e5735d3744035e730c36cc45
Deleted: sha256:eedb041814699385d14cd76f9f3c359be21de0bdd324695c963f0142dc4e39e8
Deleted: sha256:6d877d70defbf1740af3b0c8e3e8de3332fc37e90bea1a3044108554128aab91
Deleted: sha256:97c036176f512bef1751028a48cbfa6dd4029503541f2d6ed21e471ab261cfdb
Deleted: sha256:52067bb445e11fb9c8719df3e49f4f1e470e0d6d484aa7428d32bd307876415a
Deleted: sha256:71a749c81fb4cdd2fb76861141ec14fc8aa9dde71688bb492a0d4ea99457096d
Deleted: sha256:d1f07fb53873c203026c7abbb8c8dadcfc707598ee4dde04c9e530da149ca485
Deleted: sha256:5f4c4c5f1b0c35a990c5e6edd60607a78a02c1137a8cce2f735e51be6a8e30ea
Deleted: sha256:c1eb6083847d723271fcb4159c1451e6736bba564cc9983c0b46c4d80a6d522c
Deleted: sha256:5a71f4aa280cca57dca9d55ba0229eb878cd697a8abe202f97af79d9859c14cd
Deleted: sha256:94677495ffc55d5afd5f6ce239907b06eca6486fe00b64829dfe5c2670ac32ea
Deleted: sha256:1bd6f23837c83eeb8e325b40df1504b1dd6f7e17d7397cf897540245732dab12
Deleted: sha256:9b5fcf470e18c781dfcfb6b8593ede13df9725fb08dd7464607c2ab84d1ea05f
Deleted: sha256:65da28d37c352b6e3d83e83fb8e4f71a4efe228182aee7bb93a10351a21faf0b
Deleted: sha256:9a3873b4a746c34ecf1f3f8bb645bea0c0e94390bb50cee0776163f46bd04627
Deleted: sha256:17ce0e50777f5cb0fe09d1fa528d2afef48e0eaf59daa4424b35e52544abab5d
Full log: https://builds.apache.org/job/Mesos-Reviewbot/23674/console
1d54d1c0efe41aa89181bef2836123cc17ec4278
Error running command 'git checkout HEAD -- 1d54d1c0efe41aa89181bef2836123cc17ec4278
': b"error: pathspec '1d54d1c0efe41aa89181bef2836123cc17ec4278' did not match any file(s) known to git.\n"
1d54d1c0efe41aa89181bef2836123cc17ec4278
Error running command 'git checkout HEAD -- 1d54d1c0efe41aa89181bef2836123cc17ec4278
': b"error: pathspec '1d54d1c0efe41aa89181bef2836123cc17ec4278' did not match any file(s) known to git.\n"
Error in atexit._run_exitfuncs:
Traceback (most recent call last):
File "<https://builds.apache.org/job/Mesos-Reviewbot/ws/support/verify-reviews.py",> line 98, in shell
command, stderr=subprocess.STDOUT, shell=True)
File "/usr/lib/python3.5/subprocess.py", line 626, in check_output
**kwargs).stdout
File "/usr/lib/python3.5/subprocess.py", line 708, in run
output=stdout, stderr=stderr)
subprocess.CalledProcessError: Command 'git checkout HEAD -- 1d54d1c0efe41aa89181bef2836123cc17ec4278
' returned non-zero exit status 1
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 178, in cleanup
shell("git checkout HEAD -- %s" % HEAD)
File "<https://builds.apache.org/job/Mesos-Reviewbot/ws/support/verify-reviews.py",> line 101, in shell
exit(1)
File "/usr/lib/python3.5/_sitebuiltins.py", line 26, in __call__
raise SystemExit(code)
SystemExit: 1
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos-Reviewbot #23675
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Reviewbot/23675/display/redirect?page=changes>