[14:38:20.565] New invocation is queued and will start shortly
[14:38:21.951] Starting the invocation (attempt 1)
[14:38:22.088] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:38:22.088] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:38:22.088] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9078814614915966336",
"parameters_json": "{\"builder_name\":\"Deterministic Linux (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"52d75665b9e0d7fc758b2e5ffccbbe8b05165e81\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux (dbg)",
"scheduler_invocation_id:9078814614915966336",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/52d75665b9e0d7fc758b2e5ffccbbe8b05165e81",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/52d75665b9e0d7fc758b2e5ffccbbe8b05165e81",
"gitiles_ref:refs/heads/master"
]
}
[14:38:23.013] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1557931102293115",
"id": "8913384552439833184",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"52d75665b9e0d7fc758b2e5ffccbbe8b05165e81\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1557931102839034",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/7604",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/52d75665b9e0d7fc758b2e5ffccbbe8b05165e81",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/52d75665b9e0d7fc758b2e5ffccbbe8b05165e81",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9078814614915966336",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8913384552439833184/+/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": "1557931102843668",
"url": "https://ci.chromium.org/b/8913384552439833184",
"utcnow_ts": "1557931103002445"
}
}
[14:38:23.013] Task URL: https://ci.chromium.org/b/8913384552439833184
[14:38:23.013] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:2:0) after 1m0s
[14:39:23.310] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:2:0)
[14:39:23.310] Timer tick, asking Buildbucket for the build status
[14:39:23.492] Build 8913384552439833184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:39:23.492] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:3:0) after 1m0s
[14:40:02.631] Received PubSub notification, asking Buildbucket for the build status
[14:40:03.024] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:23.769] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:3:0)
[14:40:23.769] Timer tick, asking Buildbucket for the build status
[14:40:23.922] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:23.922] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:5:0) after 1m0s
[14:41:24.264] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:5:0)
[14:41:24.264] Timer tick, asking Buildbucket for the build status
[14:41:24.798] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:24.798] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:6:0) after 1m0s
[14:42:24.819] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:6:0)
[14:42:24.819] Timer tick, asking Buildbucket for the build status
[14:42:25.134] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:25.134] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:7:0) after 1m0s
[14:43:25.236] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:7:0)
[14:43:25.236] Timer tick, asking Buildbucket for the build status
[14:43:25.404] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:25.404] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:8:0) after 1m0s
[14:44:25.439] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:8:0)
[14:44:25.439] Timer tick, asking Buildbucket for the build status
[14:44:27.078] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:27.078] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:9:0) after 1m0s
[14:45:27.136] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:9:0)
[14:45:27.136] Timer tick, asking Buildbucket for the build status
[14:45:27.922] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:27.922] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:10:0) after 1m0s
[14:46:27.942] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:10:0)
[14:46:27.942] Timer tick, asking Buildbucket for the build status
[14:46:28.175] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:28.175] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:11:0) after 1m0s
[14:47:28.251] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:11:0)
[14:47:28.251] Timer tick, asking Buildbucket for the build status
[14:47:28.368] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:28.368] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:12:0) after 1m0s
[14:48:28.352] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:12:0)
[14:48:28.352] Timer tick, asking Buildbucket for the build status
[14:48:28.619] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:28.619] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:13:0) after 1m0s
[14:49:28.606] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:13:0)
[14:49:28.606] Timer tick, asking Buildbucket for the build status
[14:49:28.718] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:28.718] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:14:0) after 1m0s
[14:50:28.741] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:14:0)
[14:50:28.741] Timer tick, asking Buildbucket for the build status
[14:50:28.885] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:28.885] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:15:0) after 1m0s
[14:51:28.914] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:15:0)
[14:51:28.914] Timer tick, asking Buildbucket for the build status
[14:51:29.191] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:29.191] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:16:0) after 1m0s
[14:52:29.212] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:16:0)
[14:52:29.212] Timer tick, asking Buildbucket for the build status
[14:52:29.501] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:29.501] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:17:0) after 1m0s
[14:53:29.520] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:17:0)
[14:53:29.520] Timer tick, asking Buildbucket for the build status
[14:53:29.695] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:29.695] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:18:0) after 1m0s
[14:54:30.148] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:18:0)
[14:54:30.148] Timer tick, asking Buildbucket for the build status
[14:54:33.840] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:33.840] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:19:0) after 1m0s
[14:55:33.813] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:19:0)
[14:55:33.813] Timer tick, asking Buildbucket for the build status
[14:55:33.961] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:33.961] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:20:0) after 1m0s
[14:56:34.090] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:20:0)
[14:56:34.090] Timer tick, asking Buildbucket for the build status
[14:56:34.291] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:34.291] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:21:0) after 1m0s
[14:57:34.772] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:21:0)
[14:57:34.772] Timer tick, asking Buildbucket for the build status
[14:57:34.886] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:34.886] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:22:0) after 1m0s
[14:58:36.806] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:22:0)
[14:58:36.806] Timer tick, asking Buildbucket for the build status
[14:58:37.212] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:37.212] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:23:0) after 1m0s
[14:59:37.575] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:23:0)
[14:59:37.575] Timer tick, asking Buildbucket for the build status
[14:59:37.692] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:37.692] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:24:0) after 1m0s
[15:00:37.878] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:24:0)
[15:00:37.878] Timer tick, asking Buildbucket for the build status
[15:00:39.201] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:39.201] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:25:0) after 1m0s
[15:01:39.205] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:25:0)
[15:01:39.205] Timer tick, asking Buildbucket for the build status
[15:01:40.887] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:40.887] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:26:0) after 1m0s
[15:02:40.897] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:26:0)
[15:02:40.897] Timer tick, asking Buildbucket for the build status
[15:02:41.022] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:41.022] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:27:0) after 1m0s
[15:03:41.451] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:27:0)
[15:03:41.451] Timer tick, asking Buildbucket for the build status
[15:03:42.958] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:42.958] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:28:0) after 1m0s
[15:04:43.519] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:28:0)
[15:04:43.519] Timer tick, asking Buildbucket for the build status
[15:04:43.718] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:43.718] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:29:0) after 1m0s
[15:05:43.785] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:29:0)
[15:05:43.785] Timer tick, asking Buildbucket for the build status
[15:05:43.907] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:43.907] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:30:0) after 1m0s
[15:06:43.887] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:30:0)
[15:06:43.887] Timer tick, asking Buildbucket for the build status
[15:06:44.249] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:44.249] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:31:0) after 1m0s
[15:07:44.280] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:31:0)
[15:07:44.280] Timer tick, asking Buildbucket for the build status
[15:07:44.825] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:44.825] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:32:0) after 1m0s
[15:08:44.807] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:32:0)
[15:08:44.807] Timer tick, asking Buildbucket for the build status
[15:08:45.084] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:45.084] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:33:0) after 1m0s
[15:09:45.063] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:33:0)
[15:09:45.063] Timer tick, asking Buildbucket for the build status
[15:09:46.215] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:46.215] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:34:0) after 1m0s
[15:10:46.248] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:34:0)
[15:10:46.248] Timer tick, asking Buildbucket for the build status
[15:10:47.427] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:47.427] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:35:0) after 1m0s
[15:11:47.464] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:35:0)
[15:11:47.464] Timer tick, asking Buildbucket for the build status
[15:11:49.367] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:49.367] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:36:0) after 1m0s
[15:12:49.476] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:36:0)
[15:12:49.476] Timer tick, asking Buildbucket for the build status
[15:12:49.689] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:49.689] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:37:0) after 1m0s
[15:13:49.841] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:37:0)
[15:13:49.841] Timer tick, asking Buildbucket for the build status
[15:13:49.940] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:49.940] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:38:0) after 1m0s
[15:14:50.119] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:38:0)
[15:14:50.119] Timer tick, asking Buildbucket for the build status
[15:14:50.328] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:50.328] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:39:0) after 1m0s
[15:15:50.383] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:39:0)
[15:15:50.383] Timer tick, asking Buildbucket for the build status
[15:15:50.496] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:50.496] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:40:0) after 1m0s
[15:16:50.773] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:40:0)
[15:16:50.773] Timer tick, asking Buildbucket for the build status
[15:16:50.974] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:50.974] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:41:0) after 1m0s
[15:17:51.110] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:41:0)
[15:17:51.110] Timer tick, asking Buildbucket for the build status
[15:17:54.809] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:54.809] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:42:0) after 1m0s
[15:18:54.931] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:42:0)
[15:18:54.932] Timer tick, asking Buildbucket for the build status
[15:18:55.780] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:55.780] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:43:0) after 1m0s
[15:19:55.803] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:43:0)
[15:19:55.803] Timer tick, asking Buildbucket for the build status
[15:19:56.424] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:56.428] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:44:0) after 1m0s
[15:20:58.201] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:44:0)
[15:20:58.201] Timer tick, asking Buildbucket for the build status
[15:20:58.349] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:58.349] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:45:0) after 1m0s
[15:21:58.722] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:45:0)
[15:21:58.722] Timer tick, asking Buildbucket for the build status
[15:21:59.006] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:59.006] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:46:0) after 1m0s
[15:22:59.091] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:46:0)
[15:22:59.091] Timer tick, asking Buildbucket for the build status
[15:22:59.983] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:59.983] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:47:0) after 1m0s
[15:24:00.021] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:47:0)
[15:24:00.021] Timer tick, asking Buildbucket for the build status
[15:24:01.628] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:01.628] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:48:0) after 1m0s
[15:25:01.636] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:48:0)
[15:25:01.636] Timer tick, asking Buildbucket for the build status
[15:25:01.820] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:01.820] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:49:0) after 1m0s
[15:26:01.807] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:49:0)
[15:26:01.807] Timer tick, asking Buildbucket for the build status
[15:26:03.076] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:03.077] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:50:0) after 1m0s
[15:27:03.096] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:50:0)
[15:27:03.096] Timer tick, asking Buildbucket for the build status
[15:27:05.293] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:05.293] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:51:0) after 1m0s
[15:28:05.318] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:51:0)
[15:28:05.318] Timer tick, asking Buildbucket for the build status
[15:28:07.324] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:07.324] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:52:0) after 1m0s
[15:29:07.329] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:52:0)
[15:29:07.329] Timer tick, asking Buildbucket for the build status
[15:29:07.437] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:07.437] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:53:0) after 1m0s
[15:30:12.528] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:53:0)
[15:30:12.528] Timer tick, asking Buildbucket for the build status
[15:30:12.899] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:12.899] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:54:0) after 1m0s
[15:31:12.876] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:54:0)
[15:31:12.876] Timer tick, asking Buildbucket for the build status
[15:31:13.265] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:13.265] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:55:0) after 1m0s
[15:32:13.295] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:55:0)
[15:32:13.295] Timer tick, asking Buildbucket for the build status
[15:32:14.695] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:14.695] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:56:0) after 1m0s
[15:33:14.723] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:56:0)
[15:33:14.723] Timer tick, asking Buildbucket for the build status
[15:33:14.993] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:14.993] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:57:0) after 1m0s
[15:34:15.016] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:57:0)
[15:34:15.016] Timer tick, asking Buildbucket for the build status
[15:34:15.204] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:15.204] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:58:0) after 1m0s
[15:35:15.195] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:58:0)
[15:35:15.195] Timer tick, asking Buildbucket for the build status
[15:35:15.892] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:15.892] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:59:0) after 1m0s
[15:36:15.907] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:59:0)
[15:36:15.907] Timer tick, asking Buildbucket for the build status
[15:36:16.393] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:16.393] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:60:0) after 1m0s
[15:37:16.415] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:60:0)
[15:37:16.415] Timer tick, asking Buildbucket for the build status
[15:37:18.945] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:18.945] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:61:0) after 1m0s
[15:38:18.933] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:61:0)
[15:38:18.933] Timer tick, asking Buildbucket for the build status
[15:38:19.586] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:19.586] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:62:0) after 1m0s
[15:39:19.574] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:62:0)
[15:39:19.574] Timer tick, asking Buildbucket for the build status
[15:39:20.913] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:20.913] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:63:0) after 1m0s
[15:40:20.963] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:63:0)
[15:40:20.963] Timer tick, asking Buildbucket for the build status
[15:40:21.303] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:21.303] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:64:0) after 1m0s
[15:41:21.379] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:64:0)
[15:41:21.379] Timer tick, asking Buildbucket for the build status
[15:41:24.934] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:24.934] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:65:0) after 1m0s
[15:42:25.019] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:65:0)
[15:42:25.019] Timer tick, asking Buildbucket for the build status
[15:42:25.851] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:25.851] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:66:0) after 1m0s
[15:43:25.864] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:66:0)
[15:43:25.864] Timer tick, asking Buildbucket for the build status
[15:43:26.120] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:26.120] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:67:0) after 1m0s
[15:44:26.259] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:67:0)
[15:44:26.259] Timer tick, asking Buildbucket for the build status
[15:44:26.537] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:26.537] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:68:0) after 1m0s
[15:45:26.569] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:68:0)
[15:45:26.569] Timer tick, asking Buildbucket for the build status
[15:45:27.013] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:27.013] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:69:0) after 1m0s
[15:46:27.173] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:69:0)
[15:46:27.173] Timer tick, asking Buildbucket for the build status
[15:46:28.047] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:28.047] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:70:0) after 1m0s
[15:47:28.174] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:70:0)
[15:47:28.174] Timer tick, asking Buildbucket for the build status
[15:47:28.651] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:28.651] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:71:0) after 1m0s
[15:48:28.729] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:71:0)
[15:48:28.729] Timer tick, asking Buildbucket for the build status
[15:48:29.035] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:29.035] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:72:0) after 1m0s
[15:49:29.370] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:72:0)
[15:49:29.370] Timer tick, asking Buildbucket for the build status
[15:49:29.865] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:29.865] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:73:0) after 1m0s
[15:50:29.887] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:73:0)
[15:50:29.887] Timer tick, asking Buildbucket for the build status
[15:50:33.266] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:33.266] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:74:0) after 1m0s
[15:51:33.311] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:74:0)
[15:51:33.311] Timer tick, asking Buildbucket for the build status
[15:51:34.182] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:34.182] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:75:0) after 1m0s
[15:52:34.188] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:75:0)
[15:52:34.188] Timer tick, asking Buildbucket for the build status
[15:52:34.323] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:34.323] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:76:0) after 1m0s
[15:53:34.402] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:76:0)
[15:53:34.402] Timer tick, asking Buildbucket for the build status
[15:53:34.518] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:34.518] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:77:0) after 1m0s
[15:54:34.568] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:77:0)
[15:54:34.568] Timer tick, asking Buildbucket for the build status
[15:54:34.758] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:34.758] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:78:0) after 1m0s
[15:55:35.075] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:78:0)
[15:55:35.075] Timer tick, asking Buildbucket for the build status
[15:55:35.543] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:35.543] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:79:0) after 1m0s
[15:56:35.577] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:79:0)
[15:56:35.577] Timer tick, asking Buildbucket for the build status
[15:56:36.226] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:36.226] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:80:0) after 1m0s
[15:57:36.624] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:80:0)
[15:57:36.624] Timer tick, asking Buildbucket for the build status
[15:57:36.754] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:36.754] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:81:0) after 1m0s
[15:58:36.915] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:81:0)
[15:58:36.915] Timer tick, asking Buildbucket for the build status
[15:58:37.086] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:37.086] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:82:0) after 1m0s
[15:59:37.085] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:82:0)
[15:59:37.085] Timer tick, asking Buildbucket for the build status
[15:59:38.750] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:38.750] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:83:0) after 1m0s
[16:00:38.933] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:83:0)
[16:00:38.933] Timer tick, asking Buildbucket for the build status
[16:00:39.196] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:39.196] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:84:0) after 1m0s
[16:01:39.362] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:84:0)
[16:01:39.362] Timer tick, asking Buildbucket for the build status
[16:01:39.679] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:39.679] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:85:0) after 1m0s
[16:02:39.736] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:85:0)
[16:02:39.736] Timer tick, asking Buildbucket for the build status
[16:02:40.739] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:40.739] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:86:0) after 1m0s
[16:03:40.798] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:86:0)
[16:03:40.798] Timer tick, asking Buildbucket for the build status
[16:03:40.995] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:40.995] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:87:0) after 1m0s
[16:04:41.178] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:87:0)
[16:04:41.178] Timer tick, asking Buildbucket for the build status
[16:04:41.317] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:41.317] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:88:0) after 1m0s
[16:05:41.315] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:88:0)
[16:05:41.315] Timer tick, asking Buildbucket for the build status
[16:05:42.743] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:42.743] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:89:0) after 1m0s
[16:06:42.843] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:89:0)
[16:06:42.843] Timer tick, asking Buildbucket for the build status
[16:06:43.355] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:43.355] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:90:0) after 1m0s
[16:07:43.372] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:90:0)
[16:07:43.372] Timer tick, asking Buildbucket for the build status
[16:07:43.618] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:43.618] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:91:0) after 1m0s
[16:08:43.649] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:91:0)
[16:08:43.649] Timer tick, asking Buildbucket for the build status
[16:08:43.905] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:43.905] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:92:0) after 1m0s
[16:09:43.963] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:92:0)
[16:09:43.963] Timer tick, asking Buildbucket for the build status
[16:09:44.876] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:44.876] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:93:0) after 1m0s
[16:10:45.031] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:93:0)
[16:10:45.031] Timer tick, asking Buildbucket for the build status
[16:10:45.798] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:45.798] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:94:0) after 1m0s
[16:11:45.803] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:94:0)
[16:11:45.803] Timer tick, asking Buildbucket for the build status
[16:11:45.957] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:45.957] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:95:0) after 1m0s
[16:12:45.988] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:95:0)
[16:12:45.988] Timer tick, asking Buildbucket for the build status
[16:12:46.395] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:46.395] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:96:0) after 1m0s
[16:13:46.399] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:96:0)
[16:13:46.399] Timer tick, asking Buildbucket for the build status
[16:13:47.616] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:47.616] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:97:0) after 1m0s
[16:14:47.591] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:97:0)
[16:14:47.591] Timer tick, asking Buildbucket for the build status
[16:14:47.905] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:47.905] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:98:0) after 1m0s
[16:15:47.917] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:98:0)
[16:15:47.917] Timer tick, asking Buildbucket for the build status
[16:15:48.979] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:48.979] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:99:0) after 1m0s
[16:16:49.005] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:99:0)
[16:16:49.005] Timer tick, asking Buildbucket for the build status
[16:16:51.173] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:51.173] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:100:0) after 1m0s
[16:17:51.296] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:100:0)
[16:17:51.296] Timer tick, asking Buildbucket for the build status
[16:17:51.481] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:51.481] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:101:0) after 1m0s
[16:18:51.511] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:101:0)
[16:18:51.511] Timer tick, asking Buildbucket for the build status
[16:18:52.078] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:52.078] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:102:0) after 1m0s
[16:19:52.109] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:102:0)
[16:19:52.109] Timer tick, asking Buildbucket for the build status
[16:19:53.371] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:53.371] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:103:0) after 1m0s
[16:20:53.414] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:103:0)
[16:20:53.414] Timer tick, asking Buildbucket for the build status
[16:20:53.560] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:53.560] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:104:0) after 1m0s
[16:21:53.588] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:104:0)
[16:21:53.588] Timer tick, asking Buildbucket for the build status
[16:21:54.022] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:54.022] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:105:0) after 1m0s
[16:22:54.041] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:105:0)
[16:22:54.041] Timer tick, asking Buildbucket for the build status
[16:22:54.428] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:54.428] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:106:0) after 1m0s
[16:23:54.478] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:106:0)
[16:23:54.478] Timer tick, asking Buildbucket for the build status
[16:23:55.240] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:55.240] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:107:0) after 1m0s
[16:24:55.259] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:107:0)
[16:24:55.259] Timer tick, asking Buildbucket for the build status
[16:24:56.043] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:56.043] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:108:0) after 1m0s
[16:25:56.066] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:108:0)
[16:25:56.066] Timer tick, asking Buildbucket for the build status
[16:25:56.184] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:56.184] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:109:0) after 1m0s
[16:26:56.245] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:109:0)
[16:26:56.245] Timer tick, asking Buildbucket for the build status
[16:26:56.650] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:56.650] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:110:0) after 1m0s
[16:27:56.662] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:110:0)
[16:27:56.662] Timer tick, asking Buildbucket for the build status
[16:27:56.789] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:56.789] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:111:0) after 1m0s
[16:28:56.786] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:111:0)
[16:28:56.786] Timer tick, asking Buildbucket for the build status
[16:28:57.089] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:57.090] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:112:0) after 1m0s
[16:29:57.087] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:112:0)
[16:29:57.087] Timer tick, asking Buildbucket for the build status
[16:29:57.399] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:57.399] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:113:0) after 1m0s
[16:30:57.487] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:113:0)
[16:30:57.487] Timer tick, asking Buildbucket for the build status
[16:30:59.078] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:59.078] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:114:0) after 1m0s
[16:31:59.108] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:114:0)
[16:31:59.108] Timer tick, asking Buildbucket for the build status
[16:31:59.481] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:59.481] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:115:0) after 1m0s
[16:32:59.512] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:115:0)
[16:32:59.512] Timer tick, asking Buildbucket for the build status
[16:32:59.789] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:59.789] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:116:0) after 1m0s
[16:33:59.807] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:116:0)
[16:33:59.807] Timer tick, asking Buildbucket for the build status
[16:34:00.229] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:00.229] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:117:0) after 1m0s
[16:35:00.257] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:117:0)
[16:35:00.257] Timer tick, asking Buildbucket for the build status
[16:35:01.206] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:01.206] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:118:0) after 1m0s
[16:36:01.237] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:118:0)
[16:36:01.237] Timer tick, asking Buildbucket for the build status
[16:36:02.302] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:02.302] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:119:0) after 1m0s
[16:37:02.410] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:119:0)
[16:37:02.410] Timer tick, asking Buildbucket for the build status
[16:37:02.574] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:02.575] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:120:0) after 1m0s
[16:38:02.629] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:120:0)
[16:38:02.629] Timer tick, asking Buildbucket for the build status
[16:38:03.083] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:03.083] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:121:0) after 1m0s
[16:39:03.105] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:121:0)
[16:39:03.105] Timer tick, asking Buildbucket for the build status
[16:39:03.203] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:03.203] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:122:0) after 1m0s
[16:40:03.249] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:122:0)
[16:40:03.249] Timer tick, asking Buildbucket for the build status
[16:40:03.467] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:03.467] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:123:0) after 1m0s
[16:41:03.490] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:123:0)
[16:41:03.490] Timer tick, asking Buildbucket for the build status
[16:41:03.917] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:03.917] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:124:0) after 1m0s
[16:42:03.948] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:124:0)
[16:42:03.948] Timer tick, asking Buildbucket for the build status
[16:42:04.495] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:04.495] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:125:0) after 1m0s
[16:43:04.498] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:125:0)
[16:43:04.498] Timer tick, asking Buildbucket for the build status
[16:43:05.422] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:05.422] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:126:0) after 1m0s
[16:44:05.507] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:126:0)
[16:44:05.507] Timer tick, asking Buildbucket for the build status
[16:44:06.116] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:06.116] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:127:0) after 1m0s
[16:45:06.156] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:127:0)
[16:45:06.156] Timer tick, asking Buildbucket for the build status
[16:45:06.297] Build 8913384552439833184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:06.297] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9078814614915966336:128:0) after 1m0s
[16:46:04.564] Received PubSub notification, asking Buildbucket for the build status
[16:46:04.964] Build 8913384552439833184: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:46:04.964] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1557938763075083",
"created_by": "project:chromium",
"created_ts": "1557931102293115",
"id": "8913384552439833184",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"52d75665b9e0d7fc758b2e5ffccbbe8b05165e81\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"jobs\": 500.0}, \"$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\": \"dawn-linux-x64-builder-0-k1dp\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux (dbg)\", \"buildnumber\": 7604, \"got_angle_revision\": \"a253cff3c8ac98adce68c75ae03cb65616352d58\", \"got_dawn_revision\": \"0195dbf908071e7b7afaed7c9fb922910e85e5c2\", \"got_nacl_revision\": \"ca374f5112fca6b36fc5d73e117a60b82f394993\", \"got_revision\": \"52d75665b9e0d7fc758b2e5ffccbbe8b05165e81\", \"got_revision_cp\": \"refs/heads/master@{#659927}\", \"got_swarming_client_revision\": \"1b65f4e862045f3ba430a4cbd0643f5b1b66c230\", \"got_v8_revision\": \"ca7d526d0256a3de8eb08c0eba25c6936505d8c1\", \"got_v8_revision_cp\": \"refs/heads/7.6.190@{#1}\", \"got_webrtc_revision\": \"e62a08a87a6f21672b2ae8ba25632007f417a3f1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27934}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"52d75665b9e0d7fc758b2e5ffccbbe8b05165e81\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"Dawn Linux x64 Builder\"], \"caches\": [\"builder_8116c80c2882afcd67a910417bbd6fba6f94de5911d922ccd599199b9d07f827_v2\", \"builder_940b8dd4638ac05ec7d44839e381a2baf02720b3eac518443ac04ffe6b1809c0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"dawn-linux-x64-builder-0-k1dp\"], \"image\": [\"chrome-trusty-19041600-95c8804d634\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4299-a0fe907\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1557931201597183",
"status": "COMPLETED",
"status_changed_ts": "1557938764320285",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/7604",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/52d75665b9e0d7fc758b2e5ffccbbe8b05165e81",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/52d75665b9e0d7fc758b2e5ffccbbe8b05165e81",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9078814614915966336",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8913384552439833184/+/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:44d4bf9c35d08110",
"user_agent:luci-scheduler"
],
"updated_ts": "1557938764326774",
"url": "https://ci.chromium.org/b/8913384552439833184",
"utcnow_ts": "1557938764956819"
}
}
[16:46:04.964] Invocation finished in 2h7m44.41568289s with status SUCCEEDED