[02:13:45.467] New invocation is queued and will start shortly
[02:13:46.867] Starting the invocation (attempt 1)
[02:13:46.901] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:13:46.901] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:13:46.901] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022147759183788704",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d34f70d46207594d9afa90f821cd428f41707266\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9022147759183788704",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/d34f70d46207594d9afa90f821cd428f41707266",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d34f70d46207594d9afa90f821cd428f41707266",
"gitiles_ref:refs/heads/master"
]
}
[02:13:47.503] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611972827009245",
"id": "8856717696904524176",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d34f70d46207594d9afa90f821cd428f41707266\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611972827380024",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22406",
"builder:linux-chromeos-dbg",
"buildset:commit/git/d34f70d46207594d9afa90f821cd428f41707266",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d34f70d46207594d9afa90f821cd428f41707266",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022147759183788704",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8856717696904524176/+/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": "1611972827380309",
"url": "https://ci.chromium.org/b/8856717696904524176",
"utcnow_ts": "1611972827495711"
}
}
[02:13:47.503] Task URL: https://ci.chromium.org/b/8856717696904524176
[02:13:47.503] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:2:0) after 1m0s
[02:14:47.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:2:0)
[02:14:47.513] Timer tick, asking Buildbucket for the build status
[02:14:47.631] Build 8856717696904524176: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:14:47.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:3:0) after 1m0s
[02:15:47.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:3:0)
[02:15:47.656] Timer tick, asking Buildbucket for the build status
[02:15:47.733] Build 8856717696904524176: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:15:47.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:4:0) after 1m0s
[02:15:56.258] Received PubSub notification, asking Buildbucket for the build status
[02:15:56.326] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:47.790] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:4:0)
[02:16:47.790] Timer tick, asking Buildbucket for the build status
[02:16:47.926] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:47.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:6:0) after 1m0s
[02:17:47.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:6:0)
[02:17:47.972] Timer tick, asking Buildbucket for the build status
[02:17:48.303] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:48.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:7:0) after 1m0s
[02:18:48.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:7:0)
[02:18:48.319] Timer tick, asking Buildbucket for the build status
[02:18:48.414] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:48.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:8:0) after 1m0s
[02:19:48.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:8:0)
[02:19:48.466] Timer tick, asking Buildbucket for the build status
[02:19:48.566] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:48.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:9:0) after 1m0s
[02:20:48.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:9:0)
[02:20:48.589] Timer tick, asking Buildbucket for the build status
[02:20:48.766] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:48.766] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:10:0) after 1m0s
[02:21:48.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:10:0)
[02:21:48.810] Timer tick, asking Buildbucket for the build status
[02:21:48.894] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:48.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:11:0) after 1m0s
[02:22:48.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:11:0)
[02:22:48.942] Timer tick, asking Buildbucket for the build status
[02:22:49.022] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:49.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:12:0) after 1m0s
[02:23:49.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:12:0)
[02:23:49.043] Timer tick, asking Buildbucket for the build status
[02:23:49.160] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:49.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:13:0) after 1m0s
[02:24:49.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:13:0)
[02:24:49.241] Timer tick, asking Buildbucket for the build status
[02:24:49.658] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:49.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:14:0) after 1m0s
[02:25:49.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:14:0)
[02:25:49.748] Timer tick, asking Buildbucket for the build status
[02:25:49.824] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:49.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:15:0) after 1m0s
[02:26:49.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:15:0)
[02:26:49.878] Timer tick, asking Buildbucket for the build status
[02:26:49.992] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:49.992] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:16:0) after 1m0s
[02:27:49.978] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:16:0)
[02:27:49.978] Timer tick, asking Buildbucket for the build status
[02:27:50.044] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:50.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:17:0) after 1m0s
[02:28:50.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:17:0)
[02:28:50.125] Timer tick, asking Buildbucket for the build status
[02:28:50.234] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:50.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:18:0) after 1m0s
[02:29:50.309] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:18:0)
[02:29:50.309] Timer tick, asking Buildbucket for the build status
[02:29:51.738] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:51.738] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:19:0) after 1m0s
[02:30:51.763] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:19:0)
[02:30:51.763] Timer tick, asking Buildbucket for the build status
[02:30:51.866] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:51.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:20:0) after 1m0s
[02:31:51.902] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:20:0)
[02:31:51.902] Timer tick, asking Buildbucket for the build status
[02:31:51.986] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:51.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:21:0) after 1m0s
[02:32:52.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:21:0)
[02:32:52.086] Timer tick, asking Buildbucket for the build status
[02:32:52.179] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:52.179] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:22:0) after 1m0s
[02:33:52.359] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:22:0)
[02:33:52.359] Timer tick, asking Buildbucket for the build status
[02:33:52.617] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:52.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:23:0) after 1m0s
[02:34:52.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:23:0)
[02:34:52.643] Timer tick, asking Buildbucket for the build status
[02:34:52.732] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:52.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:24:0) after 1m0s
[02:35:52.876] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:24:0)
[02:35:52.876] Timer tick, asking Buildbucket for the build status
[02:35:52.940] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:52.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:25:0) after 1m0s
[02:36:52.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:25:0)
[02:36:52.964] Timer tick, asking Buildbucket for the build status
[02:36:53.037] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:53.037] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:26:0) after 1m0s
[02:37:53.219] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:26:0)
[02:37:53.219] Timer tick, asking Buildbucket for the build status
[02:37:53.322] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:53.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:27:0) after 1m0s
[02:38:53.354] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:27:0)
[02:38:53.354] Timer tick, asking Buildbucket for the build status
[02:38:53.539] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:53.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:28:0) after 1m0s
[02:39:53.577] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:28:0)
[02:39:53.577] Timer tick, asking Buildbucket for the build status
[02:39:53.635] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:53.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:29:0) after 1m0s
[02:40:53.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:29:0)
[02:40:53.705] Timer tick, asking Buildbucket for the build status
[02:40:53.763] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:53.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:30:0) after 1m0s
[02:41:53.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:30:0)
[02:41:53.974] Timer tick, asking Buildbucket for the build status
[02:41:54.138] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:54.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:31:0) after 1m0s
[02:42:54.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:31:0)
[02:42:54.319] Timer tick, asking Buildbucket for the build status
[02:42:54.379] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:54.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:32:0) after 1m0s
[02:43:54.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:32:0)
[02:43:54.406] Timer tick, asking Buildbucket for the build status
[02:43:54.510] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:54.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:33:0) after 1m0s
[02:44:54.574] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:33:0)
[02:44:54.574] Timer tick, asking Buildbucket for the build status
[02:44:54.679] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:54.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:34:0) after 1m0s
[02:45:54.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:34:0)
[02:45:54.831] Timer tick, asking Buildbucket for the build status
[02:45:54.890] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:54.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:35:0) after 1m0s
[02:46:54.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:35:0)
[02:46:54.973] Timer tick, asking Buildbucket for the build status
[02:46:55.107] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:55.107] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:36:0) after 1m0s
[02:47:55.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:36:0)
[02:47:55.128] Timer tick, asking Buildbucket for the build status
[02:47:55.270] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:55.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:37:0) after 1m0s
[02:48:55.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:37:0)
[02:48:55.346] Timer tick, asking Buildbucket for the build status
[02:48:55.470] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:55.470] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:38:0) after 1m0s
[02:49:55.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:38:0)
[02:49:55.513] Timer tick, asking Buildbucket for the build status
[02:49:55.586] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:55.586] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:39:0) after 1m0s
[02:50:55.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:39:0)
[02:50:55.639] Timer tick, asking Buildbucket for the build status
[02:50:56.151] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:56.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:40:0) after 1m0s
[02:51:56.328] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:40:0)
[02:51:56.328] Timer tick, asking Buildbucket for the build status
[02:51:56.537] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:56.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:41:0) after 1m0s
[02:52:56.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:41:0)
[02:52:56.620] Timer tick, asking Buildbucket for the build status
[02:52:56.784] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:56.784] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:42:0) after 1m0s
[02:53:56.807] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:42:0)
[02:53:56.807] Timer tick, asking Buildbucket for the build status
[02:53:57.053] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:57.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:43:0) after 1m0s
[02:54:57.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:43:0)
[02:54:57.104] Timer tick, asking Buildbucket for the build status
[02:54:57.305] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:57.305] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:44:0) after 1m0s
[02:55:57.318] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:44:0)
[02:55:57.318] Timer tick, asking Buildbucket for the build status
[02:55:57.392] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:57.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:45:0) after 1m0s
[02:56:57.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:45:0)
[02:56:57.464] Timer tick, asking Buildbucket for the build status
[02:56:57.641] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:57.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:46:0) after 1m0s
[02:57:57.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:46:0)
[02:57:57.708] Timer tick, asking Buildbucket for the build status
[02:57:58.074] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:58.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:47:0) after 1m0s
[02:58:58.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:47:0)
[02:58:58.095] Timer tick, asking Buildbucket for the build status
[02:58:58.209] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:58.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:48:0) after 1m0s
[02:59:58.321] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:48:0)
[02:59:58.321] Timer tick, asking Buildbucket for the build status
[02:59:58.470] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:58.470] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:49:0) after 1m0s
[03:00:58.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:49:0)
[03:00:58.466] Timer tick, asking Buildbucket for the build status
[03:00:58.576] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:58.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:50:0) after 1m0s
[03:01:58.703] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:50:0)
[03:01:58.703] Timer tick, asking Buildbucket for the build status
[03:01:58.925] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:58.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:51:0) after 1m0s
[03:02:58.948] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:51:0)
[03:02:58.948] Timer tick, asking Buildbucket for the build status
[03:02:59.505] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:59.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:52:0) after 1m0s
[03:03:59.619] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:52:0)
[03:03:59.619] Timer tick, asking Buildbucket for the build status
[03:03:59.797] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:59.797] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:53:0) after 1m0s
[03:04:59.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:53:0)
[03:04:59.845] Timer tick, asking Buildbucket for the build status
[03:04:59.950] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:59.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:54:0) after 1m0s
[03:05:59.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:54:0)
[03:05:59.974] Timer tick, asking Buildbucket for the build status
[03:06:00.215] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:00.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:55:0) after 1m0s
[03:07:05.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:55:0)
[03:07:05.516] Timer tick, asking Buildbucket for the build status
[03:07:05.592] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:05.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:56:0) after 1m0s
[03:08:05.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:56:0)
[03:08:05.706] Timer tick, asking Buildbucket for the build status
[03:08:05.948] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:05.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:57:0) after 1m0s
[03:09:06.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:57:0)
[03:09:06.009] Timer tick, asking Buildbucket for the build status
[03:09:06.327] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:06.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:58:0) after 1m0s
[03:10:06.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:58:0)
[03:10:06.393] Timer tick, asking Buildbucket for the build status
[03:10:06.469] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:06.469] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:59:0) after 1m0s
[03:11:06.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:59:0)
[03:11:06.513] Timer tick, asking Buildbucket for the build status
[03:11:06.572] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:06.572] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:60:0) after 1m0s
[03:12:06.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:60:0)
[03:12:06.640] Timer tick, asking Buildbucket for the build status
[03:12:06.809] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:06.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:61:0) after 1m0s
[03:13:06.894] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:61:0)
[03:13:06.896] Timer tick, asking Buildbucket for the build status
[03:13:07.158] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:07.158] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:62:0) after 1m0s
[03:14:07.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:62:0)
[03:14:07.184] Timer tick, asking Buildbucket for the build status
[03:14:07.376] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:07.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:63:0) after 1m0s
[03:15:07.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:63:0)
[03:15:07.407] Timer tick, asking Buildbucket for the build status
[03:15:07.795] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:07.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:64:0) after 1m0s
[03:16:07.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:64:0)
[03:16:07.853] Timer tick, asking Buildbucket for the build status
[03:16:08.138] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:08.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:65:0) after 1m0s
[03:17:08.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:65:0)
[03:17:08.169] Timer tick, asking Buildbucket for the build status
[03:17:08.296] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:08.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:66:0) after 1m0s
[03:18:08.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:66:0)
[03:18:08.322] Timer tick, asking Buildbucket for the build status
[03:18:08.416] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:08.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:67:0) after 1m0s
[03:19:08.436] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:67:0)
[03:19:08.436] Timer tick, asking Buildbucket for the build status
[03:19:08.540] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:08.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:68:0) after 1m0s
[03:20:08.529] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:68:0)
[03:20:08.529] Timer tick, asking Buildbucket for the build status
[03:20:08.773] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:08.773] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:69:0) after 1m0s
[03:21:08.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:69:0)
[03:21:08.794] Timer tick, asking Buildbucket for the build status
[03:21:08.907] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:08.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:70:0) after 1m0s
[03:22:08.889] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:70:0)
[03:22:08.889] Timer tick, asking Buildbucket for the build status
[03:22:09.106] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:09.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:71:0) after 1m0s
[03:23:09.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:71:0)
[03:23:09.111] Timer tick, asking Buildbucket for the build status
[03:23:09.199] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:09.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:72:0) after 1m0s
[03:24:09.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:72:0)
[03:24:09.275] Timer tick, asking Buildbucket for the build status
[03:24:09.428] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:09.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:73:0) after 1m0s
[03:25:09.451] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:73:0)
[03:25:09.451] Timer tick, asking Buildbucket for the build status
[03:25:09.547] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:09.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:74:0) after 1m0s
[03:26:09.587] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:74:0)
[03:26:09.587] Timer tick, asking Buildbucket for the build status
[03:26:09.663] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:09.663] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:75:0) after 1m0s
[03:27:09.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:75:0)
[03:27:09.744] Timer tick, asking Buildbucket for the build status
[03:27:09.844] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:09.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:76:0) after 1m0s
[03:28:09.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:76:0)
[03:28:09.895] Timer tick, asking Buildbucket for the build status
[03:28:09.980] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:09.980] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:77:0) after 1m0s
[03:29:10.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:77:0)
[03:29:10.094] Timer tick, asking Buildbucket for the build status
[03:29:10.614] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:10.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:78:0) after 1m0s
[03:30:10.679] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:78:0)
[03:30:10.679] Timer tick, asking Buildbucket for the build status
[03:30:10.827] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:10.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:79:0) after 1m0s
[03:31:10.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:79:0)
[03:31:10.903] Timer tick, asking Buildbucket for the build status
[03:31:11.105] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:11.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:80:0) after 1m0s
[03:32:11.201] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:80:0)
[03:32:11.201] Timer tick, asking Buildbucket for the build status
[03:32:11.283] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:11.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:81:0) after 1m0s
[03:33:11.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:81:0)
[03:33:11.325] Timer tick, asking Buildbucket for the build status
[03:33:11.384] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:11.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:82:0) after 1m0s
[03:34:11.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:82:0)
[03:34:11.392] Timer tick, asking Buildbucket for the build status
[03:34:11.512] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:11.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:83:0) after 1m0s
[03:35:11.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:83:0)
[03:35:11.539] Timer tick, asking Buildbucket for the build status
[03:35:11.598] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:11.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:84:0) after 1m0s
[03:36:11.624] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:84:0)
[03:36:11.624] Timer tick, asking Buildbucket for the build status
[03:36:11.742] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:11.742] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:85:0) after 1m0s
[03:37:11.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:85:0)
[03:37:11.797] Timer tick, asking Buildbucket for the build status
[03:37:11.926] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:11.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:86:0) after 1m0s
[03:38:11.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:86:0)
[03:38:11.944] Timer tick, asking Buildbucket for the build status
[03:38:12.048] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:12.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:87:0) after 1m0s
[03:39:12.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:87:0)
[03:39:12.099] Timer tick, asking Buildbucket for the build status
[03:39:12.204] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:12.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:88:0) after 1m0s
[03:40:12.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:88:0)
[03:40:12.233] Timer tick, asking Buildbucket for the build status
[03:40:12.317] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:12.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:89:0) after 1m0s
[03:41:12.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:89:0)
[03:41:12.348] Timer tick, asking Buildbucket for the build status
[03:41:12.505] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:12.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:90:0) after 1m0s
[03:42:12.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:90:0)
[03:42:12.551] Timer tick, asking Buildbucket for the build status
[03:42:12.620] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:12.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:91:0) after 1m0s
[03:43:12.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:91:0)
[03:43:12.612] Timer tick, asking Buildbucket for the build status
[03:43:12.682] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:12.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:92:0) after 1m0s
[03:44:12.704] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:92:0)
[03:44:12.704] Timer tick, asking Buildbucket for the build status
[03:44:12.835] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:12.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:93:0) after 1m0s
[03:45:12.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:93:0)
[03:45:12.866] Timer tick, asking Buildbucket for the build status
[03:45:12.935] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:12.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:94:0) after 1m0s
[03:46:12.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:94:0)
[03:46:12.968] Timer tick, asking Buildbucket for the build status
[03:46:13.049] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:13.049] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:95:0) after 1m0s
[03:47:13.061] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:95:0)
[03:47:13.061] Timer tick, asking Buildbucket for the build status
[03:47:13.171] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:13.171] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:96:0) after 1m0s
[03:48:13.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:96:0)
[03:48:13.202] Timer tick, asking Buildbucket for the build status
[03:48:13.607] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:13.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:97:0) after 1m0s
[03:49:13.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:97:0)
[03:49:13.628] Timer tick, asking Buildbucket for the build status
[03:49:14.500] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:14.500] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:98:0) after 1m0s
[03:50:14.540] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:98:0)
[03:50:14.540] Timer tick, asking Buildbucket for the build status
[03:50:14.659] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:14.659] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:99:0) after 1m0s
[03:51:14.726] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:99:0)
[03:51:14.726] Timer tick, asking Buildbucket for the build status
[03:51:14.825] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:14.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:100:0) after 1m0s
[03:52:14.809] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:100:0)
[03:52:14.809] Timer tick, asking Buildbucket for the build status
[03:52:14.902] Build 8856717696904524176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:14.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022147759183788704:101:0) after 1m0s
[03:52:45.466] Received PubSub notification, asking Buildbucket for the build status
[03:52:45.726] Build 8856717696904524176: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:52:45.726] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611978763507635",
"created_by": "project:chromium",
"created_ts": "1611972827009245",
"id": "8856717696904524176",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d34f70d46207594d9afa90f821cd428f41707266\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"d34f70d46207594d9afa90f821cd428f41707266\", \"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-214-1slc\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22406, \"got_angle_revision\": \"74f7be6d1fd020a432dee63222fa090e4d8df651\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"d34f70d46207594d9afa90f821cd428f41707266\", \"got_revision_cp\": \"refs/heads/master@{#848851}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3e9b79ff42de0f5547809354de89e24c7a439e39\", \"got_v8_revision\": \"89b433d7c3defd04809fba9deb6f8885160044a4\", \"got_v8_revision_cp\": \"refs/heads/9.0.100@{#1}\", \"got_webrtc_revision\": \"c5bdac64cf221b561c1678a59badfbeacd534d46\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33101}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d34f70d46207594d9afa90f821cd428f41707266\", \"swarm_hashes_refs/heads/master(at){#848851}_without_patch\": {\"absl_hardening_tests\": \"ebf8df651c660dfcfaaaa5413b6b5066df304bd2\", \"accessibility_unittests\": \"97bd6f1d05b3bd92dcecc1605c227b4125f56f93\", \"angle_unittests\": \"ffb5f108145a7bc3394abcbc64a90b7f26567453\", \"app_list_unittests\": \"aac94a3fbad1f830559109fc524195e7890066cf\", \"app_shell_unittests\": \"a41d95456118a0512f3583009d0864e4e01f8d31\", \"ash_unittests\": \"509e183e94dd0482b5fa19e60d30005031ff98b3\", \"aura_unittests\": \"4017cdfbda7b5fe004a3a3aa57e3f573fe9efbde\", \"base_unittests\": \"567d9a0cec1a5626251a7f597b695316fd0a9c73\", \"base_util_unittests\": \"2a3029ff80f83554f165b76dbe5134b47627ffd9\", \"blink_common_unittests\": \"3b1e789ba549ca18c6bb0dcdc763aebf819d3cf0\", \"blink_fuzzer_unittests\": \"a3844e0c40a1946b8ed2f23e4a6b44b5a13f3fc6\", \"blink_heap_unittests\": \"827c5191dc316fb6ea4852a12b674ff58b3158a1\", \"blink_platform_unittests\": \"a065531dfd859e0b9d0126144e119cb6efbd2153\", \"blink_unittests\": \"3c12ce6794b9abd86b47fa6523838acfd82d99e2\", \"boringssl_crypto_tests\": \"14896789cc439f669fa943c82ecc31d09e483be4\", \"boringssl_ssl_tests\": \"eefe7cd34913b9bd3b6c39262ca860e9ad718862\", \"browser_tests\": \"f137f3db1cbbdda115e7f3772300e1f7d950bdfe\", \"capture_unittests\": \"be374583d8841faba929dac9e22bddcff7b8e5f2\", \"cast_unittests\": \"3ba35f99d0de84387593c180caf69ab53526f30a\", \"cc_unittests\": \"50304898c7e92cb46c585df5842e2c72c036e1ca\", \"chrome_app_unittests\": \"21305ac4e89fd53335f0ac5c779d2b54452e67c2\", \"chromedriver_unittests\": \"31a3ba137e065f4e1936e151172b164c76c1ffc0\", \"chromeos_components_unittests\": \"f28fc45d99813854d9694720a813d09b78cb0a27\", \"chromeos_unittests\": \"8e99a00fb373391341aca0f353796e91f52328fd\", \"components_browsertests\": \"ef37abfc7a9c630dec22b6fe917409f9d94cbd3f\", \"components_unittests\": \"1947bc3c88d0f44f10ca2010b308a98be0e01579\", \"compositor_unittests\": \"0bbabff3cefb6a6c97638be1c1aa6daf8cd64117\", \"content_browsertests\": \"f11c4338a8802f094f87f84c3cfa6535308a6c7e\", \"content_unittests\": \"d11f2c8dfccf7fb21ba908268acd66d08340ce2d\", \"crashpad_tests\": \"817204909c2eae8979770fea84c84bb3b5540558\", \"crypto_unittests\": \"88d461dfce1e467aa7e80da91cb94ef5446f159b\", \"dbus_unittests\": \"8f5b8148f8aeb386ef850ecd44b2044592adb9c3\", \"device_unittests\": \"992120a3477ae9d7999d539f3052d908e29a4d07\", \"display_unittests\": \"4f4a86f96e0400b4a030fde31d304e5822588002\", \"events_unittests\": \"5aa46fabb59063f9637a1201e44d832f036ccf00\", \"exo_unittests\": \"2f00f010cb102aea2b24cc4671af21a4902bc480\", \"extensions_browsertests\": \"7d08aaac05fec07ca45131c267b3075d0c4dc8e6\", \"extensions_unittests\": \"5b74c833037ea6570674c29b66b389cfc7073f14\", \"filesystem_service_unittests\": \"5b82b07312b73e00ee11538bcb96e6329a7a0dd0\", \"gcm_unit_tests\": \"98cd7691cc12400096d7636b7b24594b0c2a603e\", \"gfx_unittests\": \"11ac17de86f3e34e77d6600c5af955e69c060844\", \"gin_unittests\": \"f1063e4bf967c9ff19bd0da27d20d4eb4fccf64c\", \"gl_unittests_ozone\": \"ff04e2cd10cfb7960024d8c86ad6e65ca99270fa\", \"google_apis_unittests\": \"ddd7b44bd32375d700b0169ec2dcad3e304527cb\", \"gpu_unittests\": \"962b582fe0846f789c94edff8621948bde4c2887\", \"gwp_asan_unittests\": \"be19e3d043cd2724f2d7a633d6c1d5be1f5da025\", \"interactive_ui_tests\": \"9585310ab6552f4c7b18ab3a43f29798aa289dfa\", \"ipc_tests\": \"d15ebc3e7d0e30985432d592391997cfbe8f13d1\", \"jingle_unittests\": \"72343141cbcfb9bdb604123301aeb8a584a3e4f6\", \"keyboard_unittests\": \"11984264a3f8058b551bf634d15aef43bff619ed\", \"latency_unittests\": \"4b04f91391d758476ec07c6235e3530ff9e9b489\", \"libjingle_xmpp_unittests\": \"525953777819ed39ae31ae6a6fdb15361db5d63c\", \"liburlpattern_unittests\": \"d8ee6d4550ce95b9544819ea0dc2928d9497c8ac\", \"media_blink_unittests\": \"37b27ea96f88b16df19a374a1bae3f6cd6a9d0c9\", \"media_unittests\": \"74b8d3e11578f6800e0cec54ca6b70b78c2e05aa\", \"message_center_unittests\": \"b503982530d398422fa21cb88faebfed198be0bd\", \"midi_unittests\": \"482f01ad25a9dd81fa13d8d648c8638dd76aa715\", \"mojo_core_unittests\": \"890983ff1c79e931ea96a0a788e5ebcec82d68d8\", \"mojo_unittests\": \"b2530e846ef46e8c707a6dfda240d10d5336e24b\", \"nacl_helper_nonsfi_unittests\": \"971d2c10f92157b50416d2097da0ed9de8a47704\", \"nacl_loader_unittests\": \"f6ca301a1624ebc4e5071b2ed50993ccdbefac62\", \"native_theme_unittests\": \"420cc8a5a14100ec4bbfc5478c6593bb0b0b79ef\", \"net_unittests\": \"270160bebf28cd067fd3939340b559ee511f4cc4\", \"ozone_gl_unittests\": \"00c6efd7004e082cf3adb2e4c60813e1685145da\", \"ozone_unittests\": \"f2ace575e857246fd738ce3c4f57a52601aa18e4\", \"ozone_x11_unittests\": \"916f5c566a9d8bb90e47e8807c9abf9d9dd16e3a\", \"pdf_unittests\": \"21bc4544d753fb2c8439400e1aa7606bb5803219\", \"perfetto_unittests\": \"54105638b0230aa8c4dda38a675770e7a24b40e2\", \"ppapi_unittests\": \"61ac60c8f30a35ffd008ad6a5a38d2cf7e81fb46\", \"printing_unittests\": \"2000e570e0cded94792da52c5015de53860bdc9d\", \"remoting_unittests\": \"07a52d3b5feea69f4dbaa8b73fc16ebcc51e7565\", \"sandbox_linux_unittests\": \"71525a408a4b6484fc8f54515c2ca696ea3cc4eb\", \"service_manager_unittests\": \"9fcd0b228e47f224a8cc4ab1a4b40fc018ddefda\", \"services_unittests\": \"68850a5196ad73f30ab72a09522f04563d8a9df0\", \"shell_dialogs_unittests\": \"fa2f9e1065e280bd3d85a4c5132319d7fc921f56\", \"shell_encryption_unittests\": \"f642003b15ae8029d9543a28f6f6fced5c39311c\", \"skia_unittests\": \"d5fd3762a4720ea2e4a6993dc55e254c9f760425\", \"snapshot_unittests\": \"0860b1bf91a480e946c3a20c5a91c57f5883b0a9\", \"sql_unittests\": \"94a7f2e130ff2496755c7f2aa08fc7bead3acc3e\", \"storage_unittests\": \"ab0382b1a16108beef83d925b3f0986f0bd142c3\", \"sync_integration_tests\": \"44f0c068c731ddcd56378848cdd361656d006257\", \"traffic_annotation_auditor_unittests\": \"5d6871bcf2b64f52e3851db5bfb99dec15b2102c\", \"ui_base_unittests\": \"0f0e7622671d0f76692fc784afc5ce2cd0090949\", \"ui_chromeos_unittests\": \"a070c721d47e0dc23beab9673f013de18e0637f5\", \"ui_touch_selection_unittests\": \"fe4bcae08ed703cc13329cb6942a760bdb63696c\", \"unit_tests\": \"c95431a3c2c61ada709b56b81f1ecf0e4d87581f\", \"url_unittests\": \"0e2d40d8afad8fbfa87bae5d2edc63454d3d0176\", \"usage_time_limit_unittests\": \"e70ab63ee5cd4a339f6e00e548b427c29f1255db\", \"views_unittests\": \"4cdf09c7bab6c3230460f36ffdd8ee977ebf207f\", \"viz_unittests\": \"9f625f1c485f7aee470cc62d25c235322ef56fcd\", \"wm_unittests\": \"1a59488bd8527c92afab636b4147ddf041e4cb99\", \"wtf_unittests\": \"88fe73624632af7741ece44273cac52d7595d4f1\", \"zlib_unittests\": \"ac0d6d27b43aed0bfee9f3dcae386d482b055658\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_158d0f10fa5d87b7b90de0551ce233e88e46559602c021beec49ce89728c3318_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_5f9879dd307b3e3de87d4273aaf77dfc3adf50a63c1d75c3b245bfdff463a933_v2\", \"builder_957c0f1a1c74c3ada6665996f2ff614223d5da32e2cc2316ff7cc4c9c4beae5c_v2\", \"builder_b6367afba840c5eef309d6435187ce32d936dc893e5a665719688ecda1f7847e_v2\", \"builder_c49efc2b6fcfe67b72a35f6b436282fc6c4393b61b532dfc8ddacf832f201b2b_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-214-1slc\"], \"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\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611972955483297",
"status": "COMPLETED",
"status_changed_ts": "1611978763988647",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22406",
"builder:linux-chromeos-dbg",
"buildset:commit/git/d34f70d46207594d9afa90f821cd428f41707266",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d34f70d46207594d9afa90f821cd428f41707266",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022147759183788704",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8856717696904524176/+/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:5169e2e1f379dd10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611978764008220",
"url": "https://ci.chromium.org/b/8856717696904524176",
"utcnow_ts": "1611978765712938"
}
}
[03:52:45.726] Invocation finished in 1h39m0.274626157s with status SUCCEEDED