[22:34:30.901] New invocation is queued and will start shortly
[22:34:33.056] Starting the invocation (attempt 1)
[22:34:33.107] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:34:33.108] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:34:33.108] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029862294892342912",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"aa8b4a6538f1f4aa0ef73deb2a3e8aa2f51f7997\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9029862294892342912",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/aa8b4a6538f1f4aa0ef73deb2a3e8aa2f51f7997",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa8b4a6538f1f4aa0ef73deb2a3e8aa2f51f7997",
"gitiles_ref:refs/heads/master"
]
}
[22:34:35.082] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1604615673206632",
"id": "8864432231810515968",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"aa8b4a6538f1f4aa0ef73deb2a3e8aa2f51f7997\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604615674577544",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21165",
"builder:linux-chromeos-dbg",
"buildset:commit/git/aa8b4a6538f1f4aa0ef73deb2a3e8aa2f51f7997",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa8b4a6538f1f4aa0ef73deb2a3e8aa2f51f7997",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029862294892342912",
"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/8864432231810515968/+/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": "1604615674577709",
"url": "https://ci.chromium.org/b/8864432231810515968",
"utcnow_ts": "1604615675007525"
}
}
[22:34:35.082] Task URL: https://ci.chromium.org/b/8864432231810515968
[22:34:35.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:2:0) after 1m0s
[22:34:37.245] Received PubSub notification, asking Buildbucket for the build status
[22:34:37.451] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:35.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:2:0)
[22:35:35.151] Timer tick, asking Buildbucket for the build status
[22:35:35.637] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:35.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:4:0) after 1m0s
[22:36:35.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:4:0)
[22:36:35.657] Timer tick, asking Buildbucket for the build status
[22:36:35.773] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:35.773] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:5:0) after 1m0s
[22:37:35.807] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:5:0)
[22:37:35.807] Timer tick, asking Buildbucket for the build status
[22:37:36.141] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:36.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:6:0) after 1m0s
[22:38:36.223] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:6:0)
[22:38:36.223] Timer tick, asking Buildbucket for the build status
[22:38:36.332] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:36.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:7:0) after 1m0s
[22:39:36.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:7:0)
[22:39:36.481] Timer tick, asking Buildbucket for the build status
[22:39:36.585] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:36.585] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:8:0) after 1m0s
[22:40:36.587] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:8:0)
[22:40:36.587] Timer tick, asking Buildbucket for the build status
[22:40:36.988] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:36.988] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:9:0) after 1m0s
[22:41:37.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:9:0)
[22:41:37.068] Timer tick, asking Buildbucket for the build status
[22:41:37.370] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:37.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:10:0) after 1m0s
[22:42:37.399] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:10:0)
[22:42:37.399] Timer tick, asking Buildbucket for the build status
[22:42:37.458] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:37.458] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:11:0) after 1m0s
[22:43:37.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:11:0)
[22:43:37.501] Timer tick, asking Buildbucket for the build status
[22:43:37.575] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:37.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:12:0) after 1m0s
[22:44:37.677] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:12:0)
[22:44:37.677] Timer tick, asking Buildbucket for the build status
[22:44:37.807] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:37.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:13:0) after 1m0s
[22:45:37.927] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:13:0)
[22:45:37.927] Timer tick, asking Buildbucket for the build status
[22:45:37.991] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:37.991] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:14:0) after 1m0s
[22:46:38.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:14:0)
[22:46:38.064] Timer tick, asking Buildbucket for the build status
[22:46:38.147] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:38.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:15:0) after 1m0s
[22:47:38.190] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:15:0)
[22:47:38.190] Timer tick, asking Buildbucket for the build status
[22:47:38.327] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:38.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:16:0) after 1m0s
[22:48:38.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:16:0)
[22:48:38.759] Timer tick, asking Buildbucket for the build status
[22:48:40.170] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:40.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:17:0) after 1m0s
[22:49:40.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:17:0)
[22:49:40.188] Timer tick, asking Buildbucket for the build status
[22:49:40.698] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:40.698] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:18:0) after 1m0s
[22:50:40.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:18:0)
[22:50:40.719] Timer tick, asking Buildbucket for the build status
[22:50:40.809] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:40.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:19:0) after 1m0s
[22:51:40.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:19:0)
[22:51:40.832] Timer tick, asking Buildbucket for the build status
[22:51:41.779] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:41.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:20:0) after 1m0s
[22:52:41.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:20:0)
[22:52:41.820] Timer tick, asking Buildbucket for the build status
[22:52:41.887] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:41.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:21:0) after 1m0s
[22:53:41.963] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:21:0)
[22:53:41.963] Timer tick, asking Buildbucket for the build status
[22:53:42.031] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:42.031] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:22:0) after 1m0s
[22:54:42.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:22:0)
[22:54:42.092] Timer tick, asking Buildbucket for the build status
[22:54:42.503] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:42.503] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:23:0) after 1m0s
[22:55:42.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:23:0)
[22:55:42.537] Timer tick, asking Buildbucket for the build status
[22:55:42.751] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:42.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:24:0) after 1m0s
[22:56:42.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:24:0)
[22:56:42.824] Timer tick, asking Buildbucket for the build status
[22:56:42.895] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:42.895] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:25:0) after 1m0s
[22:57:42.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:25:0)
[22:57:42.940] Timer tick, asking Buildbucket for the build status
[22:57:43.097] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:43.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:26:0) after 1m0s
[22:58:43.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:26:0)
[22:58:43.153] Timer tick, asking Buildbucket for the build status
[22:58:43.464] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:43.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:27:0) after 1m0s
[22:59:43.493] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:27:0)
[22:59:43.493] Timer tick, asking Buildbucket for the build status
[22:59:43.627] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:43.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:28:0) after 1m0s
[23:00:43.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:28:0)
[23:00:43.656] Timer tick, asking Buildbucket for the build status
[23:00:43.750] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:43.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:29:0) after 1m0s
[23:01:43.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:29:0)
[23:01:43.872] Timer tick, asking Buildbucket for the build status
[23:01:43.955] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:43.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:30:0) after 1m0s
[23:02:44.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:30:0)
[23:02:44.031] Timer tick, asking Buildbucket for the build status
[23:02:44.104] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:44.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:31:0) after 1m0s
[23:03:44.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:31:0)
[23:03:44.188] Timer tick, asking Buildbucket for the build status
[23:03:44.243] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:44.243] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:32:0) after 1m0s
[23:04:44.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:32:0)
[23:04:44.389] Timer tick, asking Buildbucket for the build status
[23:04:44.498] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:44.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:33:0) after 1m0s
[23:05:44.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:33:0)
[23:05:44.642] Timer tick, asking Buildbucket for the build status
[23:05:44.749] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:44.749] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:34:0) after 1m0s
[23:06:44.782] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:34:0)
[23:06:44.782] Timer tick, asking Buildbucket for the build status
[23:06:45.033] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:45.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:35:0) after 1m0s
[23:07:45.063] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:35:0)
[23:07:45.063] Timer tick, asking Buildbucket for the build status
[23:07:45.278] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:45.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:36:0) after 1m0s
[23:08:45.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:36:0)
[23:08:45.333] Timer tick, asking Buildbucket for the build status
[23:08:45.473] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:45.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:37:0) after 1m0s
[23:09:45.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:37:0)
[23:09:45.492] Timer tick, asking Buildbucket for the build status
[23:09:45.616] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:45.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:38:0) after 1m0s
[23:10:45.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:38:0)
[23:10:45.689] Timer tick, asking Buildbucket for the build status
[23:10:45.778] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:45.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:39:0) after 1m0s
[23:11:45.835] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:39:0)
[23:11:45.835] Timer tick, asking Buildbucket for the build status
[23:11:45.978] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:45.978] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:40:0) after 1m0s
[23:12:46.070] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:40:0)
[23:12:46.070] Timer tick, asking Buildbucket for the build status
[23:12:46.783] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:46.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:41:0) after 1m0s
[23:13:46.829] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:41:0)
[23:13:46.829] Timer tick, asking Buildbucket for the build status
[23:13:46.976] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:46.976] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:42:0) after 1m0s
[23:14:47.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:42:0)
[23:14:47.043] Timer tick, asking Buildbucket for the build status
[23:14:47.362] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:47.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:43:0) after 1m0s
[23:15:47.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:43:0)
[23:15:47.404] Timer tick, asking Buildbucket for the build status
[23:15:47.527] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:47.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:44:0) after 1m0s
[23:16:47.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:44:0)
[23:16:47.551] Timer tick, asking Buildbucket for the build status
[23:16:47.674] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:47.674] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:45:0) after 1m0s
[23:17:47.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:45:0)
[23:17:47.725] Timer tick, asking Buildbucket for the build status
[23:17:47.832] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:47.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:46:0) after 1m0s
[23:18:47.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:46:0)
[23:18:47.863] Timer tick, asking Buildbucket for the build status
[23:18:47.990] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:47.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:47:0) after 1m0s
[23:19:48.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:47:0)
[23:19:48.067] Timer tick, asking Buildbucket for the build status
[23:19:48.190] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:48.190] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:48:0) after 1m0s
[23:20:48.221] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:48:0)
[23:20:48.221] Timer tick, asking Buildbucket for the build status
[23:20:48.302] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:48.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:49:0) after 1m0s
[23:21:48.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:49:0)
[23:21:48.374] Timer tick, asking Buildbucket for the build status
[23:21:48.473] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:48.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:50:0) after 1m0s
[23:22:48.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:50:0)
[23:22:48.566] Timer tick, asking Buildbucket for the build status
[23:22:48.685] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:48.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:51:0) after 1m0s
[23:23:48.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:51:0)
[23:23:48.744] Timer tick, asking Buildbucket for the build status
[23:23:48.905] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:48.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:52:0) after 1m0s
[23:24:48.946] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:52:0)
[23:24:48.946] Timer tick, asking Buildbucket for the build status
[23:24:49.085] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:49.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:53:0) after 1m0s
[23:25:49.143] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:53:0)
[23:25:49.143] Timer tick, asking Buildbucket for the build status
[23:25:49.342] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:49.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:54:0) after 1m0s
[23:26:49.415] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:54:0)
[23:26:49.415] Timer tick, asking Buildbucket for the build status
[23:26:49.531] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:49.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:55:0) after 1m0s
[23:27:49.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:55:0)
[23:27:49.579] Timer tick, asking Buildbucket for the build status
[23:27:49.663] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:49.663] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:56:0) after 1m0s
[23:28:49.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:56:0)
[23:28:49.689] Timer tick, asking Buildbucket for the build status
[23:28:49.781] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:49.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:57:0) after 1m0s
[23:29:49.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:57:0)
[23:29:49.762] Timer tick, asking Buildbucket for the build status
[23:29:50.552] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:50.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:58:0) after 1m0s
[23:30:50.610] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:58:0)
[23:30:50.610] Timer tick, asking Buildbucket for the build status
[23:30:51.325] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:51.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:59:0) after 1m0s
[23:31:51.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:59:0)
[23:31:51.323] Timer tick, asking Buildbucket for the build status
[23:31:51.629] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:51.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:60:0) after 1m0s
[23:32:51.737] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:60:0)
[23:32:51.737] Timer tick, asking Buildbucket for the build status
[23:32:51.902] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:51.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:61:0) after 1m0s
[23:33:51.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:61:0)
[23:33:51.926] Timer tick, asking Buildbucket for the build status
[23:33:52.051] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:52.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:62:0) after 1m0s
[23:34:52.063] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:62:0)
[23:34:52.063] Timer tick, asking Buildbucket for the build status
[23:34:52.174] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:52.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:63:0) after 1m0s
[23:35:52.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:63:0)
[23:35:52.226] Timer tick, asking Buildbucket for the build status
[23:35:52.370] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:52.370] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:64:0) after 1m0s
[23:36:52.452] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:64:0)
[23:36:52.452] Timer tick, asking Buildbucket for the build status
[23:36:53.145] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:53.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:65:0) after 1m0s
[23:37:53.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:65:0)
[23:37:53.156] Timer tick, asking Buildbucket for the build status
[23:37:53.438] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:53.438] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:66:0) after 1m0s
[23:38:53.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:66:0)
[23:38:53.586] Timer tick, asking Buildbucket for the build status
[23:38:53.713] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:53.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:67:0) after 1m0s
[23:39:53.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:67:0)
[23:39:53.786] Timer tick, asking Buildbucket for the build status
[23:39:53.898] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:53.898] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:68:0) after 1m0s
[23:40:53.982] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:68:0)
[23:40:53.982] Timer tick, asking Buildbucket for the build status
[23:40:54.075] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:54.075] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:69:0) after 1m0s
[23:41:54.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:69:0)
[23:41:54.152] Timer tick, asking Buildbucket for the build status
[23:41:54.238] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:54.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:70:0) after 1m0s
[23:42:54.399] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:70:0)
[23:42:54.399] Timer tick, asking Buildbucket for the build status
[23:42:54.470] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:54.470] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:71:0) after 1m0s
[23:43:54.543] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:71:0)
[23:43:54.543] Timer tick, asking Buildbucket for the build status
[23:43:54.651] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:54.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:72:0) after 1m0s
[23:44:54.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:72:0)
[23:44:54.701] Timer tick, asking Buildbucket for the build status
[23:44:55.228] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:55.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:73:0) after 1m0s
[23:45:55.254] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:73:0)
[23:45:55.254] Timer tick, asking Buildbucket for the build status
[23:45:55.512] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:55.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:74:0) after 1m0s
[23:46:55.597] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:74:0)
[23:46:55.597] Timer tick, asking Buildbucket for the build status
[23:46:55.834] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:55.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:75:0) after 1m0s
[23:47:55.889] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:75:0)
[23:47:55.889] Timer tick, asking Buildbucket for the build status
[23:47:55.959] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:55.959] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:76:0) after 1m0s
[23:48:56.016] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:76:0)
[23:48:56.016] Timer tick, asking Buildbucket for the build status
[23:48:56.255] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:56.255] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:77:0) after 1m0s
[23:49:56.311] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:77:0)
[23:49:56.311] Timer tick, asking Buildbucket for the build status
[23:49:56.487] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:56.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:78:0) after 1m0s
[23:50:56.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:78:0)
[23:50:56.533] Timer tick, asking Buildbucket for the build status
[23:50:56.752] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:56.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:79:0) after 1m0s
[23:51:56.819] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:79:0)
[23:51:56.819] Timer tick, asking Buildbucket for the build status
[23:51:56.893] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:56.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:80:0) after 1m0s
[23:52:56.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:80:0)
[23:52:56.951] Timer tick, asking Buildbucket for the build status
[23:52:57.024] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:57.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:81:0) after 1m0s
[23:53:57.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:81:0)
[23:53:57.072] Timer tick, asking Buildbucket for the build status
[23:53:57.146] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:57.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:82:0) after 1m0s
[23:54:57.185] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:82:0)
[23:54:57.185] Timer tick, asking Buildbucket for the build status
[23:54:57.297] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:57.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:83:0) after 1m0s
[23:55:57.394] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:83:0)
[23:55:57.394] Timer tick, asking Buildbucket for the build status
[23:55:57.817] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:57.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:84:0) after 1m0s
[23:56:58.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:84:0)
[23:56:58.500] Timer tick, asking Buildbucket for the build status
[23:56:58.604] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:58.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:85:0) after 1m0s
[23:57:58.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:85:0)
[23:57:58.650] Timer tick, asking Buildbucket for the build status
[23:57:58.744] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:58.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:86:0) after 1m0s
[23:58:58.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:86:0)
[23:58:58.826] Timer tick, asking Buildbucket for the build status
[23:58:59.301] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:59.301] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:87:0) after 1m0s
[23:59:59.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:87:0)
[23:59:59.314] Timer tick, asking Buildbucket for the build status
[23:59:59.493] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:59.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:88:0) after 1m0s
[00:00:59.534] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:88:0)
[00:00:59.534] Timer tick, asking Buildbucket for the build status
[00:01:01.078] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:01.078] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:89:0) after 1m0s
[00:02:01.543] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:89:0)
[00:02:01.543] Timer tick, asking Buildbucket for the build status
[00:02:01.794] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:01.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:90:0) after 1m0s
[00:03:01.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:90:0)
[00:03:01.822] Timer tick, asking Buildbucket for the build status
[00:03:02.110] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:02.110] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:91:0) after 1m0s
[00:04:02.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:91:0)
[00:04:02.102] Timer tick, asking Buildbucket for the build status
[00:04:02.702] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:02.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:92:0) after 1m0s
[00:05:02.753] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:92:0)
[00:05:02.753] Timer tick, asking Buildbucket for the build status
[00:05:03.172] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:03.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:93:0) after 1m0s
[00:06:03.542] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:93:0)
[00:06:03.542] Timer tick, asking Buildbucket for the build status
[00:06:03.781] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:03.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:94:0) after 1m0s
[00:07:03.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:94:0)
[00:07:03.832] Timer tick, asking Buildbucket for the build status
[00:07:03.930] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:03.930] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:95:0) after 1m0s
[00:08:03.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:95:0)
[00:08:03.966] Timer tick, asking Buildbucket for the build status
[00:08:04.300] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:04.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:96:0) after 1m0s
[00:09:04.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:96:0)
[00:09:04.348] Timer tick, asking Buildbucket for the build status
[00:09:04.612] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:04.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:97:0) after 1m0s
[00:10:04.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:97:0)
[00:10:04.666] Timer tick, asking Buildbucket for the build status
[00:10:04.829] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:04.829] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:98:0) after 1m0s
[00:11:04.870] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:98:0)
[00:11:04.870] Timer tick, asking Buildbucket for the build status
[00:11:05.050] Build 8864432231810515968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:05.050] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029862294892342912:99:0) after 1m0s
[00:11:38.832] Received PubSub notification, asking Buildbucket for the build status
[00:11:38.908] Build 8864432231810515968: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:11:38.909] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1604621490779430",
"created_by": "project:chromium",
"created_ts": "1604615673206632",
"id": "8864432231810515968",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"aa8b4a6538f1f4aa0ef73deb2a3e8aa2f51f7997\"}}",
"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\": \"aa8b4a6538f1f4aa0ef73deb2a3e8aa2f51f7997\", \"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-100-rvs1\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21165, \"got_angle_revision\": \"56ea854ec5e74b2f8e9b4ed7967b56c4c2a67bc9\", \"got_dawn_revision\": \"d42713de7aa3227f1feb405beddac4e37051b679\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"aa8b4a6538f1f4aa0ef73deb2a3e8aa2f51f7997\", \"got_revision_cp\": \"refs/heads/master@{#824615}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"3476ca348bd0cd1223d815173ec528abbabd32f5\", \"got_v8_revision\": \"368dd750e2f684f0cb1f7527494676d69d7b8f76\", \"got_v8_revision_cp\": \"refs/heads/8.8.240@{#1}\", \"got_webrtc_revision\": \"42cafa5696f516712bbe6709fedeedffac61544c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32540}\", \"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\": \"aa8b4a6538f1f4aa0ef73deb2a3e8aa2f51f7997\", \"swarm_hashes_refs/heads/master(at){#824615}_without_patch\": {\"absl_hardening_tests\": \"77ee64fe5a65bd638c98bc4219d89ac99153ce39\", \"accessibility_unittests\": \"134719168d9131202775ca823361fc22f7c1cbed\", \"angle_unittests\": \"a1da1f8172399beae3f4fbffb7dd5941c9274a73\", \"app_list_unittests\": \"c412438772c39077b296059382fac571dd5d9a30\", \"app_shell_unittests\": \"c0ed9eea30a860f289324ec1b0e0e2da87fddbc6\", \"ash_unittests\": \"7b93ba6629f509cd530d7295de49a9ff25b63445\", \"aura_unittests\": \"6e195e425ab4e970ff3e7e9999433cdd0a445ba7\", \"base_unittests\": \"e2f4dea5e447faefd40015f4bbf705b2fe52f1a5\", \"base_util_unittests\": \"ca8e0e11dfafd623a33e54b72c8bec285afe7d6b\", \"blink_common_unittests\": \"95c91d8acaf37db8ca17333753e8f513fea2e3d9\", \"blink_fuzzer_unittests\": \"3047bcd1b69ed71010151759575f55d6a424e48a\", \"blink_heap_unittests\": \"bcf27f4cc80e12085a039658db7c45868a552d87\", \"blink_platform_unittests\": \"13565fd6f304c3e65e22a96e93531a3d2fb10479\", \"blink_unittests\": \"9c33ba756cd5099566e8990cc2183294a4b45ac6\", \"boringssl_crypto_tests\": \"409eb6a6e7fc6fd961272574873c18c76a09caeb\", \"boringssl_ssl_tests\": \"147264bacb6f4b5ba14660bdb0f830227a5c5f09\", \"browser_tests\": \"a17f8249a0834ddd4d2144dd7726bc52b30b4dab\", \"capture_unittests\": \"708a2a3be9787a1c2e47099bb6ef2c427c6f17ad\", \"cast_unittests\": \"526fbace3f0331f4912e610fe52845521aad8ad3\", \"cc_unittests\": \"ec17d06614f05dc39ad5e7454a6bed962b74fc11\", \"chrome_app_unittests\": \"460017b8a5faa8cacc5d9443c0836e120347a90c\", \"chromedriver_unittests\": \"f9ca31037ca80a104a85fb1321a1501ee12b8a93\", \"chromeos_components_unittests\": \"d51d00c49199f7d71a3b2621ac9d3f5b09a3f527\", \"chromeos_unittests\": \"c8e222732d4dac51200d3744d6da277dc6aef21d\", \"components_browsertests\": \"4b03e3757b4480c4d77cb093664fa4305178b1bd\", \"components_unittests\": \"b14114218385647105fc95d1407a7ad37be66153\", \"compositor_unittests\": \"fa76b81cb1adcbd3ae089d3eb5369cde2da572e3\", \"content_browsertests\": \"c97843bdfd1adca432d656f66ef50dc9389e8156\", \"content_unittests\": \"3f7ab1710b954611c57226b617340d4b3c6fe268\", \"crypto_unittests\": \"be7f9fd9d010473f6b5ec5eedfedf0e33d579243\", \"dbus_unittests\": \"6b2e786280874ef925ebe00ff5f9bfc401e10f27\", \"device_unittests\": \"81f11f4e94a79a42f725a294d3e8d7cf295b7180\", \"display_unittests\": \"998d666f900eec8167de216f19da790b033a7bd7\", \"events_unittests\": \"f2b900895ec320c53a4336b9fc113e58be3ce12d\", \"exo_unittests\": \"5175c07279966498ebf2689ccd54ec140693fb48\", \"extensions_browsertests\": \"6576e985dcbf989194d916529cbf058367e731c0\", \"extensions_unittests\": \"ba8d9dde3069f1155f0a487bab09861a996eb43a\", \"filesystem_service_unittests\": \"2e7e949a8b36d23c8926b522b0bb6d04b2f5c509\", \"gcm_unit_tests\": \"7c1a93e223af42af586c55252b6dbe26f1814a15\", \"gfx_unittests\": \"94922bed9d0e7d9f0af9d01c5755467ccdfbb16e\", \"gin_unittests\": \"2ed129bf3ef74a16ce88f42aeec327ba81f498bd\", \"gl_unittests_ozone\": \"200cacc520986d12ea30ab0483c2f9dcceece480\", \"google_apis_unittests\": \"075b5c950b9f9cdd3e5525911c511962452fbb51\", \"gpu_unittests\": \"aa7b547ad2f6f2437c14b8cea4c89b1bbbec957d\", \"gwp_asan_unittests\": \"233b663c2a06b07705c47f0ab870cad162e6bff0\", \"interactive_ui_tests\": \"994f727493593a26d3d346884c766b5ce8e3e0fe\", \"ipc_tests\": \"f0cf3df47a15d7b8a1a482c04ece9e0560c6e59a\", \"jingle_unittests\": \"3df730936a6c6762a1a32f7225b7d0eb0232d64d\", \"keyboard_unittests\": \"edbdf0906380b95c384b3fc7aaa3cb2ae1c618a9\", \"latency_unittests\": \"c6fca156e0e334d0ddb9283b225c694a71d24797\", \"libjingle_xmpp_unittests\": \"22d4ee94618f09bc487e20933f37a1d9a192dce6\", \"liburlpattern_unittests\": \"435dff624f8b7dc6508377d1d5e8f4ef760ce846\", \"media_blink_unittests\": \"181d95f720dedceb399e629c686409f185db08f1\", \"media_unittests\": \"df85b4e791b94ce9ece29b4dab7a14314cb5ed3a\", \"message_center_unittests\": \"96495044c0bca88187c9f2668304149dda14e2e2\", \"midi_unittests\": \"068d9edc0b0fb034dd27f334d09616dbd806c097\", \"mojo_core_unittests\": \"2a1555ca58a375ba561bc7a1c3b0ba68ed66496a\", \"mojo_unittests\": \"19985472036dfdae4c4c17f0f01ff114699510fe\", \"nacl_helper_nonsfi_unittests\": \"b0ed86a049e38836a47589e97212bdb42af44ef1\", \"nacl_loader_unittests\": \"e618b513d984c9bde0e18e359a796a622da86e9f\", \"native_theme_unittests\": \"469d8d43b0fd129b625f27f2b9a95c9977e61db0\", \"net_unittests\": \"cb2489c500823d4e33ffc4db9afa1863adaba751\", \"ozone_gl_unittests\": \"e992824309931f5da138aa9ae36ae9c861e59d87\", \"ozone_unittests\": \"2c7eda10fc65da782b1a28895c89560564890aae\", \"ozone_x11_unittests\": \"ebc3ce54d61b4033ce030b7d59bf1c38d9d65ca5\", \"pdf_unittests\": \"2c8245443206ac86517516a443e3dfc3f0b5ab66\", \"perfetto_unittests\": \"9bc3d447b599b045057ada0a645960b305440afb\", \"ppapi_unittests\": \"dec554facb5df8468b7432b6eb30bf45d0489f8c\", \"printing_unittests\": \"c987e9ec98984dcf1609e34d973374ebfe9402c4\", \"remoting_unittests\": \"aa83c0166fd9a6ccbebc9b418a26a63af33ebdbd\", \"sandbox_linux_unittests\": \"99c127a311a0f2467d4157519263a44e501c2af6\", \"service_manager_unittests\": \"4a76cb354ca4c2188430d64a458eca5781650f2c\", \"services_unittests\": \"431b908aab271733ff0c33607e1f14c9fdeed7e1\", \"shell_dialogs_unittests\": \"aef491576f1237e2bdbd2834cbe741d326f01e6d\", \"skia_unittests\": \"6b60836efe9688276c48fc4f077ab2766283b83a\", \"snapshot_unittests\": \"c9683e8ec5a8d741a494b0be7d66874ac5987865\", \"sql_unittests\": \"78998bb5f36bf7f81969449df7ab49f68da7cd73\", \"storage_unittests\": \"ebcfdfd692302e83159f967f3e9652c17225d540\", \"sync_integration_tests\": \"ac25c821b8eea8bbee1304d99e05f7fcf3c38d8c\", \"traffic_annotation_auditor_unittests\": \"8841d44a5fba15a768fcffe15578d78b341234a3\", \"ui_base_unittests\": \"4b0c7b96b8b5534e0f0df6a7c701012bf88483aa\", \"ui_chromeos_unittests\": \"a552d0b4a286964818824845b225abb8592d5ebe\", \"ui_touch_selection_unittests\": \"7a1aa13610cae303ed288a0209e1b68212eeda00\", \"unit_tests\": \"cbb3421235b7258fb2eca88a9062b4b0a799735e\", \"url_unittests\": \"cc1102817299731f3e62b4f13d991b7ac8a5ded9\", \"usage_time_limit_unittests\": \"0899c27e708aebab5177bfb3ac43eab31673f07e\", \"views_unittests\": \"a08db1897fe993a034b5fdd34b52b1a03c5c8d32\", \"viz_unittests\": \"888acf0ffa6a6be68a8c63f6c03c826168d6230e\", \"wm_unittests\": \"7841cb3cc41f1ec210bdf8f60a21332b59b0c15d\", \"wtf_unittests\": \"0c45172fc10a676c5817461433709e3945e6aa56\", \"zlib_unittests\": \"3f1bb2426e224b5b134e36cca6306e6c82c1ae68\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_33498e86c0181efb6d75c3f73059d9522f6d5d2b3b1c7a2dc2a1c6b75cd205cd_v2\", \"builder_425d15596feb4c1a31f11fc1911a8217c0e7ee1a27198f37227d51247058a439_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_b9373cfdcc5f43b5e07cc4931fc34027757a424c7183ae2b31ae65ec7718ca12_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-100-rvs1\"], \"image\": [\"chrome-xenial-20102500-5da31bca5f9\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604615676421075",
"status": "COMPLETED",
"status_changed_ts": "1604621491821407",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21165",
"builder:linux-chromeos-dbg",
"buildset:commit/git/aa8b4a6538f1f4aa0ef73deb2a3e8aa2f51f7997",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa8b4a6538f1f4aa0ef73deb2a3e8aa2f51f7997",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029862294892342912",
"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/8864432231810515968/+/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:4fb35da56c683e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1604621491905533",
"url": "https://ci.chromium.org/b/8864432231810515968",
"utcnow_ts": "1604621498896954"
}
}
[00:11:38.909] Invocation finished in 1h37m8.026051806s with status SUCCEEDED