[01:21:53.657] New invocation is queued and will start shortly
[01:21:54.944] Starting the invocation (attempt 1)
[01:21:55.001] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:21:55.002] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:21:55.002] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029398779465331216",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9335ddafb80108dc22444b088ff9495e85d11a4a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9029398779465331216",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/9335ddafb80108dc22444b088ff9495e85d11a4a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9335ddafb80108dc22444b088ff9495e85d11a4a",
"gitiles_ref:refs/heads/master"
]
}
[01:21:56.116] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605057715115894",
"id": "8863968717273487328",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9335ddafb80108dc22444b088ff9495e85d11a4a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605057715849802",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21245",
"builder:linux-chromeos-dbg",
"buildset:commit/git/9335ddafb80108dc22444b088ff9495e85d11a4a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9335ddafb80108dc22444b088ff9495e85d11a4a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029398779465331216",
"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/8863968717273487328/+/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": "1605057715849952",
"url": "https://ci.chromium.org/b/8863968717273487328",
"utcnow_ts": "1605057716103306"
}
}
[01:21:56.116] Task URL: https://ci.chromium.org/b/8863968717273487328
[01:21:56.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:2:0) after 1m0s
[01:22:32.234] Received PubSub notification, asking Buildbucket for the build status
[01:22:32.488] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:56.165] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:2:0)
[01:22:56.165] Timer tick, asking Buildbucket for the build status
[01:22:56.242] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:56.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:4:0) after 1m0s
[01:23:56.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:4:0)
[01:23:56.234] Timer tick, asking Buildbucket for the build status
[01:23:56.347] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:56.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:5:0) after 1m0s
[01:24:56.394] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:5:0)
[01:24:56.394] Timer tick, asking Buildbucket for the build status
[01:24:56.454] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:56.454] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:6:0) after 1m0s
[01:25:56.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:6:0)
[01:25:56.470] Timer tick, asking Buildbucket for the build status
[01:25:56.554] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:56.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:7:0) after 1m0s
[01:26:56.600] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:7:0)
[01:26:56.600] Timer tick, asking Buildbucket for the build status
[01:26:56.754] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:56.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:8:0) after 1m0s
[01:27:56.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:8:0)
[01:27:56.825] Timer tick, asking Buildbucket for the build status
[01:27:56.991] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:56.991] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:9:0) after 1m0s
[01:28:56.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:9:0)
[01:28:56.977] Timer tick, asking Buildbucket for the build status
[01:28:57.126] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:57.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:10:0) after 1m0s
[01:29:57.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:10:0)
[01:29:57.175] Timer tick, asking Buildbucket for the build status
[01:29:57.384] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:57.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:11:0) after 1m0s
[01:30:57.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:11:0)
[01:30:57.448] Timer tick, asking Buildbucket for the build status
[01:30:57.577] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:57.577] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:12:0) after 1m0s
[01:31:57.630] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:12:0)
[01:31:57.630] Timer tick, asking Buildbucket for the build status
[01:31:57.694] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:57.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:13:0) after 1m0s
[01:32:57.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:13:0)
[01:32:57.719] Timer tick, asking Buildbucket for the build status
[01:32:57.857] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:57.857] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:14:0) after 1m0s
[01:33:57.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:14:0)
[01:33:57.869] Timer tick, asking Buildbucket for the build status
[01:33:58.043] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:58.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:15:0) after 1m0s
[01:34:58.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:15:0)
[01:34:58.118] Timer tick, asking Buildbucket for the build status
[01:34:58.501] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:58.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:16:0) after 1m0s
[01:35:58.547] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:16:0)
[01:35:58.547] Timer tick, asking Buildbucket for the build status
[01:35:58.619] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:58.619] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:17:0) after 1m0s
[01:36:58.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:17:0)
[01:36:58.629] Timer tick, asking Buildbucket for the build status
[01:36:58.763] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:58.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:18:0) after 1m0s
[01:37:58.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:18:0)
[01:37:58.785] Timer tick, asking Buildbucket for the build status
[01:38:00.557] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:00.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:19:0) after 1m0s
[01:39:00.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:19:0)
[01:39:00.586] Timer tick, asking Buildbucket for the build status
[01:39:00.804] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:00.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:20:0) after 1m0s
[01:40:03.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:20:0)
[01:40:03.108] Timer tick, asking Buildbucket for the build status
[01:40:03.338] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:03.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:21:0) after 1m0s
[01:41:04.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:21:0)
[01:41:04.670] Timer tick, asking Buildbucket for the build status
[01:41:04.749] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:04.749] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:22:0) after 1m0s
[01:42:04.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:22:0)
[01:42:04.797] Timer tick, asking Buildbucket for the build status
[01:42:05.242] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:05.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:23:0) after 1m0s
[01:43:05.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:23:0)
[01:43:05.267] Timer tick, asking Buildbucket for the build status
[01:43:05.425] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:05.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:24:0) after 1m0s
[01:44:05.490] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:24:0)
[01:44:05.490] Timer tick, asking Buildbucket for the build status
[01:44:05.635] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:05.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:25:0) after 1m0s
[01:45:05.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:25:0)
[01:45:05.815] Timer tick, asking Buildbucket for the build status
[01:45:06.019] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:06.019] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:26:0) after 1m0s
[01:46:06.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:26:0)
[01:46:06.087] Timer tick, asking Buildbucket for the build status
[01:46:06.246] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:06.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:27:0) after 1m0s
[01:47:07.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:27:0)
[01:47:07.484] Timer tick, asking Buildbucket for the build status
[01:47:07.693] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:07.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:28:0) after 1m0s
[01:48:07.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:28:0)
[01:48:07.798] Timer tick, asking Buildbucket for the build status
[01:48:08.293] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:08.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:29:0) after 1m0s
[01:49:08.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:29:0)
[01:49:08.338] Timer tick, asking Buildbucket for the build status
[01:49:08.422] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:08.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:30:0) after 1m0s
[01:50:08.457] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:30:0)
[01:50:08.457] Timer tick, asking Buildbucket for the build status
[01:50:08.617] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:08.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:31:0) after 1m0s
[01:51:08.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:31:0)
[01:51:08.643] Timer tick, asking Buildbucket for the build status
[01:51:08.899] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:08.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:32:0) after 1m0s
[01:52:08.987] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:32:0)
[01:52:08.987] Timer tick, asking Buildbucket for the build status
[01:52:09.168] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:09.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:33:0) after 1m0s
[01:53:09.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:33:0)
[01:53:09.203] Timer tick, asking Buildbucket for the build status
[01:53:09.268] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:09.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:34:0) after 1m0s
[01:54:09.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:34:0)
[01:54:09.334] Timer tick, asking Buildbucket for the build status
[01:54:09.491] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:09.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:35:0) after 1m0s
[01:55:09.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:35:0)
[01:55:09.514] Timer tick, asking Buildbucket for the build status
[01:55:09.644] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:09.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:36:0) after 1m0s
[01:56:09.669] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:36:0)
[01:56:09.669] Timer tick, asking Buildbucket for the build status
[01:56:09.823] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:09.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:37:0) after 1m0s
[01:57:09.876] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:37:0)
[01:57:09.876] Timer tick, asking Buildbucket for the build status
[01:57:10.023] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:10.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:38:0) after 1m0s
[01:58:10.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:38:0)
[01:58:10.095] Timer tick, asking Buildbucket for the build status
[01:58:10.164] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:10.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:39:0) after 1m0s
[01:59:10.189] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:39:0)
[01:59:10.189] Timer tick, asking Buildbucket for the build status
[01:59:10.267] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:10.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:40:0) after 1m0s
[02:00:10.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:40:0)
[02:00:10.370] Timer tick, asking Buildbucket for the build status
[02:00:10.833] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:10.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:41:0) after 1m0s
[02:01:10.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:41:0)
[02:01:10.900] Timer tick, asking Buildbucket for the build status
[02:01:11.059] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:11.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:42:0) after 1m0s
[02:02:11.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:42:0)
[02:02:11.124] Timer tick, asking Buildbucket for the build status
[02:02:11.237] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:11.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:43:0) after 1m0s
[02:03:11.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:43:0)
[02:03:11.314] Timer tick, asking Buildbucket for the build status
[02:03:11.590] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:11.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:44:0) after 1m0s
[02:04:11.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:44:0)
[02:04:11.599] Timer tick, asking Buildbucket for the build status
[02:04:11.703] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:11.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:45:0) after 1m0s
[02:05:11.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:45:0)
[02:05:11.728] Timer tick, asking Buildbucket for the build status
[02:05:11.924] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:11.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:46:0) after 1m0s
[02:06:11.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:46:0)
[02:06:11.993] Timer tick, asking Buildbucket for the build status
[02:06:12.084] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:12.084] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:47:0) after 1m0s
[02:07:12.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:47:0)
[02:07:12.158] Timer tick, asking Buildbucket for the build status
[02:07:12.931] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:12.931] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:48:0) after 1m0s
[02:08:13.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:48:0)
[02:08:13.083] Timer tick, asking Buildbucket for the build status
[02:08:13.214] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:13.214] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:49:0) after 1m0s
[02:09:13.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:49:0)
[02:09:13.366] Timer tick, asking Buildbucket for the build status
[02:09:13.514] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:13.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:50:0) after 1m0s
[02:10:13.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:50:0)
[02:10:13.531] Timer tick, asking Buildbucket for the build status
[02:10:13.661] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:13.661] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:51:0) after 1m0s
[02:11:13.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:51:0)
[02:11:13.729] Timer tick, asking Buildbucket for the build status
[02:11:14.417] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:14.417] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:52:0) after 1m0s
[02:12:14.547] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:52:0)
[02:12:14.547] Timer tick, asking Buildbucket for the build status
[02:12:14.889] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:14.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:53:0) after 1m0s
[02:13:14.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:53:0)
[02:13:14.938] Timer tick, asking Buildbucket for the build status
[02:13:15.028] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:15.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:54:0) after 1m0s
[02:14:15.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:54:0)
[02:14:15.145] Timer tick, asking Buildbucket for the build status
[02:14:15.261] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:15.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:55:0) after 1m0s
[02:15:15.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:55:0)
[02:15:15.349] Timer tick, asking Buildbucket for the build status
[02:15:15.466] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:15.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:56:0) after 1m0s
[02:16:15.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:56:0)
[02:16:15.518] Timer tick, asking Buildbucket for the build status
[02:16:15.665] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:15.665] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:57:0) after 1m0s
[02:17:15.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:57:0)
[02:17:15.667] Timer tick, asking Buildbucket for the build status
[02:17:15.807] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:15.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:58:0) after 1m0s
[02:18:15.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:58:0)
[02:18:15.834] Timer tick, asking Buildbucket for the build status
[02:18:15.952] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:15.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:59:0) after 1m0s
[02:19:16.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:59:0)
[02:19:16.024] Timer tick, asking Buildbucket for the build status
[02:19:16.497] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:16.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:60:0) after 1m0s
[02:20:16.553] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:60:0)
[02:20:16.553] Timer tick, asking Buildbucket for the build status
[02:20:16.997] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:16.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:61:0) after 1m0s
[02:21:17.089] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:61:0)
[02:21:17.089] Timer tick, asking Buildbucket for the build status
[02:21:17.174] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:17.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:62:0) after 1m0s
[02:22:17.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:62:0)
[02:22:17.224] Timer tick, asking Buildbucket for the build status
[02:22:17.392] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:17.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:63:0) after 1m0s
[02:23:17.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:63:0)
[02:23:17.480] Timer tick, asking Buildbucket for the build status
[02:23:17.567] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:17.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:64:0) after 1m0s
[02:24:17.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:64:0)
[02:24:17.544] Timer tick, asking Buildbucket for the build status
[02:24:17.783] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:17.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:65:0) after 1m0s
[02:25:17.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:65:0)
[02:25:17.934] Timer tick, asking Buildbucket for the build status
[02:25:18.075] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:18.075] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:66:0) after 1m0s
[02:26:18.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:66:0)
[02:26:18.217] Timer tick, asking Buildbucket for the build status
[02:26:18.588] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:18.588] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:67:0) after 1m0s
[02:27:18.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:67:0)
[02:27:18.606] Timer tick, asking Buildbucket for the build status
[02:27:19.347] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:19.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:68:0) after 1m0s
[02:28:19.512] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:68:0)
[02:28:19.512] Timer tick, asking Buildbucket for the build status
[02:28:20.109] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:20.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:69:0) after 1m0s
[02:29:20.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:69:0)
[02:29:20.140] Timer tick, asking Buildbucket for the build status
[02:29:20.489] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:20.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:70:0) after 1m0s
[02:30:20.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:70:0)
[02:30:20.467] Timer tick, asking Buildbucket for the build status
[02:30:20.601] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:20.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:71:0) after 1m0s
[02:31:20.625] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:71:0)
[02:31:20.625] Timer tick, asking Buildbucket for the build status
[02:31:20.773] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:20.773] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:72:0) after 1m0s
[02:32:20.803] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:72:0)
[02:32:20.803] Timer tick, asking Buildbucket for the build status
[02:32:21.070] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:21.070] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:73:0) after 1m0s
[02:33:21.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:73:0)
[02:33:21.117] Timer tick, asking Buildbucket for the build status
[02:33:21.201] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:21.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:74:0) after 1m0s
[02:34:21.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:74:0)
[02:34:21.233] Timer tick, asking Buildbucket for the build status
[02:34:21.404] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:21.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:75:0) after 1m0s
[02:35:21.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:75:0)
[02:35:21.413] Timer tick, asking Buildbucket for the build status
[02:35:21.516] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:21.516] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:76:0) after 1m0s
[02:36:21.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:76:0)
[02:36:21.583] Timer tick, asking Buildbucket for the build status
[02:36:21.663] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:21.663] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:77:0) after 1m0s
[02:37:21.739] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:77:0)
[02:37:21.739] Timer tick, asking Buildbucket for the build status
[02:37:21.866] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:21.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:78:0) after 1m0s
[02:38:21.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:78:0)
[02:38:21.919] Timer tick, asking Buildbucket for the build status
[02:38:21.985] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:21.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:79:0) after 1m0s
[02:39:22.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:79:0)
[02:39:22.023] Timer tick, asking Buildbucket for the build status
[02:39:22.136] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:22.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:80:0) after 1m0s
[02:40:22.133] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:80:0)
[02:40:22.133] Timer tick, asking Buildbucket for the build status
[02:40:22.212] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:22.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:81:0) after 1m0s
[02:41:22.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:81:0)
[02:41:22.252] Timer tick, asking Buildbucket for the build status
[02:41:22.426] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:22.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:82:0) after 1m0s
[02:42:22.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:82:0)
[02:42:22.454] Timer tick, asking Buildbucket for the build status
[02:42:22.608] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:22.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:83:0) after 1m0s
[02:43:22.684] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:83:0)
[02:43:22.684] Timer tick, asking Buildbucket for the build status
[02:43:22.903] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:22.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:84:0) after 1m0s
[02:44:22.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:84:0)
[02:44:22.960] Timer tick, asking Buildbucket for the build status
[02:44:23.053] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:23.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:85:0) after 1m0s
[02:45:23.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:85:0)
[02:45:23.072] Timer tick, asking Buildbucket for the build status
[02:45:23.151] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:23.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:86:0) after 1m0s
[02:46:23.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:86:0)
[02:46:23.198] Timer tick, asking Buildbucket for the build status
[02:46:24.002] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:24.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:87:0) after 1m0s
[02:47:24.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:87:0)
[02:47:24.258] Timer tick, asking Buildbucket for the build status
[02:47:24.415] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:24.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:88:0) after 1m0s
[02:48:24.538] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:88:0)
[02:48:24.538] Timer tick, asking Buildbucket for the build status
[02:48:24.605] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:24.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:89:0) after 1m0s
[02:49:24.731] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:89:0)
[02:49:24.731] Timer tick, asking Buildbucket for the build status
[02:49:25.221] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:25.221] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:90:0) after 1m0s
[02:50:25.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:90:0)
[02:50:25.856] Timer tick, asking Buildbucket for the build status
[02:50:26.011] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:26.011] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:91:0) after 1m0s
[02:51:26.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:91:0)
[02:51:26.265] Timer tick, asking Buildbucket for the build status
[02:51:26.397] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:26.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:92:0) after 1m0s
[02:52:26.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:92:0)
[02:52:26.537] Timer tick, asking Buildbucket for the build status
[02:52:26.669] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:26.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:93:0) after 1m0s
[02:53:26.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:93:0)
[02:53:26.886] Timer tick, asking Buildbucket for the build status
[02:53:26.963] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:26.963] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:94:0) after 1m0s
[02:54:27.033] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:94:0)
[02:54:27.033] Timer tick, asking Buildbucket for the build status
[02:54:27.205] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:27.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:95:0) after 1m0s
[02:55:27.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:95:0)
[02:55:27.238] Timer tick, asking Buildbucket for the build status
[02:55:27.317] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:27.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:96:0) after 1m0s
[02:56:27.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:96:0)
[02:56:27.308] Timer tick, asking Buildbucket for the build status
[02:56:27.388] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:27.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:97:0) after 1m0s
[02:57:27.469] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:97:0)
[02:57:27.469] Timer tick, asking Buildbucket for the build status
[02:57:28.399] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:28.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:98:0) after 1m0s
[02:58:28.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:98:0)
[02:58:28.712] Timer tick, asking Buildbucket for the build status
[02:58:28.843] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:28.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:99:0) after 1m0s
[02:59:28.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:99:0)
[02:59:28.820] Timer tick, asking Buildbucket for the build status
[02:59:28.945] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:28.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:100:0) after 1m0s
[03:00:29.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:100:0)
[03:00:29.119] Timer tick, asking Buildbucket for the build status
[03:00:29.206] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:29.206] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:101:0) after 1m0s
[03:01:29.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:101:0)
[03:01:29.248] Timer tick, asking Buildbucket for the build status
[03:01:29.401] Build 8863968717273487328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:29.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029398779465331216:102:0) after 1m0s
[03:01:37.700] Received PubSub notification, asking Buildbucket for the build status
[03:01:37.816] Build 8863968717273487328: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[03:01:37.816] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605063694049822",
"created_by": "project:chromium",
"created_ts": "1605057715115894",
"failure_reason": "BUILD_FAILURE",
"id": "8863968717273487328",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9335ddafb80108dc22444b088ff9495e85d11a4a\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**gwp_asan_unittests** failed because of:\\n\\n- SamplingMallocShimsTest.Calloc\"}, \"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\": \"9335ddafb80108dc22444b088ff9495e85d11a4a\", \"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-102-p9wv\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21245, \"got_angle_revision\": \"98035e11d907c2dadd8d5aaa2309944c7a2d0bd3\", \"got_dawn_revision\": \"f3c829047220ec1305c6a3202ee3e067e10512c9\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"9335ddafb80108dc22444b088ff9495e85d11a4a\", \"got_revision_cp\": \"refs/heads/master@{#826053}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"2dbcdc105b963ee2501c82139eef7e0603977ff0\", \"got_v8_revision_cp\": \"refs/heads/8.8.278@{#1}\", \"got_webrtc_revision\": \"9c99b7964fabb16a022293ffbd2804f9b46551f6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32565}\", \"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\": \"9335ddafb80108dc22444b088ff9495e85d11a4a\", \"swarm_hashes_refs/heads/master(at){#826053}_without_patch\": {\"absl_hardening_tests\": \"c59733428a0104ce1071318942f55ca6172a246d\", \"accessibility_unittests\": \"9691cbce3b169fb7c85a363e35a97e8a73959f5b\", \"angle_unittests\": \"2806842f8e07f5276f6efca136032ab53f63029c\", \"app_list_unittests\": \"f0363c8060a9a85a20c688b8da3d5b3f91d351eb\", \"app_shell_unittests\": \"fd108fb46fa66e488b97e1e0c1c9510d65cdb681\", \"ash_unittests\": \"d6cfa70b04e88266f1719c69f3aa23a591175609\", \"aura_unittests\": \"8e5cf953a87bb7cf7d3c72f07af6ddb6871d5bd9\", \"base_unittests\": \"220671940a706a0c76cf5240809ec9dfe36bd0a4\", \"base_util_unittests\": \"c6cb10360626d7544efe279a8166bd91eda6e8c9\", \"blink_common_unittests\": \"87346dedc7dd3211e454404af7aa9cde7ad01d38\", \"blink_fuzzer_unittests\": \"1acfe13588e148f17c36e6df847f47e8a6f8764d\", \"blink_heap_unittests\": \"996d7bcc309328352afe3801dc231fb4536c91ad\", \"blink_platform_unittests\": \"e864276ab4635590553c708aa8108d2f31c2066e\", \"blink_unittests\": \"093ead8bc5ca333c87ce2fc2b56246e3d04d5f3b\", \"boringssl_crypto_tests\": \"e391415d002b3bad2566a400d460cd0fc43b0377\", \"boringssl_ssl_tests\": \"ec71918d72101b1098e15c54906217c9ffff1b02\", \"browser_tests\": \"e3e2f77d45f59340cf205d9a1bfa578939f2acbc\", \"capture_unittests\": \"07d6eefdb94b57151926daee15b956d8ee486beb\", \"cast_unittests\": \"7dd3ed34bc04a8723bb2e5fc0deaf27d069817d7\", \"cc_unittests\": \"f4781cbb9f7a8c5d47de3180f9c0a58aa0016557\", \"chrome_app_unittests\": \"b9e55906e321319291300633047eade5367b1c52\", \"chromedriver_unittests\": \"ab6aeb712ac57a192c3594dde4397f52b7b2ce4b\", \"chromeos_components_unittests\": \"c40e0b923c886f2da112548e164f164ec538a53a\", \"chromeos_unittests\": \"d2b25dd20fb7a02e9799386fd2ac8e4a8ab7711c\", \"components_browsertests\": \"bd441184f12eefe7d904be9a8f38829e74efe348\", \"components_unittests\": \"a8c6716b38b53568fdadba96608fd74cc5760c8b\", \"compositor_unittests\": \"fe27a4dd6c9aae3323e0a818d6e38675ee7126cb\", \"content_browsertests\": \"2ab3f26ff552c427288fde1cb719f63f3dc1cbcb\", \"content_unittests\": \"dfbf4c1a374de779fe15eaafaee7b4276879e2b6\", \"crypto_unittests\": \"ed875f894356314fd0526600a605da2f9d48a956\", \"dbus_unittests\": \"f664ec2d6672dfde85ef901734380c0fea7f1c4f\", \"device_unittests\": \"fa52413529d6ce57382a048d4f59f5a73dff58fc\", \"display_unittests\": \"2e44aad672ae4abf5028f9e6844b809271f66ea0\", \"events_unittests\": \"5cf28462291e667e558a3748fbc013a4015285ad\", \"exo_unittests\": \"a4500718088a77d27e407477691e7a7a85b00813\", \"extensions_browsertests\": \"6341dbadbdb1e18157c1a2cd46847953544bc6e3\", \"extensions_unittests\": \"25251a740ad8fcb1c531e0ea9fe23af651eac887\", \"filesystem_service_unittests\": \"3fd54c6afe0dae7abe300144054a5ed29e3b1675\", \"gcm_unit_tests\": \"931a1b95ac5741c8ac7abc38807545fdfdda63db\", \"gfx_unittests\": \"202e5eda78b659a227055f95461a7d04a24414f4\", \"gin_unittests\": \"aa84dc4099460e58ab4c46f22aac6d2398d47bbb\", \"gl_unittests_ozone\": \"b2df1bb1941ccc3b535b83557b7b2ef9050cb2d4\", \"google_apis_unittests\": \"24972b2837982275ec93ae8b73354c152dae8eea\", \"gpu_unittests\": \"a2e559579f5fdf7a7cd45ef35de80511531a2f5a\", \"gwp_asan_unittests\": \"6d8f4244858279450506cd684c3c327078c3f7bb\", \"interactive_ui_tests\": \"54bdd0985f7b2e3acb56fde883e7f4dc3599ca50\", \"ipc_tests\": \"968a4de9814f904e63fc93a97e21b19ea7a8e0a9\", \"jingle_unittests\": \"8de22f79d0ad0010ef11c848baa624f1673d78f3\", \"keyboard_unittests\": \"50636406a3d593541925f0c806fe9e5ef084edb9\", \"latency_unittests\": \"89e01dfb6137ab8f46531976560629520d79c791\", \"libjingle_xmpp_unittests\": \"09243ed371e9396735d331e8f245bf1dc92c1def\", \"liburlpattern_unittests\": \"8aa3d5466d7422566310d641d204c3fa1e04b87a\", \"media_blink_unittests\": \"18a6a21f175bd463b85d31bf2f280b0efab16f48\", \"media_unittests\": \"121e85a79f4fd20f066e1d7ccdfbfda97e0d119d\", \"message_center_unittests\": \"657236559934382779f6c511562fc04d85115e71\", \"midi_unittests\": \"aec83a3c1b8731b482f265172a64fd2fc284fcc5\", \"mojo_core_unittests\": \"857c3d4df171be3f29065b29aa14b32c202dc712\", \"mojo_unittests\": \"296185da8064500e2eaf1cba0b4fde335ed326f4\", \"nacl_helper_nonsfi_unittests\": \"c9ea64b65ff06621a1354a40d26c95491fbab5b8\", \"nacl_loader_unittests\": \"58c77f8da0c3deb12f12fabae29799081190cd5b\", \"native_theme_unittests\": \"8a1fcc004f9756d2c608430a21945ebbb71cd294\", \"net_unittests\": \"3f6f30c240f9006940853df00b52fb1ab04b5695\", \"ozone_gl_unittests\": \"f38c51c8ef3bb058afd60a24ac99e0682371d64e\", \"ozone_unittests\": \"dda42573ab02a72ec73ac3d053cb0dde745d2da3\", \"ozone_x11_unittests\": \"5fe3bcdaf9c88e07828c5520a6d4371bf1f63119\", \"pdf_unittests\": \"f82a63ef655f8315eaabd78c5bf190731d6b5ded\", \"perfetto_unittests\": \"9fb61c45cc2d8f89c47b941c3d27e23cb73e2a90\", \"ppapi_unittests\": \"fab113509ae5a0a199309ec69797d26f4726a946\", \"printing_unittests\": \"7ed912ee24c9642083da4646eb1e4cbc39124c66\", \"remoting_unittests\": \"94d412c7857b97b5d8cd668a6d525b6df0832525\", \"sandbox_linux_unittests\": \"84ea6b27135f093144a1f0a8213b76f63f72ef30\", \"service_manager_unittests\": \"9c24c7fcb1e2ea953b9d7f982c5fef4f729e6eb5\", \"services_unittests\": \"232c2dad86189be129cb0c10d4d757c111f7e494\", \"shell_dialogs_unittests\": \"4a7291df545326e9e06b003ddaded93e06823afe\", \"skia_unittests\": \"ed1a89283c4667d130e1f084268f69ba0cec04bf\", \"snapshot_unittests\": \"7c2a749a903be1a73f7e4c9a11569cfc76b8de9b\", \"sql_unittests\": \"03d9e3e4d0276884c7b61d6c5f53e98ea942b80f\", \"storage_unittests\": \"30ab6e8690f0e68b447911797302ebd2225b6add\", \"sync_integration_tests\": \"1ec5d2eaaddcf98e7c6334e6dd599be2c2e0d0f3\", \"traffic_annotation_auditor_unittests\": \"68f2f6d7415683ef9fe5d7b0372c85aff0abdae4\", \"ui_base_unittests\": \"a8f52c2ffd8b7abdef3076fdae3b1982c6c35e09\", \"ui_chromeos_unittests\": \"91ac69ae02b0fecadb1420891d1596812044fb7a\", \"ui_touch_selection_unittests\": \"520f05ca7458a80dccc4e4e9ac4cc16f39932a67\", \"unit_tests\": \"5c58f95e58a82726ccf6d6b761eba97df74ff0af\", \"url_unittests\": \"4be156a9c0e343a176c024f3b3cfa539a7f666d0\", \"usage_time_limit_unittests\": \"3164e4cfe1fe1785ad1fdf9659fbc8987997f20a\", \"views_unittests\": \"f9e6ade417782feb08cc14f4be57c7c2d3a3b150\", \"viz_unittests\": \"38d5e4ba07300ef7850b71d289221ec32d1b89ec\", \"wm_unittests\": \"c19bf45078098ebe8943488c61db06e357b59f4a\", \"wtf_unittests\": \"8c895de8706e73af33b44362d4560bd53ff60d3c\", \"zlib_unittests\": \"e5d7a817f97450fd7a280e1193eea6ff26a6da0d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3ebf4dd509a5805e98d79f047f39cac1c13d897e075c42798b95fb1279fe5d7c_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_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-102-p9wv\"], \"image\": [\"chrome-xenial-20110100-7e97731f9b6\"], \"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\": [\"5626-39642e9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**gwp_asan_unittests** failed because of:\\n\\n- SamplingMallocShimsTest.Calloc\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605057747219090",
"status": "COMPLETED",
"status_changed_ts": "1605057748736787",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21245",
"builder:linux-chromeos-dbg",
"buildset:commit/git/9335ddafb80108dc22444b088ff9495e85d11a4a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9335ddafb80108dc22444b088ff9495e85d11a4a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029398779465331216",
"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/8863968717273487328/+/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:4fcdb6ac6ff82410",
"user_agent:luci-scheduler"
],
"updated_ts": "1605063697248878",
"url": "https://ci.chromium.org/b/8863968717273487328",
"utcnow_ts": "1605063697806288"
}
}
[03:01:37.816] Invocation finished in 1h39m44.175242986s with status FAILED