[08:32:24.830] New invocation is queued and will start shortly
[08:32:26.007] Starting the invocation (attempt 1)
[08:32:26.054] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:32:26.054] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:32:26.054] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018590654515120432",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"0385ffbfe47191ea609f0ce5df3a1599f10697fb\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9018590654515120432",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/0385ffbfe47191ea609f0ce5df3a1599f10697fb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0385ffbfe47191ea609f0ce5df3a1599f10697fb",
"gitiles_ref:refs/heads/master"
]
}
[08:32:27.044] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615365146128793",
"id": "8853160592492457616",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0385ffbfe47191ea609f0ce5df3a1599f10697fb\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615365146838000",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181263",
"builder:Linux Builder (dbg)",
"buildset:commit/git/0385ffbfe47191ea609f0ce5df3a1599f10697fb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0385ffbfe47191ea609f0ce5df3a1599f10697fb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018590654515120432",
"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/8853160592492457616/+/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": "1615365146838117",
"url": "https://ci.chromium.org/b/8853160592492457616",
"utcnow_ts": "1615365147031924"
}
}
[08:32:27.044] Task URL: https://ci.chromium.org/b/8853160592492457616
[08:32:27.044] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:2:0) after 1m0s
[08:32:28.848] Received PubSub notification, asking Buildbucket for the build status
[08:32:28.901] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:27.051] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:2:0)
[08:33:27.051] Timer tick, asking Buildbucket for the build status
[08:33:27.144] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:27.144] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:4:0) after 1m0s
[08:34:27.366] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:4:0)
[08:34:27.366] Timer tick, asking Buildbucket for the build status
[08:34:27.433] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:27.433] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:5:0) after 1m0s
[08:35:27.574] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:5:0)
[08:35:27.574] Timer tick, asking Buildbucket for the build status
[08:35:27.642] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:27.642] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:6:0) after 1m0s
[08:36:27.706] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:6:0)
[08:36:27.706] Timer tick, asking Buildbucket for the build status
[08:36:27.768] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:27.768] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:7:0) after 1m0s
[08:37:27.765] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:7:0)
[08:37:27.765] Timer tick, asking Buildbucket for the build status
[08:37:27.933] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:27.933] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:8:0) after 1m0s
[08:38:27.938] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:8:0)
[08:38:27.938] Timer tick, asking Buildbucket for the build status
[08:38:28.115] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:28.115] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:9:0) after 1m0s
[08:39:28.115] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:9:0)
[08:39:28.115] Timer tick, asking Buildbucket for the build status
[08:39:28.192] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:28.192] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:10:0) after 1m0s
[08:40:28.617] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:10:0)
[08:40:28.617] Timer tick, asking Buildbucket for the build status
[08:40:28.676] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:28.676] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:11:0) after 1m0s
[08:41:30.758] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:11:0)
[08:41:30.758] Timer tick, asking Buildbucket for the build status
[08:41:30.823] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:30.823] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:12:0) after 1m0s
[08:42:30.879] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:12:0)
[08:42:30.879] Timer tick, asking Buildbucket for the build status
[08:42:30.958] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:30.958] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:13:0) after 1m0s
[08:43:31.015] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:13:0)
[08:43:31.015] Timer tick, asking Buildbucket for the build status
[08:43:31.150] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:31.150] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:14:0) after 1m0s
[08:44:31.213] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:14:0)
[08:44:31.213] Timer tick, asking Buildbucket for the build status
[08:44:31.278] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:31.278] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:15:0) after 1m0s
[08:45:31.277] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:15:0)
[08:45:31.277] Timer tick, asking Buildbucket for the build status
[08:45:31.439] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:31.439] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:16:0) after 1m0s
[08:46:31.484] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:16:0)
[08:46:31.484] Timer tick, asking Buildbucket for the build status
[08:46:31.617] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:31.617] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:17:0) after 1m0s
[08:47:31.672] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:17:0)
[08:47:31.672] Timer tick, asking Buildbucket for the build status
[08:47:31.758] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:31.758] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:18:0) after 1m0s
[08:48:31.806] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:18:0)
[08:48:31.806] Timer tick, asking Buildbucket for the build status
[08:48:31.930] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:31.930] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:19:0) after 1m0s
[08:49:31.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:19:0)
[08:49:31.994] Timer tick, asking Buildbucket for the build status
[08:49:32.127] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:32.127] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:20:0) after 1m0s
[08:50:32.246] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:20:0)
[08:50:32.246] Timer tick, asking Buildbucket for the build status
[08:50:32.348] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:32.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:21:0) after 1m0s
[08:51:32.355] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:21:0)
[08:51:32.355] Timer tick, asking Buildbucket for the build status
[08:51:32.417] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:32.417] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:22:0) after 1m0s
[08:52:32.429] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:22:0)
[08:52:32.429] Timer tick, asking Buildbucket for the build status
[08:52:32.520] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:32.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:23:0) after 1m0s
[08:53:32.589] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:23:0)
[08:53:32.589] Timer tick, asking Buildbucket for the build status
[08:53:32.727] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:32.727] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:24:0) after 1m0s
[08:54:32.999] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:24:0)
[08:54:32.999] Timer tick, asking Buildbucket for the build status
[08:54:33.157] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:33.157] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:25:0) after 1m0s
[08:55:33.268] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:25:0)
[08:55:33.268] Timer tick, asking Buildbucket for the build status
[08:55:33.455] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:33.455] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:26:0) after 1m0s
[08:56:33.557] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:26:0)
[08:56:33.557] Timer tick, asking Buildbucket for the build status
[08:56:33.635] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:33.635] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:27:0) after 1m0s
[08:57:33.746] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:27:0)
[08:57:33.746] Timer tick, asking Buildbucket for the build status
[08:57:33.819] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:33.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:28:0) after 1m0s
[08:58:33.905] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:28:0)
[08:58:33.905] Timer tick, asking Buildbucket for the build status
[08:58:33.993] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:33.993] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:29:0) after 1m0s
[08:59:34.025] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:29:0)
[08:59:34.025] Timer tick, asking Buildbucket for the build status
[08:59:34.348] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:34.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:30:0) after 1m0s
[09:00:34.388] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:30:0)
[09:00:34.388] Timer tick, asking Buildbucket for the build status
[09:00:34.614] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:34.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:31:0) after 1m0s
[09:01:34.604] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:31:0)
[09:01:34.604] Timer tick, asking Buildbucket for the build status
[09:01:34.683] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:34.683] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:32:0) after 1m0s
[09:02:34.709] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:32:0)
[09:02:34.709] Timer tick, asking Buildbucket for the build status
[09:02:34.792] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:34.792] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:33:0) after 1m0s
[09:03:34.849] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:33:0)
[09:03:34.849] Timer tick, asking Buildbucket for the build status
[09:03:35.040] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:35.040] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:34:0) after 1m0s
[09:04:35.066] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:34:0)
[09:04:35.066] Timer tick, asking Buildbucket for the build status
[09:04:35.277] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:35.277] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:35:0) after 1m0s
[09:05:35.308] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:35:0)
[09:05:35.308] Timer tick, asking Buildbucket for the build status
[09:05:35.383] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:35.383] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:36:0) after 1m0s
[09:06:35.429] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:36:0)
[09:06:35.429] Timer tick, asking Buildbucket for the build status
[09:06:35.501] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:35.501] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:37:0) after 1m0s
[09:07:35.593] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:37:0)
[09:07:35.593] Timer tick, asking Buildbucket for the build status
[09:07:35.734] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:35.734] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:38:0) after 1m0s
[09:08:35.749] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:38:0)
[09:08:35.749] Timer tick, asking Buildbucket for the build status
[09:08:36.053] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:36.053] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:39:0) after 1m0s
[09:09:36.105] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:39:0)
[09:09:36.105] Timer tick, asking Buildbucket for the build status
[09:09:36.235] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:36.235] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:40:0) after 1m0s
[09:10:36.261] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:40:0)
[09:10:36.261] Timer tick, asking Buildbucket for the build status
[09:10:36.334] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:36.334] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:41:0) after 1m0s
[09:11:36.342] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:41:0)
[09:11:36.342] Timer tick, asking Buildbucket for the build status
[09:11:36.421] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:36.421] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:42:0) after 1m0s
[09:12:36.472] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:42:0)
[09:12:36.472] Timer tick, asking Buildbucket for the build status
[09:12:36.552] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:36.552] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:43:0) after 1m0s
[09:13:36.619] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:43:0)
[09:13:36.619] Timer tick, asking Buildbucket for the build status
[09:13:37.226] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:37.226] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:44:0) after 1m0s
[09:14:37.268] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:44:0)
[09:14:37.268] Timer tick, asking Buildbucket for the build status
[09:14:37.369] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:37.369] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:45:0) after 1m0s
[09:15:37.397] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:45:0)
[09:15:37.397] Timer tick, asking Buildbucket for the build status
[09:15:37.547] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:37.547] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:46:0) after 1m0s
[09:16:37.596] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:46:0)
[09:16:37.596] Timer tick, asking Buildbucket for the build status
[09:16:37.739] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:37.739] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:47:0) after 1m0s
[09:17:37.757] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:47:0)
[09:17:37.757] Timer tick, asking Buildbucket for the build status
[09:17:37.839] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:37.839] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:48:0) after 1m0s
[09:18:37.856] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:48:0)
[09:18:37.856] Timer tick, asking Buildbucket for the build status
[09:18:37.915] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:37.915] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:49:0) after 1m0s
[09:19:38.220] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:49:0)
[09:19:38.220] Timer tick, asking Buildbucket for the build status
[09:19:38.303] Build 8853160592492457616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:38.303] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018590654515120432:50:0) after 1m0s
[09:19:39.892] Received PubSub notification, asking Buildbucket for the build status
[09:19:40.151] Build 8853160592492457616: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:19:40.151] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615367979220265",
"created_by": "project:chromium",
"created_ts": "1615365146128793",
"id": "8853160592492457616",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0385ffbfe47191ea609f0ce5df3a1599f10697fb\"}}",
"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\": \"0385ffbfe47191ea609f0ce5df3a1599f10697fb\", \"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-58-lu8q\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 181263, \"got_angle_revision\": \"c054008f9efb2f86a0bd6b8031e8c635c69107e4\", \"got_dawn_revision\": \"6d4617a2d28d8d3d4aa946abdbabb368d025b6b7\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"0385ffbfe47191ea609f0ce5df3a1599f10697fb\", \"got_revision_cp\": \"refs/heads/master@{#861475}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"023914a27b634063766fee96f2e6763513f5b059\", \"got_v8_revision\": \"05696889ed8ad6708b18bdfbabe603d04a0d76da\", \"got_v8_revision_cp\": \"refs/heads/9.1.88@{#1}\", \"got_webrtc_revision\": \"92d12707e00837a978485f731d72ef30cf19d2a2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33402}\", \"is_cached\": true, \"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\": \"0385ffbfe47191ea609f0ce5df3a1599f10697fb\", \"swarm_hashes_refs/heads/master(at){#861475}_without_patch\": {\"absl_hardening_tests\": \"f95d836901d1be6cbc3e898f70d4eab24813feb8\", \"accessibility_unittests\": \"154b500d0e5db865ae51c02d5a9bc25bc23b608f\", \"angle_unittests\": \"0006e5dc9edc4c0f84e498096d46f12520312e2c\", \"app_shell_unittests\": \"0b2ab3c369fef81c57646e96e0b55d80b901e9e0\", \"aura_unittests\": \"869d77d545bc5ba5c6a09eaa58ce014c85fea23d\", \"base_unittests\": \"f3a54bee0197d3af427d7fe70ccf8c5827312cd5\", \"base_util_unittests\": \"381d84440b0fe794f37bd43bfc5fc6043305f94a\", \"blink_common_unittests\": \"bc961fcd859e38a65dfac747e2a6c74cece0ec52\", \"blink_fuzzer_unittests\": \"c672800dc499333b2972ddca2dd6138bdbd8294f\", \"blink_heap_unittests\": \"e3b9903e49006007a49a345aa87fb7c1ea69286d\", \"blink_platform_unittests\": \"af16c6165d4dd353ef5ebdf556787566c7145d81\", \"blink_python_tests\": \"206319d8e50ccb275241819ba74651a15b95714d\", \"blink_unittests\": \"3dc74a0db55aa5fe78a500e24c960bd29164f654\", \"blink_web_tests\": \"3ee3684f62ccb78f9ad844208179e7c8e40106dc\", \"boringssl_crypto_tests\": \"60c904e4e7de963b8e36e9f9dcdd9b402fa64598\", \"boringssl_ssl_tests\": \"eeb7e4b31fe4c21fe9cf74cebe9df997689d96bd\", \"browser_tests\": \"4cab11f59a2daf2a86af2eb4d0e5417c5af4eb98\", \"capture_unittests\": \"7992278839a8feb95f00bc9462c7a137eda05511\", \"cast_unittests\": \"986b2ca4c8375cb9e665797a0b29468b1267faa5\", \"cc_unittests\": \"5645755d1c6d3b3be489892b17b1dfd32328855c\", \"chrome_app_unittests\": \"a786abc4247ec80913b1e3ae55547074ad40f8ea\", \"chromedriver_unittests\": \"6ff651ab0a1fc640b3b911952b3d9059e6ba586d\", \"color_unittests\": \"cec8a0715f71cc2afbee6145433f3e88bc2f77a5\", \"components_browsertests\": \"ecd02d431ee478ce0dc8707033094451c1bc6be4\", \"components_unittests\": \"5f18e8c8355346bad70a86a92378d220df20f89a\", \"compositor_unittests\": \"46cc9a9279fe1a69ddbe20c42c8e5501cdc6694e\", \"content_browsertests\": \"ab022a10bc6811766e89bc7917d61067a830bb5c\", \"content_shell_crash_test\": \"93a483441897126bfc080e67a4ced3d8db197dc2\", \"content_unittests\": \"0ef855f788a6f4fa04846ef10080ce39c31ae804\", \"crashpad_tests\": \"4c018bfb417592f9a3dbe31625b4da6cd91299db\", \"cronet_tests\": \"1425d232e3c84893eb335d76bd20774fa346677e\", \"cronet_unittests\": \"9d191519ab5edaf0e2b813d45e5dc9e77904e76f\", \"crypto_unittests\": \"171c0678af1b5e46ed932b0c1927ef50c13bae89\", \"dbus_unittests\": \"31cd2b8393c5e6adc98d4ea9683c39db6688bbaf\", \"device_unittests\": \"90f9ba0ae3c533ff8dde9d31fc5633021adee05b\", \"display_unittests\": \"5716eaaa451bbe2d4dfb140733edfc21758df177\", \"events_unittests\": \"ff91a28cff7c8c6bdec238c4eed0b46e7132434c\", \"extensions_browsertests\": \"ec103e5ee9a092bacc5b68697a1b0877b212053d\", \"extensions_unittests\": \"c8dddec3882c5e193fb7a1244de44264f3644bd5\", \"filesystem_service_unittests\": \"3051657cfdab15142ea0cbc3b11098512077d4a0\", \"flatbuffers_unittests\": \"917c1926f9a03d6ef30fc9665ef3a1d956152ddf\", \"gcm_unit_tests\": \"964c0e21887e0f8a215bc4e5c02f320471c5db20\", \"gfx_unittests\": \"cc88f6da4b2123a985a2f19219ea1833672a2a51\", \"gin_unittests\": \"7e144f44163e30a6601f81933a002b99c9376073\", \"google_apis_unittests\": \"dc861d706ef620f3c0c5620e868c67486af06295\", \"gpu_unittests\": \"b7ac8fc982c70a29a388d4bfea89f9d9129050e5\", \"grit_python_unittests\": \"2629172029a5ce27ead3b3791972502f1e7f17c8\", \"gwp_asan_unittests\": \"d297c3086553f2cee5a58a2542deab41588ccbdc\", \"headless_browsertests\": \"d89316889084f3d2954c20af3262727e3686e3d8\", \"headless_unittests\": \"ce69489518333ff036284d5b9d440ca84f6d7ff7\", \"interactive_ui_tests\": \"0d3f980861862f6338460bf1d7f7016eca022aff\", \"ipc_tests\": \"f88248dd06a9cffad276438b31094bfc0b9bde3a\", \"jingle_unittests\": \"624066a133ef97281efe3d2c71b3b72c3e52264e\", \"latency_unittests\": \"02b99060f244d19a1e39ffa2c9730e1e3dc034c2\", \"libjingle_xmpp_unittests\": \"ca54ab45a83b85ab592d949c24d8bbb0d5991c39\", \"liburlpattern_unittests\": \"f27f3c3172ddac6b17fc531d33004f04eac2e34c\", \"media_blink_unittests\": \"b6da80ecc90a3fb99412081893c7442563f8b316\", \"media_unittests\": \"0431e1947d0c34c83b6200a289c39dac5a6ffad7\", \"message_center_unittests\": \"36bdd876193980f80a9958d2e3f55b2dc0b5c82d\", \"metrics_python_tests\": \"4b11916f1ab63ffa7cd08305dc0decf828d13f83\", \"midi_unittests\": \"2ae5c8f533d6e547f16350fb64c83d9285a5abb3\", \"mojo_core_unittests\": \"d518c7f751c3878eb4055a10ff7d70948c0ef8b5\", \"mojo_unittests\": \"f524d36826db37b939c80330b83a8bc31eced6bb\", \"nacl_helper_nonsfi_unittests\": \"b81d1030cb9bc469305a8b2f83684627708521cc\", \"nacl_loader_unittests\": \"055cbb31b46752b618285885c457d6c56adcfcb6\", \"native_theme_unittests\": \"c4a0644798dc242189f4969d90f9ba022e10eac9\", \"net_unittests\": \"4938acd01731f8c9ab16688734761ec09371b3bd\", \"openscreen_unittests\": \"8860388f383706fa20fa485ffb6a3ab19cd7d6e3\", \"pdf_unittests\": \"d848664dd2fb61e6b92f7f931a4342fb51c1c2e3\", \"perfetto_unittests\": \"3ed5068a5f7367862c1e19cdd09d1fbee41d38a1\", \"ppapi_unittests\": \"41f8e966710d28be90f876b19b9d4aed6a341a7c\", \"printing_unittests\": \"a82a5859bb2b0835cec3ec2f65d70e763fe5b245\", \"remoting_unittests\": \"fd2bc02d70d420bee679121fe306e96513ae3fc2\", \"sandbox_linux_unittests\": \"3b62f956d43e020f51ba44eb58a6001a34a33e8d\", \"service_manager_unittests\": \"7c134fa4d0a7bbee23fca7b357cc0d4ad60852f9\", \"services_unittests\": \"6ae53912bc96b6ed4f5e656df22a15e7b70777d4\", \"shell_dialogs_unittests\": \"82c1e92f26b9e54be9b05932592f944c2676c764\", \"skia_unittests\": \"be17b881021952b9fcaba1913ed370a18061f0f1\", \"snapshot_unittests\": \"d305840eb766384cfaabd418b1abeca021bffd64\", \"sql_unittests\": \"b76942a8361a9b80e16a1c97d8ce8b2107f6bb07\", \"storage_unittests\": \"cdde39e910e289a85f6b8086d03d258618a0da18\", \"sync_integration_tests\": \"4b19c0a14335cc3d6a4dbe60772753e450da8e25\", \"telemetry_gpu_unittests\": \"57367748a8b808617de9514d57b7883985fe3442\", \"telemetry_perf_unittests\": \"a88c452eb1657fb717faec461df9bc79df4bed5a\", \"telemetry_unittests\": \"c3e6220eba069cc727128e3e0a13d16b921562b9\", \"traffic_annotation_auditor_unittests\": \"d43d6444aca9a1bbab0a6b39545fcbc21b3fded3\", \"ui_base_unittests\": \"586b6e147c4fb55c510a86726eaf88c8cb672d2a\", \"ui_touch_selection_unittests\": \"ac49a7ef26b1966dea44c240c4d61dfeacd76f16\", \"unit_tests\": \"5969daed5ffd2c47e6a3570c969596436bd0d064\", \"url_unittests\": \"a82eee9b38b05464102b6305dcf1ce08e5027bed\", \"views_perftests\": \"21a56b92be268d05b506a71d5f140f9a4b932368\", \"views_unittests\": \"808fc50a340db6b397f54df4a90075903b12ae70\", \"viz_unittests\": \"3accdad7c2099371769ac392682a92bcb373dd0a\", \"vr_common_unittests\": \"02ea07e526a43ad26c083882c0661340052c59c8\", \"vr_pixeltests\": \"e1d7545e88824eeb9c0d9fd0b502ff69667c22a2\", \"webdriver_wpt_tests\": \"8ed29518c4f23a541c51fb5b73cc5d36556b6cb9\", \"weblayer_browsertests\": \"848d42a897cec1460044166274e93a5e1f675a57\", \"weblayer_unittests\": \"0375157d9d38c32aa189f971053d3fc238f8ad41\", \"wm_unittests\": \"31325d0308d16afadac24e19a112abff5a7d2413\", \"wtf_unittests\": \"5d88a872faac87fb3e910deae9d2e97554de3553\", \"x11_unittests\": \"eff08c16d73ad029a4a072540bfc5656e6e72cca\", \"xr_browser_tests\": \"a3d16abbefcdaef7db700bee4f08da9b13e5b5d5\", \"zlib_unittests\": \"f70e1fc2334144c906828f0fe509d1e51d158a15\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0b457c29832afe9869549a9d3fb1269d99c2cbc2ef2da9533a15fddd8d201757_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"builder_994c6d057c4d72e6e60d1eac48ee38aafacc9bb85f78c7911d66463be69b94de_v2\", \"builder_abe2adbd32ad911c3e8d1f384e915329cf1f65e427edb6b91a9fbb61a55ed743_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-58-lu8q\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"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\": [\"5746-91ff3bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615365148212815",
"status": "COMPLETED",
"status_changed_ts": "1615367979556348",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181263",
"builder:Linux Builder (dbg)",
"buildset:commit/git/0385ffbfe47191ea609f0ce5df3a1599f10697fb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0385ffbfe47191ea609f0ce5df3a1599f10697fb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018590654515120432",
"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/8853160592492457616/+/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:523415929b91ba10",
"user_agent:luci-scheduler"
],
"updated_ts": "1615367979560908",
"url": "https://ci.chromium.org/b/8853160592492457616",
"utcnow_ts": "1615367980133995"
}
}
[09:19:40.151] Invocation finished in 47m15.335330522s with status SUCCEEDED