[18:19:43.692] New invocation is queued and will start shortly
[18:19:44.804] Starting the invocation (attempt 1)
[18:19:44.875] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:19:44.882] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:19:44.883] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028881758072765584",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"cc244f13743731c71f4324271ef2810a7be07b66\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9028881758072765584",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/cc244f13743731c71f4324271ef2810a7be07b66",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cc244f13743731c71f4324271ef2810a7be07b66",
"gitiles_ref:refs/heads/master"
]
}
[18:19:45.664] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605550785015122",
"id": "8863451696009855616",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cc244f13743731c71f4324271ef2810a7be07b66\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605550785493053",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21334",
"builder:linux-chromeos-dbg",
"buildset:commit/git/cc244f13743731c71f4324271ef2810a7be07b66",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cc244f13743731c71f4324271ef2810a7be07b66",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028881758072765584",
"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/8863451696009855616/+/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": "1605550785493217",
"url": "https://ci.chromium.org/b/8863451696009855616",
"utcnow_ts": "1605550785643010"
}
}
[18:19:45.664] Task URL: https://ci.chromium.org/b/8863451696009855616
[18:19:45.664] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:2:0) after 1m0s
[18:19:48.193] Received PubSub notification, asking Buildbucket for the build status
[18:19:48.528] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:45.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:2:0)
[18:20:45.725] Timer tick, asking Buildbucket for the build status
[18:20:45.849] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:45.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:4:0) after 1m0s
[18:21:45.946] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:4:0)
[18:21:45.946] Timer tick, asking Buildbucket for the build status
[18:21:46.056] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:46.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:5:0) after 1m0s
[18:22:46.107] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:5:0)
[18:22:46.108] Timer tick, asking Buildbucket for the build status
[18:22:46.186] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:46.186] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:6:0) after 1m0s
[18:23:46.239] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:6:0)
[18:23:46.239] Timer tick, asking Buildbucket for the build status
[18:23:46.369] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:46.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:7:0) after 1m0s
[18:24:46.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:7:0)
[18:24:46.429] Timer tick, asking Buildbucket for the build status
[18:24:46.521] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:46.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:8:0) after 1m0s
[18:25:46.625] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:8:0)
[18:25:46.625] Timer tick, asking Buildbucket for the build status
[18:25:46.725] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:46.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:9:0) after 1m0s
[18:26:46.782] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:9:0)
[18:26:46.782] Timer tick, asking Buildbucket for the build status
[18:26:46.903] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:46.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:10:0) after 1m0s
[18:27:46.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:10:0)
[18:27:46.928] Timer tick, asking Buildbucket for the build status
[18:27:47.005] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:47.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:11:0) after 1m0s
[18:28:47.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:11:0)
[18:28:47.039] Timer tick, asking Buildbucket for the build status
[18:28:47.124] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:47.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:12:0) after 1m0s
[18:29:47.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:12:0)
[18:29:47.145] Timer tick, asking Buildbucket for the build status
[18:29:47.344] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:47.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:13:0) after 1m0s
[18:30:47.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:13:0)
[18:30:47.379] Timer tick, asking Buildbucket for the build status
[18:30:47.602] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:47.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:14:0) after 1m0s
[18:31:47.592] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:14:0)
[18:31:47.592] Timer tick, asking Buildbucket for the build status
[18:31:47.670] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:47.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:15:0) after 1m0s
[18:32:47.923] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:15:0)
[18:32:47.923] Timer tick, asking Buildbucket for the build status
[18:32:48.006] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:48.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:16:0) after 1m0s
[18:33:48.227] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:16:0)
[18:33:48.227] Timer tick, asking Buildbucket for the build status
[18:33:48.305] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:48.305] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:17:0) after 1m0s
[18:34:48.414] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:17:0)
[18:34:48.414] Timer tick, asking Buildbucket for the build status
[18:34:48.519] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:48.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:18:0) after 1m0s
[18:35:48.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:18:0)
[18:35:48.609] Timer tick, asking Buildbucket for the build status
[18:35:48.696] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:48.696] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:19:0) after 1m0s
[18:36:48.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:19:0)
[18:36:48.725] Timer tick, asking Buildbucket for the build status
[18:36:48.815] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:48.815] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:20:0) after 1m0s
[18:37:48.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:20:0)
[18:37:48.903] Timer tick, asking Buildbucket for the build status
[18:37:49.215] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:49.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:21:0) after 1m0s
[18:38:49.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:21:0)
[18:38:49.275] Timer tick, asking Buildbucket for the build status
[18:38:49.421] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:49.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:22:0) after 1m0s
[18:39:49.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:22:0)
[18:39:49.471] Timer tick, asking Buildbucket for the build status
[18:39:49.577] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:49.577] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:23:0) after 1m0s
[18:40:49.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:23:0)
[18:40:49.613] Timer tick, asking Buildbucket for the build status
[18:40:49.723] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:49.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:24:0) after 1m0s
[18:41:49.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:24:0)
[18:41:49.873] Timer tick, asking Buildbucket for the build status
[18:41:50.056] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:50.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:25:0) after 1m0s
[18:42:50.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:25:0)
[18:42:50.109] Timer tick, asking Buildbucket for the build status
[18:42:50.190] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:50.190] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:26:0) after 1m0s
[18:43:50.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:26:0)
[18:43:50.255] Timer tick, asking Buildbucket for the build status
[18:43:50.313] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:50.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:27:0) after 1m0s
[18:44:50.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:27:0)
[18:44:50.366] Timer tick, asking Buildbucket for the build status
[18:44:50.476] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:50.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:28:0) after 1m0s
[18:45:50.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:28:0)
[18:45:50.546] Timer tick, asking Buildbucket for the build status
[18:45:50.612] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:50.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:29:0) after 1m0s
[18:46:50.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:29:0)
[18:46:50.618] Timer tick, asking Buildbucket for the build status
[18:46:50.689] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:50.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:30:0) after 1m0s
[18:47:50.752] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:30:0)
[18:47:50.752] Timer tick, asking Buildbucket for the build status
[18:47:50.823] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:50.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:31:0) after 1m0s
[18:48:50.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:31:0)
[18:48:50.871] Timer tick, asking Buildbucket for the build status
[18:48:51.564] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:51.564] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:32:0) after 1m0s
[18:49:51.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:32:0)
[18:49:51.618] Timer tick, asking Buildbucket for the build status
[18:49:51.727] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:51.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:33:0) after 1m0s
[18:50:51.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:33:0)
[18:50:51.786] Timer tick, asking Buildbucket for the build status
[18:50:51.926] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:51.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:34:0) after 1m0s
[18:51:51.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:34:0)
[18:51:51.971] Timer tick, asking Buildbucket for the build status
[18:51:52.151] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:52.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:35:0) after 1m0s
[18:52:52.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:35:0)
[18:52:52.184] Timer tick, asking Buildbucket for the build status
[18:52:52.617] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:52.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:36:0) after 1m0s
[18:53:52.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:36:0)
[18:53:52.608] Timer tick, asking Buildbucket for the build status
[18:53:56.824] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:56.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:37:0) after 1m0s
[18:54:56.847] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:37:0)
[18:54:56.847] Timer tick, asking Buildbucket for the build status
[18:54:56.991] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:56.991] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:38:0) after 1m0s
[18:55:57.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:38:0)
[18:55:57.067] Timer tick, asking Buildbucket for the build status
[18:55:57.149] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:57.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:39:0) after 1m0s
[18:56:57.254] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:39:0)
[18:56:57.254] Timer tick, asking Buildbucket for the build status
[18:56:57.404] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:57.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:40:0) after 1m0s
[18:57:57.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:40:0)
[18:57:57.471] Timer tick, asking Buildbucket for the build status
[18:57:57.656] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:57.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:41:0) after 1m0s
[18:58:57.776] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:41:0)
[18:58:57.776] Timer tick, asking Buildbucket for the build status
[18:58:57.906] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:57.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:42:0) after 1m0s
[18:59:57.946] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:42:0)
[18:59:57.946] Timer tick, asking Buildbucket for the build status
[18:59:58.065] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:58.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:43:0) after 1m0s
[19:00:58.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:43:0)
[19:00:58.212] Timer tick, asking Buildbucket for the build status
[19:00:58.990] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:58.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:44:0) after 1m0s
[19:01:59.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:44:0)
[19:01:59.028] Timer tick, asking Buildbucket for the build status
[19:01:59.167] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:59.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:45:0) after 1m0s
[19:02:59.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:45:0)
[19:02:59.255] Timer tick, asking Buildbucket for the build status
[19:02:59.379] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:59.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:46:0) after 1m0s
[19:03:59.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:46:0)
[19:03:59.401] Timer tick, asking Buildbucket for the build status
[19:03:59.801] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:59.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:47:0) after 1m0s
[19:04:59.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:47:0)
[19:04:59.836] Timer tick, asking Buildbucket for the build status
[19:04:59.982] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:59.982] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:48:0) after 1m0s
[19:06:00.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:48:0)
[19:06:00.024] Timer tick, asking Buildbucket for the build status
[19:06:00.521] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:00.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:49:0) after 1m0s
[19:07:00.587] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:49:0)
[19:07:00.587] Timer tick, asking Buildbucket for the build status
[19:07:00.747] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:00.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:50:0) after 1m0s
[19:08:00.755] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:50:0)
[19:08:00.755] Timer tick, asking Buildbucket for the build status
[19:08:00.868] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:00.868] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:51:0) after 1m0s
[19:09:00.982] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:51:0)
[19:09:00.982] Timer tick, asking Buildbucket for the build status
[19:09:01.323] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:01.323] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:52:0) after 1m0s
[19:10:01.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:52:0)
[19:10:01.412] Timer tick, asking Buildbucket for the build status
[19:10:02.966] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:02.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:53:0) after 1m0s
[19:11:02.984] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:53:0)
[19:11:02.984] Timer tick, asking Buildbucket for the build status
[19:11:03.303] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:03.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:54:0) after 1m0s
[19:12:03.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:54:0)
[19:12:03.320] Timer tick, asking Buildbucket for the build status
[19:12:03.787] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:03.787] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:55:0) after 1m0s
[19:13:03.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:55:0)
[19:13:03.908] Timer tick, asking Buildbucket for the build status
[19:13:04.046] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:04.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:56:0) after 1m0s
[19:14:04.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:56:0)
[19:14:04.088] Timer tick, asking Buildbucket for the build status
[19:14:04.834] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:04.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:57:0) after 1m0s
[19:15:04.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:57:0)
[19:15:04.845] Timer tick, asking Buildbucket for the build status
[19:15:05.402] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:05.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:58:0) after 1m0s
[19:16:05.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:58:0)
[19:16:05.594] Timer tick, asking Buildbucket for the build status
[19:16:09.267] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:09.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:59:0) after 1m0s
[19:17:09.260] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:59:0)
[19:17:09.260] Timer tick, asking Buildbucket for the build status
[19:17:09.370] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:09.370] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:60:0) after 1m0s
[19:18:09.419] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:60:0)
[19:18:09.419] Timer tick, asking Buildbucket for the build status
[19:18:09.487] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:09.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:61:0) after 1m0s
[19:19:09.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:61:0)
[19:19:09.476] Timer tick, asking Buildbucket for the build status
[19:19:09.548] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:09.548] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:62:0) after 1m0s
[19:20:09.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:62:0)
[19:20:09.579] Timer tick, asking Buildbucket for the build status
[19:20:09.955] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:09.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:63:0) after 1m0s
[19:21:10.006] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:63:0)
[19:21:10.006] Timer tick, asking Buildbucket for the build status
[19:21:10.197] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:10.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:64:0) after 1m0s
[19:22:10.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:64:0)
[19:22:10.371] Timer tick, asking Buildbucket for the build status
[19:22:10.491] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:10.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:65:0) after 1m0s
[19:23:10.561] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:65:0)
[19:23:10.561] Timer tick, asking Buildbucket for the build status
[19:23:10.782] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:10.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:66:0) after 1m0s
[19:24:10.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:66:0)
[19:24:10.911] Timer tick, asking Buildbucket for the build status
[19:24:11.178] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:11.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:67:0) after 1m0s
[19:25:11.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:67:0)
[19:25:11.346] Timer tick, asking Buildbucket for the build status
[19:25:11.537] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:11.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:68:0) after 1m0s
[19:26:11.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:68:0)
[19:26:11.769] Timer tick, asking Buildbucket for the build status
[19:26:12.246] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:12.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:69:0) after 1m0s
[19:27:12.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:69:0)
[19:27:12.287] Timer tick, asking Buildbucket for the build status
[19:27:12.386] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:12.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:70:0) after 1m0s
[19:28:12.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:70:0)
[19:28:12.448] Timer tick, asking Buildbucket for the build status
[19:28:12.768] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:12.769] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:71:0) after 1m0s
[19:29:12.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:71:0)
[19:29:12.766] Timer tick, asking Buildbucket for the build status
[19:29:12.898] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:12.898] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:72:0) after 1m0s
[19:30:13.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:72:0)
[19:30:13.083] Timer tick, asking Buildbucket for the build status
[19:30:13.465] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:13.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:73:0) after 1m0s
[19:31:13.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:73:0)
[19:31:13.569] Timer tick, asking Buildbucket for the build status
[19:31:13.658] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:13.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:74:0) after 1m0s
[19:32:13.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:74:0)
[19:32:13.793] Timer tick, asking Buildbucket for the build status
[19:32:13.870] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:13.870] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:75:0) after 1m0s
[19:33:13.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:75:0)
[19:33:13.983] Timer tick, asking Buildbucket for the build status
[19:33:14.346] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:14.346] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:76:0) after 1m0s
[19:34:14.410] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:76:0)
[19:34:14.410] Timer tick, asking Buildbucket for the build status
[19:34:14.510] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:14.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:77:0) after 1m0s
[19:35:14.582] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:77:0)
[19:35:14.582] Timer tick, asking Buildbucket for the build status
[19:35:14.760] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:14.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:78:0) after 1m0s
[19:36:14.783] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:78:0)
[19:36:14.783] Timer tick, asking Buildbucket for the build status
[19:36:14.953] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:14.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:79:0) after 1m0s
[19:37:15.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:79:0)
[19:37:15.151] Timer tick, asking Buildbucket for the build status
[19:37:15.225] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:15.225] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:80:0) after 1m0s
[19:38:15.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:80:0)
[19:38:15.371] Timer tick, asking Buildbucket for the build status
[19:38:15.450] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:15.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:81:0) after 1m0s
[19:39:15.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:81:0)
[19:39:15.489] Timer tick, asking Buildbucket for the build status
[19:39:15.564] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:15.564] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:82:0) after 1m0s
[19:40:15.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:82:0)
[19:40:15.575] Timer tick, asking Buildbucket for the build status
[19:40:15.685] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:15.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:83:0) after 1m0s
[19:41:15.747] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:83:0)
[19:41:15.747] Timer tick, asking Buildbucket for the build status
[19:41:16.189] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:16.189] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:84:0) after 1m0s
[19:42:16.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:84:0)
[19:42:16.196] Timer tick, asking Buildbucket for the build status
[19:42:16.302] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:16.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:85:0) after 1m0s
[19:43:16.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:85:0)
[19:43:16.441] Timer tick, asking Buildbucket for the build status
[19:43:16.591] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:16.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:86:0) after 1m0s
[19:44:16.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:86:0)
[19:44:16.614] Timer tick, asking Buildbucket for the build status
[19:44:16.701] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:16.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:87:0) after 1m0s
[19:45:16.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:87:0)
[19:45:16.751] Timer tick, asking Buildbucket for the build status
[19:45:16.896] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:16.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:88:0) after 1m0s
[19:46:16.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:88:0)
[19:46:16.992] Timer tick, asking Buildbucket for the build status
[19:46:18.917] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:18.917] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:89:0) after 1m0s
[19:47:18.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:89:0)
[19:47:18.973] Timer tick, asking Buildbucket for the build status
[19:47:19.420] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:19.420] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:90:0) after 1m0s
[19:48:19.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:90:0)
[19:48:19.474] Timer tick, asking Buildbucket for the build status
[19:48:19.553] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:19.553] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:91:0) after 1m0s
[19:49:19.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:91:0)
[19:49:19.631] Timer tick, asking Buildbucket for the build status
[19:49:19.924] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:19.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:92:0) after 1m0s
[19:50:19.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:92:0)
[19:50:19.936] Timer tick, asking Buildbucket for the build status
[19:50:20.088] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:20.088] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:93:0) after 1m0s
[19:51:20.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:93:0)
[19:51:20.102] Timer tick, asking Buildbucket for the build status
[19:51:20.193] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:20.193] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:94:0) after 1m0s
[19:52:20.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:94:0)
[19:52:20.317] Timer tick, asking Buildbucket for the build status
[19:52:20.389] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:20.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:95:0) after 1m0s
[19:53:20.549] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:95:0)
[19:53:20.549] Timer tick, asking Buildbucket for the build status
[19:53:20.672] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:20.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:96:0) after 1m0s
[19:54:20.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:96:0)
[19:54:20.719] Timer tick, asking Buildbucket for the build status
[19:54:20.888] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:20.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:97:0) after 1m0s
[19:55:20.987] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:97:0)
[19:55:20.987] Timer tick, asking Buildbucket for the build status
[19:55:21.220] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:21.220] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:98:0) after 1m0s
[19:56:21.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:98:0)
[19:56:21.267] Timer tick, asking Buildbucket for the build status
[19:56:21.372] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:21.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:99:0) after 1m0s
[19:57:21.400] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:99:0)
[19:57:21.400] Timer tick, asking Buildbucket for the build status
[19:57:21.538] Build 8863451696009855616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:21.538] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028881758072765584:100:0) after 1m0s
[19:58:03.519] Received PubSub notification, asking Buildbucket for the build status
[19:58:03.822] Build 8863451696009855616: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:58:03.822] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605556681166264",
"created_by": "project:chromium",
"created_ts": "1605550785015122",
"id": "8863451696009855616",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cc244f13743731c71f4324271ef2810a7be07b66\"}}",
"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\": \"cc244f13743731c71f4324271ef2810a7be07b66\", \"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-5-xus6\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21334, \"got_angle_revision\": \"f46e6201b40bdee3e0b79d5d97660fc302fd76f5\", \"got_dawn_revision\": \"dd6b36e8801ebeee53342c295fb56812504db80d\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"cc244f13743731c71f4324271ef2810a7be07b66\", \"got_revision_cp\": \"refs/heads/master@{#827835}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"8dceaddf8503b9a83e07ff7788b3edfbb0d9665a\", \"got_v8_revision\": \"cfb8bc492eb44482518665f7d1013d3c2e8f5000\", \"got_v8_revision_cp\": \"refs/heads/8.9.1@{#1}\", \"got_webrtc_revision\": \"02736010cb171c3cc36ea2039911a6dadec9952d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32613}\", \"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\": \"cc244f13743731c71f4324271ef2810a7be07b66\", \"swarm_hashes_refs/heads/master(at){#827835}_without_patch\": {\"absl_hardening_tests\": \"1c8cbac87c399f75979f78e27bac9070b5b4b236\", \"accessibility_unittests\": \"18ddcd88ba3f9b0ea73c60fdcb12fda68f241846\", \"angle_unittests\": \"21113970a4a187b1fb1aa0df94778ffe86fe5c32\", \"app_list_unittests\": \"45293bc46d44db0c76bba3841c72154899c9ab8e\", \"app_shell_unittests\": \"87619696e4466256d00a62ff6a973705031e59ed\", \"ash_unittests\": \"70400b48ddf1051d6ccc617e9e888864ce9c45dc\", \"aura_unittests\": \"283245abdc854feac45347575220473c8d118164\", \"base_unittests\": \"218a8af537c088f7872dd94dae711e68f3add2c2\", \"base_util_unittests\": \"9f937e7136ef673e824e57152e38f9c3e66f3c82\", \"blink_common_unittests\": \"bb7e5635af55f97789e1e26c51733fb67fecd717\", \"blink_fuzzer_unittests\": \"d559a0055a5ead2d040b4e8b5fc161af4ede8347\", \"blink_heap_unittests\": \"f225e28887a7361742a651d948f8d44862a8c77e\", \"blink_platform_unittests\": \"a7ae3aeb94eb88bd561bcecf3e3aae7ee5a7dddf\", \"blink_unittests\": \"45cb21037638520009b5a9cc49bec1d8a08f1030\", \"boringssl_crypto_tests\": \"83d163519db20b914131e27bfb12ddc43bdc48b3\", \"boringssl_ssl_tests\": \"fab169b9ba33303cce400c3c88bc513a7665e15f\", \"browser_tests\": \"b537266ddb76303da5f86055e97f3e10a7339862\", \"capture_unittests\": \"34e3637882e5d2eda0fab3c7ed5f4681f4949ba7\", \"cast_unittests\": \"1bd385f593344489becc5a7dba46b69da946dda8\", \"cc_unittests\": \"7086575ee7d91cdb4bd3afcca18bc439dd7fd139\", \"chrome_app_unittests\": \"68bbc9d3746ac3dcf62e1c20711f68f9939be97d\", \"chromedriver_unittests\": \"3a0dcb4536217b3bdfe2a555f054916358e45aea\", \"chromeos_components_unittests\": \"37af990bf892dee0ba2898771da1cea80c075ed9\", \"chromeos_unittests\": \"6dbd8c90d98a62fd4ebd1fc69e3dbbde413b9102\", \"components_browsertests\": \"7746098a9909b9e1acfe8341bacbc0386b173c42\", \"components_unittests\": \"5b0899c02fd7bd2bd995c9805643ff906c3dba43\", \"compositor_unittests\": \"848ea26c3d46f1f9502e45bd532f38aafef0753e\", \"content_browsertests\": \"52a6e0be798f111dd65aae628e2287f838c04a68\", \"content_unittests\": \"a33653c558e9d0547b01ed7f6e1a0c72faeed919\", \"crashpad_tests\": \"43bbd8f9fd16f37a84cab818aef6b38444976ead\", \"crypto_unittests\": \"c7dc1b95667810c3cc84854f127403d3b14ef95b\", \"dbus_unittests\": \"ea58059e52c06e0048eb25d923af4f5c33084082\", \"device_unittests\": \"e90a7b101eda43d4054151e3770419970711ac62\", \"display_unittests\": \"135ed73ee15f9b47b6ee4af9f53fe44a4403a799\", \"events_unittests\": \"d8794829e9d52fa61d6d88fa6b733502b6afa902\", \"exo_unittests\": \"78ad503e081d629bba47526d9029b03f6b1cc6bf\", \"extensions_browsertests\": \"91680d7ab176c0a064266687ae67c38b3293e09e\", \"extensions_unittests\": \"bddb0a14b70358e4d482328171d3a81712c74d42\", \"filesystem_service_unittests\": \"aa40753b712c43cfaa5ca19e59d515fc5ee77f5c\", \"gcm_unit_tests\": \"0453991055f4b7bb7c6d5159cbe1cb316bbf27c6\", \"gfx_unittests\": \"648a0979d8c8f615f7d7acc7ad7d93b69edd6f85\", \"gin_unittests\": \"125588008b34770080adbdb1f931fd7eb9b4a92e\", \"gl_unittests_ozone\": \"5a8f917ea39b3fc57a90e9c49d04ecfb0e8ae990\", \"google_apis_unittests\": \"e82386f68336ed5fdb46d1c9e4f2116b168d3996\", \"gpu_unittests\": \"c80bc1ea3be7e0d7892a5daa0b767901e65042af\", \"gwp_asan_unittests\": \"694fda3c4308f05c8cd78ed05cbaf0381f5ca1f1\", \"interactive_ui_tests\": \"ab88c0b61f1ab9568fdf2c0cb7ac0e3790139865\", \"ipc_tests\": \"f4faa01f3b2e26b6c13ffdf062da20bb351b9829\", \"jingle_unittests\": \"7a1c1dbfdfa273260011dd076aa3f6a56dafc372\", \"keyboard_unittests\": \"dcee6844b4041b4ed6bf9dfe09fc7b7c64d0dc6f\", \"latency_unittests\": \"cae95adeb8533b8611cfab909077f80ac66e2375\", \"libjingle_xmpp_unittests\": \"3b7fc48c8ed91a9dcb23646a3c1cca3aa580bc4f\", \"liburlpattern_unittests\": \"b17522e19719ce1cc77b913cd7789cc8e53850a2\", \"media_blink_unittests\": \"588549da08eaa8d6a9abba48bd4e9f61a9d046e1\", \"media_unittests\": \"f3c0db6ae33a30aa6dd4aabba0f6db81418dbfa8\", \"message_center_unittests\": \"306d9d7adcd20fc38eab1d5fa364919c78fe1525\", \"midi_unittests\": \"9f872bbcefdb172b23daf7bb7b210917e67a36d5\", \"mojo_core_unittests\": \"afedeb345e9e893368e28e1560dc11ce6473ba08\", \"mojo_unittests\": \"6617d94c2c77c78802040cf4930bf821f990ac1d\", \"nacl_helper_nonsfi_unittests\": \"4ae644e4f987079091cba8cd1f2c9cd14991cb47\", \"nacl_loader_unittests\": \"81be220c8628b76beb3a24f23041ef07e3848845\", \"native_theme_unittests\": \"2d13cced300defbd788c03427645daeab6ad7504\", \"net_unittests\": \"4ccf136639bffd64f0a2ab470d840fca1db62d55\", \"ozone_gl_unittests\": \"f844975aa9e8b532177c47a21a4b558a3c60e279\", \"ozone_unittests\": \"24fe6109863112b96c329f1b27ca99dd39510864\", \"ozone_x11_unittests\": \"fa595b4f83e22fe259a07640ee2f0d4f14ded20e\", \"pdf_unittests\": \"81c1eb76625bdd0135d3578a583039dd7414a6ad\", \"perfetto_unittests\": \"e7a032b26f9c625cc030e31df7935d5a612d0f6f\", \"ppapi_unittests\": \"999081315b8468a2269bcdd1703d77d3f00be30f\", \"printing_unittests\": \"5916ca1888848a681c02d0ffb6e4996f747ac3e0\", \"remoting_unittests\": \"eb6b6a3b54f07243d783350b165324877a975498\", \"sandbox_linux_unittests\": \"13089f259cd231fcdd8aebe07deede208735ef35\", \"service_manager_unittests\": \"7f6099e9526c11efd3d9e18df1564fb5e494cb8a\", \"services_unittests\": \"cdb80a334de66ffb3b29364f32e10b6d57876db0\", \"shell_dialogs_unittests\": \"26f23caa16c6fffa26e446a40f752fe8ae537841\", \"skia_unittests\": \"f24bb3af5653546af2404442042ed94d8299a97f\", \"snapshot_unittests\": \"c763d95de6336e0ae4c7c2ceab04b94cc7641002\", \"sql_unittests\": \"ec981b6d8c17cfc21df6e9fe0d8783a5568a068a\", \"storage_unittests\": \"612dfa19ddebfb060f9cab2d9c97a091b562a84c\", \"sync_integration_tests\": \"373952c14586f1fbc29b64ba35692283a9b34be5\", \"traffic_annotation_auditor_unittests\": \"40245f72590c861f368b2b60723874b674d7968b\", \"ui_base_unittests\": \"d91b02e047e85c6228d92f8a5dfda45916f1b841\", \"ui_chromeos_unittests\": \"8accee89e1d3520727d31134efa3b28eed1a6800\", \"ui_touch_selection_unittests\": \"613ebdc2db7c920d05c767f31be2473e79b83fd0\", \"unit_tests\": \"36e50cae83e456fd06e0f5031db5b85a6a402832\", \"url_unittests\": \"02096292b34652ac54fe85732c444e27bae1f1b7\", \"usage_time_limit_unittests\": \"9420cccf571de8ec77055cc47f4dd858f0a01e12\", \"views_unittests\": \"9409cf833a856e23cd5d4f17619ffe1bbf0758f0\", \"viz_unittests\": \"c3897497bc8d47d3a43116a2e7f52d41e4e496cc\", \"wm_unittests\": \"a001aaf93f04255922145ccb5644ce007ade47e8\", \"wtf_unittests\": \"d83412d327578360354437a33b6c698044947865\", \"zlib_unittests\": \"b5ebc4ff0391bda54a86e77e58805680ed04bbff\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3b0e28eebaae607a111b3d14afaf4a38944aa5084a33cb6cff32b5c412399a3d_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_8afdcfef4ae6fecf44bdc59bc36ab1bd30dfc75b00b262fd5e6b3421af127659_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"builder_c33cb68a27562f3c0030aeadb8872bc9395ca543fdfb70fdbe284a5ae715c202_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-5-xus6\"], \"image\": [\"chrome-xenial-20110800-08efb743065\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5632-2e614e1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605550787398851",
"status": "COMPLETED",
"status_changed_ts": "1605556681600174",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21334",
"builder:linux-chromeos-dbg",
"buildset:commit/git/cc244f13743731c71f4324271ef2810a7be07b66",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cc244f13743731c71f4324271ef2810a7be07b66",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028881758072765584",
"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/8863451696009855616/+/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:4feb1a4cfbc20a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605556681607410",
"url": "https://ci.chromium.org/b/8863451696009855616",
"utcnow_ts": "1605556683811818"
}
}
[19:58:03.822] Invocation finished in 1h38m20.156547506s with status SUCCEEDED