[04:24:44.715] New invocation is queued and will start shortly
[04:24:45.840] Starting the invocation (attempt 1)
[04:24:45.876] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:24:45.876] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:24:45.876] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9017790863778712464",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b56218eade6614c35d30a82d87594ec9e365c013\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9017790863778712464",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/b56218eade6614c35d30a82d87594ec9e365c013",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b56218eade6614c35d30a82d87594ec9e365c013",
"gitiles_ref:refs/heads/master"
]
}
[04:24:46.495] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1616127885990692",
"id": "8852360801778119168",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b56218eade6614c35d30a82d87594ec9e365c013\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1616127886394037",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/23043",
"builder:linux-chromeos-dbg",
"buildset:commit/git/b56218eade6614c35d30a82d87594ec9e365c013",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b56218eade6614c35d30a82d87594ec9e365c013",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017790863778712464",
"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/8852360801778119168/+/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": "1616127886394292",
"url": "https://ci.chromium.org/b/8852360801778119168",
"utcnow_ts": "1616127886488595"
}
}
[04:24:46.495] Task URL: https://ci.chromium.org/b/8852360801778119168
[04:24:46.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:2:0) after 1m0s
[04:25:46.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:2:0)
[04:25:46.595] Timer tick, asking Buildbucket for the build status
[04:25:46.672] Build 8852360801778119168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:25:46.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:3:0) after 1m0s
[04:26:46.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:3:0)
[04:26:46.768] Timer tick, asking Buildbucket for the build status
[04:26:46.827] Build 8852360801778119168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:26:46.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:4:0) after 1m0s
[04:27:45.370] Received PubSub notification, asking Buildbucket for the build status
[04:27:45.436] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:46.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:4:0)
[04:27:46.827] Timer tick, asking Buildbucket for the build status
[04:27:46.920] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:46.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:6:0) after 1m0s
[04:28:46.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:6:0)
[04:28:46.945] Timer tick, asking Buildbucket for the build status
[04:28:47.053] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:47.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:7:0) after 1m0s
[04:29:47.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:7:0)
[04:29:47.049] Timer tick, asking Buildbucket for the build status
[04:29:47.126] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:47.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:8:0) after 1m0s
[04:30:47.170] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:8:0)
[04:30:47.170] Timer tick, asking Buildbucket for the build status
[04:30:47.254] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:47.254] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:9:0) after 1m0s
[04:31:47.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:9:0)
[04:31:47.285] Timer tick, asking Buildbucket for the build status
[04:31:47.361] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:47.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:10:0) after 1m0s
[04:32:47.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:10:0)
[04:32:47.366] Timer tick, asking Buildbucket for the build status
[04:32:47.423] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:47.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:11:0) after 1m0s
[04:33:47.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:11:0)
[04:33:47.442] Timer tick, asking Buildbucket for the build status
[04:33:47.514] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:47.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:12:0) after 1m0s
[04:34:47.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:12:0)
[04:34:47.537] Timer tick, asking Buildbucket for the build status
[04:34:47.658] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:47.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:13:0) after 1m0s
[04:35:47.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:13:0)
[04:35:47.682] Timer tick, asking Buildbucket for the build status
[04:35:47.755] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:47.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:14:0) after 1m0s
[04:36:47.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:14:0)
[04:36:47.824] Timer tick, asking Buildbucket for the build status
[04:36:47.891] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:47.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:15:0) after 1m0s
[04:37:47.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:15:0)
[04:37:47.924] Timer tick, asking Buildbucket for the build status
[04:37:47.993] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:47.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:16:0) after 1m0s
[04:38:48.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:16:0)
[04:38:48.039] Timer tick, asking Buildbucket for the build status
[04:38:48.181] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:48.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:17:0) after 1m0s
[04:39:48.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:17:0)
[04:39:48.275] Timer tick, asking Buildbucket for the build status
[04:39:48.434] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:48.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:18:0) after 1m0s
[04:40:48.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:18:0)
[04:40:48.492] Timer tick, asking Buildbucket for the build status
[04:40:48.560] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:48.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:19:0) after 1m0s
[04:41:48.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:19:0)
[04:41:48.596] Timer tick, asking Buildbucket for the build status
[04:41:48.874] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:48.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:20:0) after 1m0s
[04:42:48.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:20:0)
[04:42:48.875] Timer tick, asking Buildbucket for the build status
[04:42:48.944] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:48.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:21:0) after 1m0s
[04:43:48.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:21:0)
[04:43:48.964] Timer tick, asking Buildbucket for the build status
[04:43:49.035] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:49.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:22:0) after 1m0s
[04:44:49.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:22:0)
[04:44:49.077] Timer tick, asking Buildbucket for the build status
[04:44:49.164] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:49.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:23:0) after 1m0s
[04:45:49.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:23:0)
[04:45:49.158] Timer tick, asking Buildbucket for the build status
[04:45:49.247] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:49.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:24:0) after 1m0s
[04:46:49.270] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:24:0)
[04:46:49.270] Timer tick, asking Buildbucket for the build status
[04:46:49.332] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:49.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:25:0) after 1m0s
[04:47:49.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:25:0)
[04:47:49.352] Timer tick, asking Buildbucket for the build status
[04:47:50.044] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:50.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:26:0) after 1m0s
[04:48:50.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:26:0)
[04:48:50.086] Timer tick, asking Buildbucket for the build status
[04:48:50.167] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:50.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:27:0) after 1m0s
[04:49:50.170] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:27:0)
[04:49:50.170] Timer tick, asking Buildbucket for the build status
[04:49:50.359] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:50.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:28:0) after 1m0s
[04:50:50.388] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:28:0)
[04:50:50.388] Timer tick, asking Buildbucket for the build status
[04:50:50.456] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:50.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:29:0) after 1m0s
[04:51:50.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:29:0)
[04:51:50.476] Timer tick, asking Buildbucket for the build status
[04:51:50.728] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:50.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:30:0) after 1m0s
[04:52:50.726] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:30:0)
[04:52:50.726] Timer tick, asking Buildbucket for the build status
[04:52:50.812] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:50.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:31:0) after 1m0s
[04:53:50.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:31:0)
[04:53:50.787] Timer tick, asking Buildbucket for the build status
[04:53:50.905] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:50.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:32:0) after 1m0s
[04:54:50.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:32:0)
[04:54:50.936] Timer tick, asking Buildbucket for the build status
[04:54:51.096] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:51.096] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:33:0) after 1m0s
[04:55:51.130] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:33:0)
[04:55:51.130] Timer tick, asking Buildbucket for the build status
[04:55:51.198] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:51.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:34:0) after 1m0s
[04:56:51.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:34:0)
[04:56:51.225] Timer tick, asking Buildbucket for the build status
[04:56:51.291] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:51.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:35:0) after 1m0s
[04:57:51.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:35:0)
[04:57:51.313] Timer tick, asking Buildbucket for the build status
[04:57:51.374] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:51.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:36:0) after 1m0s
[04:58:52.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:36:0)
[04:58:52.337] Timer tick, asking Buildbucket for the build status
[04:58:52.506] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:52.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:37:0) after 1m0s
[04:59:52.731] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:37:0)
[04:59:52.731] Timer tick, asking Buildbucket for the build status
[04:59:52.859] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:52.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:38:0) after 1m0s
[05:00:53.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:38:0)
[05:00:53.039] Timer tick, asking Buildbucket for the build status
[05:00:53.159] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:53.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:39:0) after 1m0s
[05:01:54.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:39:0)
[05:01:54.327] Timer tick, asking Buildbucket for the build status
[05:01:54.514] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:54.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:40:0) after 1m0s
[05:02:54.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:40:0)
[05:02:54.603] Timer tick, asking Buildbucket for the build status
[05:02:54.744] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:54.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:41:0) after 1m0s
[05:03:54.763] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:41:0)
[05:03:54.763] Timer tick, asking Buildbucket for the build status
[05:03:54.898] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:54.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:42:0) after 1m0s
[05:04:54.943] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:42:0)
[05:04:54.943] Timer tick, asking Buildbucket for the build status
[05:04:55.030] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:55.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:43:0) after 1m0s
[05:05:55.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:43:0)
[05:05:55.053] Timer tick, asking Buildbucket for the build status
[05:05:55.142] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:55.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:44:0) after 1m0s
[05:06:55.191] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:44:0)
[05:06:55.191] Timer tick, asking Buildbucket for the build status
[05:06:55.709] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:55.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:45:0) after 1m0s
[05:07:55.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:45:0)
[05:07:55.745] Timer tick, asking Buildbucket for the build status
[05:07:56.218] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:56.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:46:0) after 1m0s
[05:08:56.214] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:46:0)
[05:08:56.214] Timer tick, asking Buildbucket for the build status
[05:08:56.309] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:56.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:47:0) after 1m0s
[05:09:56.335] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:47:0)
[05:09:56.335] Timer tick, asking Buildbucket for the build status
[05:09:56.687] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:56.687] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:48:0) after 1m0s
[05:10:56.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:48:0)
[05:10:56.734] Timer tick, asking Buildbucket for the build status
[05:10:56.809] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:56.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:49:0) after 1m0s
[05:11:56.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:49:0)
[05:11:56.855] Timer tick, asking Buildbucket for the build status
[05:11:56.941] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:56.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:50:0) after 1m0s
[05:12:56.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:50:0)
[05:12:56.997] Timer tick, asking Buildbucket for the build status
[05:12:57.090] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:57.090] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:51:0) after 1m0s
[05:13:57.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:51:0)
[05:13:57.112] Timer tick, asking Buildbucket for the build status
[05:13:57.609] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:57.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:52:0) after 1m0s
[05:14:57.635] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:52:0)
[05:14:57.635] Timer tick, asking Buildbucket for the build status
[05:14:57.741] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:57.741] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:53:0) after 1m0s
[05:15:57.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:53:0)
[05:15:57.810] Timer tick, asking Buildbucket for the build status
[05:15:57.876] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:57.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:54:0) after 1m0s
[05:16:57.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:54:0)
[05:16:57.954] Timer tick, asking Buildbucket for the build status
[05:16:58.041] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:58.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:55:0) after 1m0s
[05:17:58.207] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:55:0)
[05:17:58.207] Timer tick, asking Buildbucket for the build status
[05:17:58.275] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:58.275] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:56:0) after 1m0s
[05:18:58.372] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:56:0)
[05:18:58.372] Timer tick, asking Buildbucket for the build status
[05:18:58.597] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:58.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:57:0) after 1m0s
[05:19:58.604] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:57:0)
[05:19:58.604] Timer tick, asking Buildbucket for the build status
[05:19:58.700] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:58.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:58:0) after 1m0s
[05:20:58.702] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:58:0)
[05:20:58.702] Timer tick, asking Buildbucket for the build status
[05:20:58.782] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:58.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:59:0) after 1m0s
[05:21:58.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:59:0)
[05:21:58.853] Timer tick, asking Buildbucket for the build status
[05:21:58.919] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:58.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:60:0) after 1m0s
[05:22:58.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:60:0)
[05:22:58.925] Timer tick, asking Buildbucket for the build status
[05:22:58.995] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:58.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:61:0) after 1m0s
[05:23:59.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:61:0)
[05:23:59.019] Timer tick, asking Buildbucket for the build status
[05:23:59.102] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:59.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:62:0) after 1m0s
[05:24:59.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:62:0)
[05:24:59.123] Timer tick, asking Buildbucket for the build status
[05:24:59.721] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:59.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:63:0) after 1m0s
[05:25:59.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:63:0)
[05:25:59.792] Timer tick, asking Buildbucket for the build status
[05:25:59.935] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:59.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:64:0) after 1m0s
[05:26:59.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:64:0)
[05:26:59.966] Timer tick, asking Buildbucket for the build status
[05:27:00.733] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:00.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:65:0) after 1m0s
[05:28:00.763] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:65:0)
[05:28:00.763] Timer tick, asking Buildbucket for the build status
[05:28:01.117] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:01.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:66:0) after 1m0s
[05:29:01.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:66:0)
[05:29:01.123] Timer tick, asking Buildbucket for the build status
[05:29:01.205] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:01.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:67:0) after 1m0s
[05:30:01.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:67:0)
[05:30:01.416] Timer tick, asking Buildbucket for the build status
[05:30:01.517] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:01.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:68:0) after 1m0s
[05:31:01.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:68:0)
[05:31:01.523] Timer tick, asking Buildbucket for the build status
[05:31:01.594] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:01.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:69:0) after 1m0s
[05:32:01.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:69:0)
[05:32:01.692] Timer tick, asking Buildbucket for the build status
[05:32:01.831] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:01.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:70:0) after 1m0s
[05:33:01.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:70:0)
[05:33:01.896] Timer tick, asking Buildbucket for the build status
[05:33:02.042] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:02.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:71:0) after 1m0s
[05:34:02.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:71:0)
[05:34:02.132] Timer tick, asking Buildbucket for the build status
[05:34:02.215] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:02.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:72:0) after 1m0s
[05:35:02.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:72:0)
[05:35:02.279] Timer tick, asking Buildbucket for the build status
[05:35:02.726] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:02.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:73:0) after 1m0s
[05:36:02.731] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:73:0)
[05:36:02.731] Timer tick, asking Buildbucket for the build status
[05:36:02.913] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:02.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:74:0) after 1m0s
[05:37:02.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:74:0)
[05:37:02.973] Timer tick, asking Buildbucket for the build status
[05:37:03.372] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:03.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:75:0) after 1m0s
[05:38:03.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:75:0)
[05:38:03.426] Timer tick, asking Buildbucket for the build status
[05:38:03.742] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:03.742] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:76:0) after 1m0s
[05:39:03.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:76:0)
[05:39:03.719] Timer tick, asking Buildbucket for the build status
[05:39:03.805] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:03.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:77:0) after 1m0s
[05:40:03.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:77:0)
[05:40:03.831] Timer tick, asking Buildbucket for the build status
[05:40:04.238] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:04.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:78:0) after 1m0s
[05:41:04.300] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:78:0)
[05:41:04.300] Timer tick, asking Buildbucket for the build status
[05:41:04.376] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:04.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:79:0) after 1m0s
[05:42:04.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:79:0)
[05:42:04.589] Timer tick, asking Buildbucket for the build status
[05:42:04.671] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:04.671] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:80:0) after 1m0s
[05:43:04.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:80:0)
[05:43:04.813] Timer tick, asking Buildbucket for the build status
[05:43:04.897] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:04.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:81:0) after 1m0s
[05:44:05.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:81:0)
[05:44:05.083] Timer tick, asking Buildbucket for the build status
[05:44:05.350] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:05.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:82:0) after 1m0s
[05:45:05.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:82:0)
[05:45:05.341] Timer tick, asking Buildbucket for the build status
[05:45:05.444] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:05.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:83:0) after 1m0s
[05:46:05.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:83:0)
[05:46:05.787] Timer tick, asking Buildbucket for the build status
[05:46:05.880] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:05.880] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:84:0) after 1m0s
[05:47:05.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:84:0)
[05:47:05.896] Timer tick, asking Buildbucket for the build status
[05:47:05.969] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:05.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:85:0) after 1m0s
[05:48:06.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:85:0)
[05:48:06.157] Timer tick, asking Buildbucket for the build status
[05:48:06.234] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:06.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:86:0) after 1m0s
[05:49:06.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:86:0)
[05:49:06.206] Timer tick, asking Buildbucket for the build status
[05:49:06.287] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:06.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:87:0) after 1m0s
[05:50:06.310] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:87:0)
[05:50:06.310] Timer tick, asking Buildbucket for the build status
[05:50:06.396] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:06.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:88:0) after 1m0s
[05:51:06.419] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:88:0)
[05:51:06.419] Timer tick, asking Buildbucket for the build status
[05:51:06.491] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:06.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:89:0) after 1m0s
[05:52:06.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:89:0)
[05:52:06.507] Timer tick, asking Buildbucket for the build status
[05:52:06.576] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:06.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:90:0) after 1m0s
[05:53:06.622] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:90:0)
[05:53:06.622] Timer tick, asking Buildbucket for the build status
[05:53:06.842] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:06.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:91:0) after 1m0s
[05:54:06.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:91:0)
[05:54:06.942] Timer tick, asking Buildbucket for the build status
[05:54:07.087] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:07.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:92:0) after 1m0s
[05:55:07.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:92:0)
[05:55:07.127] Timer tick, asking Buildbucket for the build status
[05:55:07.404] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:07.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:93:0) after 1m0s
[05:56:07.446] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:93:0)
[05:56:07.446] Timer tick, asking Buildbucket for the build status
[05:56:07.533] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:07.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:94:0) after 1m0s
[05:57:07.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:94:0)
[05:57:07.608] Timer tick, asking Buildbucket for the build status
[05:57:07.679] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:07.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:95:0) after 1m0s
[05:58:07.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:95:0)
[05:58:07.715] Timer tick, asking Buildbucket for the build status
[05:58:07.788] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:07.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:96:0) after 1m0s
[05:59:07.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:96:0)
[05:59:07.814] Timer tick, asking Buildbucket for the build status
[05:59:07.924] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:07.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:97:0) after 1m0s
[06:00:07.956] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:97:0)
[06:00:07.956] Timer tick, asking Buildbucket for the build status
[06:00:08.156] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:08.156] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:98:0) after 1m0s
[06:01:10.817] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:98:0)
[06:01:10.817] Timer tick, asking Buildbucket for the build status
[06:01:10.893] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:10.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:99:0) after 1m0s
[06:02:11.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:99:0)
[06:02:11.099] Timer tick, asking Buildbucket for the build status
[06:02:11.197] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:11.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:100:0) after 1m0s
[06:03:11.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:100:0)
[06:03:11.520] Timer tick, asking Buildbucket for the build status
[06:03:11.589] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:11.589] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:101:0) after 1m0s
[06:04:11.791] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:101:0)
[06:04:11.791] Timer tick, asking Buildbucket for the build status
[06:04:12.080] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:12.080] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:102:0) after 1m0s
[06:05:12.231] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:102:0)
[06:05:12.231] Timer tick, asking Buildbucket for the build status
[06:05:12.538] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:12.538] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:103:0) after 1m0s
[06:06:12.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:103:0)
[06:06:12.636] Timer tick, asking Buildbucket for the build status
[06:06:12.767] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:12.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:104:0) after 1m0s
[06:07:12.842] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:104:0)
[06:07:12.842] Timer tick, asking Buildbucket for the build status
[06:07:12.910] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:12.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:105:0) after 1m0s
[06:08:13.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:105:0)
[06:08:13.197] Timer tick, asking Buildbucket for the build status
[06:08:13.715] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:13.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:106:0) after 1m0s
[06:09:13.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:106:0)
[06:09:13.841] Timer tick, asking Buildbucket for the build status
[06:09:13.923] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:13.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:107:0) after 1m0s
[06:10:13.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:107:0)
[06:10:13.985] Timer tick, asking Buildbucket for the build status
[06:10:14.087] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:14.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:108:0) after 1m0s
[06:11:14.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:108:0)
[06:11:14.225] Timer tick, asking Buildbucket for the build status
[06:11:14.306] Build 8852360801778119168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:14.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9017790863778712464:109:0) after 1m0s
[06:11:19.338] Received PubSub notification, asking Buildbucket for the build status
[06:11:19.414] Build 8852360801778119168: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:11:19.415] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1616134278320400",
"created_by": "project:chromium",
"created_ts": "1616127885990692",
"id": "8852360801778119168",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b56218eade6614c35d30a82d87594ec9e365c013\"}}",
"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\": \"b56218eade6614c35d30a82d87594ec9e365c013\", \"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-81-wlxu\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 23043, \"got_angle_revision\": \"b717952ee77647ff7fc2fa31a1b9dfc344228dca\", \"got_dawn_revision\": \"3209df5a9cc2de5415688653d1142b1adda554db\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"b56218eade6614c35d30a82d87594ec9e365c013\", \"got_revision_cp\": \"refs/heads/master@{#864559}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a98fb3f8380a3a5c9ae3e0175634ba88c85a434f\", \"got_v8_revision\": \"43315277e45e866e927722377d36b04ca3c1014b\", \"got_v8_revision_cp\": \"refs/heads/9.1.158@{#1}\", \"got_webrtc_revision\": \"92a768ad66f54ca57002f6f2e87c7a732e3fec39\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33488}\", \"is_cached\": true, \"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\": \"b56218eade6614c35d30a82d87594ec9e365c013\", \"swarm_hashes_refs/heads/master(at){#864559}_without_patch\": {\"absl_hardening_tests\": \"2c343e0d1a495eed06685ab207fa768923bc63bc\", \"accessibility_unittests\": \"8b8636288a4aec35336d219a6511acf85696f339\", \"angle_unittests\": \"b3331b33ba3a8cbfe9e9fe6a7761fb245495f36e\", \"app_list_unittests\": \"d2c8c6962edf1dbc91d7f4514cb4e82665072636\", \"app_shell_unittests\": \"e0aa3aaac5aeeabe73c23c14115d57dcaa1eadfa\", \"ash_unittests\": \"179bcde08757f53ca45e096aae049455879d59f5\", \"aura_unittests\": \"d66995c11dbe375b376f627dee422e87d75b5825\", \"base_unittests\": \"c4faa90059ebecace63a219fb4edcd9ba8d2f987\", \"base_util_unittests\": \"63f3bd26aef50ee0b116094fde6f32681537dc13\", \"blink_common_unittests\": \"851a540689442a6a0e17f6ca10e733c9b2050632\", \"blink_fuzzer_unittests\": \"f4bd1fd41747d493ec2c97fb5dbd607ca80dacec\", \"blink_heap_unittests\": \"eb997f17b568a32a602a0a8eb2d21ea68c3b458f\", \"blink_platform_unittests\": \"23fa912a27bee34ea43f816f2429ea83a4258033\", \"blink_unittests\": \"304b406326890ab5d3fde853255fa741cdb8d61e\", \"boringssl_crypto_tests\": \"ce4398f85001e52026caeca91ee241a512c29873\", \"boringssl_ssl_tests\": \"ab8ba2262ba057b18e581429862571dbd1fb153e\", \"browser_tests\": \"9818e494d89c818a2670494a4d86892e5669e3f6\", \"capture_unittests\": \"8da7b5bcb6eb898727e9b4661a7695a1af804d52\", \"cast_unittests\": \"716c442e5286a0ac7618fa82515d0246a86d90ed\", \"cc_unittests\": \"dd168763895c1553aca16b615a56a7d7a8671a6d\", \"chrome_app_unittests\": \"db5a8563b563f5c15ea470e78f75b6a4c7a9fd19\", \"chromedriver_unittests\": \"43a804088c034c49213eef70f0a71ffcdceb9c0e\", \"chromeos_components_unittests\": \"54293bd73682905c20f63a254b00406a19cbea74\", \"chromeos_unittests\": \"09e40d7eddba58c2bdc2382a4b4c0922f053e950\", \"color_unittests\": \"bd56ac5ab66f6fef70b301807ebffa159b71be84\", \"components_browsertests\": \"fe81bf8b33c3be52e17c08d722e7bd7466764675\", \"components_unittests\": \"325e9ff03d8a813b819d2573a6debda044b6e202\", \"compositor_unittests\": \"1ee47da2fb6fc144abb90ae54e5c8fa08fa24a65\", \"content_browsertests\": \"3db7be9f5e7282884fb64f454110c2f31dbbfd88\", \"content_unittests\": \"14d085aacf62e35663d76c1426e22387c4310ad9\", \"crashpad_tests\": \"2d7a4a56fc660dc8e1211599d47103c7a8774fbd\", \"crypto_unittests\": \"dfd4fd19174feafaa6486bd9c2b1900ab2eb8e5c\", \"dbus_unittests\": \"cde1a304e8d96dd4d0b7a51e527624313b16e328\", \"device_unittests\": \"8ba5ca2a5af55af72850d542c3a6c71a03087729\", \"display_unittests\": \"5e63bad4caf48909f2ae8db46dcc737dec462bcf\", \"events_unittests\": \"4f6d6fb81ffd4dfca0f5326ffc944b8cdb1d8923\", \"exo_unittests\": \"294362e6175ab8a24fd28027c749b6822d2812af\", \"extensions_browsertests\": \"4b4f07abd51c6a4a765de68e9abd9763ebda3eb9\", \"extensions_unittests\": \"2c11ad58b82ad21ccf3adf11c8f55cf16b23bc80\", \"filesystem_service_unittests\": \"f08c0bda5c12e5371efe2a4b38639570a5489c58\", \"gcm_unit_tests\": \"534cdb819ac6bafe835f39f7f76d54b32766569b\", \"gfx_unittests\": \"39ba2a0b764e0ba0eb4e5f550caad8110fa65aa6\", \"gin_unittests\": \"2cc56e3c01341a4b127b22ca2aa723060514a592\", \"gl_unittests_ozone\": \"bf4580b6b79c502ac24ddac1076c71e1d136ccbf\", \"google_apis_unittests\": \"8747ce9333812502aa85265e46721a4fbd8acf56\", \"gpu_unittests\": \"ca4f61389e9671191934b4d20e28bc40d1dbfa3b\", \"gwp_asan_unittests\": \"c3108b5a940f36b1e31d0959f93282f28eed2ab0\", \"interactive_ui_tests\": \"7c9b31b31285f33d23849c1932adeb11001ff880\", \"ipc_tests\": \"1caca52e707532e77a2b9c50dee13842e3f3f4cf\", \"jingle_unittests\": \"ac089e7e971c5acff0dbc6d4b372c12315adc99d\", \"keyboard_unittests\": \"666b84b9e3ddc121df907b9c084b726981399fdd\", \"latency_unittests\": \"2dd22232d5fd3096b7009ed3c4b387f5b96e3afc\", \"libjingle_xmpp_unittests\": \"a79416761897fa88ea76aece373d4f01aa2d31c0\", \"liburlpattern_unittests\": \"e39ce344708b83d8a841dba3f44fbb97cfe3f2ac\", \"media_blink_unittests\": \"4228c31ee89631a626d1851062f422b84e91324b\", \"media_unittests\": \"d3bbcfca88fb4b48fa048b6f5aa1831e9fef6507\", \"message_center_unittests\": \"743c12491c09f631e53d85e0bc9dbf0994058b47\", \"midi_unittests\": \"2b63a46eddcdf9c2fb8a60119540b06895f5a8fb\", \"mojo_core_unittests\": \"559bf13b6911000c7e92bb4d95683b1e3599193c\", \"mojo_unittests\": \"d9a1c2fc4647c9c1b361c932e5e1016e0ce8f1f9\", \"nacl_helper_nonsfi_unittests\": \"b1ba186b10dd14ada026a8c6e3015cf7004c93d2\", \"nacl_loader_unittests\": \"a2d4c83bf29a182c521d189dec370b76da4ac91a\", \"native_theme_unittests\": \"14361177ec222df01450c93e274afb664bb15a9a\", \"net_unittests\": \"f87b25459404816e893d823eb43cb9ac18031cc7\", \"ozone_gl_unittests\": \"355f373bab456c8c3df3e3216598051990f3540a\", \"ozone_unittests\": \"b3c726e49bdfd6215dda11923f241d4a6cec70c9\", \"ozone_x11_unittests\": \"93a32be91e5bfb773efb60d552b0911e064b1db0\", \"pdf_unittests\": \"e4ab4cc8746e06acf946c491b6baa6638a8c0bdd\", \"perfetto_unittests\": \"c46dc5a6e4801b99e01045696c5f107c54eba67a\", \"ppapi_unittests\": \"0602d7908a208cd7ceac493956dbe0707212193c\", \"printing_unittests\": \"b9893cea825d9c20c89043b20358d7bcce1691d2\", \"remoting_unittests\": \"7884253e85d36d754dc91b5d624ae56188e4ba35\", \"sandbox_linux_unittests\": \"5a25613af6dfd5abae58d6066166cfcd48151612\", \"service_manager_unittests\": \"d5cf61d0954ed9db53209ce058edfeaccde96a50\", \"services_unittests\": \"61e4cf9f2824c90f59bcaff81ec8b795dee9f86e\", \"shell_dialogs_unittests\": \"d459923b50432a8dee379b1bdda7f893d0b58234\", \"shell_encryption_unittests\": \"aa10f97f774e28fd16e2999bad1434342efe2890\", \"skia_unittests\": \"84b887c9aa543f70f39edcc8e73fd0e1a3f2e41e\", \"snapshot_unittests\": \"83d4525d6fe5c180162983dcfe711787b7c7e660\", \"sql_unittests\": \"61facabe5c2136d1db7ae272112f8c36773d9f94\", \"storage_unittests\": \"38b7d3c3e14af0d79d226137b854b8263a9ae680\", \"sync_integration_tests\": \"c53a167dd6bca318993f414e6af09d66b7ccad39\", \"traffic_annotation_auditor_unittests\": \"c34efdb2778e23f91abb3b761ad1039108aef14f\", \"ui_base_unittests\": \"7b0369c71eac8cc5ed917b28140fd4d7e192c904\", \"ui_chromeos_unittests\": \"5dbc251279bc4a0b3c6771bc65c44b2c0b1f8b23\", \"ui_touch_selection_unittests\": \"60c7c19987b8215ccd9d437a30e3eda1f5402f99\", \"unit_tests\": \"84f988fce33bf275ded1829313d8b0d067c4accd\", \"url_unittests\": \"bf8e476528908c8a5060b2d81b7f56619e1b90c2\", \"usage_time_limit_unittests\": \"0a94d9a1aa043571d5407fc5fb93fd4088deab78\", \"views_unittests\": \"2f87cd15afd22815e848c9bedc797052903c8392\", \"viz_unittests\": \"a3bcaa1f81b8494d4735a22d41e291cc76b1cf61\", \"wayland_client_tests\": \"49c3471513722720e710525bf10ab500da814584\", \"wm_unittests\": \"80405744e8662ddba0644611264f40bcb9c86cc6\", \"wtf_unittests\": \"963949cfa48318ee81737e9e45d10ac1540333cb\", \"zlib_unittests\": \"8ef2a9b391efcaab018e064a6117bd0aee8f367a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_84395cd86c4615c28c38755187d54d1bbe2dcea268d302d74191d04ce3a055d0_v2\", \"builder_8a4e9d5e5a37a98f1521a3a36ddb77cf3e170b8528c1bf60d5d419f9d69b17e3_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-81-wlxu\"], \"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\", \"2.7\", \"2.7.12\"], \"server_version\": [\"5776-cb9e157\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1616128064611755",
"status": "COMPLETED",
"status_changed_ts": "1616134278661840",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/23043",
"builder:linux-chromeos-dbg",
"buildset:commit/git/b56218eade6614c35d30a82d87594ec9e365c013",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b56218eade6614c35d30a82d87594ec9e365c013",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017790863778712464",
"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/8852360801778119168/+/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:52618c0d0a244010",
"user_agent:luci-scheduler"
],
"updated_ts": "1616134278744206",
"url": "https://ci.chromium.org/b/8852360801778119168",
"utcnow_ts": "1616134279404522"
}
}
[06:11:19.418] Invocation finished in 1h46m34.71897563s with status SUCCEEDED