[01:23:05.626] New invocation is queued and will start shortly
[01:23:06.791] Starting the invocation (attempt 1)
[01:23:06.855] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:23:06.855] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:23:06.856] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029126913115969008",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ba04a73c99869cede1e8132d0707af5fa5aede68\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9029126913115969008",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/ba04a73c99869cede1e8132d0707af5fa5aede68",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ba04a73c99869cede1e8132d0707af5fa5aede68",
"gitiles_ref:refs/heads/master"
]
}
[01:23:07.522] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605316986955623",
"id": "8863696851044682800",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ba04a73c99869cede1e8132d0707af5fa5aede68\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605316987369800",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177666",
"builder:Linux Builder (dbg)",
"buildset:commit/git/ba04a73c99869cede1e8132d0707af5fa5aede68",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ba04a73c99869cede1e8132d0707af5fa5aede68",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029126913115969008",
"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/8863696851044682800/+/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": "1605316987369929",
"url": "https://ci.chromium.org/b/8863696851044682800",
"utcnow_ts": "1605316987510720"
}
}
[01:23:07.522] Task URL: https://ci.chromium.org/b/8863696851044682800
[01:23:07.522] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:2:0) after 1m0s
[01:24:07.521] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:2:0)
[01:24:07.521] Timer tick, asking Buildbucket for the build status
[01:24:07.628] Build 8863696851044682800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:24:07.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:3:0) after 1m0s
[01:25:07.653] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:3:0)
[01:25:07.653] Timer tick, asking Buildbucket for the build status
[01:25:07.995] Build 8863696851044682800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:25:07.995] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:4:0) after 1m0s
[01:25:44.459] Received PubSub notification, asking Buildbucket for the build status
[01:25:44.548] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:08.125] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:4:0)
[01:26:08.125] Timer tick, asking Buildbucket for the build status
[01:26:08.245] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:08.245] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:6:0) after 1m0s
[01:27:08.267] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:6:0)
[01:27:08.267] Timer tick, asking Buildbucket for the build status
[01:27:10.248] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:10.248] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:7:0) after 1m0s
[01:28:10.350] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:7:0)
[01:28:10.350] Timer tick, asking Buildbucket for the build status
[01:28:10.907] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:10.907] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:8:0) after 1m0s
[01:29:10.927] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:8:0)
[01:29:10.927] Timer tick, asking Buildbucket for the build status
[01:29:11.063] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:11.063] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:9:0) after 1m0s
[01:30:11.053] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:9:0)
[01:30:11.053] Timer tick, asking Buildbucket for the build status
[01:30:11.151] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:11.151] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:10:0) after 1m0s
[01:31:11.180] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:10:0)
[01:31:11.180] Timer tick, asking Buildbucket for the build status
[01:31:11.294] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:11.294] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:11:0) after 1m0s
[01:32:11.316] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:11:0)
[01:32:11.316] Timer tick, asking Buildbucket for the build status
[01:32:11.392] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:11.392] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:12:0) after 1m0s
[01:33:11.404] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:12:0)
[01:33:11.404] Timer tick, asking Buildbucket for the build status
[01:33:11.562] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:11.562] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:13:0) after 1m0s
[01:34:11.592] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:13:0)
[01:34:11.592] Timer tick, asking Buildbucket for the build status
[01:34:11.671] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:11.671] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:14:0) after 1m0s
[01:35:11.692] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:14:0)
[01:35:11.692] Timer tick, asking Buildbucket for the build status
[01:35:11.915] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:11.915] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:15:0) after 1m0s
[01:36:11.948] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:15:0)
[01:36:11.948] Timer tick, asking Buildbucket for the build status
[01:36:12.023] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:12.023] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:16:0) after 1m0s
[01:37:12.044] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:16:0)
[01:37:12.044] Timer tick, asking Buildbucket for the build status
[01:37:12.123] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:12.123] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:17:0) after 1m0s
[01:38:12.177] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:17:0)
[01:38:12.177] Timer tick, asking Buildbucket for the build status
[01:38:12.316] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:12.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:18:0) after 1m0s
[01:39:12.393] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:18:0)
[01:39:12.393] Timer tick, asking Buildbucket for the build status
[01:39:12.539] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:12.539] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:19:0) after 1m0s
[01:40:12.552] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:19:0)
[01:40:12.552] Timer tick, asking Buildbucket for the build status
[01:40:12.824] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:12.824] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:20:0) after 1m0s
[01:41:12.886] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:20:0)
[01:41:12.886] Timer tick, asking Buildbucket for the build status
[01:41:12.953] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:12.953] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:21:0) after 1m0s
[01:42:12.999] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:21:0)
[01:42:12.999] Timer tick, asking Buildbucket for the build status
[01:42:13.120] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:13.120] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:22:0) after 1m0s
[01:43:13.201] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:22:0)
[01:43:13.201] Timer tick, asking Buildbucket for the build status
[01:43:13.326] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:13.326] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:23:0) after 1m0s
[01:44:13.348] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:23:0)
[01:44:13.348] Timer tick, asking Buildbucket for the build status
[01:44:13.428] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:13.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:24:0) after 1m0s
[01:45:13.513] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:24:0)
[01:45:13.513] Timer tick, asking Buildbucket for the build status
[01:45:13.585] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:13.585] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:25:0) after 1m0s
[01:46:13.675] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:25:0)
[01:46:13.675] Timer tick, asking Buildbucket for the build status
[01:46:13.739] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:13.739] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:26:0) after 1m0s
[01:47:13.787] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:26:0)
[01:47:13.787] Timer tick, asking Buildbucket for the build status
[01:47:22.863] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:22.863] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:27:0) after 1m0s
[01:48:23.210] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:27:0)
[01:48:23.210] Timer tick, asking Buildbucket for the build status
[01:48:23.320] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:23.320] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:28:0) after 1m0s
[01:49:23.568] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:28:0)
[01:49:23.568] Timer tick, asking Buildbucket for the build status
[01:49:23.653] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:23.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:29:0) after 1m0s
[01:50:23.808] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:29:0)
[01:50:23.808] Timer tick, asking Buildbucket for the build status
[01:50:24.419] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:24.419] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:30:0) after 1m0s
[01:51:24.481] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:30:0)
[01:51:24.481] Timer tick, asking Buildbucket for the build status
[01:51:24.540] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:24.540] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:31:0) after 1m0s
[01:52:24.638] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:31:0)
[01:52:24.638] Timer tick, asking Buildbucket for the build status
[01:52:24.706] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:24.706] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:32:0) after 1m0s
[01:53:24.753] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:32:0)
[01:53:24.753] Timer tick, asking Buildbucket for the build status
[01:53:24.879] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:24.879] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:33:0) after 1m0s
[01:54:25.017] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:33:0)
[01:54:25.017] Timer tick, asking Buildbucket for the build status
[01:54:25.601] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:25.601] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:34:0) after 1m0s
[01:55:25.677] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:34:0)
[01:55:25.677] Timer tick, asking Buildbucket for the build status
[01:55:25.754] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:25.754] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:35:0) after 1m0s
[01:56:25.985] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:35:0)
[01:56:25.985] Timer tick, asking Buildbucket for the build status
[01:56:26.050] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:26.050] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:36:0) after 1m0s
[01:57:26.249] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:36:0)
[01:57:26.249] Timer tick, asking Buildbucket for the build status
[01:57:26.321] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:26.321] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:37:0) after 1m0s
[01:58:26.455] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:37:0)
[01:58:26.455] Timer tick, asking Buildbucket for the build status
[01:58:26.562] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:26.562] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:38:0) after 1m0s
[01:59:26.562] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:38:0)
[01:59:26.562] Timer tick, asking Buildbucket for the build status
[01:59:26.655] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:26.655] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:39:0) after 1m0s
[02:00:26.813] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:39:0)
[02:00:26.813] Timer tick, asking Buildbucket for the build status
[02:00:26.897] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:26.897] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:40:0) after 1m0s
[02:01:27.038] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:40:0)
[02:01:27.039] Timer tick, asking Buildbucket for the build status
[02:01:27.129] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:27.129] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:41:0) after 1m0s
[02:02:27.204] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:41:0)
[02:02:27.204] Timer tick, asking Buildbucket for the build status
[02:02:27.291] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:27.291] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:42:0) after 1m0s
[02:03:27.445] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:42:0)
[02:03:27.445] Timer tick, asking Buildbucket for the build status
[02:03:27.566] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:27.566] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:43:0) after 1m0s
[02:04:27.807] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:43:0)
[02:04:27.807] Timer tick, asking Buildbucket for the build status
[02:04:27.869] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:27.869] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:44:0) after 1m0s
[02:05:28.053] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:44:0)
[02:05:28.053] Timer tick, asking Buildbucket for the build status
[02:05:28.135] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:28.135] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:45:0) after 1m0s
[02:06:28.282] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:45:0)
[02:06:28.282] Timer tick, asking Buildbucket for the build status
[02:06:28.443] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:28.443] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:46:0) after 1m0s
[02:07:28.497] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:46:0)
[02:07:28.497] Timer tick, asking Buildbucket for the build status
[02:07:28.821] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:28.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:47:0) after 1m0s
[02:08:28.876] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:47:0)
[02:08:28.876] Timer tick, asking Buildbucket for the build status
[02:08:28.988] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:28.988] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:48:0) after 1m0s
[02:09:29.059] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:48:0)
[02:09:29.059] Timer tick, asking Buildbucket for the build status
[02:09:29.133] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:29.133] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:49:0) after 1m0s
[02:10:29.232] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:49:0)
[02:10:29.232] Timer tick, asking Buildbucket for the build status
[02:10:29.313] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:29.313] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:50:0) after 1m0s
[02:11:29.415] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:50:0)
[02:11:29.415] Timer tick, asking Buildbucket for the build status
[02:11:29.931] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:29.931] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:51:0) after 1m0s
[02:12:30.073] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:51:0)
[02:12:30.074] Timer tick, asking Buildbucket for the build status
[02:12:30.154] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:30.154] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:52:0) after 1m0s
[02:13:30.366] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:52:0)
[02:13:30.366] Timer tick, asking Buildbucket for the build status
[02:13:30.604] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:30.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:53:0) after 1m0s
[02:14:30.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:53:0)
[02:14:30.782] Timer tick, asking Buildbucket for the build status
[02:14:31.084] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:31.084] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:54:0) after 1m0s
[02:15:31.168] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:54:0)
[02:15:31.168] Timer tick, asking Buildbucket for the build status
[02:15:31.492] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:31.492] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:55:0) after 1m0s
[02:16:31.568] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:55:0)
[02:16:31.568] Timer tick, asking Buildbucket for the build status
[02:16:31.825] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:31.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:56:0) after 1m0s
[02:17:31.872] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:56:0)
[02:17:31.872] Timer tick, asking Buildbucket for the build status
[02:17:32.026] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:32.026] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:57:0) after 1m0s
[02:18:32.072] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:57:0)
[02:18:32.072] Timer tick, asking Buildbucket for the build status
[02:18:32.196] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:32.196] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:58:0) after 1m0s
[02:19:32.208] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:58:0)
[02:19:32.208] Timer tick, asking Buildbucket for the build status
[02:19:32.263] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:32.263] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:59:0) after 1m0s
[02:20:32.285] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:59:0)
[02:20:32.285] Timer tick, asking Buildbucket for the build status
[02:20:32.352] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:32.352] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:60:0) after 1m0s
[02:21:32.413] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:60:0)
[02:21:32.413] Timer tick, asking Buildbucket for the build status
[02:21:32.491] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:32.491] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:61:0) after 1m0s
[02:22:32.546] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:61:0)
[02:22:32.546] Timer tick, asking Buildbucket for the build status
[02:22:32.715] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:32.715] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:62:0) after 1m0s
[02:23:32.775] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:62:0)
[02:23:32.775] Timer tick, asking Buildbucket for the build status
[02:23:32.893] Build 8863696851044682800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:32.893] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029126913115969008:63:0) after 1m0s
[02:24:22.997] Received PubSub notification, asking Buildbucket for the build status
[02:24:23.066] Build 8863696851044682800: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:24:23.066] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605320662110564",
"created_by": "project:chromium",
"created_ts": "1605316986955623",
"id": "8863696851044682800",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ba04a73c99869cede1e8132d0707af5fa5aede68\"}}",
"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\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"ba04a73c99869cede1e8132d0707af5fa5aede68\", \"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-central1-b-8-51-g66c\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 177666, \"got_angle_revision\": \"f46e6201b40bdee3e0b79d5d97660fc302fd76f5\", \"got_dawn_revision\": \"da1f66c8cee18677bf921181613732a9378e9864\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"ba04a73c99869cede1e8132d0707af5fa5aede68\", \"got_revision_cp\": \"refs/heads/master@{#827514}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e4c1a25cc6797a47043fc415c53b8edcd7b3e37e\", \"got_v8_revision\": \"2dbcdc105b963ee2501c82139eef7e0603977ff0\", \"got_v8_revision_cp\": \"refs/heads/8.8.278@{#1}\", \"got_webrtc_revision\": \"f42a94a7f50d697bdd1f94b584c94f86c5fff67a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32606}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ba04a73c99869cede1e8132d0707af5fa5aede68\", \"swarm_hashes_refs/heads/master(at){#827514}_without_patch\": {\"absl_hardening_tests\": \"c44b79deb66a1b8400dc82632d721a3fc6c1c938\", \"accessibility_unittests\": \"37eacace1e78ce5de0ed3245be1d48fa1a81ef25\", \"angle_unittests\": \"08f8fe1e965257584c23eed748b81ef1ba0da96b\", \"app_shell_unittests\": \"e01167a73e1508004dadfeb4b6a6dc80c06cf418\", \"aura_unittests\": \"b9b9487fa94079b1c79be550285bb65f05b2fe37\", \"base_unittests\": \"b15cae803269b27b0fb569db4e5925cc6ac26bd6\", \"base_util_unittests\": \"835fb34efe16e206d99ccd84a90792c095585d4a\", \"blink_common_unittests\": \"d66c203e291168bc16a520b022aa7557a103dcba\", \"blink_fuzzer_unittests\": \"1159ead9aca56c301d898c437782d79fcac43714\", \"blink_heap_unittests\": \"b2b8436be94a683b0ddb5124bfb0f4e0f816de9c\", \"blink_platform_unittests\": \"38057cd36f07f79bed0a9f09ceffb29652ac6fa9\", \"blink_python_tests\": \"53f9a1fc562ad1139350af73f9b7e7f666739369\", \"blink_unittests\": \"c1033ea8426adbe6c79962bda0e7c261646719a5\", \"blink_web_tests\": \"21073e88eb6f3201b1cadba114d64eccf00f59d9\", \"boringssl_crypto_tests\": \"65904d19cf929db2a63612af434498353852bd91\", \"boringssl_ssl_tests\": \"384d2967dfd0f56cdee98a73fd6ee411bb0c7d7c\", \"browser_tests\": \"0b0dac4fdb6d2c9a23aa5bbce0a3cc8540ce2715\", \"capture_unittests\": \"c6d1fb2c4e8a4e1cde18c38591835b9ca739886c\", \"cast_unittests\": \"abf6406da7bd4c5bcd88ea8bbd6d174564c61049\", \"cc_unittests\": \"cccd07dcc9fb7ac390593d8c1e8cf42433fae889\", \"chrome_app_unittests\": \"5a7ae07b6e1a0fd6a56f0dd9e5418cbf703391fa\", \"chromedriver_unittests\": \"333d986b94069e9f7ebac2f7a2ca11b22b2f5a20\", \"components_browsertests\": \"33b72a0d916fdcb002536871901a6cb256529115\", \"components_unittests\": \"877d4d25041f7cda96b0821495d3df618a390374\", \"compositor_unittests\": \"0bbae9a6bb7e9e2efb4ddb3911d265e306b8f0fe\", \"content_browsertests\": \"7891a18f4fe735e5c9045897c94a54d9dd667bdc\", \"content_shell_crash_test\": \"c0411d02ff40743702a10dd5b4f2315efcf49c5a\", \"content_unittests\": \"3c04ea203874fdfd931a33ebc533fe216e530c11\", \"crashpad_tests\": \"8965bb9cb837aaaf94c35fd7f2f69e7eda64daec\", \"cronet_tests\": \"ef7581038963367670554b1662fb149dbd65aad8\", \"cronet_unittests\": \"022012cbb03cb310ffe9de295eafffdfd6eb69f2\", \"crypto_unittests\": \"363baab59f5ba76455cca85eb9253ae88870aeef\", \"dbus_unittests\": \"849669eb3215c238b2611a9e79bb5849dd48ad16\", \"device_unittests\": \"d42746d4e3f61be2858a2efbf6e1c83e8381e1df\", \"display_unittests\": \"19ff50455cc4639f399a210491634c76fdafbbda\", \"events_unittests\": \"4a04284d97e26c85b11e4007997c6c6003a47243\", \"extension_docserver_python_unittests\": \"063f47c2f53e02ff328dbc5ba678910409e8d76d\", \"extensions_browsertests\": \"27957c1569a9f13b1ddfb043c905b6ac6a1b1dff\", \"extensions_unittests\": \"28ecf8db59822aaf7a7271bda44eb703e27bbc86\", \"filesystem_service_unittests\": \"26619ca9e271d15ad1ff9ae39170e88a07e56dbc\", \"flatbuffers_unittests\": \"e44ed88e1dde0ef7f6136eb0949503718efe54b6\", \"gcm_unit_tests\": \"b14cdce999062482348b779ebcef0972576a5a2a\", \"gfx_unittests\": \"ab5a6374ca872f3cde92ac4f51a7551401eff2df\", \"gin_unittests\": \"cbbfdac7ce5190fdbeb383080aa580365c674291\", \"google_apis_unittests\": \"b8d83211d515ea6566508a8ca50093fbc488cbdc\", \"gpu_unittests\": \"efb7eeda4099b09eeb5efdbd6b9855c9aa821670\", \"grit_python_unittests\": \"f4020ed5757956fbd2d0e1bd58035b529a5e6a74\", \"gwp_asan_unittests\": \"966ed4f1a4aed1e659d643c4bbb908ef2933d904\", \"headless_browsertests\": \"b78b85a81ab83b7cdfd8a71ffadf6f6d56014ff1\", \"headless_unittests\": \"b956925fc69928f223bba091dd81625d8deddb44\", \"interactive_ui_tests\": \"8ac3b1a5296d0c17177b88995c381667de152d4d\", \"ipc_tests\": \"3ed65973470a78ee862f916b6211d294b17ee19e\", \"jingle_unittests\": \"88cb52be2217b5dcf8d55e2b5281b6d29548ae0d\", \"latency_unittests\": \"a0986c99a0f106c5fb9e898a8807e93b8ed371f5\", \"libjingle_xmpp_unittests\": \"eb71f1e81cc99f06676c3c97d4c43b85ff5e5205\", \"liburlpattern_unittests\": \"406456281e1232028e6f90de4703828a42939400\", \"media_blink_unittests\": \"b8a6d1b21ebf07af1cbb358c858853785f8d9114\", \"media_unittests\": \"ab7f012b32bf1645f3807211ea7f82130c641c75\", \"message_center_unittests\": \"4772fa4cbb62b1e170c15eb66173da5d32223a34\", \"metrics_python_tests\": \"8dfecde7227034ccebcc06c6fcdc412d1440f098\", \"midi_unittests\": \"fa05ecf727e1e056a1f68bb8af1349f8d9af63b5\", \"mojo_core_unittests\": \"2cf6fee598debcb8dcc347ad56dfa3c066634351\", \"mojo_unittests\": \"f2eddb0b010e67ae1ac18a48ccdb18baee41fa6a\", \"nacl_helper_nonsfi_unittests\": \"e0e6b308779149390d6bdd3a31a3e86b687243c7\", \"nacl_loader_unittests\": \"f672f1273d6038106ed0a139beaf27e3ad60bd13\", \"native_theme_unittests\": \"b6e2cb3129ec509d0d92feaf8a21d9ea3e030d00\", \"net_unittests\": \"c7da8127c4c004121cd86d1351b6685d4a02b21b\", \"openscreen_unittests\": \"5ce4877e8a40a42bd237e650b1a592cdce403944\", \"pdf_unittests\": \"3491e46599de09f913255a912c5b9976805b659a\", \"perfetto_unittests\": \"ecae59ee29cf48668808cf305511cdd2cb5a75c1\", \"ppapi_unittests\": \"4761406e7b12f403d17d529ae2ab0ba1b2a2f895\", \"printing_unittests\": \"6c68e78143317099ed42d565a5531a0eaf8a3d1e\", \"remoting_unittests\": \"0ba9ce3b739de3cd26681d96e55b2d7f37d0cb9a\", \"sandbox_linux_unittests\": \"b3a89c61db83bc318b2cc61c7d1a5eb9c4393e15\", \"service_manager_unittests\": \"907d88af11ed8fba9933a7bb858181698224a874\", \"services_unittests\": \"f86d2b11f5c9373e2aab25981d6b0d2e239a0e3a\", \"shell_dialogs_unittests\": \"52bba86ba0dd279628e438408c8bded20f893ea7\", \"skia_unittests\": \"58d5ce93001b050080d77334d16a4082d5d39973\", \"snapshot_unittests\": \"dc691446ed39466dc0397129e3cdd58c4eaa9dae\", \"sql_unittests\": \"8052d29fe9c8d4f1b524eb6587673fff05e9d9d6\", \"storage_unittests\": \"b793e347298a6c8b2b0ba29422b66793fe862ab9\", \"sync_integration_tests\": \"7dc1b1385ccaab69c54ccb855dd08e9b63738a23\", \"telemetry_gpu_unittests\": \"3d20955ff7d72f60c9df809ee8f335355befe741\", \"telemetry_perf_unittests\": \"700129fd6491e0f6121454a8b384d87cd7e61b66\", \"telemetry_unittests\": \"663ff30d6341fabd78944ae90d9e659d801bce5c\", \"traffic_annotation_auditor_unittests\": \"a0f34529f00ff2c33619036ef375f7610b4a7fe2\", \"ui_base_unittests\": \"5d71a09cd6676aa817a8403b3a4bcb1860ba8058\", \"ui_touch_selection_unittests\": \"f2375e18e7000e0a6c9dda28687529362747132e\", \"unit_tests\": \"dd72da9ac39705b98dd8c2c6fe3d77f137e5d7fb\", \"url_unittests\": \"1f647f337a7f17e37b2e5d4c770f05979047187d\", \"views_perftests\": \"cde07b7260028cc9555f71830c3c743a5375cb4b\", \"views_unittests\": \"a54f425920e653e36c371ee9c928f33322fa2aa5\", \"viz_unittests\": \"e70d48d73c2ba46489d3003125766e96db9b8095\", \"vr_common_unittests\": \"72569576cca3c3645bf5928971cf61fbb6970576\", \"vr_pixeltests\": \"95f1f7864e6abde77b65756d5b7208047f3f0a55\", \"webdriver_wpt_tests\": \"6f98c8469e6ccff8d88c7310e127aeaab5974292\", \"weblayer_browsertests\": \"b2e63555015b476156c01cac13d4a63ff101b74a\", \"weblayer_unittests\": \"122beedfc23163ac62ec866b088bb598b7904137\", \"wm_unittests\": \"b81fa3866de8ac1a549a0d1ec62d3237a9f25ad2\", \"wtf_unittests\": \"ea4353af5cb362d17a1ae1e1827bcbb2807c4f11\", \"x11_unittests\": \"fbabe4d464edf22a9e6283c87defcc838eef2338\", \"xr_browser_tests\": \"1293c387a7bab04ab71090a7839d47f33be303bf\", \"zlib_unittests\": \"9b7ac717e6c29842bb0f4f4bc84aa50a046e1f8b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_414309451a62452c5fc91088f02bc2b3c7255663a128fe9787a2b8d2a76dca13_v2\", \"builder_dbe717e93dfefb94e765b2da7ffc34b16e5134b01772a8d37ee52c1fe1505654_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_e7fd4b7a9e211f8d968af60263c508e13e49814167aff980c2bf239c05ea48ef_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-central1-b-8-51-g66c\"], \"image\": [\"chrome-xenial-20110800-08efb743065\"], \"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\": [\"5626-39642e9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605317143478183",
"status": "COMPLETED",
"status_changed_ts": "1605320662464308",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177666",
"builder:Linux Builder (dbg)",
"buildset:commit/git/ba04a73c99869cede1e8132d0707af5fa5aede68",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ba04a73c99869cede1e8132d0707af5fa5aede68",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029126913115969008",
"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/8863696851044682800/+/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:4fdd2ad70fcd9a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605320662534221",
"url": "https://ci.chromium.org/b/8863696851044682800",
"utcnow_ts": "1605320663056624"
}
}
[02:24:23.066] Invocation finished in 1h1m17.470420135s with status SUCCEEDED