[06:57:35.348] New invocation is queued and will start shortly
[06:57:36.455] Starting the invocation (attempt 1)
[06:57:36.488] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:57:36.488] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:57:36.488] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9024123035320903520",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"76f7b76ae62de0bdbcbb420f07894d02b130a61a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9024123035320903520",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/76f7b76ae62de0bdbcbb420f07894d02b130a61a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/76f7b76ae62de0bdbcbb420f07894d02b130a61a",
"gitiles_ref:refs/heads/master"
]
}
[06:57:37.404] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610089056572936",
"id": "8858692973374632192",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"76f7b76ae62de0bdbcbb420f07894d02b130a61a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610089057257946",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179451",
"builder:Linux Builder (dbg)",
"buildset:commit/git/76f7b76ae62de0bdbcbb420f07894d02b130a61a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/76f7b76ae62de0bdbcbb420f07894d02b130a61a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024123035320903520",
"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/8858692973374632192/+/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": "1610089057258080",
"url": "https://ci.chromium.org/b/8858692973374632192",
"utcnow_ts": "1610089057394315"
}
}
[06:57:37.404] Task URL: https://ci.chromium.org/b/8858692973374632192
[06:57:37.404] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:2:0) after 1m0s
[06:57:51.010] Received PubSub notification, asking Buildbucket for the build status
[06:57:51.245] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:37.497] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:2:0)
[06:58:37.497] Timer tick, asking Buildbucket for the build status
[06:58:37.601] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:37.601] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:4:0) after 1m0s
[06:59:37.796] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:4:0)
[06:59:37.796] Timer tick, asking Buildbucket for the build status
[06:59:37.890] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:37.890] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:5:0) after 1m0s
[07:00:37.866] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:5:0)
[07:00:37.866] Timer tick, asking Buildbucket for the build status
[07:00:38.054] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:38.054] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:6:0) after 1m0s
[07:01:38.027] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:6:0)
[07:01:38.027] Timer tick, asking Buildbucket for the build status
[07:01:38.166] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:38.166] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:7:0) after 1m0s
[07:02:38.226] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:7:0)
[07:02:38.226] Timer tick, asking Buildbucket for the build status
[07:02:38.488] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:38.488] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:8:0) after 1m0s
[07:03:38.597] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:8:0)
[07:03:38.597] Timer tick, asking Buildbucket for the build status
[07:03:38.685] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:38.685] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:9:0) after 1m0s
[07:04:38.750] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:9:0)
[07:04:38.750] Timer tick, asking Buildbucket for the build status
[07:04:38.860] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:38.860] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:10:0) after 1m0s
[07:05:38.993] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:10:0)
[07:05:38.993] Timer tick, asking Buildbucket for the build status
[07:05:39.106] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:39.106] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:11:0) after 1m0s
[07:06:39.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:11:0)
[07:06:39.187] Timer tick, asking Buildbucket for the build status
[07:06:39.246] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:39.246] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:12:0) after 1m0s
[07:07:39.294] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:12:0)
[07:07:39.294] Timer tick, asking Buildbucket for the build status
[07:07:39.351] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:39.351] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:13:0) after 1m0s
[07:08:39.417] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:13:0)
[07:08:39.417] Timer tick, asking Buildbucket for the build status
[07:08:39.519] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:39.519] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:14:0) after 1m0s
[07:09:39.545] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:14:0)
[07:09:39.545] Timer tick, asking Buildbucket for the build status
[07:09:39.608] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:39.608] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:15:0) after 1m0s
[07:10:39.704] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:15:0)
[07:10:39.705] Timer tick, asking Buildbucket for the build status
[07:10:39.777] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:39.777] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:16:0) after 1m0s
[07:11:39.894] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:16:0)
[07:11:39.894] Timer tick, asking Buildbucket for the build status
[07:11:39.957] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:39.957] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:17:0) after 1m0s
[07:12:40.065] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:17:0)
[07:12:40.065] Timer tick, asking Buildbucket for the build status
[07:12:40.152] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:40.152] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:18:0) after 1m0s
[07:13:40.198] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:18:0)
[07:13:40.198] Timer tick, asking Buildbucket for the build status
[07:13:40.364] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:40.364] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:19:0) after 1m0s
[07:14:40.346] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:19:0)
[07:14:40.346] Timer tick, asking Buildbucket for the build status
[07:14:40.426] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:40.427] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:20:0) after 1m0s
[07:15:40.457] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:20:0)
[07:15:40.457] Timer tick, asking Buildbucket for the build status
[07:15:40.528] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:40.528] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:21:0) after 1m0s
[07:16:40.639] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:21:0)
[07:16:40.639] Timer tick, asking Buildbucket for the build status
[07:16:40.692] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:40.692] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:22:0) after 1m0s
[07:17:40.843] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:22:0)
[07:17:40.844] Timer tick, asking Buildbucket for the build status
[07:17:40.938] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:40.938] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:23:0) after 1m0s
[07:18:41.059] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:23:0)
[07:18:41.059] Timer tick, asking Buildbucket for the build status
[07:18:42.493] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:42.493] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:24:0) after 1m0s
[07:19:42.511] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:24:0)
[07:19:42.512] Timer tick, asking Buildbucket for the build status
[07:19:42.602] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:42.602] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:25:0) after 1m0s
[07:20:42.620] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:25:0)
[07:20:42.620] Timer tick, asking Buildbucket for the build status
[07:20:42.681] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:42.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:26:0) after 1m0s
[07:21:42.722] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:26:0)
[07:21:42.722] Timer tick, asking Buildbucket for the build status
[07:21:42.773] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:42.773] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:27:0) after 1m0s
[07:22:42.829] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:27:0)
[07:22:42.829] Timer tick, asking Buildbucket for the build status
[07:22:42.931] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:42.931] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:28:0) after 1m0s
[07:23:42.983] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:28:0)
[07:23:42.983] Timer tick, asking Buildbucket for the build status
[07:23:43.052] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:43.052] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:29:0) after 1m0s
[07:24:43.153] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:29:0)
[07:24:43.153] Timer tick, asking Buildbucket for the build status
[07:24:43.410] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:43.410] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:30:0) after 1m0s
[07:25:43.462] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:30:0)
[07:25:43.462] Timer tick, asking Buildbucket for the build status
[07:25:43.644] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:43.644] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:31:0) after 1m0s
[07:26:43.713] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:31:0)
[07:26:43.713] Timer tick, asking Buildbucket for the build status
[07:26:44.002] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:44.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:32:0) after 1m0s
[07:27:43.992] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:32:0)
[07:27:43.992] Timer tick, asking Buildbucket for the build status
[07:27:44.104] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:44.104] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:33:0) after 1m0s
[07:28:44.151] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:33:0)
[07:28:44.151] Timer tick, asking Buildbucket for the build status
[07:28:44.212] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:44.212] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:34:0) after 1m0s
[07:29:44.254] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:34:0)
[07:29:44.254] Timer tick, asking Buildbucket for the build status
[07:29:44.323] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:44.323] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:35:0) after 1m0s
[07:30:44.436] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:35:0)
[07:30:44.436] Timer tick, asking Buildbucket for the build status
[07:30:44.516] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:44.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:36:0) after 1m0s
[07:31:44.584] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:36:0)
[07:31:44.584] Timer tick, asking Buildbucket for the build status
[07:31:44.676] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:44.676] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:37:0) after 1m0s
[07:32:44.699] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:37:0)
[07:32:44.699] Timer tick, asking Buildbucket for the build status
[07:32:45.427] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:45.427] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:38:0) after 1m0s
[07:33:45.448] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:38:0)
[07:33:45.448] Timer tick, asking Buildbucket for the build status
[07:33:45.516] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:45.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:39:0) after 1m0s
[07:34:45.568] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:39:0)
[07:34:45.568] Timer tick, asking Buildbucket for the build status
[07:34:45.927] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:45.927] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:40:0) after 1m0s
[07:35:45.967] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:40:0)
[07:35:45.967] Timer tick, asking Buildbucket for the build status
[07:35:46.423] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:46.423] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:41:0) after 1m0s
[07:36:46.560] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:41:0)
[07:36:46.560] Timer tick, asking Buildbucket for the build status
[07:36:46.796] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:46.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:42:0) after 1m0s
[07:37:46.970] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:42:0)
[07:37:46.970] Timer tick, asking Buildbucket for the build status
[07:37:47.298] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:47.298] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:43:0) after 1m0s
[07:38:47.328] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:43:0)
[07:38:47.328] Timer tick, asking Buildbucket for the build status
[07:38:47.483] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:47.483] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:44:0) after 1m0s
[07:39:47.531] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:44:0)
[07:39:47.531] Timer tick, asking Buildbucket for the build status
[07:39:47.590] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:47.590] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:45:0) after 1m0s
[07:40:47.611] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:45:0)
[07:40:47.611] Timer tick, asking Buildbucket for the build status
[07:40:47.944] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:47.944] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:46:0) after 1m0s
[07:41:47.969] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:46:0)
[07:41:47.969] Timer tick, asking Buildbucket for the build status
[07:41:48.030] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:48.030] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:47:0) after 1m0s
[07:42:48.057] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:47:0)
[07:42:48.057] Timer tick, asking Buildbucket for the build status
[07:42:48.410] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:48.410] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:48:0) after 1m0s
[07:43:48.431] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:48:0)
[07:43:48.431] Timer tick, asking Buildbucket for the build status
[07:43:48.492] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:48.492] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:49:0) after 1m0s
[07:44:48.516] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:49:0)
[07:44:48.516] Timer tick, asking Buildbucket for the build status
[07:44:48.601] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:48.601] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:50:0) after 1m0s
[07:45:48.622] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:50:0)
[07:45:48.622] Timer tick, asking Buildbucket for the build status
[07:45:48.730] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:48.730] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:51:0) after 1m0s
[07:46:48.752] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:51:0)
[07:46:48.752] Timer tick, asking Buildbucket for the build status
[07:46:48.809] Build 8858692973374632192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:48.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024123035320903520:52:0) after 1m0s
[07:47:43.426] Received PubSub notification, asking Buildbucket for the build status
[07:47:43.497] Build 8858692973374632192: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:47:43.497] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610092062614476",
"created_by": "project:chromium",
"created_ts": "1610089056572936",
"id": "8858692973374632192",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"76f7b76ae62de0bdbcbb420f07894d02b130a61a\"}}",
"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\": \"76f7b76ae62de0bdbcbb420f07894d02b130a61a\", \"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-163-okyb\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 179451, \"got_angle_revision\": \"f99ccb082ba59aab0fba2b8d04625bc2364fc01f\", \"got_dawn_revision\": \"00fcab636a055c78036ee20bb1a89339b0a28bad\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"76f7b76ae62de0bdbcbb420f07894d02b130a61a\", \"got_revision_cp\": \"refs/heads/master@{#841392}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"937395c1ed5d20af5a5fd999d7e2deddf1b78fe3\", \"got_v8_revision\": \"4d379d2f001373295530d8154f5bea14f1257e8d\", \"got_v8_revision_cp\": \"refs/heads/8.9.218@{#1}\", \"got_webrtc_revision\": \"cdb3bc3b93dae5237610d0e45bccd900812a0cfe\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32922}\", \"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\": \"76f7b76ae62de0bdbcbb420f07894d02b130a61a\", \"swarm_hashes_refs/heads/master(at){#841392}_without_patch\": {\"absl_hardening_tests\": \"4c03c8b392e452fdf229a75e9d37b54e95876e70\", \"accessibility_unittests\": \"d47ad0bdc2d912e4858eb31154466804aeb7649a\", \"angle_unittests\": \"f3266b8efbdde0eb6370034a0b6387369f6c5d46\", \"app_shell_unittests\": \"490293d18392581555016f211268a396254c26cf\", \"aura_unittests\": \"c31735a5b1eef041efaa30cd65fbc86f7acb62b7\", \"base_unittests\": \"e9cc62f60f750f68e8d2991594b5fff65b04affb\", \"base_util_unittests\": \"0345e42b59b2c6057cc296d55aa0351f17d1cb14\", \"blink_common_unittests\": \"1e14fbfc0fb5f0a1b0812491bde4a680b4e1a8ca\", \"blink_fuzzer_unittests\": \"ea7741909df7dd2a22cd62a6741bb1f20bbac175\", \"blink_heap_unittests\": \"0a4f3556b691081e4c12c6a6a73d0028f9109148\", \"blink_platform_unittests\": \"df8730a533c1554aa0fc05bd410ab37572377314\", \"blink_python_tests\": \"3d7d1bac233e3f47705eb4314704c9d5d5df13c4\", \"blink_unittests\": \"02788c1432d911b50c2cca188b9780896d75f38e\", \"blink_web_tests\": \"3f6460d423c2f39af9476b0a50ee0f1c20b38933\", \"boringssl_crypto_tests\": \"54f05ead54ad9c511b6d0bc888d87e6e0393cd66\", \"boringssl_ssl_tests\": \"1177cd60ec4bea193c04b2a9611b365d6c2f6f62\", \"browser_tests\": \"1418614b96d994d9a6fa3caba39d78c573dc5052\", \"capture_unittests\": \"76ddd6895ffdbe9333fc7b5266551d8ae31dcf00\", \"cast_unittests\": \"5003fc10fc2fc4050735364822a74b9f545010fa\", \"cc_unittests\": \"8dc04b4c8639c25980adb354f01754ac30aebffc\", \"chrome_app_unittests\": \"ac6f9251dff92a4f78968c33c8b39a70284a4312\", \"chromedriver_unittests\": \"24870316e9282a7927dcfea7c203719746480b4b\", \"components_browsertests\": \"a4de36e14a5ecdbae8c9fde61bd63052ca63eee5\", \"components_unittests\": \"943aaed9f6fb1f785e29897372f69c6322698944\", \"compositor_unittests\": \"105f4c7fa6ba0bc61b3ed620ff2d4acef7b14aa6\", \"content_browsertests\": \"db1680b59207505810dea64ad49144e9a1d70f01\", \"content_shell_crash_test\": \"c4a1cd8b7bf100160cfbb81e0628f448c1572f2e\", \"content_unittests\": \"8c96a4495dc8adfa6b0a98fe947813eab52ef9b2\", \"crashpad_tests\": \"c5a331b6ae4ab922067e92e2abf99cb83eccf4da\", \"cronet_tests\": \"d3a1d5d65d853ef5e906b4c642543ee4bad2aa98\", \"cronet_unittests\": \"dab534f687d496597462595f0d931240d0aa6b23\", \"crypto_unittests\": \"583ae62740ed122d459d1acd75acd8412df5fbe3\", \"dbus_unittests\": \"74c627ae04fbbdbc3fa8bfbd3203086f5b2b561e\", \"device_unittests\": \"51ceca9343ef61fe1bc1a567aa87d74b236cab05\", \"display_unittests\": \"6ebdc713bd6c363c79dddf3a7c89b149d89a8e30\", \"events_unittests\": \"4f0e38c6894ea859314dbad280940a3654f62808\", \"extensions_browsertests\": \"069eaf97eaaa82d9233e70ef8f832525fc59d1f4\", \"extensions_unittests\": \"486f7438064c7087bc41c3eba3f9007be5a76080\", \"filesystem_service_unittests\": \"1919a5dccc620ab3a00cf16cd24e30165abe9eaf\", \"flatbuffers_unittests\": \"cc869a2fbd06ae1fab18c809541dec3b75d7db1a\", \"gcm_unit_tests\": \"89719c7ab91ac79db956a9b9d6a300f14c41f296\", \"gfx_unittests\": \"2b7923c920fcf275e9b3d05a562fdbc410400431\", \"gin_unittests\": \"c215255afbb2f3c6eec2091e0d9faaf5359775ae\", \"google_apis_unittests\": \"6bab50d6348b4f1902d8dfb727284e0ae3c09e3a\", \"gpu_unittests\": \"974e1c2e9046c32320289ee23f03e57267a686fa\", \"grit_python_unittests\": \"0718a5373aa0ae8758877d63c90aad8024074ace\", \"gwp_asan_unittests\": \"1542f14fd9eb3514c180d35f2e221555011a900a\", \"headless_browsertests\": \"b01962a7ca387ca2015590dce039deb9be536d2f\", \"headless_unittests\": \"75f989ba1d4b26e0cbdb3184cb0d5f4ea1a63f6f\", \"interactive_ui_tests\": \"4ea132555f4d8d790b9b23186f80e83346d07a10\", \"ipc_tests\": \"8e7592f97f130b91c27d42426f3049dd42867153\", \"jingle_unittests\": \"3bd4bc2323fc0b87125df5fc2563f5baee9fb504\", \"latency_unittests\": \"24048b2ad1ebb69f47a3549b426aefca958b6aca\", \"libjingle_xmpp_unittests\": \"29f085fdf8204ef2e1efd807a98590a92a376f73\", \"liburlpattern_unittests\": \"0e688ded0470e468b741c9d6ce8340a8a7caf750\", \"media_blink_unittests\": \"523b840843b00052d7447eabd16aefbb0b0acd23\", \"media_unittests\": \"5db968a1afd50508572d22a10d0151ca855ccc33\", \"message_center_unittests\": \"716d144f4152ad7b3cfcee87617823fc1f032b2f\", \"metrics_python_tests\": \"c91d8532bd3c53a49e4cfe66a528102a246dbb3b\", \"midi_unittests\": \"1d68569378bbf2b43a957d91a31075a73acebaa9\", \"mojo_core_unittests\": \"639ca84b709a25d511e301caad147100ca96c335\", \"mojo_unittests\": \"56ef7326b0d88e5b4534b8e41043248311065a97\", \"nacl_helper_nonsfi_unittests\": \"91a9aa157dfdc6d6c44732213d3a10834beb5081\", \"nacl_loader_unittests\": \"873c1cd106e7c81cf6643f08d8d382247c654fa9\", \"native_theme_unittests\": \"c76be4c1ba0361ed2f2f45cd87c4b89b82b9f8fe\", \"net_unittests\": \"1a9b4af3c1296a467a6e14ab29c4d1087456e7c0\", \"openscreen_unittests\": \"63cb588956322a59e46231f04d4c194bb3b0cbd8\", \"pdf_unittests\": \"b1d76ca0b9e885c3eddb6a1554d5dfb5b43682ff\", \"perfetto_unittests\": \"5701e753f444854a036804f021984b7961399ec6\", \"ppapi_unittests\": \"40bfc634ad18ab51f51ac072684371c8e6bdf6c2\", \"printing_unittests\": \"14644f9ee9bab450f5a833fd493339d4c3320611\", \"remoting_unittests\": \"9dd6dd2373cc5829bfb2bb613b9533fc1cfcad89\", \"sandbox_linux_unittests\": \"f1b41ccb8f27751d4ca13260db055dc2ece35379\", \"service_manager_unittests\": \"507105b551fa4c5be7b3a5ef2b2f684b8c6fb16a\", \"services_unittests\": \"c8a5a2b87086fba285f2d1413eafdc3d03a8ff2a\", \"shell_dialogs_unittests\": \"148f59f1cba23e3c75fb36546a9fadc6e8739f56\", \"skia_unittests\": \"b1a9f8ab90706e431acd83e20bee587d74dfd36e\", \"snapshot_unittests\": \"cd70303e1334eebeb8afecc4148f487f3ae712f9\", \"sql_unittests\": \"8903c96aea12141af7d39b02305540aa650ccf7c\", \"storage_unittests\": \"98f9df147c3f7eabbc910ad6d746f3b2a82a103f\", \"sync_integration_tests\": \"8d61f4ead8588eb838d6f13c1728be3511196a6e\", \"telemetry_gpu_unittests\": \"de918c3c493d6023241892e9d46f82fb76fce98d\", \"telemetry_perf_unittests\": \"5bd9c50ed064aef35f0334017683c7d31a183b1b\", \"telemetry_unittests\": \"e45d2c0ed3120d6d01c6b25aec31f4a1c014050d\", \"traffic_annotation_auditor_unittests\": \"9c14e664a46e2cb2a80915a23296cbcb0db2cbf3\", \"ui_base_unittests\": \"a8d56a6c167b1161560d56aa13cee36ac1306056\", \"ui_touch_selection_unittests\": \"f7088c726b8403cbdd02a534c3ebfd2cdd1f0e25\", \"unit_tests\": \"600c63503064eb513c3ef9a77b53f4c474f2b42f\", \"url_unittests\": \"eba76c49c7bac11a1d4f08285db1b2e5087847d7\", \"views_perftests\": \"317982d92f047d598dea44beb7fd82189afcc612\", \"views_unittests\": \"bbd3440330e70ff8efa358f16e57ae52efe7b3ca\", \"viz_unittests\": \"0e5ca74514e285d1e38d3ca5806b933706161ec3\", \"vr_common_unittests\": \"edaefb20a3e1ed215f1bcd3156cc43b768a087e0\", \"vr_pixeltests\": \"f97dff41034b7a490dfbe8058a963a9098cb465e\", \"webdriver_wpt_tests\": \"35a80a45c5f5858bf98f7fc02d6fa77820d1de74\", \"weblayer_browsertests\": \"113d0eeb672778a3fe5deeaa5888637c6dab927d\", \"weblayer_unittests\": \"74e79a60126d002af69af4db2a18e83352284944\", \"wm_unittests\": \"81061628dfa0e7c15ddc4339506257ccde0b8bc2\", \"wtf_unittests\": \"a7aa30306b84650fa9deb4c85f91202d673eda0b\", \"x11_unittests\": \"57e01873e7b2058b24978e569122b2722bae36c0\", \"xr_browser_tests\": \"79f607e527ca3938421139bd5f8c5a7bc73b2616\", \"zlib_unittests\": \"237ae3a38c09d98c36aa3a2ae3fb45cafa414cb3\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4bb8df61718ee3173d82ea540402eadde21707c87b43c35a861cfb17546437c1_v2\", \"builder_6cd5ded23cefc640ae511b7a529237cb2561e39c1afb96e401c63016ddcf35a6_v2\", \"builder_78080097a3960c8831291638a631c67e272aa3d821d469cd7fbf44d1ce982b94_v2\", \"builder_8ed59a4fa98a52009c5b7be7e9c90826b738aab438c85f8db549ef122247493f_v2\", \"builder_d99b56d6fc6fd15316497c0509dbc8d437110174a09b554c19aeca35e1687cdb_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_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-163-okyb\"], \"image\": [\"chrome-xenial-20122700-a13233ce10d\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610089070481958",
"status": "COMPLETED",
"status_changed_ts": "1610092062963754",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179451",
"builder:Linux Builder (dbg)",
"buildset:commit/git/76f7b76ae62de0bdbcbb420f07894d02b130a61a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/76f7b76ae62de0bdbcbb420f07894d02b130a61a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024123035320903520",
"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/8858692973374632192/+/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:50f99adb8a72ba10",
"user_agent:luci-scheduler"
],
"updated_ts": "1610092062968644",
"url": "https://ci.chromium.org/b/8858692973374632192",
"utcnow_ts": "1610092063486266"
}
}
[07:47:43.497] Invocation finished in 50m8.165758233s with status SUCCEEDED