[00:10:40.306] New invocation is queued and will start shortly
[00:10:41.897] Starting the invocation (attempt 1)
[00:10:41.962] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:10:41.963] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:10:41.963] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9073161595172940080",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"91bab480f1151391efc729f5f7971a83e2575d95\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9073161595172940080",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/91bab480f1151391efc729f5f7971a83e2575d95",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/91bab480f1151391efc729f5f7971a83e2575d95",
"gitiles_ref:refs/heads/master"
]
}
[00:10:43.004] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1563322242207758",
"id": "8907731532514149040",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"91bab480f1151391efc729f5f7971a83e2575d95\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1563322242855702",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/24127",
"builder:Deterministic Linux",
"buildset:commit/git/91bab480f1151391efc729f5f7971a83e2575d95",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/91bab480f1151391efc729f5f7971a83e2575d95",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9073161595172940080",
"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/8907731532514149040/+/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": "1563322242855835",
"url": "https://ci.chromium.org/b/8907731532514149040",
"utcnow_ts": "1563322242993145"
}
}
[00:10:43.004] Task URL: https://ci.chromium.org/b/8907731532514149040
[00:10:43.004] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:2:0) after 1m0s
[00:10:48.720] Received PubSub notification, asking Buildbucket for the build status
[00:10:48.880] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:43.323] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:2:0)
[00:11:43.323] Timer tick, asking Buildbucket for the build status
[00:11:43.752] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:43.752] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:4:0) after 1m0s
[00:12:43.788] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:4:0)
[00:12:43.788] Timer tick, asking Buildbucket for the build status
[00:12:47.267] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:47.267] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:5:0) after 1m0s
[00:13:47.714] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:5:0)
[00:13:47.714] Timer tick, asking Buildbucket for the build status
[00:13:48.060] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:48.062] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:6:0) after 1m0s
[00:14:48.343] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:6:0)
[00:14:48.344] Timer tick, asking Buildbucket for the build status
[00:14:48.657] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:48.657] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:7:0) after 1m0s
[00:15:48.682] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:7:0)
[00:15:48.682] Timer tick, asking Buildbucket for the build status
[00:15:50.061] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:50.061] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:8:0) after 1m0s
[00:16:50.245] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:8:0)
[00:16:50.245] Timer tick, asking Buildbucket for the build status
[00:16:51.584] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:51.584] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:9:0) after 1m0s
[00:17:51.918] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:9:0)
[00:17:51.918] Timer tick, asking Buildbucket for the build status
[00:17:54.396] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:54.396] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:10:0) after 1m0s
[00:18:54.895] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:10:0)
[00:18:54.895] Timer tick, asking Buildbucket for the build status
[00:18:55.159] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:55.159] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:11:0) after 1m0s
[00:19:55.269] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:11:0)
[00:19:55.269] Timer tick, asking Buildbucket for the build status
[00:19:57.143] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:57.143] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:12:0) after 1m0s
[00:20:57.579] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:12:0)
[00:20:57.579] Timer tick, asking Buildbucket for the build status
[00:20:57.819] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:57.819] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:13:0) after 1m0s
[00:21:58.056] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:13:0)
[00:21:58.056] Timer tick, asking Buildbucket for the build status
[00:21:59.499] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:59.499] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:14:0) after 1m0s
[00:22:59.613] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:14:0)
[00:22:59.613] Timer tick, asking Buildbucket for the build status
[00:22:59.983] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:59.983] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:15:0) after 1m0s
[00:24:00.350] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:15:0)
[00:24:00.350] Timer tick, asking Buildbucket for the build status
[00:24:00.893] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:00.893] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:16:0) after 1m0s
[00:25:01.054] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:16:0)
[00:25:01.054] Timer tick, asking Buildbucket for the build status
[00:25:01.423] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:01.423] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:17:0) after 1m0s
[00:26:01.463] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:17:0)
[00:26:01.463] Timer tick, asking Buildbucket for the build status
[00:26:01.867] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:01.867] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:18:0) after 1m0s
[00:27:02.029] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:18:0)
[00:27:02.029] Timer tick, asking Buildbucket for the build status
[00:27:02.393] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:02.393] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:19:0) after 1m0s
[00:28:02.432] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:19:0)
[00:28:02.432] Timer tick, asking Buildbucket for the build status
[00:28:02.996] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:02.996] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:20:0) after 1m0s
[00:29:03.076] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:20:0)
[00:29:03.076] Timer tick, asking Buildbucket for the build status
[00:29:03.436] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:03.436] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:21:0) after 1m0s
[00:30:03.583] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:21:0)
[00:30:03.583] Timer tick, asking Buildbucket for the build status
[00:30:04.186] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:04.187] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:22:0) after 1m0s
[00:31:04.418] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:22:0)
[00:31:04.418] Timer tick, asking Buildbucket for the build status
[00:31:05.578] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:05.578] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:23:0) after 1m0s
[00:32:05.693] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:23:0)
[00:32:05.693] Timer tick, asking Buildbucket for the build status
[00:32:08.169] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:08.169] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:24:0) after 1m0s
[00:33:08.349] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:24:0)
[00:33:08.350] Timer tick, asking Buildbucket for the build status
[00:33:09.358] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:09.358] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:25:0) after 1m0s
[00:34:09.349] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:25:0)
[00:34:09.349] Timer tick, asking Buildbucket for the build status
[00:34:09.716] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:09.716] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:26:0) after 1m0s
[00:35:09.741] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:26:0)
[00:35:09.741] Timer tick, asking Buildbucket for the build status
[00:35:10.069] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:10.069] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:27:0) after 1m0s
[00:36:10.232] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:27:0)
[00:36:10.232] Timer tick, asking Buildbucket for the build status
[00:36:10.838] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:10.838] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:28:0) after 1m0s
[00:37:10.962] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:28:0)
[00:37:10.962] Timer tick, asking Buildbucket for the build status
[00:37:12.852] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:12.853] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:29:0) after 1m0s
[00:38:12.888] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:29:0)
[00:38:12.888] Timer tick, asking Buildbucket for the build status
[00:38:13.236] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:13.236] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:30:0) after 1m0s
[00:39:13.262] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:30:0)
[00:39:13.263] Timer tick, asking Buildbucket for the build status
[00:39:13.786] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:13.786] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:31:0) after 1m0s
[00:40:13.898] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:31:0)
[00:40:13.898] Timer tick, asking Buildbucket for the build status
[00:40:14.546] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:14.546] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:32:0) after 1m0s
[00:41:14.689] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:32:0)
[00:41:14.689] Timer tick, asking Buildbucket for the build status
[00:41:15.222] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:15.222] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:33:0) after 1m0s
[00:42:15.252] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:33:0)
[00:42:15.252] Timer tick, asking Buildbucket for the build status
[00:42:15.681] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:15.681] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:34:0) after 1m0s
[00:43:15.718] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:34:0)
[00:43:15.718] Timer tick, asking Buildbucket for the build status
[00:43:18.624] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:18.624] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:35:0) after 1m0s
[00:44:18.664] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:35:0)
[00:44:18.664] Timer tick, asking Buildbucket for the build status
[00:44:19.610] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:19.610] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:36:0) after 1m0s
[00:45:19.642] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:36:0)
[00:45:19.642] Timer tick, asking Buildbucket for the build status
[00:45:19.917] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:19.917] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:37:0) after 1m0s
[00:46:19.990] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:37:0)
[00:46:19.990] Timer tick, asking Buildbucket for the build status
[00:46:21.135] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:21.135] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:38:0) after 1m0s
[00:47:21.373] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:38:0)
[00:47:21.373] Timer tick, asking Buildbucket for the build status
[00:47:22.219] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:22.219] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:39:0) after 1m0s
[00:48:22.503] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:39:0)
[00:48:22.503] Timer tick, asking Buildbucket for the build status
[00:48:22.835] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:22.835] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:40:0) after 1m0s
[00:49:22.980] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:40:0)
[00:49:22.980] Timer tick, asking Buildbucket for the build status
[00:49:23.302] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:23.302] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:41:0) after 1m0s
[00:50:23.373] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:41:0)
[00:50:23.373] Timer tick, asking Buildbucket for the build status
[00:50:24.913] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:24.913] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:42:0) after 1m0s
[00:51:25.007] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:42:0)
[00:51:25.007] Timer tick, asking Buildbucket for the build status
[00:51:27.940] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:27.940] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:43:0) after 1m0s
[00:52:27.966] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:43:0)
[00:52:27.966] Timer tick, asking Buildbucket for the build status
[00:52:28.281] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:28.281] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:44:0) after 1m0s
[00:53:28.282] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:44:0)
[00:53:28.282] Timer tick, asking Buildbucket for the build status
[00:53:29.082] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:29.082] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:45:0) after 1m0s
[00:54:29.163] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:45:0)
[00:54:29.163] Timer tick, asking Buildbucket for the build status
[00:54:29.311] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:29.311] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:46:0) after 1m0s
[00:55:29.374] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:46:0)
[00:55:29.374] Timer tick, asking Buildbucket for the build status
[00:55:31.318] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:31.318] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:47:0) after 1m0s
[00:56:31.343] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:47:0)
[00:56:31.343] Timer tick, asking Buildbucket for the build status
[00:56:32.215] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:32.215] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:48:0) after 1m0s
[00:57:32.401] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:48:0)
[00:57:32.401] Timer tick, asking Buildbucket for the build status
[00:57:32.744] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:32.744] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:49:0) after 1m0s
[00:58:32.872] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:49:0)
[00:58:32.872] Timer tick, asking Buildbucket for the build status
[00:58:33.335] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:33.335] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:50:0) after 1m0s
[00:59:33.376] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:50:0)
[00:59:33.376] Timer tick, asking Buildbucket for the build status
[00:59:33.515] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:33.515] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:51:0) after 1m0s
[01:00:33.596] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:51:0)
[01:00:33.596] Timer tick, asking Buildbucket for the build status
[01:00:33.738] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:33.738] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:52:0) after 1m0s
[01:01:33.824] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:52:0)
[01:01:33.824] Timer tick, asking Buildbucket for the build status
[01:01:34.606] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:34.606] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:53:0) after 1m0s
[01:02:34.645] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:53:0)
[01:02:34.645] Timer tick, asking Buildbucket for the build status
[01:02:35.416] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:35.416] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:54:0) after 1m0s
[01:03:35.499] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:54:0)
[01:03:35.499] Timer tick, asking Buildbucket for the build status
[01:03:35.729] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:35.729] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:55:0) after 1m0s
[01:04:35.825] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:55:0)
[01:04:35.825] Timer tick, asking Buildbucket for the build status
[01:04:36.019] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:36.019] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:56:0) after 1m0s
[01:05:36.163] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:56:0)
[01:05:36.163] Timer tick, asking Buildbucket for the build status
[01:05:37.805] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:37.805] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:57:0) after 1m0s
[01:06:37.920] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:57:0)
[01:06:37.920] Timer tick, asking Buildbucket for the build status
[01:06:38.179] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:38.179] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:58:0) after 1m0s
[01:07:38.218] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:58:0)
[01:07:38.218] Timer tick, asking Buildbucket for the build status
[01:07:38.632] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:38.632] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:59:0) after 1m0s
[01:08:38.705] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:59:0)
[01:08:38.705] Timer tick, asking Buildbucket for the build status
[01:08:39.633] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:39.633] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:60:0) after 1m0s
[01:09:39.713] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:60:0)
[01:09:39.713] Timer tick, asking Buildbucket for the build status
[01:09:39.948] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:39.948] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:61:0) after 1m0s
[01:10:40.115] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:61:0)
[01:10:40.115] Timer tick, asking Buildbucket for the build status
[01:10:40.293] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:40.293] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:62:0) after 1m0s
[01:11:40.327] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:62:0)
[01:11:40.327] Timer tick, asking Buildbucket for the build status
[01:11:40.553] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:40.553] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:63:0) after 1m0s
[01:12:40.592] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:63:0)
[01:12:40.592] Timer tick, asking Buildbucket for the build status
[01:12:41.234] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:41.234] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:64:0) after 1m0s
[01:13:41.490] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:64:0)
[01:13:41.490] Timer tick, asking Buildbucket for the build status
[01:13:44.696] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:44.696] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:65:0) after 1m0s
[01:14:44.738] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:65:0)
[01:14:44.738] Timer tick, asking Buildbucket for the build status
[01:14:45.010] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:45.010] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:66:0) after 1m0s
[01:15:45.095] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:66:0)
[01:15:45.095] Timer tick, asking Buildbucket for the build status
[01:15:46.718] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:46.718] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:67:0) after 1m0s
[01:16:46.782] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:67:0)
[01:16:46.782] Timer tick, asking Buildbucket for the build status
[01:16:47.023] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:47.023] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:68:0) after 1m0s
[01:17:47.101] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:68:0)
[01:17:47.101] Timer tick, asking Buildbucket for the build status
[01:17:47.379] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:47.379] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:69:0) after 1m0s
[01:18:47.528] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:69:0)
[01:18:47.529] Timer tick, asking Buildbucket for the build status
[01:18:48.547] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:48.547] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:70:0) after 1m0s
[01:19:48.567] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:70:0)
[01:19:48.567] Timer tick, asking Buildbucket for the build status
[01:19:49.368] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:49.369] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:71:0) after 1m0s
[01:20:49.477] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:71:0)
[01:20:49.477] Timer tick, asking Buildbucket for the build status
[01:20:49.606] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:49.606] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:72:0) after 1m0s
[01:21:49.682] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:72:0)
[01:21:49.682] Timer tick, asking Buildbucket for the build status
[01:21:50.271] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:50.271] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:73:0) after 1m0s
[01:22:50.383] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:73:0)
[01:22:50.383] Timer tick, asking Buildbucket for the build status
[01:22:54.016] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:54.016] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:74:0) after 1m0s
[01:23:54.080] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:74:0)
[01:23:54.080] Timer tick, asking Buildbucket for the build status
[01:23:54.334] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:54.334] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:75:0) after 1m0s
[01:24:54.363] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:75:0)
[01:24:54.363] Timer tick, asking Buildbucket for the build status
[01:24:54.572] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:54.572] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:76:0) after 1m0s
[01:25:54.728] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:76:0)
[01:25:54.728] Timer tick, asking Buildbucket for the build status
[01:25:55.208] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:55.208] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:77:0) after 1m0s
[01:26:55.290] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:77:0)
[01:26:55.290] Timer tick, asking Buildbucket for the build status
[01:26:55.662] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:55.662] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:78:0) after 1m0s
[01:27:55.706] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:78:0)
[01:27:55.706] Timer tick, asking Buildbucket for the build status
[01:27:55.832] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:55.832] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:79:0) after 1m0s
[01:28:55.896] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:79:0)
[01:28:55.896] Timer tick, asking Buildbucket for the build status
[01:28:56.313] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:56.313] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:80:0) after 1m0s
[01:29:56.494] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:80:0)
[01:29:56.494] Timer tick, asking Buildbucket for the build status
[01:29:56.716] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:56.716] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:81:0) after 1m0s
[01:30:56.897] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:81:0)
[01:30:56.897] Timer tick, asking Buildbucket for the build status
[01:30:57.047] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:57.047] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:82:0) after 1m0s
[01:31:57.224] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:82:0)
[01:31:57.224] Timer tick, asking Buildbucket for the build status
[01:31:57.982] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:57.982] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:83:0) after 1m0s
[01:32:58.022] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:83:0)
[01:32:58.022] Timer tick, asking Buildbucket for the build status
[01:32:58.215] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:58.215] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:84:0) after 1m0s
[01:33:58.347] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:84:0)
[01:33:58.347] Timer tick, asking Buildbucket for the build status
[01:33:58.508] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:58.508] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:85:0) after 1m0s
[01:34:58.557] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:85:0)
[01:34:58.557] Timer tick, asking Buildbucket for the build status
[01:34:59.147] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:59.147] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:86:0) after 1m0s
[01:35:59.247] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:86:0)
[01:35:59.247] Timer tick, asking Buildbucket for the build status
[01:36:00.559] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:00.559] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:87:0) after 1m0s
[01:37:00.561] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:87:0)
[01:37:00.561] Timer tick, asking Buildbucket for the build status
[01:37:00.918] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:00.918] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:88:0) after 1m0s
[01:38:00.955] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:88:0)
[01:38:00.955] Timer tick, asking Buildbucket for the build status
[01:38:01.694] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:01.694] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:89:0) after 1m0s
[01:39:01.720] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:89:0)
[01:39:01.720] Timer tick, asking Buildbucket for the build status
[01:39:02.250] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:02.250] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:90:0) after 1m0s
[01:40:02.313] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:90:0)
[01:40:02.313] Timer tick, asking Buildbucket for the build status
[01:40:02.900] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:02.900] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:91:0) after 1m0s
[01:41:03.334] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:91:0)
[01:41:03.334] Timer tick, asking Buildbucket for the build status
[01:41:03.497] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:03.497] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:92:0) after 1m0s
[01:42:03.775] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:92:0)
[01:42:03.775] Timer tick, asking Buildbucket for the build status
[01:42:04.789] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:04.789] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:93:0) after 1m0s
[01:43:05.276] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:93:0)
[01:43:05.276] Timer tick, asking Buildbucket for the build status
[01:43:06.113] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:06.114] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:94:0) after 1m0s
[01:44:07.944] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:94:0)
[01:44:07.944] Timer tick, asking Buildbucket for the build status
[01:44:08.219] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:08.219] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:95:0) after 1m0s
[01:45:09.836] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:95:0)
[01:45:09.836] Timer tick, asking Buildbucket for the build status
[01:45:10.741] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:10.741] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:96:0) after 1m0s
[01:46:11.037] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:96:0)
[01:46:11.037] Timer tick, asking Buildbucket for the build status
[01:46:11.321] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:11.321] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:97:0) after 1m0s
[01:47:11.584] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:97:0)
[01:47:11.585] Timer tick, asking Buildbucket for the build status
[01:47:12.284] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:12.284] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:98:0) after 1m0s
[01:48:12.326] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:98:0)
[01:48:12.326] Timer tick, asking Buildbucket for the build status
[01:48:12.552] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:12.552] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:99:0) after 1m0s
[01:49:12.630] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:99:0)
[01:49:12.630] Timer tick, asking Buildbucket for the build status
[01:49:12.925] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:12.925] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:100:0) after 1m0s
[01:50:13.000] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:100:0)
[01:50:13.000] Timer tick, asking Buildbucket for the build status
[01:50:13.418] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:13.418] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:101:0) after 1m0s
[01:51:14.528] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:101:0)
[01:51:14.528] Timer tick, asking Buildbucket for the build status
[01:51:14.704] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:14.704] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:102:0) after 1m0s
[01:52:14.715] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:102:0)
[01:52:14.715] Timer tick, asking Buildbucket for the build status
[01:52:15.071] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:15.071] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:103:0) after 1m0s
[01:53:15.097] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:103:0)
[01:53:15.097] Timer tick, asking Buildbucket for the build status
[01:53:15.561] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:15.561] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:104:0) after 1m0s
[01:54:15.634] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:104:0)
[01:54:15.634] Timer tick, asking Buildbucket for the build status
[01:54:15.878] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:15.878] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:105:0) after 1m0s
[01:55:15.997] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:105:0)
[01:55:15.997] Timer tick, asking Buildbucket for the build status
[01:55:16.176] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:16.176] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:106:0) after 1m0s
[01:56:16.242] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:106:0)
[01:56:16.242] Timer tick, asking Buildbucket for the build status
[01:56:16.653] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:16.653] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:107:0) after 1m0s
[01:57:16.777] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:107:0)
[01:57:16.777] Timer tick, asking Buildbucket for the build status
[01:57:17.482] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:17.482] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:108:0) after 1m0s
[01:58:17.524] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:108:0)
[01:58:17.524] Timer tick, asking Buildbucket for the build status
[01:58:20.260] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:20.260] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:109:0) after 1m0s
[01:59:20.290] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:109:0)
[01:59:20.290] Timer tick, asking Buildbucket for the build status
[01:59:20.437] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:20.437] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:110:0) after 1m0s
[02:00:20.578] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:110:0)
[02:00:20.578] Timer tick, asking Buildbucket for the build status
[02:00:21.927] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:21.927] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:111:0) after 1m0s
[02:01:22.121] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:111:0)
[02:01:22.121] Timer tick, asking Buildbucket for the build status
[02:01:23.495] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:23.495] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:112:0) after 1m0s
[02:02:23.578] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:112:0)
[02:02:23.578] Timer tick, asking Buildbucket for the build status
[02:02:24.324] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:24.324] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:113:0) after 1m0s
[02:03:24.431] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:113:0)
[02:03:24.431] Timer tick, asking Buildbucket for the build status
[02:03:25.340] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:25.340] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:114:0) after 1m0s
[02:04:25.456] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:114:0)
[02:04:25.456] Timer tick, asking Buildbucket for the build status
[02:04:27.727] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:27.727] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:115:0) after 1m0s
[02:05:27.830] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:115:0)
[02:05:27.830] Timer tick, asking Buildbucket for the build status
[02:05:28.007] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:28.007] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:116:0) after 1m0s
[02:06:28.074] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:116:0)
[02:06:28.074] Timer tick, asking Buildbucket for the build status
[02:06:28.367] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:28.367] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:117:0) after 1m0s
[02:07:28.525] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:117:0)
[02:07:28.525] Timer tick, asking Buildbucket for the build status
[02:07:28.683] Build 8907731532514149040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:28.683] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9073161595172940080:118:0) after 1m0s
[02:07:29.327] Received PubSub notification, asking Buildbucket for the build status
[02:07:29.520] Build 8907731532514149040: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:07:29.520] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1563329248503806",
"created_by": "project:chromium",
"created_ts": "1563322242207758",
"id": "8907731532514149040",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"91bab480f1151391efc729f5f7971a83e2575d95\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"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-trusty-8-37-cbdl\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 24127, \"got_angle_revision\": \"f92fc916887e53f862ffefaabf07786813f8c9e1\", \"got_dawn_revision\": \"4af9808400d993f58977ed7d320b1f912e92573f\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"91bab480f1151391efc729f5f7971a83e2575d95\", \"got_revision_cp\": \"refs/heads/master@{#678042}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"ffee6baaeee1bcaa8d1bba5e981377d30b37bd88\", \"got_v8_revision_cp\": \"refs/heads/7.7.248@{#1}\", \"got_webrtc_revision\": \"08da49d0a488aaf915f90c33b1f9bdbfecbe4367\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28579}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"91bab480f1151391efc729f5f7971a83e2575d95\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_28bbe8e6e9c00f2d4cca6bb7518e2e3abcc6dba52c0db172294f96352b49589a_v2\", \"builder_36472ddafb4960b563fa0dfd4883d4c097bf9805cea97d60ada20c6be0c80514_v2\", \"builder_5962259a05f00f2add6b886e805611a7d5779224d38d219d9f2179a6416f230e_v2\", \"builder_65fafd0c860c8cf0043a2ec0f6482d6e089dd429d22310040aa34c8b96106827_v2\", \"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-trusty-8-37-cbdl\"], \"image\": [\"chrome-trusty-19041600-95c8804d634\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4370-0e704a3\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1563322245483859",
"status": "COMPLETED",
"status_changed_ts": "1563329248858297",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/24127",
"builder:Deterministic Linux",
"buildset:commit/git/91bab480f1151391efc729f5f7971a83e2575d95",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/91bab480f1151391efc729f5f7971a83e2575d95",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9073161595172940080",
"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/8907731532514149040/+/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:461615e0c44dee10",
"user_agent:luci-scheduler"
],
"updated_ts": "1563329248878631",
"url": "https://ci.chromium.org/b/8907731532514149040",
"utcnow_ts": "1563329249512539"
}
}
[02:07:29.520] Invocation finished in 1h56m49.231881972s with status SUCCEEDED