[19:42:54.378] New invocation is queued and will start shortly
[19:42:55.497] Starting the invocation (attempt 1)
[19:42:55.556] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:42:55.556] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:42:55.556] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9052159945314284256",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"895dd46461c818a63bbbc2db4f9e2c9f9967e86f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9052159945314284256",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/895dd46461c818a63bbbc2db4f9e2c9f9967e86f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/895dd46461c818a63bbbc2db4f9e2c9f9967e86f",
"gitiles_ref:refs/heads/master"
]
}
[19:42:56.282] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1583350975667049",
"id": "8886729883297429376",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"895dd46461c818a63bbbc2db4f9e2c9f9967e86f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1583350975995761",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169335",
"builder:Linux Builder (dbg)",
"buildset:commit/git/895dd46461c818a63bbbc2db4f9e2c9f9967e86f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/895dd46461c818a63bbbc2db4f9e2c9f9967e86f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052159945314284256",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8886729883297429376/+/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": "1583350975995885",
"url": "https://ci.chromium.org/b/8886729883297429376",
"utcnow_ts": "1583350976260365"
}
}
[19:42:56.282] Task URL: https://ci.chromium.org/b/8886729883297429376
[19:42:56.282] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:2:0) after 1m0s
[19:43:56.379] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:2:0)
[19:43:56.379] Timer tick, asking Buildbucket for the build status
[19:43:56.584] Build 8886729883297429376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:43:56.584] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:3:0) after 1m0s
[19:44:56.786] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:3:0)
[19:44:56.786] Timer tick, asking Buildbucket for the build status
[19:44:56.983] Build 8886729883297429376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:44:56.983] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:4:0) after 1m0s
[19:45:57.133] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:4:0)
[19:45:57.133] Timer tick, asking Buildbucket for the build status
[19:45:57.232] Build 8886729883297429376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:45:57.232] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:5:0) after 1m0s
[19:46:57.358] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:5:0)
[19:46:57.358] Timer tick, asking Buildbucket for the build status
[19:46:57.460] Build 8886729883297429376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:46:57.460] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:6:0) after 1m0s
[19:47:04.782] Received PubSub notification, asking Buildbucket for the build status
[19:47:04.879] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:57.596] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:6:0)
[19:47:57.596] Timer tick, asking Buildbucket for the build status
[19:47:57.688] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:57.688] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:8:0) after 1m0s
[19:48:58.483] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:8:0)
[19:48:58.483] Timer tick, asking Buildbucket for the build status
[19:48:58.589] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:58.589] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:9:0) after 1m0s
[19:49:58.913] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:9:0)
[19:49:58.913] Timer tick, asking Buildbucket for the build status
[19:49:59.042] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:59.042] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:10:0) after 1m0s
[19:50:59.112] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:10:0)
[19:50:59.112] Timer tick, asking Buildbucket for the build status
[19:50:59.384] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:59.384] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:11:0) after 1m0s
[19:51:59.554] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:11:0)
[19:51:59.554] Timer tick, asking Buildbucket for the build status
[19:51:59.694] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:59.694] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:12:0) after 1m0s
[19:52:59.831] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:12:0)
[19:52:59.831] Timer tick, asking Buildbucket for the build status
[19:52:59.970] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:59.970] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:13:0) after 1m0s
[19:54:00.859] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:13:0)
[19:54:00.859] Timer tick, asking Buildbucket for the build status
[19:54:01.052] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:01.052] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:14:0) after 1m0s
[19:55:01.290] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:14:0)
[19:55:01.290] Timer tick, asking Buildbucket for the build status
[19:55:01.426] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:01.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:15:0) after 1m0s
[19:56:01.790] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:15:0)
[19:56:01.790] Timer tick, asking Buildbucket for the build status
[19:56:01.921] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:01.921] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:16:0) after 1m0s
[19:57:01.997] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:16:0)
[19:57:01.997] Timer tick, asking Buildbucket for the build status
[19:57:02.106] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:02.106] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:17:0) after 1m0s
[19:58:02.224] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:17:0)
[19:58:02.224] Timer tick, asking Buildbucket for the build status
[19:58:02.324] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:02.324] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:18:0) after 1m0s
[19:59:02.384] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:18:0)
[19:59:02.384] Timer tick, asking Buildbucket for the build status
[19:59:02.488] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:02.488] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:19:0) after 1m0s
[20:00:02.658] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:19:0)
[20:00:02.658] Timer tick, asking Buildbucket for the build status
[20:00:02.781] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:02.781] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:20:0) after 1m0s
[20:01:02.893] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:20:0)
[20:01:02.893] Timer tick, asking Buildbucket for the build status
[20:01:03.177] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:03.177] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:21:0) after 1m0s
[20:02:03.233] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:21:0)
[20:02:03.233] Timer tick, asking Buildbucket for the build status
[20:02:03.474] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:03.474] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:22:0) after 1m0s
[20:03:03.745] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:22:0)
[20:03:03.745] Timer tick, asking Buildbucket for the build status
[20:03:03.859] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:03.859] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:23:0) after 1m0s
[20:04:03.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:23:0)
[20:04:03.994] Timer tick, asking Buildbucket for the build status
[20:04:04.111] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:04.111] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:24:0) after 1m0s
[20:05:04.225] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:24:0)
[20:05:04.225] Timer tick, asking Buildbucket for the build status
[20:05:04.449] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:04.449] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:25:0) after 1m0s
[20:06:04.584] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:25:0)
[20:06:04.585] Timer tick, asking Buildbucket for the build status
[20:06:04.780] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:04.780] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:26:0) after 1m0s
[20:07:04.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:26:0)
[20:07:04.871] Timer tick, asking Buildbucket for the build status
[20:07:05.082] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:05.082] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:27:0) after 1m0s
[20:08:05.144] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:27:0)
[20:08:05.144] Timer tick, asking Buildbucket for the build status
[20:08:05.301] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:05.301] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:28:0) after 1m0s
[20:09:05.321] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:28:0)
[20:09:05.321] Timer tick, asking Buildbucket for the build status
[20:09:05.487] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:05.487] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:29:0) after 1m0s
[20:10:05.522] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:29:0)
[20:10:05.522] Timer tick, asking Buildbucket for the build status
[20:10:05.623] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:05.623] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:30:0) after 1m0s
[20:11:05.729] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:30:0)
[20:11:05.729] Timer tick, asking Buildbucket for the build status
[20:11:06.014] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:06.014] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:31:0) after 1m0s
[20:12:06.112] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:31:0)
[20:12:06.112] Timer tick, asking Buildbucket for the build status
[20:12:06.547] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:06.547] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:32:0) after 1m0s
[20:13:06.586] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:32:0)
[20:13:06.586] Timer tick, asking Buildbucket for the build status
[20:13:06.778] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:06.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:33:0) after 1m0s
[20:14:06.935] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:33:0)
[20:14:06.935] Timer tick, asking Buildbucket for the build status
[20:14:07.354] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:07.354] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:34:0) after 1m0s
[20:15:07.422] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:34:0)
[20:15:07.422] Timer tick, asking Buildbucket for the build status
[20:15:07.561] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:07.562] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:35:0) after 1m0s
[20:16:07.620] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:35:0)
[20:16:07.620] Timer tick, asking Buildbucket for the build status
[20:16:07.787] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:07.787] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:36:0) after 1m0s
[20:17:07.904] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:36:0)
[20:17:07.904] Timer tick, asking Buildbucket for the build status
[20:17:08.424] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:08.424] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:37:0) after 1m0s
[20:18:08.598] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:37:0)
[20:18:08.598] Timer tick, asking Buildbucket for the build status
[20:18:08.692] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:08.692] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:38:0) after 1m0s
[20:19:08.768] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:38:0)
[20:19:08.768] Timer tick, asking Buildbucket for the build status
[20:19:09.024] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:09.024] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:39:0) after 1m0s
[20:20:09.059] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:39:0)
[20:20:09.059] Timer tick, asking Buildbucket for the build status
[20:20:09.286] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:09.286] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:40:0) after 1m0s
[20:21:09.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:40:0)
[20:21:09.333] Timer tick, asking Buildbucket for the build status
[20:21:09.422] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:09.422] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:41:0) after 1m0s
[20:22:09.485] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:41:0)
[20:22:09.485] Timer tick, asking Buildbucket for the build status
[20:22:09.589] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:09.589] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:42:0) after 1m0s
[20:23:09.682] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:42:0)
[20:23:09.682] Timer tick, asking Buildbucket for the build status
[20:23:09.897] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:09.897] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:43:0) after 1m0s
[20:24:10.027] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:43:0)
[20:24:10.027] Timer tick, asking Buildbucket for the build status
[20:24:10.138] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:10.138] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:44:0) after 1m0s
[20:25:10.400] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:44:0)
[20:25:10.400] Timer tick, asking Buildbucket for the build status
[20:25:10.735] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:10.735] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:45:0) after 1m0s
[20:26:10.803] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:45:0)
[20:26:10.803] Timer tick, asking Buildbucket for the build status
[20:26:10.920] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:10.920] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:46:0) after 1m0s
[20:27:10.953] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:46:0)
[20:27:10.953] Timer tick, asking Buildbucket for the build status
[20:27:11.108] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:11.108] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:47:0) after 1m0s
[20:28:11.180] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:47:0)
[20:28:11.180] Timer tick, asking Buildbucket for the build status
[20:28:11.562] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:11.562] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:48:0) after 1m0s
[20:29:11.596] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:48:0)
[20:29:11.596] Timer tick, asking Buildbucket for the build status
[20:29:13.800] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:13.800] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:49:0) after 1m0s
[20:30:13.810] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:49:0)
[20:30:13.810] Timer tick, asking Buildbucket for the build status
[20:30:14.195] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:14.195] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:50:0) after 1m0s
[20:31:14.248] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:50:0)
[20:31:14.248] Timer tick, asking Buildbucket for the build status
[20:31:14.457] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:14.457] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:51:0) after 1m0s
[20:32:14.590] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:51:0)
[20:32:14.591] Timer tick, asking Buildbucket for the build status
[20:32:14.731] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:14.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:52:0) after 1m0s
[20:33:14.779] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:52:0)
[20:33:14.779] Timer tick, asking Buildbucket for the build status
[20:33:14.882] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:14.882] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:53:0) after 1m0s
[20:34:14.915] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:53:0)
[20:34:14.915] Timer tick, asking Buildbucket for the build status
[20:34:15.112] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:15.112] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:54:0) after 1m0s
[20:35:15.206] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:54:0)
[20:35:15.206] Timer tick, asking Buildbucket for the build status
[20:35:15.743] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:15.743] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:55:0) after 1m0s
[20:36:15.755] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:55:0)
[20:36:15.755] Timer tick, asking Buildbucket for the build status
[20:36:16.031] Build 8886729883297429376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:16.031] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052159945314284256:56:0) after 1m0s
[20:36:57.460] Received PubSub notification, asking Buildbucket for the build status
[20:36:57.517] Build 8886729883297429376: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:36:57.517] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1583354213804264",
"created_by": "project:chromium",
"created_ts": "1583350975667049",
"id": "8886729883297429376",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"895dd46461c818a63bbbc2db4f9e2c9f9967e86f\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-central1-b-8-4-8mu3\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 169335, \"got_angle_revision\": \"27a813089d835c1ad706237c7adf70f5e0e1f59f\", \"got_dawn_revision\": \"35645a601a73c26e40e9ddf20f2f685acacf7bde\", \"got_nacl_revision\": \"35bcc9f6d5e81c3c39ad57de97ef9cd22301ee9e\", \"got_revision\": \"895dd46461c818a63bbbc2db4f9e2c9f9967e86f\", \"got_revision_cp\": \"refs/heads/master@{#746890}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"2e6cd9c400d193592e3a1f17aa200e50c152e5d9\", \"got_v8_revision\": \"ad298fa351b6b1f968d6a9da0e40e893f791f5be\", \"got_v8_revision_cp\": \"refs/heads/8.2.257@{#1}\", \"got_webrtc_revision\": \"589b41e743db232fabde3f24653c76db45d6cedf\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30680}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"895dd46461c818a63bbbc2db4f9e2c9f9967e86f\", \"swarm_hashes_refs/heads/master(at){#746890}_without_patch\": {\"accessibility_unittests\": \"4e903c5283a869ba7242b2c6299dc01cbb9250b7\", \"angle_unittests\": \"c5cef8304349bc97a70e19ce448a7a4861dc627e\", \"app_shell_unittests\": \"5ddf1a3a7cc7be70f7f41e2abb33636b3aef3aac\", \"aura_unittests\": \"32899e28fdc1fb25e5bd28c4e9dac14d460d5b35\", \"base_unittests\": \"6a5e7c4830df0f95293d126bf736a49be05a4520\", \"base_util_unittests\": \"d0b7182d93a9c62804f548e63a1865035d050068\", \"blink_common_unittests\": \"231b1934deb16ea3ae0800409ce7de13137f5f63\", \"blink_fuzzer_unittests\": \"98d31bba5daa26d26e525705fe596c1ce0112a3f\", \"blink_heap_unittests\": \"4deadffdbd182d5c83e6291c8b11a44417d4bdec\", \"blink_platform_unittests\": \"795e44f0ccf1d293f625da807a495b21c86b8329\", \"blink_python_tests\": \"7d68703cbebb79c391aef8559a7ddaea2cb98d20\", \"blink_unittests\": \"2ea9c8b6bf76069537f95020317f9b307aae2edf\", \"blink_web_tests\": \"a770eedabd3e1c0dedc786ff973f75122dba7f68\", \"boringssl_crypto_tests\": \"1fe353e65229134ba76f59d2c08b26f412855470\", \"boringssl_ssl_tests\": \"ce4b9d64c6f7e079b2fa1611491c7e5824fafc87\", \"browser_tests\": \"b27b1a732ed69ae84db6d9463a540efc9a1a1dc5\", \"cacheinvalidation_unittests\": \"fa5d154244fdde046baf62451c55582a6f41fca2\", \"capture_unittests\": \"2b57f9ba66689f40858a20255ae8faff7be3bf9e\", \"cast_unittests\": \"02fd8dea282d81f0324f4d19194388addafc0ad0\", \"cc_unittests\": \"9c8d680b6ab5ce400d7baebdafdbcf5bcdd4d5d7\", \"chrome_app_unittests\": \"3fc2d9db19c56d5faa79e8eb1cb5632869c02e50\", \"chromedriver_unittests\": \"e79c9a32697b83b36871e502cc808e26f748a9df\", \"components_browsertests\": \"a8e13ce13d1f237d037d43a7a129a9dcd27f668b\", \"components_unittests\": \"bd1e3ff8fa42bb06b14cafbd5f38b2f249b3980b\", \"compositor_unittests\": \"b39f20b713999eb9b1c0c5ae5db4e15fe6023dc5\", \"content_browsertests\": \"1e13285a6c58fb266494ed15b46dafd3129e8f8e\", \"content_shell_crash_test\": \"9e5d2da75bd6be4516f3d8fd1480a5e7ffa51ae1\", \"content_unittests\": \"cd93f0985f30a917b06adca2423042b2a3f924a0\", \"crashpad_tests\": \"b13ee6ab716ae68df0cf3b60dcdb9abbe9efe300\", \"cronet_tests\": \"22fefcda1a3979bd180a2173b4e826db73be8e70\", \"cronet_unittests\": \"249fa97e6ef0b58567bae149c57ae60e6bb0ea4b\", \"crypto_unittests\": \"47ab3e134ac3f1eb187513f491912d2c5cf51dd8\", \"dbus_unittests\": \"397a6305c064d34e426af448af7e93e57f365d7c\", \"device_unittests\": \"16266e8f77bc9f4cbf07f4b73a552f163d783222\", \"display_unittests\": \"b98e768b42cbfc81157a01f3c06b43319a9fbeaa\", \"events_unittests\": \"d04209b23995184dac0d5b3c83e2a37b30da837f\", \"extensions_browsertests\": \"4bf5a0cecf457e2449405cd285b9992e7b7c5c66\", \"extensions_unittests\": \"78cc65900dd84f7f6612a9bee8f5fd95ce446b32\", \"filesystem_service_unittests\": \"5e9de98dc1bf62a7195d84e48c6d6a3fd20152f3\", \"flatbuffers_unittests\": \"501dfa51280eae93fccecaec30d9257cff6dbcc8\", \"gcm_unit_tests\": \"0a08e4e7aec499f487f003f99523c01326aab96c\", \"gfx_unittests\": \"ddc3f98a7d0d9edb55621b5445420f33192db7a5\", \"gin_unittests\": \"37b3796fab64ab4e28f5e58f19a90c266f9f47dc\", \"google_apis_unittests\": \"061b8eb274f7036d4b03dcb9c86d11793484999a\", \"gpu_unittests\": \"3383daecef97da814afe5d4e3c8fd9a8de4510dd\", \"grit_python_unittests\": \"300ea8455288eab00cd459e887bd99a4f6468e8a\", \"gwp_asan_unittests\": \"a10fe7568fc08cbfdd389a04215fdc85a6e89176\", \"headless_browsertests\": \"40367f13568b903113c5aa32166e2f8675ff3f9c\", \"headless_unittests\": \"07795002b009dd26fda22b2d84aeb8d52239f4e0\", \"interactive_ui_tests\": \"1f4217a4b21a15ebe3d7e3a3550d6decb766c15b\", \"ipc_tests\": \"b2135cd97ada3c7eedae8d56f4c3f53ef97d3003\", \"jingle_unittests\": \"cb05757357e55d38cb9c3e84aed0c4a8b351d7f8\", \"latency_unittests\": \"69e69dfcec7a794173ac90ee2fcac31d7d476434\", \"libjingle_xmpp_unittests\": \"60389bed39a04b8a314c0d4f30204db3adc55766\", \"media_blink_unittests\": \"c11b8853e4265b8db1c9bb217e239e50021e015d\", \"media_service_unittests\": \"7c873c8ba39347206950c01c7694b86efd771e65\", \"media_unittests\": \"2d613af163e098ee54d11ecea9418b9d3359f0f4\", \"message_center_unittests\": \"173bc48698310381164559cd9b17c9a509b32eff\", \"metrics_python_tests\": \"3ff193139eb743d481e530e82089531d9d338f1a\", \"midi_unittests\": \"844bee6d02e23a9ef49d01c9221b8bea56f2651d\", \"mojo_core_unittests\": \"878443d04896f9c216be534d676ea899041428ef\", \"mojo_unittests\": \"8a5cc138f62d3a29410bb7649802300105de3215\", \"nacl_helper_nonsfi_unittests\": \"acb732f37f85e292eaad9db75f39e832aebd59df\", \"nacl_loader_unittests\": \"89539c1e5fe576eec0f35e0ea08abd8c61fef02b\", \"native_theme_unittests\": \"8466c6bb7060ad409475629b6dacdf6f4ecc7edb\", \"net_unittests\": \"a9fc196693bda40bfa37767d3753ed18c63c55cf\", \"pdf_unittests\": \"15592a106c880ffe8aa3969d945e58f078933c7f\", \"perfetto_unittests\": \"91d94a612962d5d64ab7476f240f287803ec17b5\", \"ppapi_unittests\": \"01ac7b488b6bfca2a4aa5dd4f7f4f79a226498e2\", \"printing_unittests\": \"e303a2e247120feb536341f104d9371b7f7a928f\", \"remoting_unittests\": \"73fd7a816652a5a9acc4ec6d0d132a695333c3ed\", \"sandbox_linux_unittests\": \"f65a43eabd60547200cbfcb84ce2724218dfe36f\", \"service_manager_unittests\": \"69e7e83f6cc905e45cebab601b7581376afa0b1c\", \"services_unittests\": \"3f1f6efb8914f478c4669ceb704adf66fce42758\", \"shell_dialogs_unittests\": \"fb7fc0b520b6d932adf4200ad421c45f82df47cf\", \"skia_unittests\": \"b639c595d162b74b010b51c2a98cbd2c118339bd\", \"snapshot_unittests\": \"b9881d2397e0ba0eb8972a8bc1135db805c4544f\", \"sql_unittests\": \"24c709ea85b52c891f7a175163045b9004ba20cd\", \"storage_unittests\": \"46321e3a76aad1308a5eb575b8aa7da919f9adde\", \"sync_integration_tests\": \"92bf9acf0a7586f41ed35fec5b81e45732c43f05\", \"telemetry_gpu_unittests\": \"b555d036400d760adf1252e7638384d2828f3c59\", \"telemetry_perf_unittests\": \"556726cf4b039c625dff8cf3d4f80b5fdd8e35f2\", \"telemetry_unittests\": \"4d5ca56d0d1302f5d8e7450fc5ce667eaedbc4e4\", \"traffic_annotation_auditor_unittests\": \"6edc7b1084e58fca0163c38b3a643f82ae34d9a5\", \"ui_base_unittests\": \"09dca91706a44694cb2edc3f4fb5037ced3f1a32\", \"ui_touch_selection_unittests\": \"bca51dfd1d4514c535a5882227791f9e03b8bbae\", \"unit_tests\": \"2b47255ad122dc970115d17146cda5efd633b31f\", \"url_unittests\": \"67a837476d6d412d88a976127a441332029e0a03\", \"views_perftests\": \"5c6fad9897a078a4e1e0430d8643ac31d5c3b435\", \"views_unittests\": \"66dbeabe8b9509094654e3a7b2a5c575deb4442b\", \"viz_unittests\": \"58f44230450612d576a7f411f8f5820fcbcae851\", \"vr_common_unittests\": \"2e16e21548b092a0c842db8e63bb5a359c6d8f29\", \"vr_pixeltests\": \"775b8d2fcbd2337d335e5afb5a0f9dd75ac2dbf2\", \"webdriver_wpt_tests\": \"4ed4dd20ce342f9536743dca81d15592ecf5b232\", \"weblayer_browsertests\": \"35b2f44dc952df6ac62f9600691e983911e1211f\", \"wm_unittests\": \"666552ae6ec4c43e48d2071f21a727f2d029fc96\", \"wtf_unittests\": \"06046d2a24a8a62f0269dbc734479aaa5cbddbd0\", \"xr_browser_tests\": \"29d1040e1b8775b0ea04741a25096c608e920fc5\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1855fffe06c5131ebf89186d4b9c18984f724019f1e040002bd6399dfa18192c_v2\", \"builder_36472ddafb4960b563fa0dfd4883d4c097bf9805cea97d60ada20c6be0c80514_v2\", \"builder_45c5b54513fd8d251ddf48af87bd70552077e6f51953669d04eaa4296b96a344_v2\", \"builder_980e79f61a9eb10b3ecd5f710f08f0308a5299da9889db3d2b6a7010c019cc1f_v2\", \"builder_fa0031875b7f2f11c46443055ab400bfaeb07a1d2a142b58c631314016c04e0a_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-4-8mu3\"], \"image\": [\"chrome-xenial-20030100-2bddf837f90\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4851-268d16b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1583351223771389",
"status": "COMPLETED",
"status_changed_ts": "1583354214611286",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169335",
"builder:Linux Builder (dbg)",
"buildset:commit/git/895dd46461c818a63bbbc2db4f9e2c9f9967e86f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/895dd46461c818a63bbbc2db4f9e2c9f9967e86f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052159945314284256",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8886729883297429376/+/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:4abfe41941cced10",
"user_agent:luci-scheduler"
],
"updated_ts": "1583354214621994",
"url": "https://ci.chromium.org/b/8886729883297429376",
"utcnow_ts": "1583354217508622"
}
}
[20:36:57.518] Invocation finished in 54m3.157688269s with status SUCCEEDED