[22:56:47.754] New invocation is queued and will start shortly
[22:56:49.276] Starting the invocation (attempt 1)
[22:56:49.310] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:56:49.311] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:56:49.311] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030676265803056416",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ecb93f4dce5da17cfc0543a4f2d2a904e41592cb\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9030676265803056416",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/ecb93f4dce5da17cfc0543a4f2d2a904e41592cb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ecb93f4dce5da17cfc0543a4f2d2a904e41592cb",
"gitiles_ref:refs/heads/master"
]
}
[22:56:50.074] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1603839409420674",
"id": "8865246203385985616",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ecb93f4dce5da17cfc0543a4f2d2a904e41592cb\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603839409880968",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42324",
"builder:linux-chromeos-rel",
"buildset:commit/git/ecb93f4dce5da17cfc0543a4f2d2a904e41592cb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ecb93f4dce5da17cfc0543a4f2d2a904e41592cb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030676265803056416",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8865246203385985616/+/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": "1603839409881146",
"url": "https://ci.chromium.org/b/8865246203385985616",
"utcnow_ts": "1603839410054712"
}
}
[22:56:50.074] Task URL: https://ci.chromium.org/b/8865246203385985616
[22:56:50.075] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:2:0) after 1m0s
[22:57:47.602] Received PubSub notification, asking Buildbucket for the build status
[22:57:47.699] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:50.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:2:0)
[22:57:50.175] Timer tick, asking Buildbucket for the build status
[22:57:50.266] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:50.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:4:0) after 1m0s
[22:58:50.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:4:0)
[22:58:50.393] Timer tick, asking Buildbucket for the build status
[22:58:50.523] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:50.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:5:0) after 1m0s
[22:59:50.630] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:5:0)
[22:59:50.630] Timer tick, asking Buildbucket for the build status
[22:59:50.813] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:50.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:6:0) after 1m0s
[23:00:50.854] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:6:0)
[23:00:50.854] Timer tick, asking Buildbucket for the build status
[23:00:51.006] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:51.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:7:0) after 1m0s
[23:01:51.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:7:0)
[23:01:51.014] Timer tick, asking Buildbucket for the build status
[23:01:51.310] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:51.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:8:0) after 1m0s
[23:02:51.357] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:8:0)
[23:02:51.357] Timer tick, asking Buildbucket for the build status
[23:02:51.620] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:51.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:9:0) after 1m0s
[23:03:51.755] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:9:0)
[23:03:51.755] Timer tick, asking Buildbucket for the build status
[23:03:51.909] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:51.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:10:0) after 1m0s
[23:04:52.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:10:0)
[23:04:52.323] Timer tick, asking Buildbucket for the build status
[23:04:52.412] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:52.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:11:0) after 1m0s
[23:05:52.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:11:0)
[23:05:52.513] Timer tick, asking Buildbucket for the build status
[23:05:52.602] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:52.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:12:0) after 1m0s
[23:06:52.779] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:12:0)
[23:06:52.779] Timer tick, asking Buildbucket for the build status
[23:06:52.930] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:52.930] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:13:0) after 1m0s
[23:07:52.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:13:0)
[23:07:52.955] Timer tick, asking Buildbucket for the build status
[23:07:53.151] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:53.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:14:0) after 1m0s
[23:08:53.219] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:14:0)
[23:08:53.219] Timer tick, asking Buildbucket for the build status
[23:08:53.423] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:53.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:15:0) after 1m0s
[23:09:53.432] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:15:0)
[23:09:53.432] Timer tick, asking Buildbucket for the build status
[23:09:53.524] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:53.524] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:16:0) after 1m0s
[23:10:53.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:16:0)
[23:10:53.633] Timer tick, asking Buildbucket for the build status
[23:10:54.004] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:54.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:17:0) after 1m0s
[23:11:54.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:17:0)
[23:11:54.068] Timer tick, asking Buildbucket for the build status
[23:11:54.246] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:54.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:18:0) after 1m0s
[23:12:54.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:18:0)
[23:12:54.330] Timer tick, asking Buildbucket for the build status
[23:12:54.402] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:54.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:19:0) after 1m0s
[23:13:54.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:19:0)
[23:13:54.484] Timer tick, asking Buildbucket for the build status
[23:13:54.554] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:54.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:20:0) after 1m0s
[23:14:54.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:20:0)
[23:14:54.586] Timer tick, asking Buildbucket for the build status
[23:14:54.717] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:54.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:21:0) after 1m0s
[23:15:54.737] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:21:0)
[23:15:54.737] Timer tick, asking Buildbucket for the build status
[23:15:54.821] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:54.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:22:0) after 1m0s
[23:16:54.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:22:0)
[23:16:54.846] Timer tick, asking Buildbucket for the build status
[23:16:54.947] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:54.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:23:0) after 1m0s
[23:17:54.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:23:0)
[23:17:54.988] Timer tick, asking Buildbucket for the build status
[23:17:55.057] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:55.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:24:0) after 1m0s
[23:18:55.149] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:24:0)
[23:18:55.149] Timer tick, asking Buildbucket for the build status
[23:18:55.289] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:55.289] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:25:0) after 1m0s
[23:19:55.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:25:0)
[23:19:55.317] Timer tick, asking Buildbucket for the build status
[23:19:55.415] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:55.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:26:0) after 1m0s
[23:20:55.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:26:0)
[23:20:55.481] Timer tick, asking Buildbucket for the build status
[23:20:55.675] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:55.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:27:0) after 1m0s
[23:21:55.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:27:0)
[23:21:55.724] Timer tick, asking Buildbucket for the build status
[23:21:55.850] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:55.850] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:28:0) after 1m0s
[23:22:55.885] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:28:0)
[23:22:55.885] Timer tick, asking Buildbucket for the build status
[23:22:56.522] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:56.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:29:0) after 1m0s
[23:23:56.576] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:29:0)
[23:23:56.576] Timer tick, asking Buildbucket for the build status
[23:23:56.782] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:56.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:30:0) after 1m0s
[23:24:56.847] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:30:0)
[23:24:56.847] Timer tick, asking Buildbucket for the build status
[23:24:57.007] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:57.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:31:0) after 1m0s
[23:25:57.134] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:31:0)
[23:25:57.134] Timer tick, asking Buildbucket for the build status
[23:25:57.219] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:57.220] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:32:0) after 1m0s
[23:26:57.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:32:0)
[23:26:57.265] Timer tick, asking Buildbucket for the build status
[23:26:57.744] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:57.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:33:0) after 1m0s
[23:27:57.773] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:33:0)
[23:27:57.773] Timer tick, asking Buildbucket for the build status
[23:27:57.838] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:57.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:34:0) after 1m0s
[23:28:57.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:34:0)
[23:28:57.852] Timer tick, asking Buildbucket for the build status
[23:28:57.927] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:57.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:35:0) after 1m0s
[23:29:58.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:35:0)
[23:29:58.595] Timer tick, asking Buildbucket for the build status
[23:29:58.668] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:58.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:36:0) after 1m0s
[23:30:58.717] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:36:0)
[23:30:58.717] Timer tick, asking Buildbucket for the build status
[23:30:59.113] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:59.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:37:0) after 1m0s
[23:31:59.149] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:37:0)
[23:31:59.150] Timer tick, asking Buildbucket for the build status
[23:31:59.341] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:59.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:38:0) after 1m0s
[23:32:59.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:38:0)
[23:32:59.361] Timer tick, asking Buildbucket for the build status
[23:32:59.439] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:59.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:39:0) after 1m0s
[23:33:59.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:39:0)
[23:33:59.530] Timer tick, asking Buildbucket for the build status
[23:33:59.839] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:59.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:40:0) after 1m0s
[23:34:59.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:40:0)
[23:34:59.878] Timer tick, asking Buildbucket for the build status
[23:34:59.986] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:59.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:41:0) after 1m0s
[23:36:00.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:41:0)
[23:36:00.022] Timer tick, asking Buildbucket for the build status
[23:36:00.267] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:00.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:42:0) after 1m0s
[23:37:01.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:42:0)
[23:37:01.111] Timer tick, asking Buildbucket for the build status
[23:37:02.104] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:02.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:43:0) after 1m0s
[23:38:02.143] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:43:0)
[23:38:02.143] Timer tick, asking Buildbucket for the build status
[23:38:02.507] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:02.507] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:44:0) after 1m0s
[23:39:03.101] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:44:0)
[23:39:03.101] Timer tick, asking Buildbucket for the build status
[23:39:03.295] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:03.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:45:0) after 1m0s
[23:40:03.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:45:0)
[23:40:03.343] Timer tick, asking Buildbucket for the build status
[23:40:03.692] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:03.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:46:0) after 1m0s
[23:41:03.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:46:0)
[23:41:03.671] Timer tick, asking Buildbucket for the build status
[23:41:03.979] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:03.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:47:0) after 1m0s
[23:42:03.987] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:47:0)
[23:42:03.987] Timer tick, asking Buildbucket for the build status
[23:42:04.305] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:04.305] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:48:0) after 1m0s
[23:43:04.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:48:0)
[23:43:04.322] Timer tick, asking Buildbucket for the build status
[23:43:04.444] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:04.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:49:0) after 1m0s
[23:44:04.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:49:0)
[23:44:04.449] Timer tick, asking Buildbucket for the build status
[23:44:04.715] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:04.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:50:0) after 1m0s
[23:45:04.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:50:0)
[23:45:04.749] Timer tick, asking Buildbucket for the build status
[23:45:05.128] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:05.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:51:0) after 1m0s
[23:46:05.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:51:0)
[23:46:05.206] Timer tick, asking Buildbucket for the build status
[23:46:06.451] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:06.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:52:0) after 1m0s
[23:47:06.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:52:0)
[23:47:06.499] Timer tick, asking Buildbucket for the build status
[23:47:07.025] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:07.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:53:0) after 1m0s
[23:48:07.073] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:53:0)
[23:48:07.073] Timer tick, asking Buildbucket for the build status
[23:48:07.673] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:07.673] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:54:0) after 1m0s
[23:49:07.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:54:0)
[23:49:07.745] Timer tick, asking Buildbucket for the build status
[23:49:07.908] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:07.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:55:0) after 1m0s
[23:50:07.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:55:0)
[23:50:07.979] Timer tick, asking Buildbucket for the build status
[23:50:08.466] Build 8865246203385985616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:08.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030676265803056416:56:0) after 1m0s
[23:50:50.908] Received PubSub notification, asking Buildbucket for the build status
[23:50:51.034] Build 8865246203385985616: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:50:51.034] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1603842649648368",
"created_by": "project:chromium",
"created_ts": "1603839409420674",
"id": "8865246203385985616",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ecb93f4dce5da17cfc0543a4f2d2a904e41592cb\"}}",
"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\": \"ecb93f4dce5da17cfc0543a4f2d2a904e41592cb\", \"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-61-durd\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42324, \"got_angle_revision\": \"b5ba693316fdd5e680f2bb4cf1a2f9bed589d8e2\", \"got_dawn_revision\": \"6b087819dd1ea56a50e15bcc34c97ad2fa01d463\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"ecb93f4dce5da17cfc0543a4f2d2a904e41592cb\", \"got_revision_cp\": \"refs/heads/master@{#821482}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"20aa521f10950ef2db0f60fc487e68d9fa14d703\", \"got_v8_revision_cp\": \"refs/heads/8.8.190@{#1}\", \"got_webrtc_revision\": \"ee24eb66d23ffea5ef729dc340e1fc4381c72a4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32507}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ecb93f4dce5da17cfc0543a4f2d2a904e41592cb\", \"swarm_hashes_refs/heads/master(at){#821482}_without_patch\": {\"absl_hardening_tests\": \"f041c30210719c2b75fcab30a183235b12c5dd53\", \"accessibility_unittests\": \"df3c7a3be54e5220eca73d513d1e19a4d3806e89\", \"angle_unittests\": \"4414dc3f42ec0a06127901dee18babad6129be4f\", \"app_list_unittests\": \"1d45f5629a09dc74c51b9b852f95f4a6ed185be6\", \"app_shell_unittests\": \"359d7fb0958840cb973bd66332ba769ea6ee067e\", \"ash_unittests\": \"d7893c54603bc231a00c456d3c37480f8cb650bd\", \"aura_unittests\": \"fe2faaabc8c9cc61b0ba2955b7745a925e925a33\", \"base_unittests\": \"aeab6310027d6ee3d68d352b60792e56bd8e4ef9\", \"base_util_unittests\": \"061d7e033ff298913ce41de31ba594964fa51a96\", \"blink_common_unittests\": \"022fd7aebd3fd7f4e2948a47a33bd068853dcbde\", \"blink_fuzzer_unittests\": \"40172a42cdb12d9fe938735f2d5c60292cbbec72\", \"blink_heap_unittests\": \"291212ce002dd41c9f65baa1fb3ba9088c076792\", \"blink_platform_unittests\": \"4e712e65a86b8d5f7b7d7623d4cba128f12fa266\", \"blink_unittests\": \"30d62c0275559cb1128595afaf36a6dc646f23db\", \"boringssl_crypto_tests\": \"e0a906bedb95c79cd854fe9d989fba31081cd4f6\", \"boringssl_ssl_tests\": \"440a27b27369ef7f2357ffd00ada5cad55ba9f76\", \"browser_tests\": \"4e9de39bcb037910b896dda3b0a47523c0646380\", \"capture_unittests\": \"63a31e36d5a88816ec0f7cfeaa0e8dd84af7fd30\", \"cast_unittests\": \"d4b64faad7c8263765873fc60bc62bed931fd5d1\", \"cc_unittests\": \"c64945dec35e33ab8c846b60062afa337de5d25e\", \"chrome_app_unittests\": \"7e57358f6f3738119bf6a22c4a1b9deb32aa1819\", \"chromedriver_unittests\": \"b30a0e9c1a332784a175126345626ba5c6303c73\", \"chromeos_components_unittests\": \"94ad3308920a27ab39b9c5401875ede3ada573b7\", \"chromeos_unittests\": \"de222bf2019a535d4e98a9516131e2ae54460bf6\", \"components_browsertests\": \"cccbc1cf18dc7ba79edf1d6cbf6bc96c97a9e8f5\", \"components_unittests\": \"68c8f682badb59bc87efb00f3d948d139a570e90\", \"compositor_unittests\": \"0e42dbe5049df7e9a379e578a85d56f798565089\", \"content_browsertests\": \"b96cd680179a1e66d6898e9d0cc47dc9309a30d4\", \"content_unittests\": \"7430ff3ceb44224e93f30c8e26e30c67cefdc21f\", \"crypto_unittests\": \"0aa8abaa8c8131db5579996cd009135ff7eb128f\", \"dbus_unittests\": \"8fc14604b9ab31afb94999979e675856d460ba64\", \"device_unittests\": \"84b6bae7d2e1e94f203e7a8f7c74348edd0112eb\", \"display_unittests\": \"4ca5e7cc7cc8be8dda9556f7fee87960d6a28161\", \"events_unittests\": \"cd1a7e84df536ebbe228e79230d5f1e833d375da\", \"exo_unittests\": \"aa473a458d3560c035a229b5a0f067f7a83c027e\", \"extensions_browsertests\": \"06fa2c447b65b9c70fb3fb3e3b11eb3ca6b8841c\", \"extensions_unittests\": \"3f9bc39418da8e57331443f74133de6fe65ef1f3\", \"filesystem_service_unittests\": \"1bd445675bbce06adf0adbf239887d7bc3892179\", \"gcm_unit_tests\": \"16414fd86130e21a160ef8b6ee4938030b9ff792\", \"gfx_unittests\": \"c0a1ff9276327990e3f7d196beaaa776b5a1dcf3\", \"gin_unittests\": \"adbd98482d68b654465a9be753ac4c6e0ac9da30\", \"gl_unittests_ozone\": \"e28562edb9cbeb9ffd27eed394d37c3494b82f91\", \"google_apis_unittests\": \"87acd5a4a454af97add71cd72c0b099aab3469ca\", \"gpu_unittests\": \"6032876a7315a27e4b6d0e45e7d79e454f98c159\", \"gwp_asan_unittests\": \"72cf43bc5059bedc6302558edd38817a28bbecb7\", \"interactive_ui_tests\": \"16258eb963255e98d84a4f3f11d7c651c5eeea6c\", \"ipc_tests\": \"fe30d433d8028843b4dd5d9e7740912445931ad2\", \"jingle_unittests\": \"2ac0187345cd07492d1910db8948f724365b5d07\", \"keyboard_unittests\": \"2cb65695f7a4bd324a68bb44efb776860a63d630\", \"latency_unittests\": \"285b926cfc347b0a83530139b89d0ad84e9c3c23\", \"libjingle_xmpp_unittests\": \"767b2bf52bd84286dcd8bccaaf9164e0985a50f0\", \"media_blink_unittests\": \"f4d8a18e787c7c395f8391bdd8647d25d30c12c7\", \"media_unittests\": \"3259d7fa562e448fdb6946927f4a199d7a99af00\", \"message_center_unittests\": \"e3fbade0a492945e68441e60dca70597eb1b2110\", \"midi_unittests\": \"993d032b4f4d79245bfbd359a550cfb8d96cd2f2\", \"mojo_core_unittests\": \"fde66b995bf1eaee402112130f7221880a74fe4d\", \"mojo_unittests\": \"77564675eadcfc7b7b25e662f83b2523d99f2729\", \"nacl_helper_nonsfi_unittests\": \"528ea151bf3c49e65fc668cedbe1c9c8cdc10d3f\", \"nacl_loader_unittests\": \"917a40791d2c094cdbb9380860565f1c6e737be0\", \"native_theme_unittests\": \"3fa286ccecbb1b8a09d164f646298744d2a70baf\", \"net_unittests\": \"654b243c163a4a145b7cca4c94cad0739dcfd518\", \"ozone_gl_unittests\": \"df3aec4bccdf59e99515fffec4e6519cfb210dce\", \"ozone_unittests\": \"d016aa7f3706dfe826cbc1d93afbb4420a417e5f\", \"ozone_x11_unittests\": \"bd5f610c04011bc44817c71964937b0aeecaa765\", \"pdf_unittests\": \"80311357f83469f5c54e3f0a939dd7c264e458b3\", \"perfetto_unittests\": \"5f3dd3d94f67ec371fb766510bb9f9f5d0451598\", \"ppapi_unittests\": \"52f33d94fcfb03cb6d8d01970b491f0e947f528b\", \"printing_unittests\": \"49aac0dd23a81a6764d0746bc65f026eaef0e3a9\", \"remoting_unittests\": \"f011df6e55ff3e82d94fca9dc8fd9c0ec5d207be\", \"sandbox_linux_unittests\": \"8dfbfefafc8734e95ae16409e466f2abc29f72de\", \"service_manager_unittests\": \"2bcc9855d6fb0c1f3ff3a6a26f89321e14eed18d\", \"services_unittests\": \"ff1613fb57e82010e587f7c4f8ae8ae0176485ce\", \"shell_dialogs_unittests\": \"1b821ba092d654fd050913092d67cce42e37af0a\", \"skia_unittests\": \"be29d09f783bf6d8f48a9f6d9e4d53d89c40d199\", \"snapshot_unittests\": \"63867c09b9df16824d1ad33210219494c6f13315\", \"sql_unittests\": \"1f5f0a65e4bfad7faaa144c7ddc5325faf76346f\", \"storage_unittests\": \"89a85731b8279472680dbf3eb193219f34469ac7\", \"sync_integration_tests\": \"e2fe921019b309019a90f6f0f3225a98710a758e\", \"traffic_annotation_auditor_unittests\": \"f9775afa15e28d30793354d0490cd2d60ca37bd3\", \"ui_base_unittests\": \"4a6ac931d67ebbc3b1821c18334201b5ab44660b\", \"ui_chromeos_unittests\": \"a1386b44154a94be0327413b22e0b5fc41fa0d90\", \"ui_touch_selection_unittests\": \"950b24eab0e0966d2824e26c7aec5835fd48d293\", \"unit_tests\": \"89d89545e0bb9765be20f1ffacd2752707928498\", \"url_unittests\": \"fd1ae726c16cb65334df7cd63051db6c5cb3a1dc\", \"usage_time_limit_unittests\": \"4b1e3f2366b51909ffdbe94fd29414fcf38e8db7\", \"views_unittests\": \"f9e6602c295200a711bb8c04fc276e73c82309a7\", \"viz_unittests\": \"bf6c89d5b4d02e45b88ee0ffdc35b84f8e0e10d0\", \"wayland_client_perftests\": \"8e4616a4752d7708bd8a3f81c6ade778207e1e4d\", \"wm_unittests\": \"4f4ab096898fa2f9eb0692ea3869eb98f38408d5\", \"wtf_unittests\": \"c495b7557a4d63572a39a4d9886243baca3d87f2\", \"zlib_unittests\": \"ee28b915f0347a8bd817962d6716d24fff25721b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_544ce64b59aa2a62f93b2d1058d8c643105c17650fa0dc2da4c94ddccafb95f6_v2\", \"builder_94dc7d486ab1bafc5bfb11010ef18f0cf20e8e07ae86b58c09f57ba294c280ac_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_cfdb55a1f65ed072d1fe07f7fc1107a97a5e848a8d1b6b0015401ab521f6b501_v2\", \"builder_d6c402558de63915dde657133f192d995a5b729212ea1587a5d59fbce371e332_v2\", \"builder_ddf530b99db2c48999a16b04f27f886d0f06df616543b36733eb8d0558bd23f5_v2\", \"builder_ffe623326ac74578ce917ff55ef6cefa75094e5ad3ad5fe3409a729d79be647a_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-61-durd\"], \"image\": [\"chrome-xenial-20101800-2d400e1627f\"], \"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\": [\"5613-2fddb4d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603839467042624",
"status": "COMPLETED",
"status_changed_ts": "1603842650031418",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42324",
"builder:linux-chromeos-rel",
"buildset:commit/git/ecb93f4dce5da17cfc0543a4f2d2a904e41592cb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ecb93f4dce5da17cfc0543a4f2d2a904e41592cb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030676265803056416",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8865246203385985616/+/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:4f8518c7f59aae10",
"user_agent:luci-scheduler"
],
"updated_ts": "1603842650036057",
"url": "https://ci.chromium.org/b/8865246203385985616",
"utcnow_ts": "1603842651021370"
}
}
[23:50:51.034] Invocation finished in 54m3.301418672s with status SUCCEEDED