[21:00:58.627] New invocation is queued and will start shortly
[21:00:59.861] Starting the invocation (attempt 1)
[21:00:59.897] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:00:59.897] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:00:59.897] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030955343384864496",
"parameters_json": "{\"builder_name\":\"Linux CFI\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b2d0ff257fa16a1b5df8be1da2fe395653a64983\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux CFI",
"scheduler_invocation_id:9030955343384864496",
"scheduler_job_id:chromium/Linux CFI",
"user_agent:luci-scheduler",
"buildset:commit/git/b2d0ff257fa16a1b5df8be1da2fe395653a64983",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b2d0ff257fa16a1b5df8be1da2fe395653a64983",
"gitiles_ref:refs/heads/master"
]
}
[21:01:00.825] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603573259995977",
"id": "8865525281286149808",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b2d0ff257fa16a1b5df8be1da2fe395653a64983\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603573260544117",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/18755",
"builder:Linux CFI",
"buildset:commit/git/b2d0ff257fa16a1b5df8be1da2fe395653a64983",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b2d0ff257fa16a1b5df8be1da2fe395653a64983",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030955343384864496",
"scheduler_job_id:chromium/Linux CFI",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8865525281286149808/+/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": "1603573260544256",
"url": "https://ci.chromium.org/b/8865525281286149808",
"utcnow_ts": "1603573260741111"
}
}
[21:01:00.825] Task URL: https://ci.chromium.org/b/8865525281286149808
[21:01:00.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:2:0) after 1m0s
[21:01:02.951] Received PubSub notification, asking Buildbucket for the build status
[21:01:03.250] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:01.757] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:2:0)
[21:02:01.757] Timer tick, asking Buildbucket for the build status
[21:02:01.962] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:01.962] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:4:0) after 1m0s
[21:03:02.302] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:4:0)
[21:03:02.302] Timer tick, asking Buildbucket for the build status
[21:03:02.416] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:02.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:5:0) after 1m0s
[21:04:02.571] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:5:0)
[21:04:02.571] Timer tick, asking Buildbucket for the build status
[21:04:02.700] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:02.700] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:6:0) after 1m0s
[21:05:03.147] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:6:0)
[21:05:03.147] Timer tick, asking Buildbucket for the build status
[21:05:03.519] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:03.519] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:7:0) after 1m0s
[21:06:03.562] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:7:0)
[21:06:03.562] Timer tick, asking Buildbucket for the build status
[21:06:03.971] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:03.971] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:8:0) after 1m0s
[21:07:04.058] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:8:0)
[21:07:04.058] Timer tick, asking Buildbucket for the build status
[21:07:04.114] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:04.114] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:9:0) after 1m0s
[21:08:04.136] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:9:0)
[21:08:04.136] Timer tick, asking Buildbucket for the build status
[21:08:04.210] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:04.210] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:10:0) after 1m0s
[21:09:04.331] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:10:0)
[21:09:04.331] Timer tick, asking Buildbucket for the build status
[21:09:04.388] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:04.388] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:11:0) after 1m0s
[21:10:04.501] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:11:0)
[21:10:04.501] Timer tick, asking Buildbucket for the build status
[21:10:04.657] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:04.657] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:12:0) after 1m0s
[21:11:04.771] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:12:0)
[21:11:04.771] Timer tick, asking Buildbucket for the build status
[21:11:04.870] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:04.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:13:0) after 1m0s
[21:12:05.047] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:13:0)
[21:12:05.047] Timer tick, asking Buildbucket for the build status
[21:12:05.225] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:05.225] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:14:0) after 1m0s
[21:13:05.319] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:14:0)
[21:13:05.319] Timer tick, asking Buildbucket for the build status
[21:13:05.381] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:05.381] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:15:0) after 1m0s
[21:14:05.461] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:15:0)
[21:14:05.461] Timer tick, asking Buildbucket for the build status
[21:14:05.519] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:05.519] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:16:0) after 1m0s
[21:15:05.625] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:16:0)
[21:15:05.625] Timer tick, asking Buildbucket for the build status
[21:15:05.687] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:05.687] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:17:0) after 1m0s
[21:16:05.748] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:17:0)
[21:16:05.749] Timer tick, asking Buildbucket for the build status
[21:16:06.072] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:06.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:18:0) after 1m0s
[21:17:06.120] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:18:0)
[21:17:06.120] Timer tick, asking Buildbucket for the build status
[21:17:06.185] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:06.185] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:19:0) after 1m0s
[21:18:06.334] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:19:0)
[21:18:06.334] Timer tick, asking Buildbucket for the build status
[21:18:06.398] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:06.398] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:20:0) after 1m0s
[21:19:06.534] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:20:0)
[21:19:06.534] Timer tick, asking Buildbucket for the build status
[21:19:06.627] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:06.627] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:21:0) after 1m0s
[21:20:06.721] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:21:0)
[21:20:06.721] Timer tick, asking Buildbucket for the build status
[21:20:06.795] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:06.795] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:22:0) after 1m0s
[21:21:07.042] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:22:0)
[21:21:07.042] Timer tick, asking Buildbucket for the build status
[21:21:07.153] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:07.153] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:23:0) after 1m0s
[21:22:07.314] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:23:0)
[21:22:07.314] Timer tick, asking Buildbucket for the build status
[21:22:07.691] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:07.691] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:24:0) after 1m0s
[21:23:07.800] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:24:0)
[21:23:07.800] Timer tick, asking Buildbucket for the build status
[21:23:08.446] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:08.446] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:25:0) after 1m0s
[21:24:08.585] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:25:0)
[21:24:08.585] Timer tick, asking Buildbucket for the build status
[21:24:08.653] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:08.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:26:0) after 1m0s
[21:25:08.747] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:26:0)
[21:25:08.747] Timer tick, asking Buildbucket for the build status
[21:25:08.818] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:08.818] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:27:0) after 1m0s
[21:26:08.912] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:27:0)
[21:26:08.912] Timer tick, asking Buildbucket for the build status
[21:26:09.042] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:09.042] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:28:0) after 1m0s
[21:27:09.065] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:28:0)
[21:27:09.065] Timer tick, asking Buildbucket for the build status
[21:27:09.237] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:09.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:29:0) after 1m0s
[21:28:09.248] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:29:0)
[21:28:09.248] Timer tick, asking Buildbucket for the build status
[21:28:09.437] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:09.437] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:30:0) after 1m0s
[21:29:09.492] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:30:0)
[21:29:09.492] Timer tick, asking Buildbucket for the build status
[21:29:09.569] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:09.569] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:31:0) after 1m0s
[21:30:09.761] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:31:0)
[21:30:09.761] Timer tick, asking Buildbucket for the build status
[21:30:10.026] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:10.026] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:32:0) after 1m0s
[21:31:10.043] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:32:0)
[21:31:10.043] Timer tick, asking Buildbucket for the build status
[21:31:10.163] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:10.163] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:33:0) after 1m0s
[21:32:10.215] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:33:0)
[21:32:10.215] Timer tick, asking Buildbucket for the build status
[21:32:10.310] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:10.310] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:34:0) after 1m0s
[21:33:10.341] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:34:0)
[21:33:10.341] Timer tick, asking Buildbucket for the build status
[21:33:10.426] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:10.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:35:0) after 1m0s
[21:34:10.583] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:35:0)
[21:34:10.583] Timer tick, asking Buildbucket for the build status
[21:34:10.738] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:10.738] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:36:0) after 1m0s
[21:35:10.785] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:36:0)
[21:35:10.785] Timer tick, asking Buildbucket for the build status
[21:35:10.846] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:10.846] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:37:0) after 1m0s
[21:36:10.935] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:37:0)
[21:36:10.935] Timer tick, asking Buildbucket for the build status
[21:36:11.143] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:11.143] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:38:0) after 1m0s
[21:37:11.138] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:38:0)
[21:37:11.138] Timer tick, asking Buildbucket for the build status
[21:37:11.205] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:11.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:39:0) after 1m0s
[21:38:12.069] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:39:0)
[21:38:12.069] Timer tick, asking Buildbucket for the build status
[21:38:12.162] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:12.162] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:40:0) after 1m0s
[21:39:12.399] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:40:0)
[21:39:12.399] Timer tick, asking Buildbucket for the build status
[21:39:12.507] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:12.507] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:41:0) after 1m0s
[21:40:12.638] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:41:0)
[21:40:12.638] Timer tick, asking Buildbucket for the build status
[21:40:12.766] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:12.766] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:42:0) after 1m0s
[21:41:12.864] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:42:0)
[21:41:12.864] Timer tick, asking Buildbucket for the build status
[21:41:13.290] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:13.290] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:43:0) after 1m0s
[21:42:13.456] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:43:0)
[21:42:13.456] Timer tick, asking Buildbucket for the build status
[21:42:13.603] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:13.603] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:44:0) after 1m0s
[21:43:13.655] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:44:0)
[21:43:13.655] Timer tick, asking Buildbucket for the build status
[21:43:13.730] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:13.730] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:45:0) after 1m0s
[21:44:13.968] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:45:0)
[21:44:13.968] Timer tick, asking Buildbucket for the build status
[21:44:14.132] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:14.132] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:46:0) after 1m0s
[21:45:14.277] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:46:0)
[21:45:14.277] Timer tick, asking Buildbucket for the build status
[21:45:14.419] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:14.419] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:47:0) after 1m0s
[21:46:15.079] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:47:0)
[21:46:15.079] Timer tick, asking Buildbucket for the build status
[21:46:15.212] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:15.212] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:48:0) after 1m0s
[21:47:15.465] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:48:0)
[21:47:15.465] Timer tick, asking Buildbucket for the build status
[21:47:15.530] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:15.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:49:0) after 1m0s
[21:48:15.929] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:49:0)
[21:48:15.929] Timer tick, asking Buildbucket for the build status
[21:48:16.146] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:16.146] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:50:0) after 1m0s
[21:49:16.327] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:50:0)
[21:49:16.327] Timer tick, asking Buildbucket for the build status
[21:49:16.384] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:16.384] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:51:0) after 1m0s
[21:50:16.556] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:51:0)
[21:50:16.556] Timer tick, asking Buildbucket for the build status
[21:50:16.647] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:16.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:52:0) after 1m0s
[21:51:17.035] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:52:0)
[21:51:17.035] Timer tick, asking Buildbucket for the build status
[21:51:17.289] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:17.289] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:53:0) after 1m0s
[21:52:17.307] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:53:0)
[21:52:17.307] Timer tick, asking Buildbucket for the build status
[21:52:17.547] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:17.547] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:54:0) after 1m0s
[21:53:17.580] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:54:0)
[21:53:17.580] Timer tick, asking Buildbucket for the build status
[21:53:17.648] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:17.648] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:55:0) after 1m0s
[21:54:17.655] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:55:0)
[21:54:17.655] Timer tick, asking Buildbucket for the build status
[21:54:17.733] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:17.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:56:0) after 1m0s
[21:55:17.756] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:56:0)
[21:55:17.756] Timer tick, asking Buildbucket for the build status
[21:55:17.821] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:17.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:57:0) after 1m0s
[21:56:17.846] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:57:0)
[21:56:17.846] Timer tick, asking Buildbucket for the build status
[21:56:17.976] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:17.976] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:58:0) after 1m0s
[21:57:17.994] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:58:0)
[21:57:17.994] Timer tick, asking Buildbucket for the build status
[21:57:19.077] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:19.077] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:59:0) after 1m0s
[21:58:19.121] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:59:0)
[21:58:19.121] Timer tick, asking Buildbucket for the build status
[21:58:19.398] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:19.398] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:60:0) after 1m0s
[21:59:19.509] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:60:0)
[21:59:19.509] Timer tick, asking Buildbucket for the build status
[21:59:19.593] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:19.593] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:61:0) after 1m0s
[22:00:19.830] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:61:0)
[22:00:19.830] Timer tick, asking Buildbucket for the build status
[22:00:19.908] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:19.908] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:62:0) after 1m0s
[22:01:20.058] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:62:0)
[22:01:20.058] Timer tick, asking Buildbucket for the build status
[22:01:20.384] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:20.384] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:63:0) after 1m0s
[22:02:20.356] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:63:0)
[22:02:20.356] Timer tick, asking Buildbucket for the build status
[22:02:20.417] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:20.417] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:64:0) after 1m0s
[22:03:20.588] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:64:0)
[22:03:20.588] Timer tick, asking Buildbucket for the build status
[22:03:20.840] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:20.840] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:65:0) after 1m0s
[22:04:20.959] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:65:0)
[22:04:20.959] Timer tick, asking Buildbucket for the build status
[22:04:21.046] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:21.046] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:66:0) after 1m0s
[22:05:21.223] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:66:0)
[22:05:21.223] Timer tick, asking Buildbucket for the build status
[22:05:21.298] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:21.298] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:67:0) after 1m0s
[22:06:21.423] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:67:0)
[22:06:21.423] Timer tick, asking Buildbucket for the build status
[22:06:21.531] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:21.531] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:68:0) after 1m0s
[22:07:21.624] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:68:0)
[22:07:21.624] Timer tick, asking Buildbucket for the build status
[22:07:21.821] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:21.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:69:0) after 1m0s
[22:08:21.857] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:69:0)
[22:08:21.857] Timer tick, asking Buildbucket for the build status
[22:08:21.939] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:21.939] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:70:0) after 1m0s
[22:09:22.128] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:70:0)
[22:09:22.128] Timer tick, asking Buildbucket for the build status
[22:09:22.301] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:22.301] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:71:0) after 1m0s
[22:10:22.357] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:71:0)
[22:10:22.357] Timer tick, asking Buildbucket for the build status
[22:10:22.565] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:22.565] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:72:0) after 1m0s
[22:11:22.742] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:72:0)
[22:11:22.742] Timer tick, asking Buildbucket for the build status
[22:11:22.835] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:22.835] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:73:0) after 1m0s
[22:12:22.921] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:73:0)
[22:12:22.921] Timer tick, asking Buildbucket for the build status
[22:12:23.038] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:23.038] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:74:0) after 1m0s
[22:13:23.064] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:74:0)
[22:13:23.064] Timer tick, asking Buildbucket for the build status
[22:13:23.421] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:23.421] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:75:0) after 1m0s
[22:14:23.482] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:75:0)
[22:14:23.482] Timer tick, asking Buildbucket for the build status
[22:14:23.536] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:23.536] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:76:0) after 1m0s
[22:15:23.591] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:76:0)
[22:15:23.591] Timer tick, asking Buildbucket for the build status
[22:15:23.655] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:23.655] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:77:0) after 1m0s
[22:16:23.772] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:77:0)
[22:16:23.772] Timer tick, asking Buildbucket for the build status
[22:16:23.877] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:23.877] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:78:0) after 1m0s
[22:17:23.899] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:78:0)
[22:17:23.899] Timer tick, asking Buildbucket for the build status
[22:17:23.957] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:23.957] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:79:0) after 1m0s
[22:18:24.031] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:79:0)
[22:18:24.031] Timer tick, asking Buildbucket for the build status
[22:18:24.149] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:24.149] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:80:0) after 1m0s
[22:19:24.205] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:80:0)
[22:19:24.205] Timer tick, asking Buildbucket for the build status
[22:19:24.488] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:24.488] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:81:0) after 1m0s
[22:20:24.493] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:81:0)
[22:20:24.493] Timer tick, asking Buildbucket for the build status
[22:20:24.564] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:24.564] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:82:0) after 1m0s
[22:21:26.599] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:82:0)
[22:21:26.599] Timer tick, asking Buildbucket for the build status
[22:21:26.693] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:26.693] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:83:0) after 1m0s
[22:22:26.720] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:83:0)
[22:22:26.720] Timer tick, asking Buildbucket for the build status
[22:22:26.798] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:26.798] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:84:0) after 1m0s
[22:23:26.809] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:84:0)
[22:23:26.809] Timer tick, asking Buildbucket for the build status
[22:23:26.865] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:26.865] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:85:0) after 1m0s
[22:24:26.887] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:85:0)
[22:24:26.887] Timer tick, asking Buildbucket for the build status
[22:24:27.086] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:27.086] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:86:0) after 1m0s
[22:25:27.123] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:86:0)
[22:25:27.123] Timer tick, asking Buildbucket for the build status
[22:25:27.179] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:27.179] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:87:0) after 1m0s
[22:26:27.182] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:87:0)
[22:26:27.182] Timer tick, asking Buildbucket for the build status
[22:26:27.294] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:27.294] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:88:0) after 1m0s
[22:27:27.365] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:88:0)
[22:27:27.365] Timer tick, asking Buildbucket for the build status
[22:27:27.462] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:27.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:89:0) after 1m0s
[22:28:27.511] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:89:0)
[22:28:27.511] Timer tick, asking Buildbucket for the build status
[22:28:27.575] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:27.575] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:90:0) after 1m0s
[22:29:27.640] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:90:0)
[22:29:27.640] Timer tick, asking Buildbucket for the build status
[22:29:27.757] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:27.757] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:91:0) after 1m0s
[22:30:27.845] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:91:0)
[22:30:27.845] Timer tick, asking Buildbucket for the build status
[22:30:28.225] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:28.225] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:92:0) after 1m0s
[22:31:28.254] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:92:0)
[22:31:28.254] Timer tick, asking Buildbucket for the build status
[22:31:28.705] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:28.705] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:93:0) after 1m0s
[22:32:28.759] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:93:0)
[22:32:28.759] Timer tick, asking Buildbucket for the build status
[22:32:29.297] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:29.297] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:94:0) after 1m0s
[22:33:29.325] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:94:0)
[22:33:29.325] Timer tick, asking Buildbucket for the build status
[22:33:29.462] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:29.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:95:0) after 1m0s
[22:34:29.463] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:95:0)
[22:34:29.463] Timer tick, asking Buildbucket for the build status
[22:34:29.613] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:29.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:96:0) after 1m0s
[22:35:29.633] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:96:0)
[22:35:29.633] Timer tick, asking Buildbucket for the build status
[22:35:30.223] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:30.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:97:0) after 1m0s
[22:36:30.279] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:97:0)
[22:36:30.279] Timer tick, asking Buildbucket for the build status
[22:36:30.697] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:30.697] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:98:0) after 1m0s
[22:37:30.751] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:98:0)
[22:37:30.751] Timer tick, asking Buildbucket for the build status
[22:37:31.610] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:31.610] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:99:0) after 1m0s
[22:38:31.634] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:99:0)
[22:38:31.634] Timer tick, asking Buildbucket for the build status
[22:38:31.744] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:31.744] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:100:0) after 1m0s
[22:39:31.799] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:100:0)
[22:39:31.799] Timer tick, asking Buildbucket for the build status
[22:39:31.944] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:31.944] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:101:0) after 1m0s
[22:40:32.017] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:101:0)
[22:40:32.017] Timer tick, asking Buildbucket for the build status
[22:40:32.197] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:32.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:102:0) after 1m0s
[22:41:32.267] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:102:0)
[22:41:32.267] Timer tick, asking Buildbucket for the build status
[22:41:32.379] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:32.379] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:103:0) after 1m0s
[22:42:32.408] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:103:0)
[22:42:32.408] Timer tick, asking Buildbucket for the build status
[22:42:32.515] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:32.515] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:104:0) after 1m0s
[22:43:32.570] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:104:0)
[22:43:32.570] Timer tick, asking Buildbucket for the build status
[22:43:33.005] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:33.005] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:105:0) after 1m0s
[22:44:33.054] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:105:0)
[22:44:33.054] Timer tick, asking Buildbucket for the build status
[22:44:33.173] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:33.173] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:106:0) after 1m0s
[22:45:33.304] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:106:0)
[22:45:33.304] Timer tick, asking Buildbucket for the build status
[22:45:33.528] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:33.528] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:107:0) after 1m0s
[22:46:33.649] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:107:0)
[22:46:33.649] Timer tick, asking Buildbucket for the build status
[22:46:34.001] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:34.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:108:0) after 1m0s
[22:47:34.128] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:108:0)
[22:47:34.128] Timer tick, asking Buildbucket for the build status
[22:47:34.193] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:34.193] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:109:0) after 1m0s
[22:48:34.259] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:109:0)
[22:48:34.259] Timer tick, asking Buildbucket for the build status
[22:48:35.118] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:35.118] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:110:0) after 1m0s
[22:49:35.144] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:110:0)
[22:49:35.144] Timer tick, asking Buildbucket for the build status
[22:49:35.238] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:35.238] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:111:0) after 1m0s
[22:50:35.260] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:111:0)
[22:50:35.260] Timer tick, asking Buildbucket for the build status
[22:50:35.344] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:35.344] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:112:0) after 1m0s
[22:51:35.575] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:112:0)
[22:51:35.575] Timer tick, asking Buildbucket for the build status
[22:51:36.008] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:36.008] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:113:0) after 1m0s
[22:52:36.031] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:113:0)
[22:52:36.031] Timer tick, asking Buildbucket for the build status
[22:52:36.168] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:36.168] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:114:0) after 1m0s
[22:53:36.191] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:114:0)
[22:53:36.191] Timer tick, asking Buildbucket for the build status
[22:53:36.278] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:36.279] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:115:0) after 1m0s
[22:54:36.302] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:115:0)
[22:54:36.302] Timer tick, asking Buildbucket for the build status
[22:54:36.372] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:36.372] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:116:0) after 1m0s
[22:55:36.396] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:116:0)
[22:55:36.396] Timer tick, asking Buildbucket for the build status
[22:55:36.460] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:36.460] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:117:0) after 1m0s
[22:56:36.512] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:117:0)
[22:56:36.512] Timer tick, asking Buildbucket for the build status
[22:56:36.803] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:36.803] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:118:0) after 1m0s
[22:57:36.828] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:118:0)
[22:57:36.828] Timer tick, asking Buildbucket for the build status
[22:57:37.722] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:37.722] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:119:0) after 1m0s
[22:58:37.733] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:119:0)
[22:58:37.733] Timer tick, asking Buildbucket for the build status
[22:58:37.861] Build 8865525281286149808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:37.861] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030955343384864496:120:0) after 1m0s
[22:59:17.118] Received PubSub notification, asking Buildbucket for the build status
[22:59:17.190] Build 8865525281286149808: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:59:17.190] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603580356194661",
"created_by": "project:chromium",
"created_ts": "1603573259995977",
"id": "8865525281286149808",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b2d0ff257fa16a1b5df8be1da2fe395653a64983\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"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\": \"b2d0ff257fa16a1b5df8be1da2fe395653a64983\", \"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-19-8law\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"Linux CFI\", \"buildnumber\": 18755, \"got_angle_revision\": \"7a0263547cda936b320d80c650b69d7522ee1a9f\", \"got_dawn_revision\": \"42103bc2e911144745d8d8930b07ba7e58553a34\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"b2d0ff257fa16a1b5df8be1da2fe395653a64983\", \"got_revision_cp\": \"refs/heads/master@{#820586}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"73fe59b55662be0ff07e79da1ece8b9e42415dca\", \"got_v8_revision_cp\": \"refs/heads/8.8.171@{#1}\", \"got_webrtc_revision\": \"3065e6ef3016a906d1db82e1d4322cbd53d43247\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32481}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b2d0ff257fa16a1b5df8be1da2fe395653a64983\", \"swarm_hashes_refs/heads/master(at){#820586}_without_patch\": {\"absl_hardening_tests\": \"64f62512e9f03cbf530bff5711b084547b2ef664\", \"accessibility_unittests\": \"3739945aa5d8bcfcbd0b29739c55080409f2ce3f\", \"angle_unittests\": \"a1749d9f60c0db4381604a60b18caf14ec8ac235\", \"app_shell_unittests\": \"5aeaab0f84ea5fd1c471e756c3db72cd4623c40a\", \"aura_unittests\": \"18a4c8a77864a3a0c97cc896af17388cbd5106e0\", \"base_unittests\": \"6c4ed79285daf6081f34b2f9bb7e635e41abf453\", \"base_util_unittests\": \"bd7ba5f422993e3378e5f50327aef1d8f9db4923\", \"blink_common_unittests\": \"a6c2f0055abd616553130179ca456139412e9049\", \"blink_fuzzer_unittests\": \"d57eb4db31814d594bf90d1e9fd51d10d0c6196e\", \"blink_heap_unittests\": \"fc7b4b1939866ba961318d42eb36ed916ef6c016\", \"blink_platform_unittests\": \"253b58230c34c35d8b91833cde0df79dbcf138c4\", \"blink_unittests\": \"f1eefbdbd0b8e015062cabdec89aebd536c1ebb5\", \"boringssl_crypto_tests\": \"e149e781e9928a29b4dd9583f17cfba686900c7b\", \"boringssl_ssl_tests\": \"67e991e557e4bcf147544aa74198c7c6c19a1c54\", \"browser_tests\": \"675b5f350070156eabeb9748a484a784b513bbfa\", \"capture_unittests\": \"c65a1e95a130051627305b7996906eee72a91638\", \"cast_unittests\": \"ae27d0c76df19edfe7c7621686230f7cee08b67e\", \"cc_unittests\": \"b32ea1bb7212ebc012d9a9aa2fee189d2d4fa836\", \"chrome_app_unittests\": \"f001be097d2cc76f316013e73a072ca7a9c35568\", \"chromedriver_unittests\": \"c28e0873e354f6b11aa3caf02cf9b4181418e04c\", \"components_browsertests\": \"17670f0c5b2ea686fb25b992fe389356dc0d4329\", \"components_unittests\": \"01972054e7e81419163d3cf7c30b10790fad1b9f\", \"compositor_unittests\": \"168e6d8f3a970208d6e5b5b09250910ac71c6617\", \"content_browsertests\": \"5c6aa95c3f79a7d6d3ee2984ec666c08f689588f\", \"content_unittests\": \"81fdd80fd09afe1895330a48be736c75edfa7ace\", \"cronet_tests\": \"34a7f5aa0b198b79c0432388d7b4778143136dc8\", \"cronet_unittests\": \"41d9ae9b8fc4583f20412912b8a04e1a410e3533\", \"crypto_unittests\": \"1fa4a8923d25457a5b0e23a99d4d2bede6a7ceba\", \"dbus_unittests\": \"0182c7b13835f4cce4225d6092d3350a1308b816\", \"device_unittests\": \"09ed4caa769a4d8e41959813260f74875e7112a9\", \"display_unittests\": \"fe60f68ce7141d28f72f1485b74fd438a096b809\", \"events_unittests\": \"8ef9b84a71101b4167b482a24d690dfdc2136133\", \"extensions_browsertests\": \"27e92ea8de8c622f2feeba037f4f60d940c6d748\", \"extensions_unittests\": \"da823d0c2e894c68bd1072a488c81dd64d64d458\", \"filesystem_service_unittests\": \"8f90508c7671967fb2c394c6b7a087cf2034f255\", \"gcm_unit_tests\": \"02661237e30f4180db0d76b1a08430c946fd910b\", \"gfx_unittests\": \"9a03ea27f3352505c2dd33a1527c1611da49a623\", \"gin_unittests\": \"bd528d53cfacc7a2bbf1957bc96d1be081594092\", \"gl_tests\": \"93229f565da29620141945bf4d29da9bb6ba2a0b\", \"gl_unittests\": \"26e2346fb941913bfc5019f46c9922f215190a2c\", \"google_apis_unittests\": \"bf89a523537426561107118530b60128294db7bd\", \"gpu_unittests\": \"93049575d660c1e58f8d2edc9d3b17dd8e460254\", \"gwp_asan_unittests\": \"9b4c1237e71d0d3384f222e9fd8250de35a3b406\", \"headless_browsertests\": \"7973e62111da91e986feac3124d4a8b4dc5ff72c\", \"headless_unittests\": \"21c0674a6d9c9b9e8a5ee9a9800cc07a2a2fc8d1\", \"interactive_ui_tests\": \"5b3f1a542b3651096ca285a6569d81802f819577\", \"ipc_tests\": \"e608f8ef54c3593e442131bc5ca69bad2447bb80\", \"jingle_unittests\": \"15a5a0007f3cfa873f4116e1a441bb887348a332\", \"latency_unittests\": \"4f81ed8d54222d0450c20b42c42509d65cf7314f\", \"libjingle_xmpp_unittests\": \"04bc62d64e01dd731326a93760cec313311785d2\", \"media_blink_unittests\": \"e4fb62c96a401b96dbe6b9caa4b0e0c7adbd47fd\", \"media_unittests\": \"2c59499b4f69e646aee433aaa333f5366413c5c6\", \"message_center_unittests\": \"b245a5e1b74cff39707f5b886ef63828bd871d38\", \"midi_unittests\": \"0abd54edda4ebf01018e9d9c5bc061b2ad985c84\", \"mojo_core_unittests\": \"f11ade16466cc34749b7a32dbc3aca860f9a8d20\", \"mojo_unittests\": \"8a4ce008f1c628839724626945f2c5be1547d945\", \"nacl_helper_nonsfi_unittests\": \"2ee71dae2e47ae9d8a7e39a784c5186400d7319d\", \"nacl_loader_unittests\": \"dcea8fcf54aa24131ca35971cb1d75bdf20ece9a\", \"native_theme_unittests\": \"054ee7039471ff4c8835f8ad9704397c9d2a297a\", \"net_unittests\": \"653cbf6086987250af9d460b52c012a3d8f74cee\", \"pdf_unittests\": \"6195ab67ad2894d8165b7c691cddb8583b1f2d6b\", \"perfetto_unittests\": \"f52f5e9c31bddf461a7f0a9cc7119b1210c495d0\", \"ppapi_unittests\": \"95fdbe7af30626652b09c926aa9eeba7b606a7b1\", \"printing_unittests\": \"bb674dd07ad20f936fda8ac49aa1208002fca6a3\", \"remoting_unittests\": \"aaf69d541ab27ac63a78fdc64706c9bc36d5dc3c\", \"sandbox_linux_unittests\": \"7a9d081b42297dcd6d9879ba15d2147670786d1a\", \"service_manager_unittests\": \"c1057f7313344ebe7f7f50d0470aa1e07421adf0\", \"services_unittests\": \"635aad6e3025d8ec53b722464aff0ae11c1c161a\", \"shell_dialogs_unittests\": \"594f2915e137e13af5cebdf88699e26ebf789e29\", \"skia_unittests\": \"ca5c1aea2304b33ea083b8bf3f9eb9c73ba02bd5\", \"snapshot_unittests\": \"a5426969ad1fd9ab0f816f1f1da9c27f343ec97d\", \"sql_unittests\": \"6824602b65e1d34bad5d7b33da6d089fb19ad4af\", \"storage_unittests\": \"943e6db1a2997f737f258c5487106e8410230417\", \"sync_integration_tests\": \"8753dc77a48c6d818d9691f096e4d2d15c8aaab8\", \"traffic_annotation_auditor_unittests\": \"d355622da93f150e8d1c87c17afb0479b99e6519\", \"ui_base_unittests\": \"94915ef8c5d27a6893e77ed4fae33581531be1a5\", \"ui_touch_selection_unittests\": \"1b7e23a66aa7008855db2c464e6d7e37e809b9d1\", \"unit_tests\": \"fab3b909fc1f29845f8278f9d60c7134c9762863\", \"url_unittests\": \"28db030ff4a76c96a139160e87d9adabbf82591f\", \"views_unittests\": \"7197693180d30d1b061c97ab0b330a97e850dcaa\", \"viz_unittests\": \"8ab053bc042e3f533c77a9fa0424eb315eecf17d\", \"vr_common_unittests\": \"b2cbdeaabbf4adfd12884da8bafc0d424e108246\", \"vr_pixeltests\": \"e966b5ce94423c9ad00c776245facc92d42684b0\", \"wm_unittests\": \"31bec348c9521126915722dcc4312c2a6a0e21dc\", \"wtf_unittests\": \"14cc959b47235f1eea6d42d826a7e4c537c3569e\", \"zlib_unittests\": \"742eb25b54aa81e53626b9a97f5900e337217451\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4546ef179f50eb727f19fe6abd7705a7b8921ff8263e4e2e8e2644dd615ef1a7_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-19-8law\"], \"image\": [\"chrome-xenial-20101800-2d400e1627f\"], \"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.7.12\"], \"server_version\": [\"5612-26d29a7\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603573261656459",
"status": "COMPLETED",
"status_changed_ts": "1603580356550053",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/18755",
"builder:Linux CFI",
"buildset:commit/git/b2d0ff257fa16a1b5df8be1da2fe395653a64983",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b2d0ff257fa16a1b5df8be1da2fe395653a64983",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030955343384864496",
"scheduler_job_id:chromium/Linux CFI",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8865525281286149808/+/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:4f753bab64901810",
"user_agent:luci-scheduler"
],
"updated_ts": "1603580356554356",
"url": "https://ci.chromium.org/b/8865525281286149808",
"utcnow_ts": "1603580357180785"
}
}
[22:59:17.190] Invocation finished in 1h58m18.579413946s with status SUCCEEDED