[01:15:54.659] New invocation is queued and will start shortly
[01:15:55.872] Starting the invocation (attempt 1)
[01:15:55.927] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:15:55.927] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:15:55.927] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9036737510189653504",
"parameters_json": "{\"builder_name\":\"Deterministic Linux (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"80429ef73f1c64289aa1c40b4bb50daa49271f6f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux (dbg)",
"scheduler_invocation_id:9036737510189653504",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/80429ef73f1c64289aa1c40b4bb50daa49271f6f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/80429ef73f1c64289aa1c40b4bb50daa49271f6f",
"gitiles_ref:refs/heads/master"
]
}
[01:15:57.302] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1598058956059145",
"id": "8871307448049329632",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"80429ef73f1c64289aa1c40b4bb50daa49271f6f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1598058957038599",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/18351",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/80429ef73f1c64289aa1c40b4bb50daa49271f6f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/80429ef73f1c64289aa1c40b4bb50daa49271f6f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9036737510189653504",
"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/8871307448049329632/+/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": "1598058957038754",
"url": "https://ci.chromium.org/b/8871307448049329632",
"utcnow_ts": "1598058957281560"
}
}
[01:15:57.302] Task URL: https://ci.chromium.org/b/8871307448049329632
[01:15:57.302] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:2:0) after 1m0s
[01:15:59.657] Received PubSub notification, asking Buildbucket for the build status
[01:15:59.734] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:57.356] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:2:0)
[01:16:57.356] Timer tick, asking Buildbucket for the build status
[01:16:57.793] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:57.793] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:4:0) after 1m0s
[01:17:57.820] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:4:0)
[01:17:57.820] Timer tick, asking Buildbucket for the build status
[01:17:58.094] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:58.094] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:5:0) after 1m0s
[01:18:58.142] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:5:0)
[01:18:58.142] Timer tick, asking Buildbucket for the build status
[01:18:58.622] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:58.622] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:6:0) after 1m0s
[01:19:58.663] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:6:0)
[01:19:58.663] Timer tick, asking Buildbucket for the build status
[01:19:58.847] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:58.847] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:7:0) after 1m0s
[01:20:58.873] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:7:0)
[01:20:58.873] Timer tick, asking Buildbucket for the build status
[01:20:59.079] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:59.079] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:8:0) after 1m0s
[01:21:59.161] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:8:0)
[01:21:59.161] Timer tick, asking Buildbucket for the build status
[01:22:01.228] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:01.228] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:9:0) after 1m0s
[01:23:02.263] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:9:0)
[01:23:02.263] Timer tick, asking Buildbucket for the build status
[01:23:02.365] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:02.365] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:10:0) after 1m0s
[01:24:02.715] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:10:0)
[01:24:02.715] Timer tick, asking Buildbucket for the build status
[01:24:02.783] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:02.783] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:11:0) after 1m0s
[01:25:02.944] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:11:0)
[01:25:02.944] Timer tick, asking Buildbucket for the build status
[01:25:03.004] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:03.005] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:12:0) after 1m0s
[01:26:03.154] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:12:0)
[01:26:03.154] Timer tick, asking Buildbucket for the build status
[01:26:03.427] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:03.427] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:13:0) after 1m0s
[01:27:03.562] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:13:0)
[01:27:03.562] Timer tick, asking Buildbucket for the build status
[01:27:03.909] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:03.909] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:14:0) after 1m0s
[01:28:03.902] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:14:0)
[01:28:03.902] Timer tick, asking Buildbucket for the build status
[01:28:04.006] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:04.006] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:15:0) after 1m0s
[01:29:04.060] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:15:0)
[01:29:04.060] Timer tick, asking Buildbucket for the build status
[01:29:04.128] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:04.128] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:16:0) after 1m0s
[01:30:04.202] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:16:0)
[01:30:04.202] Timer tick, asking Buildbucket for the build status
[01:30:04.306] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:04.306] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:17:0) after 1m0s
[01:31:04.369] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:17:0)
[01:31:04.369] Timer tick, asking Buildbucket for the build status
[01:31:04.512] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:04.512] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:18:0) after 1m0s
[01:32:04.535] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:18:0)
[01:32:04.535] Timer tick, asking Buildbucket for the build status
[01:32:04.636] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:04.636] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:19:0) after 1m0s
[01:33:04.696] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:19:0)
[01:33:04.696] Timer tick, asking Buildbucket for the build status
[01:33:04.855] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:04.855] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:20:0) after 1m0s
[01:34:04.991] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:20:0)
[01:34:04.991] Timer tick, asking Buildbucket for the build status
[01:34:05.102] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:05.102] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:21:0) after 1m0s
[01:35:05.228] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:21:0)
[01:35:05.228] Timer tick, asking Buildbucket for the build status
[01:35:05.340] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:05.340] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:22:0) after 1m0s
[01:36:05.374] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:22:0)
[01:36:05.374] Timer tick, asking Buildbucket for the build status
[01:36:05.556] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:05.556] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:23:0) after 1m0s
[01:37:05.632] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:23:0)
[01:37:05.632] Timer tick, asking Buildbucket for the build status
[01:37:05.712] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:05.712] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:24:0) after 1m0s
[01:38:05.768] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:24:0)
[01:38:05.768] Timer tick, asking Buildbucket for the build status
[01:38:05.896] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:05.896] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:25:0) after 1m0s
[01:39:05.963] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:25:0)
[01:39:05.963] Timer tick, asking Buildbucket for the build status
[01:39:06.588] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:06.588] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:26:0) after 1m0s
[01:40:06.599] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:26:0)
[01:40:06.599] Timer tick, asking Buildbucket for the build status
[01:40:06.948] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:06.948] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:27:0) after 1m0s
[01:41:06.980] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:27:0)
[01:41:06.980] Timer tick, asking Buildbucket for the build status
[01:41:07.139] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:07.139] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:28:0) after 1m0s
[01:42:07.240] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:28:0)
[01:42:07.240] Timer tick, asking Buildbucket for the build status
[01:42:07.411] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:07.411] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:29:0) after 1m0s
[01:43:07.440] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:29:0)
[01:43:07.440] Timer tick, asking Buildbucket for the build status
[01:43:07.513] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:07.513] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:30:0) after 1m0s
[01:44:07.502] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:30:0)
[01:44:07.502] Timer tick, asking Buildbucket for the build status
[01:44:07.628] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:07.628] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:31:0) after 1m0s
[01:45:07.660] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:31:0)
[01:45:07.660] Timer tick, asking Buildbucket for the build status
[01:45:07.872] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:07.872] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:32:0) after 1m0s
[01:46:07.987] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:32:0)
[01:46:07.987] Timer tick, asking Buildbucket for the build status
[01:46:09.090] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:09.090] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:33:0) after 1m0s
[01:47:09.196] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:33:0)
[01:47:09.196] Timer tick, asking Buildbucket for the build status
[01:47:09.450] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:09.450] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:34:0) after 1m0s
[01:48:09.482] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:34:0)
[01:48:09.482] Timer tick, asking Buildbucket for the build status
[01:48:09.574] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:09.574] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:35:0) after 1m0s
[01:49:09.705] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:35:0)
[01:49:09.705] Timer tick, asking Buildbucket for the build status
[01:49:10.007] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:10.007] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:36:0) after 1m0s
[01:50:10.052] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:36:0)
[01:50:10.052] Timer tick, asking Buildbucket for the build status
[01:50:10.106] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:10.106] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:37:0) after 1m0s
[01:51:10.131] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:37:0)
[01:51:10.131] Timer tick, asking Buildbucket for the build status
[01:51:10.293] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:10.293] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:38:0) after 1m0s
[01:52:10.337] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:38:0)
[01:52:10.337] Timer tick, asking Buildbucket for the build status
[01:52:10.437] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:10.437] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:39:0) after 1m0s
[01:53:10.453] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:39:0)
[01:53:10.453] Timer tick, asking Buildbucket for the build status
[01:53:10.616] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:10.616] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:40:0) after 1m0s
[01:54:10.711] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:40:0)
[01:54:10.711] Timer tick, asking Buildbucket for the build status
[01:54:10.786] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:10.786] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:41:0) after 1m0s
[01:55:10.809] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:41:0)
[01:55:10.809] Timer tick, asking Buildbucket for the build status
[01:55:10.921] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:10.921] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:42:0) after 1m0s
[01:56:10.993] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:42:0)
[01:56:10.993] Timer tick, asking Buildbucket for the build status
[01:56:11.268] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:11.268] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:43:0) after 1m0s
[01:57:11.379] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:43:0)
[01:57:11.379] Timer tick, asking Buildbucket for the build status
[01:57:13.991] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:13.991] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:44:0) after 1m0s
[01:58:14.027] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:44:0)
[01:58:14.027] Timer tick, asking Buildbucket for the build status
[01:58:14.127] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:14.127] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:45:0) after 1m0s
[01:59:14.170] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:45:0)
[01:59:14.170] Timer tick, asking Buildbucket for the build status
[01:59:14.260] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:14.260] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:46:0) after 1m0s
[02:00:14.303] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:46:0)
[02:00:14.303] Timer tick, asking Buildbucket for the build status
[02:00:14.379] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:14.379] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:47:0) after 1m0s
[02:01:14.405] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:47:0)
[02:01:14.405] Timer tick, asking Buildbucket for the build status
[02:01:14.830] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:14.830] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:48:0) after 1m0s
[02:02:14.942] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:48:0)
[02:02:14.942] Timer tick, asking Buildbucket for the build status
[02:02:15.015] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:15.015] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:49:0) after 1m0s
[02:03:15.026] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:49:0)
[02:03:15.026] Timer tick, asking Buildbucket for the build status
[02:03:15.110] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:15.110] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:50:0) after 1m0s
[02:04:15.157] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:50:0)
[02:04:15.157] Timer tick, asking Buildbucket for the build status
[02:04:15.229] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:15.229] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:51:0) after 1m0s
[02:05:15.259] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:51:0)
[02:05:15.259] Timer tick, asking Buildbucket for the build status
[02:05:15.334] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:15.334] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:52:0) after 1m0s
[02:06:15.364] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:52:0)
[02:06:15.364] Timer tick, asking Buildbucket for the build status
[02:06:15.797] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:15.797] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:53:0) after 1m0s
[02:07:15.794] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:53:0)
[02:07:15.794] Timer tick, asking Buildbucket for the build status
[02:07:15.876] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:15.876] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:54:0) after 1m0s
[02:08:15.879] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:54:0)
[02:08:15.879] Timer tick, asking Buildbucket for the build status
[02:08:15.984] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:15.984] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:55:0) after 1m0s
[02:09:16.077] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:55:0)
[02:09:16.077] Timer tick, asking Buildbucket for the build status
[02:09:16.134] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:16.134] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:56:0) after 1m0s
[02:10:16.202] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:56:0)
[02:10:16.202] Timer tick, asking Buildbucket for the build status
[02:10:16.277] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:16.277] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:57:0) after 1m0s
[02:11:16.426] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:57:0)
[02:11:16.426] Timer tick, asking Buildbucket for the build status
[02:11:16.743] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:16.743] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:58:0) after 1m0s
[02:12:16.868] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:58:0)
[02:12:16.868] Timer tick, asking Buildbucket for the build status
[02:12:17.038] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:17.038] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:59:0) after 1m0s
[02:13:17.062] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:59:0)
[02:13:17.062] Timer tick, asking Buildbucket for the build status
[02:13:17.238] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:17.238] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:60:0) after 1m0s
[02:14:17.268] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:60:0)
[02:14:17.268] Timer tick, asking Buildbucket for the build status
[02:14:17.346] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:17.346] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:61:0) after 1m0s
[02:15:17.668] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:61:0)
[02:15:17.668] Timer tick, asking Buildbucket for the build status
[02:15:17.780] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:17.780] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:62:0) after 1m0s
[02:16:17.903] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:62:0)
[02:16:17.903] Timer tick, asking Buildbucket for the build status
[02:16:18.066] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:18.066] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:63:0) after 1m0s
[02:17:18.169] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:63:0)
[02:17:18.169] Timer tick, asking Buildbucket for the build status
[02:17:18.477] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:18.477] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:64:0) after 1m0s
[02:18:18.690] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:64:0)
[02:18:18.690] Timer tick, asking Buildbucket for the build status
[02:18:18.771] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:18.771] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:65:0) after 1m0s
[02:19:18.895] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:65:0)
[02:19:18.895] Timer tick, asking Buildbucket for the build status
[02:19:19.025] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:19.025] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:66:0) after 1m0s
[02:20:19.073] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:66:0)
[02:20:19.073] Timer tick, asking Buildbucket for the build status
[02:20:19.289] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:19.289] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:67:0) after 1m0s
[02:21:19.328] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:67:0)
[02:21:19.328] Timer tick, asking Buildbucket for the build status
[02:21:19.475] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:19.475] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:68:0) after 1m0s
[02:22:19.621] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:68:0)
[02:22:19.621] Timer tick, asking Buildbucket for the build status
[02:22:19.725] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:19.725] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:69:0) after 1m0s
[02:23:19.787] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:69:0)
[02:23:19.787] Timer tick, asking Buildbucket for the build status
[02:23:19.941] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:19.941] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:70:0) after 1m0s
[02:24:19.979] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:70:0)
[02:24:19.979] Timer tick, asking Buildbucket for the build status
[02:24:20.075] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:20.075] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:71:0) after 1m0s
[02:25:20.398] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:71:0)
[02:25:20.398] Timer tick, asking Buildbucket for the build status
[02:25:20.548] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:20.548] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:72:0) after 1m0s
[02:26:20.566] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:72:0)
[02:26:20.566] Timer tick, asking Buildbucket for the build status
[02:26:20.687] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:20.687] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:73:0) after 1m0s
[02:27:20.908] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:73:0)
[02:27:20.908] Timer tick, asking Buildbucket for the build status
[02:27:21.280] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:21.280] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:74:0) after 1m0s
[02:28:21.431] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:74:0)
[02:28:21.431] Timer tick, asking Buildbucket for the build status
[02:28:21.569] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:21.569] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:75:0) after 1m0s
[02:29:21.688] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:75:0)
[02:29:21.688] Timer tick, asking Buildbucket for the build status
[02:29:21.754] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:21.754] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:76:0) after 1m0s
[02:30:21.827] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:76:0)
[02:30:21.827] Timer tick, asking Buildbucket for the build status
[02:30:22.002] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:22.002] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:77:0) after 1m0s
[02:31:22.116] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:77:0)
[02:31:22.116] Timer tick, asking Buildbucket for the build status
[02:31:22.358] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:22.358] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:78:0) after 1m0s
[02:32:22.421] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:78:0)
[02:32:22.421] Timer tick, asking Buildbucket for the build status
[02:32:22.742] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:22.742] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:79:0) after 1m0s
[02:33:22.774] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:79:0)
[02:33:22.774] Timer tick, asking Buildbucket for the build status
[02:33:23.059] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:23.059] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:80:0) after 1m0s
[02:34:23.076] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:80:0)
[02:34:23.076] Timer tick, asking Buildbucket for the build status
[02:34:23.349] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:23.349] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:81:0) after 1m0s
[02:35:23.380] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:81:0)
[02:35:23.380] Timer tick, asking Buildbucket for the build status
[02:35:23.975] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:23.975] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:82:0) after 1m0s
[02:36:24.018] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:82:0)
[02:36:24.018] Timer tick, asking Buildbucket for the build status
[02:36:24.137] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:24.137] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:83:0) after 1m0s
[02:37:24.222] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:83:0)
[02:37:24.222] Timer tick, asking Buildbucket for the build status
[02:37:24.516] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:24.516] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:84:0) after 1m0s
[02:38:24.581] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:84:0)
[02:38:24.581] Timer tick, asking Buildbucket for the build status
[02:38:24.713] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:24.713] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:85:0) after 1m0s
[02:39:24.838] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:85:0)
[02:39:24.838] Timer tick, asking Buildbucket for the build status
[02:39:24.952] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:24.952] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:86:0) after 1m0s
[02:40:25.079] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:86:0)
[02:40:25.079] Timer tick, asking Buildbucket for the build status
[02:40:27.070] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:27.070] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:87:0) after 1m0s
[02:41:27.173] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:87:0)
[02:41:27.173] Timer tick, asking Buildbucket for the build status
[02:41:27.364] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:27.364] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:88:0) after 1m0s
[02:42:27.483] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:88:0)
[02:42:27.483] Timer tick, asking Buildbucket for the build status
[02:42:27.575] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:27.575] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:89:0) after 1m0s
[02:43:28.443] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:89:0)
[02:43:28.443] Timer tick, asking Buildbucket for the build status
[02:43:28.530] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:28.530] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:90:0) after 1m0s
[02:44:29.028] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:90:0)
[02:44:29.028] Timer tick, asking Buildbucket for the build status
[02:44:29.146] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:29.146] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:91:0) after 1m0s
[02:45:31.563] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:91:0)
[02:45:31.563] Timer tick, asking Buildbucket for the build status
[02:45:31.992] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:31.992] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:92:0) after 1m0s
[02:46:32.016] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:92:0)
[02:46:32.016] Timer tick, asking Buildbucket for the build status
[02:46:32.172] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:32.172] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:93:0) after 1m0s
[02:47:32.156] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:93:0)
[02:47:32.156] Timer tick, asking Buildbucket for the build status
[02:47:32.412] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:32.412] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:94:0) after 1m0s
[02:48:32.578] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:94:0)
[02:48:32.578] Timer tick, asking Buildbucket for the build status
[02:48:32.665] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:32.665] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:95:0) after 1m0s
[02:49:32.777] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:95:0)
[02:49:32.777] Timer tick, asking Buildbucket for the build status
[02:49:32.860] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:32.860] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:96:0) after 1m0s
[02:50:32.925] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:96:0)
[02:50:32.925] Timer tick, asking Buildbucket for the build status
[02:50:33.029] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:33.029] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:97:0) after 1m0s
[02:51:33.136] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:97:0)
[02:51:33.136] Timer tick, asking Buildbucket for the build status
[02:51:33.297] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:33.297] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:98:0) after 1m0s
[02:52:33.586] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:98:0)
[02:52:33.586] Timer tick, asking Buildbucket for the build status
[02:52:33.868] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:33.868] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:99:0) after 1m0s
[02:53:33.896] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:99:0)
[02:53:33.896] Timer tick, asking Buildbucket for the build status
[02:53:34.536] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:34.536] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:100:0) after 1m0s
[02:54:34.563] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:100:0)
[02:54:34.563] Timer tick, asking Buildbucket for the build status
[02:54:34.623] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:34.623] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:101:0) after 1m0s
[02:55:34.666] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:101:0)
[02:55:34.666] Timer tick, asking Buildbucket for the build status
[02:55:34.917] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:34.917] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:102:0) after 1m0s
[02:56:34.967] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:102:0)
[02:56:34.967] Timer tick, asking Buildbucket for the build status
[02:56:35.360] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:35.360] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:103:0) after 1m0s
[02:57:35.366] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:103:0)
[02:57:35.366] Timer tick, asking Buildbucket for the build status
[02:57:35.528] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:35.528] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:104:0) after 1m0s
[02:58:35.585] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:104:0)
[02:58:35.585] Timer tick, asking Buildbucket for the build status
[02:58:35.653] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:35.653] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:105:0) after 1m0s
[02:59:35.650] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:105:0)
[02:59:35.651] Timer tick, asking Buildbucket for the build status
[02:59:36.052] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:36.052] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:106:0) after 1m0s
[03:00:36.089] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:106:0)
[03:00:36.089] Timer tick, asking Buildbucket for the build status
[03:00:36.277] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:36.277] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:107:0) after 1m0s
[03:01:36.258] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:107:0)
[03:01:36.258] Timer tick, asking Buildbucket for the build status
[03:01:36.401] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:36.401] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:108:0) after 1m0s
[03:02:36.427] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:108:0)
[03:02:36.427] Timer tick, asking Buildbucket for the build status
[03:02:36.871] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:36.871] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:109:0) after 1m0s
[03:03:36.908] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:109:0)
[03:03:36.908] Timer tick, asking Buildbucket for the build status
[03:03:37.115] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:37.115] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:110:0) after 1m0s
[03:04:37.191] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:110:0)
[03:04:37.191] Timer tick, asking Buildbucket for the build status
[03:04:37.522] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:37.522] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:111:0) after 1m0s
[03:05:37.570] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:111:0)
[03:05:37.570] Timer tick, asking Buildbucket for the build status
[03:05:37.813] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:37.813] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:112:0) after 1m0s
[03:06:37.834] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:112:0)
[03:06:37.835] Timer tick, asking Buildbucket for the build status
[03:06:37.966] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:37.966] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:113:0) after 1m0s
[03:07:37.993] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:113:0)
[03:07:37.993] Timer tick, asking Buildbucket for the build status
[03:07:38.288] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:38.288] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:114:0) after 1m0s
[03:08:38.376] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:114:0)
[03:08:38.376] Timer tick, asking Buildbucket for the build status
[03:08:38.720] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:38.720] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:115:0) after 1m0s
[03:09:38.814] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:115:0)
[03:09:38.814] Timer tick, asking Buildbucket for the build status
[03:09:39.108] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:39.108] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:116:0) after 1m0s
[03:10:39.124] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:116:0)
[03:10:39.124] Timer tick, asking Buildbucket for the build status
[03:10:39.241] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:39.241] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:117:0) after 1m0s
[03:11:39.266] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:117:0)
[03:11:39.266] Timer tick, asking Buildbucket for the build status
[03:11:39.388] Build 8871307448049329632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:39.388] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9036737510189653504:118:0) after 1m0s
[03:11:45.991] Received PubSub notification, asking Buildbucket for the build status
[03:11:46.092] Build 8871307448049329632: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:11:46.092] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1598065904882984",
"created_by": "project:chromium",
"created_ts": "1598058956059145",
"id": "8871307448049329632",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"80429ef73f1c64289aa1c40b4bb50daa49271f6f\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-32-6-ls1x\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux (dbg)\", \"buildnumber\": 18351, \"got_angle_revision\": \"682f9141d174fb5dedb4d61de0ce854784a36cfb\", \"got_dawn_revision\": \"e8dc820fbc1e28eba80b8e8c49bb3e566874f4e7\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"80429ef73f1c64289aa1c40b4bb50daa49271f6f\", \"got_revision_cp\": \"refs/heads/master@{#800800}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"622558b02e1a5441c579994831a6338ffaf2de5c\", \"got_v8_revision\": \"1ca342524984084e1352ca5dd07aa9b539ff7768\", \"got_v8_revision_cp\": \"refs/heads/8.7.3@{#1}\", \"got_webrtc_revision\": \"fbb49b4f7f86487846170498dbd13fc704cff5ec\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31979}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"80429ef73f1c64289aa1c40b4bb50daa49271f6f\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_094ae2b7d41fc2d72094b7b6da708c57b0f9cf30da4d1b138156f1458af77f67_v2\", \"builder_39819929c28edbb94cfd890831720319bcf41d58e7ee63cb8a54e18e1fdfd830_v2\", \"builder_6a7ea7a29847c5e3c31f9e7f29ef0a1aa1bd0d542498088304c0bb7ba89c3242_v2\", \"builder_940b8dd4638ac05ec7d44839e381a2baf02720b3eac518443ac04ffe6b1809c0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-32-6-ls1x\"], \"image\": [\"chrome-xenial-20081700-d9392568d25\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5498-3454aa6\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1598058958933511",
"status": "COMPLETED",
"status_changed_ts": "1598065905733653",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/18351",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/80429ef73f1c64289aa1c40b4bb50daa49271f6f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/80429ef73f1c64289aa1c40b4bb50daa49271f6f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9036737510189653504",
"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/8871307448049329632/+/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:4e2c8e12dd36a310",
"user_agent:luci-scheduler"
],
"updated_ts": "1598065905739015",
"url": "https://ci.chromium.org/b/8871307448049329632",
"utcnow_ts": "1598065906081330"
}
}
[03:11:46.092] Invocation finished in 1h55m51.457471906s with status SUCCEEDED