[18:42:49.285] New invocation is queued and will start shortly
[18:42:51.031] Starting the invocation (attempt 1)
[18:42:51.072] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:42:51.075] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:42:51.075] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030058065731520256",
"parameters_json": "{\"builder_name\":\"Linux Viz\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"752fc418bd40e5300fa66c387c304712d1daf031\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Viz",
"scheduler_invocation_id:9030058065731520256",
"scheduler_job_id:chromium/Linux Viz",
"user_agent:luci-scheduler",
"buildset:commit/git/752fc418bd40e5300fa66c387c304712d1daf031",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/752fc418bd40e5300fa66c387c304712d1daf031",
"gitiles_ref:refs/heads/master"
]
}
[18:42:51.664] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604428971187617",
"id": "8864628003066937808",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"752fc418bd40e5300fa66c387c304712d1daf031\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604428971550744",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/24590",
"builder:Linux Viz",
"buildset:commit/git/752fc418bd40e5300fa66c387c304712d1daf031",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/752fc418bd40e5300fa66c387c304712d1daf031",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030058065731520256",
"scheduler_job_id:chromium/Linux Viz",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8864628003066937808/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1604428971550858",
"url": "https://ci.chromium.org/b/8864628003066937808",
"utcnow_ts": "1604428971653491"
}
}
[18:42:51.664] Task URL: https://ci.chromium.org/b/8864628003066937808
[18:42:51.664] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:2:0) after 1m0s
[18:43:05.670] Received PubSub notification, asking Buildbucket for the build status
[18:43:05.752] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:51.702] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:2:0)
[18:43:51.702] Timer tick, asking Buildbucket for the build status
[18:43:51.820] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:51.820] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:4:0) after 1m0s
[18:44:51.846] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:4:0)
[18:44:51.846] Timer tick, asking Buildbucket for the build status
[18:44:51.946] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:51.946] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:5:0) after 1m0s
[18:45:51.992] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:5:0)
[18:45:51.992] Timer tick, asking Buildbucket for the build status
[18:45:52.114] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:52.114] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:6:0) after 1m0s
[18:46:52.139] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:6:0)
[18:46:52.139] Timer tick, asking Buildbucket for the build status
[18:46:52.514] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:52.514] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:7:0) after 1m0s
[18:47:52.630] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:7:0)
[18:47:52.630] Timer tick, asking Buildbucket for the build status
[18:47:52.940] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:52.940] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:8:0) after 1m0s
[18:48:52.974] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:8:0)
[18:48:52.974] Timer tick, asking Buildbucket for the build status
[18:48:53.181] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:53.181] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:9:0) after 1m0s
[18:49:53.289] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:9:0)
[18:49:53.289] Timer tick, asking Buildbucket for the build status
[18:49:53.501] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:53.501] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:10:0) after 1m0s
[18:50:53.530] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:10:0)
[18:50:53.530] Timer tick, asking Buildbucket for the build status
[18:50:53.605] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:53.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:11:0) after 1m0s
[18:51:53.759] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:11:0)
[18:51:53.759] Timer tick, asking Buildbucket for the build status
[18:51:54.484] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:54.484] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:12:0) after 1m0s
[18:52:54.626] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:12:0)
[18:52:54.626] Timer tick, asking Buildbucket for the build status
[18:52:54.720] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:54.720] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:13:0) after 1m0s
[18:53:54.862] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:13:0)
[18:53:54.862] Timer tick, asking Buildbucket for the build status
[18:53:55.065] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:55.065] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:14:0) after 1m0s
[18:54:55.176] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:14:0)
[18:54:55.176] Timer tick, asking Buildbucket for the build status
[18:54:55.263] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:55.263] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:15:0) after 1m0s
[18:55:55.352] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:15:0)
[18:55:55.352] Timer tick, asking Buildbucket for the build status
[18:55:55.452] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:55.452] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:16:0) after 1m0s
[18:56:55.703] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:16:0)
[18:56:55.703] Timer tick, asking Buildbucket for the build status
[18:56:57.217] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:57.218] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:17:0) after 1m0s
[18:57:57.485] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:17:0)
[18:57:57.485] Timer tick, asking Buildbucket for the build status
[18:57:57.707] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:57.707] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:18:0) after 1m0s
[18:58:57.851] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:18:0)
[18:58:57.851] Timer tick, asking Buildbucket for the build status
[18:58:58.029] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:58.029] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:19:0) after 1m0s
[18:59:58.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:19:0)
[18:59:58.117] Timer tick, asking Buildbucket for the build status
[18:59:58.273] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:58.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:20:0) after 1m0s
[19:00:58.354] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:20:0)
[19:00:58.354] Timer tick, asking Buildbucket for the build status
[19:00:58.458] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:58.458] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:21:0) after 1m0s
[19:01:58.527] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:21:0)
[19:01:58.527] Timer tick, asking Buildbucket for the build status
[19:01:58.592] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:58.592] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:22:0) after 1m0s
[19:02:58.622] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:22:0)
[19:02:58.622] Timer tick, asking Buildbucket for the build status
[19:02:58.995] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:58.995] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:23:0) after 1m0s
[19:03:59.020] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:23:0)
[19:03:59.020] Timer tick, asking Buildbucket for the build status
[19:03:59.263] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:59.263] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:24:0) after 1m0s
[19:04:59.322] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:24:0)
[19:04:59.322] Timer tick, asking Buildbucket for the build status
[19:04:59.483] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:59.483] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:25:0) after 1m0s
[19:05:59.536] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:25:0)
[19:05:59.536] Timer tick, asking Buildbucket for the build status
[19:05:59.671] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:59.671] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:26:0) after 1m0s
[19:06:59.847] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:26:0)
[19:06:59.848] Timer tick, asking Buildbucket for the build status
[19:07:00.234] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:00.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:27:0) after 1m0s
[19:08:00.411] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:27:0)
[19:08:00.411] Timer tick, asking Buildbucket for the build status
[19:08:00.493] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:00.493] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:28:0) after 1m0s
[19:09:00.870] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:28:0)
[19:09:00.870] Timer tick, asking Buildbucket for the build status
[19:09:01.183] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:01.183] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:29:0) after 1m0s
[19:10:01.813] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:29:0)
[19:10:01.813] Timer tick, asking Buildbucket for the build status
[19:10:01.907] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:01.907] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:30:0) after 1m0s
[19:11:02.256] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:30:0)
[19:11:02.256] Timer tick, asking Buildbucket for the build status
[19:11:04.256] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:04.256] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:31:0) after 1m0s
[19:12:04.364] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:31:0)
[19:12:04.364] Timer tick, asking Buildbucket for the build status
[19:12:04.451] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:04.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:32:0) after 1m0s
[19:13:04.631] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:32:0)
[19:13:04.631] Timer tick, asking Buildbucket for the build status
[19:13:04.773] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:04.773] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:33:0) after 1m0s
[19:14:04.847] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:33:0)
[19:14:04.847] Timer tick, asking Buildbucket for the build status
[19:14:05.227] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:05.227] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:34:0) after 1m0s
[19:15:05.266] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:34:0)
[19:15:05.266] Timer tick, asking Buildbucket for the build status
[19:15:05.478] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:05.478] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:35:0) after 1m0s
[19:16:05.544] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:35:0)
[19:16:05.544] Timer tick, asking Buildbucket for the build status
[19:16:05.732] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:05.732] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:36:0) after 1m0s
[19:17:05.743] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:36:0)
[19:17:05.743] Timer tick, asking Buildbucket for the build status
[19:17:05.835] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:05.835] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:37:0) after 1m0s
[19:18:05.905] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:37:0)
[19:18:05.905] Timer tick, asking Buildbucket for the build status
[19:18:05.992] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:05.992] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:38:0) after 1m0s
[19:19:06.018] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:38:0)
[19:19:06.018] Timer tick, asking Buildbucket for the build status
[19:19:06.191] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:06.191] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:39:0) after 1m0s
[19:20:06.234] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:39:0)
[19:20:06.234] Timer tick, asking Buildbucket for the build status
[19:20:06.510] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:06.510] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:40:0) after 1m0s
[19:21:06.541] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:40:0)
[19:21:06.541] Timer tick, asking Buildbucket for the build status
[19:21:06.807] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:06.807] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:41:0) after 1m0s
[19:22:06.814] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:41:0)
[19:22:06.814] Timer tick, asking Buildbucket for the build status
[19:22:06.919] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:06.919] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:42:0) after 1m0s
[19:23:06.998] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:42:0)
[19:23:06.998] Timer tick, asking Buildbucket for the build status
[19:23:08.183] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:08.183] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:43:0) after 1m0s
[19:24:08.257] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:43:0)
[19:24:08.257] Timer tick, asking Buildbucket for the build status
[19:24:08.429] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:08.429] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:44:0) after 1m0s
[19:25:08.476] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:44:0)
[19:25:08.476] Timer tick, asking Buildbucket for the build status
[19:25:08.574] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:08.574] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:45:0) after 1m0s
[19:26:08.632] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:45:0)
[19:26:08.632] Timer tick, asking Buildbucket for the build status
[19:26:08.715] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:08.715] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:46:0) after 1m0s
[19:27:08.737] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:46:0)
[19:27:08.737] Timer tick, asking Buildbucket for the build status
[19:27:08.903] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:08.903] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:47:0) after 1m0s
[19:28:08.938] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:47:0)
[19:28:08.938] Timer tick, asking Buildbucket for the build status
[19:28:09.140] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:09.140] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:48:0) after 1m0s
[19:29:09.261] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:48:0)
[19:29:09.261] Timer tick, asking Buildbucket for the build status
[19:29:09.576] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:09.576] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:49:0) after 1m0s
[19:30:09.626] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:49:0)
[19:30:09.626] Timer tick, asking Buildbucket for the build status
[19:30:09.751] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:09.751] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:50:0) after 1m0s
[19:31:09.827] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:50:0)
[19:31:09.827] Timer tick, asking Buildbucket for the build status
[19:31:09.975] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:09.975] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:51:0) after 1m0s
[19:32:10.011] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:51:0)
[19:32:10.011] Timer tick, asking Buildbucket for the build status
[19:32:10.169] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:10.169] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:52:0) after 1m0s
[19:33:10.222] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:52:0)
[19:33:10.222] Timer tick, asking Buildbucket for the build status
[19:33:10.444] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:10.444] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:53:0) after 1m0s
[19:34:10.477] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:53:0)
[19:34:10.477] Timer tick, asking Buildbucket for the build status
[19:34:10.632] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:10.632] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:54:0) after 1m0s
[19:35:10.654] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:54:0)
[19:35:10.654] Timer tick, asking Buildbucket for the build status
[19:35:11.191] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:11.191] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:55:0) after 1m0s
[19:36:11.285] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:55:0)
[19:36:11.285] Timer tick, asking Buildbucket for the build status
[19:36:11.359] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:11.359] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:56:0) after 1m0s
[19:37:11.387] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:56:0)
[19:37:11.387] Timer tick, asking Buildbucket for the build status
[19:37:11.602] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:11.602] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:57:0) after 1m0s
[19:38:11.693] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:57:0)
[19:38:11.693] Timer tick, asking Buildbucket for the build status
[19:38:12.396] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:12.396] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:58:0) after 1m0s
[19:39:12.465] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:58:0)
[19:39:12.465] Timer tick, asking Buildbucket for the build status
[19:39:12.554] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:12.554] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:59:0) after 1m0s
[19:40:12.625] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:59:0)
[19:40:12.625] Timer tick, asking Buildbucket for the build status
[19:40:12.750] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:12.750] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:60:0) after 1m0s
[19:41:12.848] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:60:0)
[19:41:12.848] Timer tick, asking Buildbucket for the build status
[19:41:12.973] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:12.973] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:61:0) after 1m0s
[19:42:13.085] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:61:0)
[19:42:13.085] Timer tick, asking Buildbucket for the build status
[19:42:13.254] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:13.254] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:62:0) after 1m0s
[19:43:13.324] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:62:0)
[19:43:13.324] Timer tick, asking Buildbucket for the build status
[19:43:26.775] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:26.775] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:63:0) after 1m0s
[19:44:26.824] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:63:0)
[19:44:26.824] Timer tick, asking Buildbucket for the build status
[19:44:27.018] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:27.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:64:0) after 1m0s
[19:45:27.009] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:64:0)
[19:45:27.009] Timer tick, asking Buildbucket for the build status
[19:45:27.080] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:27.080] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:65:0) after 1m0s
[19:46:27.125] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:65:0)
[19:46:27.125] Timer tick, asking Buildbucket for the build status
[19:46:27.543] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:27.543] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:66:0) after 1m0s
[19:47:27.535] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:66:0)
[19:47:27.535] Timer tick, asking Buildbucket for the build status
[19:47:27.773] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:27.773] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:67:0) after 1m0s
[19:48:27.832] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:67:0)
[19:48:27.832] Timer tick, asking Buildbucket for the build status
[19:48:27.967] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:27.967] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:68:0) after 1m0s
[19:49:27.985] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:68:0)
[19:49:27.985] Timer tick, asking Buildbucket for the build status
[19:49:28.099] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:28.099] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:69:0) after 1m0s
[19:50:28.100] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:69:0)
[19:50:28.100] Timer tick, asking Buildbucket for the build status
[19:50:28.282] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:28.282] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:70:0) after 1m0s
[19:51:28.329] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:70:0)
[19:51:28.329] Timer tick, asking Buildbucket for the build status
[19:51:28.440] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:28.440] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:71:0) after 1m0s
[19:52:28.496] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:71:0)
[19:52:28.496] Timer tick, asking Buildbucket for the build status
[19:52:29.692] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:29.692] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:72:0) after 1m0s
[19:53:29.740] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:72:0)
[19:53:29.740] Timer tick, asking Buildbucket for the build status
[19:53:29.900] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:29.900] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:73:0) after 1m0s
[19:54:29.968] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:73:0)
[19:54:29.968] Timer tick, asking Buildbucket for the build status
[19:54:30.230] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:30.230] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:74:0) after 1m0s
[19:55:30.257] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:74:0)
[19:55:30.257] Timer tick, asking Buildbucket for the build status
[19:55:31.063] Build 8864628003066937808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:31.063] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9030058065731520256:75:0) after 1m0s
[19:56:11.719] Received PubSub notification, asking Buildbucket for the build status
[19:56:11.815] Build 8864628003066937808: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:56:11.815] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604433370844757",
"created_by": "project:chromium",
"created_ts": "1604428971187617",
"id": "8864628003066937808",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"752fc418bd40e5300fa66c387c304712d1daf031\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"752fc418bd40e5300fa66c387c304712d1daf031\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-39-0p1x\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.fyi\", \"buildername\": \"Linux Viz\", \"buildnumber\": 24590, \"got_angle_revision\": \"6a4c9bbd518521d0471880c938635c8afefd3042\", \"got_dawn_revision\": \"43ef0a365b8443226916c090b88b3a0b09d6df96\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"752fc418bd40e5300fa66c387c304712d1daf031\", \"got_revision_cp\": \"refs/heads/master@{#823632}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"b5bf82693f85b53ce31846705d323764a582489b\", \"got_v8_revision\": \"ba40ae7eef4ddab929ee4ffc61fccc5da96ee00e\", \"got_v8_revision_cp\": \"refs/heads/8.8.223@{#1}\", \"got_webrtc_revision\": \"42cafa5696f516712bbe6709fedeedffac61544c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32540}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"752fc418bd40e5300fa66c387c304712d1daf031\", \"swarm_hashes_refs/heads/master(at){#823632}_without_patch\": {\"blink_web_tests\": \"a0fcbdba1965ec7e5b2f7e89a11be23cfe828827\", \"browser_tests\": \"e7e2fe5e9b833cc4e02e1d441100c8b908680b7d\", \"content_browsertests\": \"6fc44a399c662332b7f5a7073324a2af09d763c1\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_28be8b4e850be8bd7a9db0671ff876681ccdf0c2c048860e172c20e0c8b9b79b_v2\", \"builder_5e40e9df3c25d6ec04b042625e64587de25b7cc9257c9b922c4342550ccccbb8_v2\", \"builder_61893a5c8ae9b884bb20ec7e5a61377525a63e6bcd3c290923a393e48475e916_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-39-0p1x\"], \"image\": [\"chrome-xenial-20102500-5da31bca5f9\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604428984757823",
"status": "COMPLETED",
"status_changed_ts": "1604433371278326",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/24590",
"builder:Linux Viz",
"buildset:commit/git/752fc418bd40e5300fa66c387c304712d1daf031",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/752fc418bd40e5300fa66c387c304712d1daf031",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030058065731520256",
"scheduler_job_id:chromium/Linux Viz",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8864628003066937808/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4fa83ced0775b510",
"user_agent:luci-scheduler"
],
"updated_ts": "1604433371282991",
"url": "https://ci.chromium.org/b/8864628003066937808",
"utcnow_ts": "1604433371802781"
}
}
[19:56:11.815] Invocation finished in 1h13m22.552793652s with status SUCCEEDED