[21:00:04.059] New invocation is queued and will start shortly
[21:00:05.202] Starting the invocation (attempt 1)
[21:00:05.242] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:00:05.242] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:00:05.243] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9017637646539648864",
"parameters_json": "{\"builder_name\":\"ToTFuchsia x64\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"dc78737f0f8beec9d14379127b9637b02b465147\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTFuchsia x64",
"scheduler_invocation_id:9017637646539648864",
"scheduler_job_id:chromium/ToTFuchsia x64",
"user_agent:luci-scheduler",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dc78737f0f8beec9d14379127b9637b02b465147",
"gitiles_ref:refs/heads/master"
]
}
[21:00:08.106] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1616274005370691",
"id": "8852207584503436976",
"parameters_json": "{\"builder_name\": \"ToTFuchsia x64\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dc78737f0f8beec9d14379127b9637b02b465147\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1616274007821721",
"tags": [
"build_address:luci.chromium.ci/ToTFuchsia x64/229",
"builder:ToTFuchsia x64",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dc78737f0f8beec9d14379127b9637b02b465147",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017637646539648864",
"scheduler_job_id:chromium/ToTFuchsia x64",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852207584503436976/+/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": "1616274007821858",
"url": "https://ci.chromium.org/b/8852207584503436976",
"utcnow_ts": "1616274008076378"
}
}
[21:00:08.106] Task URL: https://ci.chromium.org/b/8852207584503436976
[21:00:08.106] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:2:0) after 1m0s
[21:01:08.597] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:2:0)
[21:01:08.597] Timer tick, asking Buildbucket for the build status
[21:01:08.794] Build 8852207584503436976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:01:08.794] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:3:0) after 1m0s
[21:01:30.177] Received PubSub notification, asking Buildbucket for the build status
[21:01:30.426] Build status: STARTED
[21:02:08.849] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:3:0)
[21:02:08.849] Timer tick, asking Buildbucket for the build status
[21:02:08.918] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:08.918] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:5:0) after 1m0s
[21:03:08.911] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:5:0)
[21:03:08.936] Build status: STARTED
[21:03:08.936] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:6:0) after 3m24s
[21:06:33.073] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:6:0)
[21:06:33.108] Build status: STARTED
[21:06:33.108] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:7:0) after 2m55s
[21:09:28.170] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:7:0)
[21:09:28.170] Timer tick, asking Buildbucket for the build status
[21:09:28.253] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:28.253] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:8:0) after 1m0s
[21:10:28.346] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:8:0)
[21:10:28.346] Timer tick, asking Buildbucket for the build status
[21:10:28.414] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:28.414] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:9:0) after 1m0s
[21:11:28.535] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:9:0)
[21:11:28.535] Timer tick, asking Buildbucket for the build status
[21:11:28.673] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:28.673] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:10:0) after 1m0s
[21:12:28.741] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:10:0)
[21:12:28.741] Timer tick, asking Buildbucket for the build status
[21:12:28.808] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:28.808] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:11:0) after 1m0s
[21:13:28.895] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:11:0)
[21:13:28.925] Build status: STARTED
[21:13:28.925] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:12:0) after 1m31s
[21:14:59.951] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:12:0)
[21:14:59.951] Timer tick, asking Buildbucket for the build status
[21:15:00.058] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:00.058] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:13:0) after 1m0s
[21:16:00.179] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:13:0)
[21:16:00.212] Build status: STARTED
[21:16:00.212] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:14:0) after 3m2s
[21:19:02.229] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:14:0)
[21:19:02.229] Timer tick, asking Buildbucket for the build status
[21:19:02.397] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:02.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:15:0) after 1m0s
[21:20:02.521] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:15:0)
[21:20:02.521] Timer tick, asking Buildbucket for the build status
[21:20:02.593] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:02.593] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:16:0) after 1m0s
[21:21:02.839] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:16:0)
[21:21:02.839] Timer tick, asking Buildbucket for the build status
[21:21:03.282] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:03.282] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:17:0) after 1m0s
[21:22:03.308] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:17:0)
[21:22:03.358] Build status: STARTED
[21:22:03.358] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:18:0) after 4m45s
[21:26:48.825] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:18:0)
[21:26:48.851] Build status: STARTED
[21:26:48.851] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:19:0) after 2m45s
[21:29:33.885] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:19:0)
[21:29:33.908] Build status: STARTED
[21:29:33.908] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:20:0) after 1m43s
[21:31:17.151] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:20:0)
[21:31:17.215] Build status: STARTED
[21:31:17.215] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:21:0) after 8m12s
[21:39:29.210] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:21:0)
[21:39:29.233] Build status: STARTED
[21:39:29.233] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:22:0) after 4m56s
[21:44:25.354] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:22:0)
[21:44:25.381] Build status: STARTED
[21:44:25.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:23:0) after 9m50s
[21:54:15.533] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:23:0)
[21:54:15.533] Timer tick, asking Buildbucket for the build status
[21:54:15.613] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:15.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:24:0) after 1m0s
[21:55:15.636] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:24:0)
[21:55:15.636] Timer tick, asking Buildbucket for the build status
[21:55:15.845] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:15.845] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:25:0) after 1m0s
[21:56:15.873] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:25:0)
[21:56:15.900] Build status: STARTED
[21:56:15.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:26:0) after 1m27s
[21:57:42.914] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:26:0)
[21:57:42.914] Timer tick, asking Buildbucket for the build status
[21:57:43.004] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:43.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:27:0) after 1m0s
[21:58:43.023] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:27:0)
[21:58:43.023] Timer tick, asking Buildbucket for the build status
[21:58:43.086] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:43.086] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:28:0) after 1m0s
[21:59:43.109] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:28:0)
[21:59:43.142] Build status: STARTED
[21:59:43.142] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:29:0) after 8m29s
[22:08:12.198] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:29:0)
[22:08:12.223] Build status: STARTED
[22:08:12.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:30:0) after 4m57s
[22:13:09.276] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:30:0)
[22:13:09.304] Build status: STARTED
[22:13:09.304] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:31:0) after 4m51s
[22:18:00.489] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:31:0)
[22:18:00.522] Build status: STARTED
[22:18:00.522] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:32:0) after 4m8s
[22:22:08.540] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:32:0)
[22:22:08.540] Timer tick, asking Buildbucket for the build status
[22:22:08.656] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:08.656] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:33:0) after 1m0s
[22:23:08.699] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:33:0)
[22:23:08.699] Timer tick, asking Buildbucket for the build status
[22:23:08.781] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:08.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:34:0) after 1m0s
[22:24:08.797] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:34:0)
[22:24:08.797] Timer tick, asking Buildbucket for the build status
[22:24:08.859] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:08.859] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:35:0) after 1m0s
[22:25:08.878] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:35:0)
[22:25:08.878] Timer tick, asking Buildbucket for the build status
[22:25:08.952] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:08.952] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:36:0) after 1m0s
[22:26:08.972] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:36:0)
[22:26:08.997] Build status: STARTED
[22:26:08.997] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:37:0) after 4m35s
[22:30:44.072] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:37:0)
[22:30:44.072] Timer tick, asking Buildbucket for the build status
[22:30:44.155] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:44.155] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:38:0) after 1m0s
[22:31:44.196] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:38:0)
[22:31:44.196] Timer tick, asking Buildbucket for the build status
[22:31:44.382] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:44.382] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:39:0) after 1m0s
[22:32:44.509] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:39:0)
[22:32:44.509] Timer tick, asking Buildbucket for the build status
[22:32:44.577] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:44.577] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:40:0) after 1m0s
[22:33:44.597] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:40:0)
[22:33:44.633] Build status: STARTED
[22:33:44.633] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:41:0) after 8m43s
[22:42:27.749] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:41:0)
[22:42:27.780] Build status: STARTED
[22:42:27.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:42:0) after 1m34s
[22:44:02.111] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:42:0)
[22:44:02.111] Timer tick, asking Buildbucket for the build status
[22:44:02.702] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:02.702] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:43:0) after 1m0s
[22:45:03.147] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:43:0)
[22:45:03.147] Timer tick, asking Buildbucket for the build status
[22:45:03.255] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:03.255] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:44:0) after 1m0s
[22:46:03.299] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:44:0)
[22:46:03.299] Timer tick, asking Buildbucket for the build status
[22:46:03.570] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:03.570] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:45:0) after 1m0s
[22:47:03.739] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:45:0)
[22:47:03.739] Timer tick, asking Buildbucket for the build status
[22:47:04.197] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:04.197] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:46:0) after 1m0s
[22:48:04.542] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:46:0)
[22:48:04.568] Build status: STARTED
[22:48:04.568] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:47:0) after 2m59s
[22:51:03.585] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:47:0)
[22:51:03.631] Build status: STARTED
[22:51:03.631] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:48:0) after 5m15s
[22:56:18.648] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:48:0)
[22:56:18.680] Build status: STARTED
[22:56:18.680] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:49:0) after 7m43s
[23:04:01.699] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:49:0)
[23:04:01.699] Timer tick, asking Buildbucket for the build status
[23:04:01.903] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:01.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:50:0) after 1m0s
[23:05:01.925] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:50:0)
[23:05:01.957] Build status: STARTED
[23:05:01.957] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:51:0) after 2m21s
[23:07:23.003] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:51:0)
[23:07:23.003] Timer tick, asking Buildbucket for the build status
[23:07:23.209] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:23.210] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:52:0) after 1m0s
[23:08:23.272] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:52:0)
[23:08:23.298] Build status: STARTED
[23:08:23.298] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:53:0) after 7m18s
[23:15:41.324] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:53:0)
[23:15:41.324] Timer tick, asking Buildbucket for the build status
[23:15:41.598] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:41.598] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:54:0) after 1m0s
[23:16:41.629] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:54:0)
[23:16:41.723] Build status: STARTED
[23:16:41.723] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:55:0) after 8m9s
[23:24:50.813] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:55:0)
[23:24:50.813] Timer tick, asking Buildbucket for the build status
[23:24:50.972] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:50.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:56:0) after 1m0s
[23:25:50.990] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:56:0)
[23:25:50.990] Timer tick, asking Buildbucket for the build status
[23:25:51.051] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:51.051] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:57:0) after 1m0s
[23:26:51.266] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:57:0)
[23:26:51.289] Build status: STARTED
[23:26:51.289] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:58:0) after 5m26s
[23:32:17.332] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:58:0)
[23:32:17.332] Timer tick, asking Buildbucket for the build status
[23:32:17.497] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:17.497] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:59:0) after 1m0s
[23:33:17.522] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:59:0)
[23:33:17.557] Build status: STARTED
[23:33:17.557] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:60:0) after 4m25s
[23:37:42.674] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:60:0)
[23:37:42.700] Build status: STARTED
[23:37:42.700] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:61:0) after 5m43s
[23:43:25.757] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:61:0)
[23:43:25.789] Build status: STARTED
[23:43:25.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:62:0) after 2m10s
[23:45:35.911] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:62:0)
[23:45:35.934] Build status: STARTED
[23:45:35.934] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:63:0) after 7m37s
[23:53:12.957] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:63:0)
[23:53:12.996] Build status: STARTED
[23:53:12.996] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:64:0) after 3m54s
[23:57:07.126] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:64:0)
[23:57:07.154] Build status: STARTED
[23:57:07.154] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:65:0) after 4m28s
[00:01:35.185] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:65:0)
[00:01:35.213] Build status: STARTED
[00:01:35.213] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:66:0) after 8m29s
[00:10:04.212] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:66:0)
[00:10:04.243] Build status: STARTED
[00:10:04.243] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:67:0) after 7m39s
[00:17:43.264] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:67:0)
[00:17:43.289] Build status: STARTED
[00:17:43.289] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:68:0) after 7m55s
[00:25:38.360] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:68:0)
[00:25:38.387] Build status: STARTED
[00:25:38.387] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:69:0) after 4m9s
[00:29:47.411] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:69:0)
[00:29:47.434] Build status: STARTED
[00:29:47.434] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:70:0) after 5m16s
[00:35:03.458] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:70:0)
[00:35:03.486] Build status: STARTED
[00:35:03.486] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:71:0) after 9m6s
[00:44:09.609] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:71:0)
[00:44:09.635] Build status: STARTED
[00:44:09.635] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:72:0) after 9m54s
[00:54:03.736] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:72:0)
[00:54:03.770] Build status: STARTED
[00:54:03.770] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:73:0) after 2m53s
[00:56:56.837] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:73:0)
[00:56:56.868] Build status: STARTED
[00:56:56.868] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:74:0) after 1m23s
[00:58:19.916] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:74:0)
[00:58:19.943] Build status: STARTED
[00:58:19.943] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:75:0) after 7m0s
[01:05:19.974] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:75:0)
[01:05:19.974] Timer tick, asking Buildbucket for the build status
[01:05:20.107] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:20.107] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:76:0) after 1m0s
[01:06:20.133] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:76:0)
[01:06:20.133] Timer tick, asking Buildbucket for the build status
[01:06:20.219] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:20.219] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:77:0) after 1m0s
[01:07:20.239] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:77:0)
[01:07:20.239] Timer tick, asking Buildbucket for the build status
[01:07:20.320] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:20.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:78:0) after 1m0s
[01:08:20.441] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:78:0)
[01:08:20.469] Build status: STARTED
[01:08:20.469] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:79:0) after 5m36s
[01:13:56.492] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:79:0)
[01:13:56.518] Build status: STARTED
[01:13:56.518] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:80:0) after 3m53s
[01:17:49.539] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:80:0)
[01:17:49.539] Timer tick, asking Buildbucket for the build status
[01:17:49.624] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:49.624] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:81:0) after 1m0s
[01:18:49.643] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:81:0)
[01:18:49.670] Build status: STARTED
[01:18:49.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:82:0) after 1m55s
[01:20:44.690] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:82:0)
[01:20:44.690] Timer tick, asking Buildbucket for the build status
[01:20:44.906] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:44.906] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:83:0) after 1m0s
[01:21:44.956] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:83:0)
[01:21:44.980] Build status: STARTED
[01:21:44.980] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:84:0) after 8m47s
[01:30:32.141] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:84:0)
[01:30:32.170] Build status: STARTED
[01:30:32.170] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:85:0) after 4m52s
[01:35:24.229] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:85:0)
[01:35:24.300] Build status: STARTED
[01:35:24.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:86:0) after 7m31s
[01:42:55.321] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:86:0)
[01:42:55.349] Build status: STARTED
[01:42:55.349] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:87:0) after 8m48s
[01:51:43.329] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:87:0)
[01:51:43.378] Build status: STARTED
[01:51:43.378] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:88:0) after 5m35s
[01:57:18.419] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:88:0)
[01:57:18.419] Timer tick, asking Buildbucket for the build status
[01:57:19.028] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:19.028] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:89:0) after 1m0s
[01:58:19.198] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:89:0)
[01:58:19.227] Build status: STARTED
[01:58:19.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:90:0) after 6m8s
[02:04:27.344] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:90:0)
[02:04:27.344] Timer tick, asking Buildbucket for the build status
[02:04:27.437] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:27.437] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:91:0) after 1m0s
[02:05:27.499] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:91:0)
[02:05:27.534] Build status: STARTED
[02:05:27.534] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:92:0) after 9m11s
[02:14:38.557] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:92:0)
[02:14:38.557] Timer tick, asking Buildbucket for the build status
[02:14:38.645] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:38.645] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:93:0) after 1m0s
[02:15:38.782] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:93:0)
[02:15:38.782] Timer tick, asking Buildbucket for the build status
[02:15:38.904] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:38.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:94:0) after 1m0s
[02:16:39.019] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:94:0)
[02:16:39.047] Build status: STARTED
[02:16:39.047] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:95:0) after 4m52s
[02:21:31.070] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:95:0)
[02:21:31.155] Build status: STARTED
[02:21:31.155] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:96:0) after 4m13s
[02:25:44.219] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:96:0)
[02:25:44.219] Timer tick, asking Buildbucket for the build status
[02:25:44.312] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:44.312] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:97:0) after 1m0s
[02:26:44.451] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:97:0)
[02:26:44.451] Timer tick, asking Buildbucket for the build status
[02:26:44.546] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:44.546] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:98:0) after 1m0s
[02:27:44.582] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:98:0)
[02:27:44.625] Build status: STARTED
[02:27:44.625] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:99:0) after 9m56s
[02:37:40.704] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:99:0)
[02:37:40.704] Timer tick, asking Buildbucket for the build status
[02:37:40.831] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:40.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:100:0) after 1m0s
[02:38:40.848] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:100:0)
[02:38:40.848] Timer tick, asking Buildbucket for the build status
[02:38:40.922] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:40.922] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:101:0) after 1m0s
[02:39:40.946] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:101:0)
[02:39:40.972] Build status: STARTED
[02:39:40.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:102:0) after 9m13s
[02:48:54.154] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:102:0)
[02:48:54.154] Timer tick, asking Buildbucket for the build status
[02:48:54.252] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:54.252] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:103:0) after 1m0s
[02:49:54.280] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:103:0)
[02:49:54.280] Timer tick, asking Buildbucket for the build status
[02:49:54.353] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:54.353] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:104:0) after 1m0s
[02:50:54.378] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:104:0)
[02:50:54.378] Timer tick, asking Buildbucket for the build status
[02:50:54.452] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:54.452] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:105:0) after 1m0s
[02:51:54.475] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:105:0)
[02:51:54.502] Build status: STARTED
[02:51:54.502] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:106:0) after 1m1s
[02:52:55.523] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:106:0)
[02:52:55.553] Build status: STARTED
[02:52:55.553] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:107:0) after 7m14s
[03:00:09.572] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:107:0)
[03:00:09.572] Timer tick, asking Buildbucket for the build status
[03:00:09.838] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:09.838] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:108:0) after 1m0s
[03:01:10.217] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:108:0)
[03:01:10.217] Timer tick, asking Buildbucket for the build status
[03:01:10.424] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:10.424] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:109:0) after 1m0s
[03:02:10.470] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:109:0)
[03:02:10.470] Timer tick, asking Buildbucket for the build status
[03:02:10.543] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:10.543] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:110:0) after 1m0s
[03:03:10.609] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:110:0)
[03:03:10.609] Timer tick, asking Buildbucket for the build status
[03:03:10.738] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:10.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:111:0) after 1m0s
[03:04:10.825] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:111:0)
[03:04:10.867] Build status: STARTED
[03:04:10.867] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:112:0) after 2m32s
[03:06:42.890] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:112:0)
[03:06:42.890] Timer tick, asking Buildbucket for the build status
[03:06:43.132] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:43.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:113:0) after 1m0s
[03:07:43.292] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:113:0)
[03:07:43.292] Timer tick, asking Buildbucket for the build status
[03:07:43.412] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:43.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:114:0) after 1m0s
[03:08:43.567] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:114:0)
[03:08:43.598] Build status: STARTED
[03:08:43.598] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:115:0) after 1m15s
[03:09:58.581] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:115:0)
[03:09:58.581] Timer tick, asking Buildbucket for the build status
[03:09:58.670] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:58.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:116:0) after 1m0s
[03:10:58.696] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:116:0)
[03:10:58.696] Timer tick, asking Buildbucket for the build status
[03:10:59.100] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:59.100] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:117:0) after 1m0s
[03:11:59.102] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:117:0)
[03:11:59.130] Build status: STARTED
[03:11:59.130] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:118:0) after 9m21s
[03:21:20.167] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:118:0)
[03:21:20.195] Build status: STARTED
[03:21:20.195] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:119:0) after 7m31s
[03:28:51.320] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:119:0)
[03:28:51.346] Build status: STARTED
[03:28:51.346] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:120:0) after 9m30s
[03:38:21.372] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:120:0)
[03:38:21.372] Timer tick, asking Buildbucket for the build status
[03:38:21.520] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:21.520] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:121:0) after 1m0s
[03:39:21.571] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:121:0)
[03:39:21.601] Build status: STARTED
[03:39:21.601] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:122:0) after 8m57s
[03:48:18.821] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:122:0)
[03:48:18.851] Build status: STARTED
[03:48:18.851] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:123:0) after 9m30s
[03:57:48.905] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:123:0)
[03:57:48.905] Timer tick, asking Buildbucket for the build status
[03:57:49.036] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:49.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:124:0) after 1m0s
[03:58:49.068] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:124:0)
[03:58:49.068] Timer tick, asking Buildbucket for the build status
[03:58:49.498] Build 8852207584503436976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:49.498] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:125:0) after 1m0s
[03:59:49.519] Handling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:125:0)
[03:59:49.552] Build status: STARTED
[03:59:49.552] Scheduling timer "check-buildbucket-build-status" (chromium/ToTFuchsia x64:9017637646539648864:126:0) after 5m49s
[04:02:46.606] Received PubSub notification, asking Buildbucket for the build status
[04:02:46.680] Build 8852207584503436976: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[04:02:46.680] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1616299366151357",
"created_by": "project:chromium",
"created_ts": "1616274005370691",
"failure_reason": "BUILD_FAILURE",
"id": "8852207584503436976",
"parameters_json": "{\"builder_name\": \"ToTFuchsia x64\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dc78737f0f8beec9d14379127b9637b02b465147\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 Test Suite(s) failed.\\n\\n**components_unittests** failed because of:\\n\\n- BookmarkSpecificsConversionsTest.ShouldLoadFaviconWhenCreatingSpecificsFromBookmarkNode\\n\\n- SimpleSchemaValidatingPolicyHandlerTest.CheckAndGetValue\\n\\n- PaymentRequestSpecTest.RetryWithPayerErrors\\n\\n- BookmarkModelTest.RemoveURL\\n\\n- ...2384 more failure(s) (2388 total)...\\n\\n**blink_web_tests** failed:\\n\\n\"}, \"properties\": {\"$build/goma\": {\"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"dc78737f0f8beec9d14379127b9637b02b465147\", \"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-32-14-33iv\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.clang\", \"buildername\": \"ToTFuchsia x64\", \"buildnumber\": 229, \"clang_revision\": \"llvmorg-13-init-5050-g14696baa-0\", \"got_angle_revision\": \"135385a1ae86bf857be37475f927dcf78c9476b4\", \"got_dawn_revision\": \"853b5d765e715fc11ea28c1d3754e48d38c283b1\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"dc78737f0f8beec9d14379127b9637b02b465147\", \"got_revision_cp\": \"refs/heads/master@{#864970}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a98fb3f8380a3a5c9ae3e0175634ba88c85a434f\", \"got_v8_revision\": \"6092f990f654f2d7a4534ee8c5bbb5c4fb800bdc\", \"got_v8_revision_cp\": \"refs/heads/9.1.170@{#1}\", \"got_webrtc_revision\": \"8bf1cd1c665a538a366bce4770acbb990b025388\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33513}\", \"is_cached\": true, \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dc78737f0f8beec9d14379127b9637b02b465147\", \"swarm_hashes_refs/heads/master(at){#864970}_without_patch\": {\"absl_hardening_tests\": \"fb4683998d8210a9b3d793f2dc34dd1932b5af707dad8fbc73e5e2a4f2d55626/408\", \"accessibility_unittests\": \"2b2d2b60a32089e61eb0aaa7be252c395a7810aa9b36072807cf3775a892c9b8/408\", \"angle_unittests\": \"a11f7e77670bd1aa8a9d04f9406f30dc900f3e36fc399f64e1ac3e14311cbb86/408\", \"aura_unittests\": \"4006f0582c446eb6614fde773b89cbabad577ce0bbdbc0d9359ba132c6a4955e/408\", \"base_unittests\": \"9dcdc28981b0fe3bfd661929185938243047432a79424cf2964c07d8c08ba59e/565\", \"base_util_unittests\": \"9deb74dbd84f0b9c42833bcb6ca5f01ee47c04edc95e85d241d445d8367899a1/408\", \"blink_common_unittests\": \"9b445723880cb7a583c758d9db2b927574a85f04cecbc4d94c7566b243491acd/485\", \"blink_heap_unittests\": \"bc8378de0cec0685f2ffbddc64c3cfd587994713a9e97f1220d3e2afa3307b8e/408\", \"blink_platform_unittests\": \"b3051f7a103edd6f59a3bc45bf168dcc3ab855b56d0a50c7da1224c8985f14aa/485\", \"blink_unittests\": \"df812313755acd5d342d044b7ade4c30702b6a16883d361aff381d0667e2fd0b/564\", \"blink_web_tests\": \"a4629d05732e3fe80f997bb7dfd774757cacf8c82eeb4bb2a5f16363adf8d224/485\", \"boringssl_crypto_tests\": \"024e811a7627b3c3343bfaa438b35eaad7e514fb62761532c13046ec87fa6c69/408\", \"boringssl_ssl_tests\": \"234177af12e0bff251919acb4053ef9a1bd2f55bfa5a3d2e9ae807feac553030/408\", \"capture_unittests\": \"fad198f43ebfd56942b20613b331ff2c6a6c796cdf5724410c3ff99271db3838/487\", \"cast_runner_browsertests\": \"aef326b11891257f8ee6375eb741c531660f777b0178b7495cdf02c216c29e3c/651\", \"cast_runner_integration_tests\": \"d2c017b949ebfb276229e97a3af0294a51fe11632170502add5fca5606b35b49/650\", \"cast_runner_unittests\": \"5c9b2e0d7e08d53992a8d32ca127401ce6aebc1dfe3e2021d323cb509048ea51/650\", \"cc_unittests\": \"ee9e103ba64b24f98d38bba21b9b330afd694f574ee7372617864ab5b9bd6c17/492\", \"components_unittests\": \"645ef0fa814ad4167ac4ee69a1aa014856f13a12fe788a13be0b42c21af3118c/651\", \"compositor_unittests\": \"aec9ced9aaf5dfa609705c426358e008bf37c322b63683c6972fb82d90b193fd/484\", \"content_unittests\": \"4b776a9a95f03b2fca8639df346871d39ca9dfb0c987821d7a7d97db3bd76773/645\", \"cr_fuchsia_base_unittests\": \"2dfcc67b6a037a24d84f4be201394f270581ccffd65716c04f3f6b41a9f59f87/485\", \"cronet_tests\": \"2501a0588f69260cd045c15698eb3a213335609277361493c2830b32d864e2f3/569\", \"cronet_unittests\": \"fd676af35b3266b9c9cbb347bab511db906230393526cdf04b9b9fbbd920a42d/485\", \"crypto_unittests\": \"2c5d3c974ac5a2204d5ec3d46f86143a2a51aa3a3087eb9b48e7a28051b5e088/408\", \"display_unittests\": \"0df70a4715e47a12c7c930713c5d99d0a2d2938c28bc490f503a26353be499cb/408\", \"events_unittests\": \"39e12110c7d982ddf5602e146424d04f67b14262f554c309b2d6ee419961df92/408\", \"fuchsia_telemetry_gpu_integration_test\": \"482a9b05c20fd65a0f9128619428ae0fa496ccd59f4a630ef507da298245ef2f/814\", \"gfx_unittests\": \"27c5e86f4eaddf70e814d703e4a813faf4a0ce1b08e63fa830d5c9cd63357a8b/484\", \"gin_unittests\": \"1dcfdc128885132f4b0daf9d4b148372b57cd080920ee4ea9331477b6b316446/485\", \"google_apis_unittests\": \"3d883bc4000056f94ef815b923affe3132035f0abdf4acb205c82b704c2e0fdb/570\", \"gpu_unittests\": \"b39838a795c61e6e5580e63d44d5eb74d310db83563bee63615e0bfd71f09572/485\", \"headless_browsertests\": \"1054d6b86cedcec78034d5b611de5a313f9b8bee5e4d89b31025cd0b46e9293c/568\", \"headless_unittests\": \"245ca6a5b4b970123edb6acbc013f310c96630e46d062c501677479faca65c0e/408\", \"http_service_tests\": \"265efe813dc44be5600ca1455252c5fd984f06bce671a3c457c6214b7b02ae03/566\", \"ipc_tests\": \"4423193ba202a75dce80eb3d7d91a108e1d7002889d17bc14faf550801ca5ccc/408\", \"latency_unittests\": \"d2655f31d3b42b629e606f2c70fd99b43a3efd932c96352dbe0546d776a727e8/408\", \"media_blink_unittests\": \"f5f1254c83a1460a54f9c13e366fb36df574b60944df1822a49862f9c402ff42/564\", \"media_unittests\": \"0b3fdefd7ffd9503e78f7817a2be9bf1b4797097b33e956ab3078401a4f4b2b4/488\", \"mojo_unittests\": \"6e865d9e3b0c991b2646d7902e915ba1ec8854f003b206e126f7e1c4593b9cd6/486\", \"native_theme_unittests\": \"944623f1b882de06d37fda354a570ed6bdbe9da5888fdbed3c7abbcaac7655ea/408\", \"net_unittests\": \"b2272031769aadf2bc64d078831fdef3a1cb674f72358aefeebed3a5b5ef7a83/486\", \"perfetto_unittests\": \"9ae2b3e3e5c8ffeaaaf761f2ef916009e2667826c0720cf06499c4cd0faf0de5/408\", \"service_manager_unittests\": \"3d668a9f293e15c74a9771e9829914ce43261143ad1c6cf16eea7325b5dd89f8/408\", \"services_unittests\": \"c9abe3dedfc74d478d3c24087206c2b548930c7bae24067e0fe4d564aa9f25a6/653\", \"shell_dialogs_unittests\": \"65c16637388963c024802d7e2b4b55ad7da42bd38b083ec570d5b87c40058442/408\", \"skia_unittests\": \"3d595f237660dbb6f7bd64d841dbf0cd82ae1c31b7cfd577379ab373162c5beb/408\", \"snapshot_unittests\": \"bf28027ca34e92d2931baa73aa76f427611e15019c9e4e376045bed5be7f1827/408\", \"sql_unittests\": \"8ac6ea67b8b25b0a81353a3c888ec83ae0141436ab50df8c371620f7b034aa42/485\", \"storage_unittests\": \"a2ad92faad1d0a165e86a7567ae2d876efbc5dee13cdadc3c900e7edea0058b0/485\", \"ui_base_unittests\": \"d3b4e3255bfd5b30e599641e7712aedd4dc32ab36f0d3a6948b64a61261a29f8/561\", \"url_unittests\": \"03d2d93eb51ed9824043815f26cc6eb91433363c9ed1d3dd2f340bd259161d70/408\", \"viz_unittests\": \"25122d80a3d61f29f55011c8ab9f6d09e56a690fc6d2fbf8bdcc3b99ccbeba49/492\", \"web_engine_browsertests\": \"dde63a3bc317c37a7f6966302e4bbb216013e6ef4483317fedf1fd8f6a3e4f99/566\", \"web_engine_integration_tests\": \"2673539f7b9049170f441f67ef1fdddc636214bd9530873886aaf8e938907a46/566\", \"web_engine_unittests\": \"78fc508e8d29499c7d153b063c98a0a3fbc2ddb717d187aa76e049b6e0e6ee48/485\", \"web_runner_integration_tests\": \"71255e73f9f11f56e7dd102c68a062c5339c028aca0124dc6676146c468400ce/485\", \"wtf_unittests\": \"55903c6c712a886f10a5cde51e160d45c80cdbe17f8e751b9296e4f88191cfe2/408\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_17d4e9c3562fe440e7ef7dabcb522d5a89809ef05519650a163dd2bc405c0258_v2\", \"builder_39819929c28edbb94cfd890831720319bcf41d58e7ee63cb8a54e18e1fdfd830_v2\", \"builder_80447164fd9128f57b299ad64704e89447e5656f4886183701c68086f26508e5_v2\", \"builder_dcfcb66b8d57b27a65bec4794b95b0b7d35e8289f8160d11b4e7f1c01ad595f0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-32-14-33iv\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2\", \"2.7\", \"2.7.12\"], \"server_version\": [\"5776-cb9e157\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}, \"ui\": {\"info\": \"2 Test Suite(s) failed.\\n\\n**components_unittests** failed because of:\\n\\n- BookmarkSpecificsConversionsTest.ShouldLoadFaviconWhenCreatingSpecificsFromBookmarkNode\\n\\n- SimpleSchemaValidatingPolicyHandlerTest.CheckAndGetValue\\n\\n- PaymentRequestSpecTest.RetryWithPayerErrors\\n\\n- BookmarkModelTest.RemoveURL\\n\\n- ...2384 more failure(s) (2388 total)...\\n\\n**blink_web_tests** failed:\\n\\n\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1616274089641641",
"status": "COMPLETED",
"status_changed_ts": "1616274089964826",
"tags": [
"build_address:luci.chromium.ci/ToTFuchsia x64/229",
"builder:ToTFuchsia x64",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dc78737f0f8beec9d14379127b9637b02b465147",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017637646539648864",
"scheduler_job_id:chromium/ToTFuchsia x64",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852207584503436976/+/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:526a41bddeb32510",
"user_agent:luci-scheduler"
],
"updated_ts": "1616299366151651",
"url": "https://ci.chromium.org/b/8852207584503436976",
"utcnow_ts": "1616299366671561"
}
}
[04:02:46.680] Invocation finished in 7h2m42.635181157s with status FAILED