[08:41:08.124] New invocation is queued and will start shortly
[08:41:09.279] Starting the invocation (attempt 1)
[08:41:09.312] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:41:09.312] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:41:09.312] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9050208447075815040",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"8e9962e102b7cb0025c5c0824257770c1d4394f0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9050208447075815040",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/8e9962e102b7cb0025c5c0824257770c1d4394f0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e9962e102b7cb0025c5c0824257770c1d4394f0",
"gitiles_ref:refs/heads/master"
]
}
[08:41:10.110] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1585212069395365",
"id": "8884778385080576576",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8e9962e102b7cb0025c5c0824257770c1d4394f0\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1585212069925188",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/27303",
"builder:Deterministic Linux",
"buildset:commit/git/8e9962e102b7cb0025c5c0824257770c1d4394f0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e9962e102b7cb0025c5c0824257770c1d4394f0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050208447075815040",
"scheduler_job_id:chromium/Deterministic Linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8884778385080576576/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1585212069925293",
"url": "https://ci.chromium.org/b/8884778385080576576",
"utcnow_ts": "1585212070096199"
}
}
[08:41:10.110] Task URL: https://ci.chromium.org/b/8884778385080576576
[08:41:10.110] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:2:0) after 1m0s
[08:41:15.334] Received PubSub notification, asking Buildbucket for the build status
[08:41:15.450] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:10.134] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:2:0)
[08:42:10.134] Timer tick, asking Buildbucket for the build status
[08:42:10.243] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:10.243] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:4:0) after 1m0s
[08:43:10.262] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:4:0)
[08:43:10.262] Timer tick, asking Buildbucket for the build status
[08:43:10.426] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:10.426] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:5:0) after 1m0s
[08:44:10.448] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:5:0)
[08:44:10.448] Timer tick, asking Buildbucket for the build status
[08:44:10.582] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:10.582] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:6:0) after 1m0s
[08:45:10.671] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:6:0)
[08:45:10.671] Timer tick, asking Buildbucket for the build status
[08:45:10.884] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:10.884] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:7:0) after 1m0s
[08:46:10.975] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:7:0)
[08:46:10.975] Timer tick, asking Buildbucket for the build status
[08:46:11.547] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:11.547] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:8:0) after 1m0s
[08:47:11.554] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:8:0)
[08:47:11.554] Timer tick, asking Buildbucket for the build status
[08:47:11.701] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:11.701] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:9:0) after 1m0s
[08:48:11.682] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:9:0)
[08:48:11.682] Timer tick, asking Buildbucket for the build status
[08:48:11.896] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:11.896] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:10:0) after 1m0s
[08:49:11.959] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:10:0)
[08:49:11.959] Timer tick, asking Buildbucket for the build status
[08:49:12.054] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:12.054] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:11:0) after 1m0s
[08:50:12.195] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:11:0)
[08:50:12.195] Timer tick, asking Buildbucket for the build status
[08:50:12.308] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:12.308] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:12:0) after 1m0s
[08:51:12.490] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:12:0)
[08:51:12.490] Timer tick, asking Buildbucket for the build status
[08:51:12.693] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:12.693] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:13:0) after 1m0s
[08:52:12.818] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:13:0)
[08:52:12.818] Timer tick, asking Buildbucket for the build status
[08:52:12.982] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:12.982] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:14:0) after 1m0s
[08:53:13.074] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:14:0)
[08:53:13.074] Timer tick, asking Buildbucket for the build status
[08:53:14.559] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:14.559] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:15:0) after 1m0s
[08:54:14.610] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:15:0)
[08:54:14.610] Timer tick, asking Buildbucket for the build status
[08:54:14.884] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:14.884] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:16:0) after 1m0s
[08:55:14.973] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:16:0)
[08:55:14.973] Timer tick, asking Buildbucket for the build status
[08:55:15.083] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:15.083] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:17:0) after 1m0s
[08:56:15.210] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:17:0)
[08:56:15.210] Timer tick, asking Buildbucket for the build status
[08:56:15.480] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:15.480] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:18:0) after 1m0s
[08:57:15.604] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:18:0)
[08:57:15.604] Timer tick, asking Buildbucket for the build status
[08:57:15.765] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:15.765] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:19:0) after 1m0s
[08:58:15.878] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:19:0)
[08:58:15.878] Timer tick, asking Buildbucket for the build status
[08:58:16.055] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:16.055] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:20:0) after 1m0s
[08:59:16.112] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:20:0)
[08:59:16.112] Timer tick, asking Buildbucket for the build status
[08:59:16.252] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:16.252] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:21:0) after 1m0s
[09:00:16.339] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:21:0)
[09:00:16.339] Timer tick, asking Buildbucket for the build status
[09:00:16.439] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:16.439] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:22:0) after 1m0s
[09:01:16.468] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:22:0)
[09:01:16.468] Timer tick, asking Buildbucket for the build status
[09:01:16.950] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:16.950] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:23:0) after 1m0s
[09:02:17.014] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:23:0)
[09:02:17.014] Timer tick, asking Buildbucket for the build status
[09:02:17.202] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:17.202] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:24:0) after 1m0s
[09:03:17.350] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:24:0)
[09:03:17.350] Timer tick, asking Buildbucket for the build status
[09:03:17.527] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:17.527] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:25:0) after 1m0s
[09:04:17.513] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:25:0)
[09:04:17.513] Timer tick, asking Buildbucket for the build status
[09:04:17.631] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:17.631] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:26:0) after 1m0s
[09:05:17.685] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:26:0)
[09:05:17.685] Timer tick, asking Buildbucket for the build status
[09:05:17.935] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:17.935] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:27:0) after 1m0s
[09:06:17.968] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:27:0)
[09:06:17.968] Timer tick, asking Buildbucket for the build status
[09:06:18.110] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:18.110] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:28:0) after 1m0s
[09:07:18.283] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:28:0)
[09:07:18.283] Timer tick, asking Buildbucket for the build status
[09:07:18.645] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:18.645] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:29:0) after 1m0s
[09:08:18.693] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:29:0)
[09:08:18.693] Timer tick, asking Buildbucket for the build status
[09:08:18.877] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:18.877] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:30:0) after 1m0s
[09:09:18.883] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:30:0)
[09:09:18.883] Timer tick, asking Buildbucket for the build status
[09:09:19.006] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:19.006] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:31:0) after 1m0s
[09:10:19.178] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:31:0)
[09:10:19.178] Timer tick, asking Buildbucket for the build status
[09:10:19.289] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:19.289] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:32:0) after 1m0s
[09:11:19.507] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:32:0)
[09:11:19.507] Timer tick, asking Buildbucket for the build status
[09:11:19.652] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:19.652] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:33:0) after 1m0s
[09:12:19.854] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:33:0)
[09:12:19.854] Timer tick, asking Buildbucket for the build status
[09:12:19.976] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:19.976] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:34:0) after 1m0s
[09:13:20.164] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:34:0)
[09:13:20.164] Timer tick, asking Buildbucket for the build status
[09:13:20.399] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:20.399] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:35:0) after 1m0s
[09:14:20.792] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:35:0)
[09:14:20.792] Timer tick, asking Buildbucket for the build status
[09:14:20.934] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:20.934] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:36:0) after 1m0s
[09:15:21.042] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:36:0)
[09:15:21.042] Timer tick, asking Buildbucket for the build status
[09:15:21.203] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:21.203] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:37:0) after 1m0s
[09:16:21.441] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:37:0)
[09:16:21.441] Timer tick, asking Buildbucket for the build status
[09:16:21.595] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:21.595] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:38:0) after 1m0s
[09:17:21.579] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:38:0)
[09:17:21.579] Timer tick, asking Buildbucket for the build status
[09:17:21.845] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:21.846] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:39:0) after 1m0s
[09:18:21.885] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:39:0)
[09:18:21.885] Timer tick, asking Buildbucket for the build status
[09:18:22.015] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:22.015] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:40:0) after 1m0s
[09:19:22.091] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:40:0)
[09:19:22.091] Timer tick, asking Buildbucket for the build status
[09:19:22.196] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:22.196] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:41:0) after 1m0s
[09:20:22.243] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:41:0)
[09:20:22.243] Timer tick, asking Buildbucket for the build status
[09:20:22.377] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:22.377] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:42:0) after 1m0s
[09:21:22.410] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:42:0)
[09:21:22.410] Timer tick, asking Buildbucket for the build status
[09:21:22.546] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:22.546] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:43:0) after 1m0s
[09:22:22.596] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:43:0)
[09:22:22.596] Timer tick, asking Buildbucket for the build status
[09:22:22.737] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:22.737] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:44:0) after 1m0s
[09:23:22.899] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:44:0)
[09:23:22.899] Timer tick, asking Buildbucket for the build status
[09:23:23.751] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:23.751] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:45:0) after 1m0s
[09:24:23.823] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:45:0)
[09:24:23.823] Timer tick, asking Buildbucket for the build status
[09:24:23.888] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:23.888] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:46:0) after 1m0s
[09:25:24.028] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:46:0)
[09:25:24.028] Timer tick, asking Buildbucket for the build status
[09:25:24.202] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:24.202] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:47:0) after 1m0s
[09:26:24.306] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:47:0)
[09:26:24.306] Timer tick, asking Buildbucket for the build status
[09:26:24.437] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:24.437] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:48:0) after 1m0s
[09:27:24.655] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:48:0)
[09:27:24.655] Timer tick, asking Buildbucket for the build status
[09:27:24.938] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:24.938] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:49:0) after 1m0s
[09:28:25.009] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:49:0)
[09:28:25.009] Timer tick, asking Buildbucket for the build status
[09:28:26.124] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:26.124] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:50:0) after 1m0s
[09:29:26.413] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:50:0)
[09:29:26.413] Timer tick, asking Buildbucket for the build status
[09:29:26.526] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:26.526] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:51:0) after 1m0s
[09:30:26.668] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:51:0)
[09:30:26.668] Timer tick, asking Buildbucket for the build status
[09:30:26.787] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:26.787] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:52:0) after 1m0s
[09:31:26.886] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:52:0)
[09:31:26.886] Timer tick, asking Buildbucket for the build status
[09:31:27.055] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:27.055] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:53:0) after 1m0s
[09:32:27.184] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:53:0)
[09:32:27.184] Timer tick, asking Buildbucket for the build status
[09:32:27.582] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:27.582] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:54:0) after 1m0s
[09:33:27.680] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:54:0)
[09:33:27.681] Timer tick, asking Buildbucket for the build status
[09:33:30.735] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:30.735] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:55:0) after 1m0s
[09:34:31.071] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:55:0)
[09:34:31.071] Timer tick, asking Buildbucket for the build status
[09:34:31.577] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:31.577] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:56:0) after 1m0s
[09:35:31.663] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:56:0)
[09:35:31.663] Timer tick, asking Buildbucket for the build status
[09:35:31.787] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:31.787] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:57:0) after 1m0s
[09:36:31.827] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:57:0)
[09:36:31.827] Timer tick, asking Buildbucket for the build status
[09:36:31.968] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:31.968] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:58:0) after 1m0s
[09:37:32.185] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:58:0)
[09:37:32.185] Timer tick, asking Buildbucket for the build status
[09:37:32.452] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:32.452] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:59:0) after 1m0s
[09:38:32.522] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:59:0)
[09:38:32.522] Timer tick, asking Buildbucket for the build status
[09:38:32.653] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:32.653] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:60:0) after 1m0s
[09:39:32.821] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:60:0)
[09:39:32.821] Timer tick, asking Buildbucket for the build status
[09:39:32.990] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:32.990] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:61:0) after 1m0s
[09:40:33.165] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:61:0)
[09:40:33.165] Timer tick, asking Buildbucket for the build status
[09:40:33.411] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:33.411] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:62:0) after 1m0s
[09:41:33.439] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:62:0)
[09:41:33.439] Timer tick, asking Buildbucket for the build status
[09:41:33.578] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:33.578] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:63:0) after 1m0s
[09:42:33.602] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:63:0)
[09:42:33.602] Timer tick, asking Buildbucket for the build status
[09:42:33.719] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:33.719] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:64:0) after 1m0s
[09:43:33.784] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:64:0)
[09:43:33.784] Timer tick, asking Buildbucket for the build status
[09:43:34.272] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:34.272] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:65:0) after 1m0s
[09:44:34.301] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:65:0)
[09:44:34.301] Timer tick, asking Buildbucket for the build status
[09:44:34.465] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:34.465] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:66:0) after 1m0s
[09:45:34.542] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:66:0)
[09:45:34.542] Timer tick, asking Buildbucket for the build status
[09:45:34.705] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:34.705] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:67:0) after 1m0s
[09:46:34.763] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:67:0)
[09:46:34.763] Timer tick, asking Buildbucket for the build status
[09:46:34.874] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:34.874] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:68:0) after 1m0s
[09:47:34.906] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:68:0)
[09:47:34.906] Timer tick, asking Buildbucket for the build status
[09:47:35.061] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:35.061] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:69:0) after 1m0s
[09:48:35.086] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:69:0)
[09:48:35.086] Timer tick, asking Buildbucket for the build status
[09:48:35.231] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:35.231] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:70:0) after 1m0s
[09:49:35.262] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:70:0)
[09:49:35.262] Timer tick, asking Buildbucket for the build status
[09:49:35.517] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:35.517] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:71:0) after 1m0s
[09:50:35.545] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:71:0)
[09:50:35.545] Timer tick, asking Buildbucket for the build status
[09:50:35.629] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:35.629] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:72:0) after 1m0s
[09:51:35.705] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:72:0)
[09:51:35.705] Timer tick, asking Buildbucket for the build status
[09:51:35.820] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:35.820] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:73:0) after 1m0s
[09:52:35.845] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:73:0)
[09:52:35.845] Timer tick, asking Buildbucket for the build status
[09:52:36.553] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:36.553] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:74:0) after 1m0s
[09:53:36.574] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:74:0)
[09:53:36.574] Timer tick, asking Buildbucket for the build status
[09:53:38.757] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:38.757] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:75:0) after 1m0s
[09:54:38.782] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:75:0)
[09:54:38.782] Timer tick, asking Buildbucket for the build status
[09:54:39.223] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:39.223] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:76:0) after 1m0s
[09:55:39.251] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:76:0)
[09:55:39.251] Timer tick, asking Buildbucket for the build status
[09:55:39.409] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:39.409] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:77:0) after 1m0s
[09:56:39.436] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:77:0)
[09:56:39.436] Timer tick, asking Buildbucket for the build status
[09:56:39.582] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:39.582] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:78:0) after 1m0s
[09:57:39.605] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:78:0)
[09:57:39.605] Timer tick, asking Buildbucket for the build status
[09:57:39.740] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:39.740] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:79:0) after 1m0s
[09:58:39.762] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:79:0)
[09:58:39.762] Timer tick, asking Buildbucket for the build status
[09:58:39.944] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:39.944] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:80:0) after 1m0s
[09:59:39.967] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:80:0)
[09:59:39.967] Timer tick, asking Buildbucket for the build status
[09:59:41.633] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:41.633] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:81:0) after 1m0s
[10:00:41.682] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:81:0)
[10:00:41.682] Timer tick, asking Buildbucket for the build status
[10:00:41.796] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:41.796] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:82:0) after 1m0s
[10:01:41.794] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:82:0)
[10:01:41.794] Timer tick, asking Buildbucket for the build status
[10:01:41.881] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:41.881] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:83:0) after 1m0s
[10:02:41.922] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:83:0)
[10:02:41.922] Timer tick, asking Buildbucket for the build status
[10:02:42.083] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:42.083] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:84:0) after 1m0s
[10:03:42.106] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:84:0)
[10:03:42.106] Timer tick, asking Buildbucket for the build status
[10:03:42.198] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:42.198] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:85:0) after 1m0s
[10:04:42.217] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:85:0)
[10:04:42.217] Timer tick, asking Buildbucket for the build status
[10:04:42.845] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:42.845] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:86:0) after 1m0s
[10:05:42.869] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:86:0)
[10:05:42.869] Timer tick, asking Buildbucket for the build status
[10:05:43.023] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:43.023] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:87:0) after 1m0s
[10:06:43.058] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:87:0)
[10:06:43.058] Timer tick, asking Buildbucket for the build status
[10:06:43.182] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:43.182] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:88:0) after 1m0s
[10:07:43.215] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:88:0)
[10:07:43.215] Timer tick, asking Buildbucket for the build status
[10:07:43.357] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:43.357] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:89:0) after 1m0s
[10:08:43.386] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:89:0)
[10:08:43.386] Timer tick, asking Buildbucket for the build status
[10:08:43.606] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:43.606] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:90:0) after 1m0s
[10:09:43.674] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:90:0)
[10:09:43.674] Timer tick, asking Buildbucket for the build status
[10:09:43.979] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:43.979] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:91:0) after 1m0s
[10:10:44.015] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:91:0)
[10:10:44.015] Timer tick, asking Buildbucket for the build status
[10:10:44.121] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:44.121] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:92:0) after 1m0s
[10:11:44.242] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:92:0)
[10:11:44.242] Timer tick, asking Buildbucket for the build status
[10:11:44.438] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:44.438] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:93:0) after 1m0s
[10:12:44.519] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:93:0)
[10:12:44.519] Timer tick, asking Buildbucket for the build status
[10:12:44.729] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:44.729] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:94:0) after 1m0s
[10:13:44.753] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:94:0)
[10:13:44.753] Timer tick, asking Buildbucket for the build status
[10:13:44.871] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:44.871] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:95:0) after 1m0s
[10:14:44.917] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:95:0)
[10:14:44.917] Timer tick, asking Buildbucket for the build status
[10:14:45.428] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:45.428] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:96:0) after 1m0s
[10:15:45.723] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:96:0)
[10:15:45.723] Timer tick, asking Buildbucket for the build status
[10:15:46.287] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:46.287] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:97:0) after 1m0s
[10:16:46.421] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:97:0)
[10:16:46.421] Timer tick, asking Buildbucket for the build status
[10:16:46.863] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:46.863] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:98:0) after 1m0s
[10:17:46.944] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:98:0)
[10:17:46.944] Timer tick, asking Buildbucket for the build status
[10:17:47.174] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:47.174] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:99:0) after 1m0s
[10:18:47.248] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:99:0)
[10:18:47.248] Timer tick, asking Buildbucket for the build status
[10:18:47.468] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:47.468] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:100:0) after 1m0s
[10:19:47.479] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:100:0)
[10:19:47.479] Timer tick, asking Buildbucket for the build status
[10:19:48.388] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:48.388] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:101:0) after 1m0s
[10:20:48.414] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:101:0)
[10:20:48.414] Timer tick, asking Buildbucket for the build status
[10:20:48.772] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:48.772] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:102:0) after 1m0s
[10:21:48.862] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:102:0)
[10:21:48.862] Timer tick, asking Buildbucket for the build status
[10:21:48.978] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:48.978] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:103:0) after 1m0s
[10:22:49.050] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:103:0)
[10:22:49.050] Timer tick, asking Buildbucket for the build status
[10:22:49.235] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:49.235] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:104:0) after 1m0s
[10:23:49.346] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:104:0)
[10:23:49.346] Timer tick, asking Buildbucket for the build status
[10:23:49.541] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:49.541] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:105:0) after 1m0s
[10:24:49.880] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:105:0)
[10:24:49.880] Timer tick, asking Buildbucket for the build status
[10:24:50.075] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:50.075] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:106:0) after 1m0s
[10:25:50.707] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:106:0)
[10:25:50.707] Timer tick, asking Buildbucket for the build status
[10:25:51.163] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:51.163] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:107:0) after 1m0s
[10:26:51.347] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:107:0)
[10:26:51.347] Timer tick, asking Buildbucket for the build status
[10:26:51.551] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:51.551] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:108:0) after 1m0s
[10:27:51.820] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:108:0)
[10:27:51.820] Timer tick, asking Buildbucket for the build status
[10:27:51.942] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:51.942] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:109:0) after 1m0s
[10:28:52.064] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:109:0)
[10:28:52.064] Timer tick, asking Buildbucket for the build status
[10:28:52.180] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:52.180] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:110:0) after 1m0s
[10:29:52.378] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:110:0)
[10:29:52.378] Timer tick, asking Buildbucket for the build status
[10:29:52.478] Build 8884778385080576576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:52.478] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050208447075815040:111:0) after 1m0s
[10:30:03.412] Received PubSub notification, asking Buildbucket for the build status
[10:30:03.468] Build 8884778385080576576: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:30:03.468] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1585218601774377",
"created_by": "project:chromium",
"created_ts": "1585212069395365",
"id": "8884778385080576576",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8e9962e102b7cb0025c5c0824257770c1d4394f0\"}}",
"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\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-63-mzs7\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 27303, \"got_angle_revision\": \"6719f54ac7ce85d5ea812299352387033a099530\", \"got_dawn_revision\": \"d5db214564bd781d5a6438a5fa48e39c9ba021b5\", \"got_nacl_revision\": \"ffed96d1528df9f114a30b14d4eb06120c8fb022\", \"got_revision\": \"8e9962e102b7cb0025c5c0824257770c1d4394f0\", \"got_revision_cp\": \"refs/heads/master@{#753549}\", \"got_swarming_client_revision\": \"cc958279ffd6853e0a1b227a7e957ca334fe56af\", \"got_swiftshader_revision\": \"77090261dabcf44c7b5a0f97bdf35e812a13a66a\", \"got_v8_revision\": \"3714932e224a7a48553563a7eb18e2ffc000d796\", \"got_v8_revision_cp\": \"refs/heads/8.3.82@{#1}\", \"got_webrtc_revision\": \"d19513f3ffbb939fd56b5377b678bb31d3154e14\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30881}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8e9962e102b7cb0025c5c0824257770c1d4394f0\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_138eac15610b3f0440a6667a818842b236cdfafca7b64487cccd341b71441a31_v2\", \"builder_36472ddafb4960b563fa0dfd4883d4c097bf9805cea97d60ada20c6be0c80514_v2\", \"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-63-mzs7\"], \"image\": [\"chrome-xenial-20032200-f0f7a76907a\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4895-ce889b2\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1585212074387110",
"status": "COMPLETED",
"status_changed_ts": "1585218602537534",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/27303",
"builder:Deterministic Linux",
"buildset:commit/git/8e9962e102b7cb0025c5c0824257770c1d4394f0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e9962e102b7cb0025c5c0824257770c1d4394f0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050208447075815040",
"scheduler_job_id:chromium/Deterministic Linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8884778385080576576/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4b2ed229abad0e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1585218602781720",
"url": "https://ci.chromium.org/b/8884778385080576576",
"utcnow_ts": "1585218603460843"
}
}
[10:30:03.468] Invocation finished in 1h48m55.360013121s with status SUCCEEDED