[00:17:32.620] New invocation is queued and will start shortly
[00:17:33.695] Starting the invocation (attempt 1)
[00:17:33.744] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:17:33.744] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:17:33.744] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9053229830221802544",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4a7df26e0691615743677d7c329cdf090fac51d9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9053229830221802544",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/4a7df26e0691615743677d7c329cdf090fac51d9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4a7df26e0691615743677d7c329cdf090fac51d9",
"gitiles_ref:refs/heads/master"
]
}
[00:17:34.444] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1582330653863448",
"id": "8887799768252851440",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4a7df26e0691615743677d7c329cdf090fac51d9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582330654277357",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26908",
"builder:Deterministic Linux",
"buildset:commit/git/4a7df26e0691615743677d7c329cdf090fac51d9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4a7df26e0691615743677d7c329cdf090fac51d9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053229830221802544",
"scheduler_job_id:chromium/Deterministic Linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8887799768252851440/+/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": "1582330654277459",
"url": "https://ci.chromium.org/b/8887799768252851440",
"utcnow_ts": "1582330654431558"
}
}
[00:17:34.444] Task URL: https://ci.chromium.org/b/8887799768252851440
[00:17:34.444] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:2:0) after 1m0s
[00:17:44.364] Received PubSub notification, asking Buildbucket for the build status
[00:17:44.432] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:34.532] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:2:0)
[00:18:34.532] Timer tick, asking Buildbucket for the build status
[00:18:34.622] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:34.622] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:4:0) after 1m0s
[00:19:34.683] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:4:0)
[00:19:34.683] Timer tick, asking Buildbucket for the build status
[00:19:34.868] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:34.868] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:5:0) after 1m0s
[00:20:34.888] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:5:0)
[00:20:34.888] Timer tick, asking Buildbucket for the build status
[00:20:35.047] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:35.047] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:6:0) after 1m0s
[00:21:35.075] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:6:0)
[00:21:35.075] Timer tick, asking Buildbucket for the build status
[00:21:36.065] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:36.065] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:7:0) after 1m0s
[00:22:36.099] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:7:0)
[00:22:36.099] Timer tick, asking Buildbucket for the build status
[00:22:36.244] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:36.244] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:8:0) after 1m0s
[00:23:36.296] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:8:0)
[00:23:36.296] Timer tick, asking Buildbucket for the build status
[00:23:36.374] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:36.374] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:9:0) after 1m0s
[00:24:36.456] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:9:0)
[00:24:36.456] Timer tick, asking Buildbucket for the build status
[00:24:36.505] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:36.505] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:10:0) after 1m0s
[00:25:36.487] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:10:0)
[00:25:36.487] Timer tick, asking Buildbucket for the build status
[00:25:36.604] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:36.604] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:11:0) after 1m0s
[00:26:36.679] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:11:0)
[00:26:36.679] Timer tick, asking Buildbucket for the build status
[00:26:36.985] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:36.985] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:12:0) after 1m0s
[00:27:37.055] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:12:0)
[00:27:37.055] Timer tick, asking Buildbucket for the build status
[00:27:37.124] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:37.124] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:13:0) after 1m0s
[00:28:37.155] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:13:0)
[00:28:37.155] Timer tick, asking Buildbucket for the build status
[00:28:37.286] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:37.286] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:14:0) after 1m0s
[00:29:37.317] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:14:0)
[00:29:37.317] Timer tick, asking Buildbucket for the build status
[00:29:37.540] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:37.540] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:15:0) after 1m0s
[00:30:37.573] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:15:0)
[00:30:37.573] Timer tick, asking Buildbucket for the build status
[00:30:37.628] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:37.628] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:16:0) after 1m0s
[00:31:37.694] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:16:0)
[00:31:37.694] Timer tick, asking Buildbucket for the build status
[00:31:37.930] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:37.930] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:17:0) after 1m0s
[00:32:38.046] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:17:0)
[00:32:38.046] Timer tick, asking Buildbucket for the build status
[00:32:38.176] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:38.176] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:18:0) after 1m0s
[00:33:38.168] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:18:0)
[00:33:38.168] Timer tick, asking Buildbucket for the build status
[00:33:38.344] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:38.344] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:19:0) after 1m0s
[00:34:38.344] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:19:0)
[00:34:38.344] Timer tick, asking Buildbucket for the build status
[00:34:39.588] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:39.588] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:20:0) after 1m0s
[00:35:39.588] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:20:0)
[00:35:39.588] Timer tick, asking Buildbucket for the build status
[00:35:39.914] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:39.914] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:21:0) after 1m0s
[00:36:40.001] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:21:0)
[00:36:40.001] Timer tick, asking Buildbucket for the build status
[00:36:44.171] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:44.171] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:22:0) after 1m0s
[00:37:44.499] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:22:0)
[00:37:44.499] Timer tick, asking Buildbucket for the build status
[00:37:44.591] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:44.591] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:23:0) after 1m0s
[00:38:44.617] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:23:0)
[00:38:44.617] Timer tick, asking Buildbucket for the build status
[00:38:44.820] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:44.820] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:24:0) after 1m0s
[00:39:44.906] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:24:0)
[00:39:44.906] Timer tick, asking Buildbucket for the build status
[00:39:45.076] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:45.076] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:25:0) after 1m0s
[00:40:45.100] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:25:0)
[00:40:45.100] Timer tick, asking Buildbucket for the build status
[00:40:45.413] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:45.413] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:26:0) after 1m0s
[00:41:45.505] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:26:0)
[00:41:45.505] Timer tick, asking Buildbucket for the build status
[00:41:46.631] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:46.631] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:27:0) after 1m0s
[00:42:46.661] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:27:0)
[00:42:46.661] Timer tick, asking Buildbucket for the build status
[00:42:46.755] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:46.755] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:28:0) after 1m0s
[00:43:46.804] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:28:0)
[00:43:46.804] Timer tick, asking Buildbucket for the build status
[00:43:47.169] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:47.169] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:29:0) after 1m0s
[00:44:47.230] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:29:0)
[00:44:47.231] Timer tick, asking Buildbucket for the build status
[00:44:47.347] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:47.347] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:30:0) after 1m0s
[00:45:47.482] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:30:0)
[00:45:47.482] Timer tick, asking Buildbucket for the build status
[00:45:47.666] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:47.666] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:31:0) after 1m0s
[00:46:47.808] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:31:0)
[00:46:47.808] Timer tick, asking Buildbucket for the build status
[00:46:49.173] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:49.173] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:32:0) after 1m0s
[00:47:49.204] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:32:0)
[00:47:49.204] Timer tick, asking Buildbucket for the build status
[00:47:49.300] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:49.300] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:33:0) after 1m0s
[00:48:49.388] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:33:0)
[00:48:49.388] Timer tick, asking Buildbucket for the build status
[00:48:49.504] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:49.504] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:34:0) after 1m0s
[00:49:49.629] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:34:0)
[00:49:49.629] Timer tick, asking Buildbucket for the build status
[00:49:49.799] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:49.799] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:35:0) after 1m0s
[00:50:49.861] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:35:0)
[00:50:49.861] Timer tick, asking Buildbucket for the build status
[00:50:50.154] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:50.154] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:36:0) after 1m0s
[00:51:50.204] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:36:0)
[00:51:50.204] Timer tick, asking Buildbucket for the build status
[00:51:50.354] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:50.355] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:37:0) after 1m0s
[00:52:50.515] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:37:0)
[00:52:50.515] Timer tick, asking Buildbucket for the build status
[00:52:50.734] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:50.734] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:38:0) after 1m0s
[00:53:51.004] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:38:0)
[00:53:51.004] Timer tick, asking Buildbucket for the build status
[00:53:51.283] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:51.283] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:39:0) after 1m0s
[00:54:51.535] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:39:0)
[00:54:51.535] Timer tick, asking Buildbucket for the build status
[00:54:51.664] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:51.664] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:40:0) after 1m0s
[00:55:51.757] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:40:0)
[00:55:51.757] Timer tick, asking Buildbucket for the build status
[00:55:52.235] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:52.235] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:41:0) after 1m0s
[00:56:52.301] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:41:0)
[00:56:52.301] Timer tick, asking Buildbucket for the build status
[00:56:52.596] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:52.596] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:42:0) after 1m0s
[00:57:53.006] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:42:0)
[00:57:53.006] Timer tick, asking Buildbucket for the build status
[00:57:53.687] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:53.687] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:43:0) after 1m0s
[00:58:53.937] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:43:0)
[00:58:53.937] Timer tick, asking Buildbucket for the build status
[00:58:54.022] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:54.022] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:44:0) after 1m0s
[00:59:54.159] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:44:0)
[00:59:54.159] Timer tick, asking Buildbucket for the build status
[00:59:54.283] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:54.283] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:45:0) after 1m0s
[01:00:54.382] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:45:0)
[01:00:54.382] Timer tick, asking Buildbucket for the build status
[01:00:54.494] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:54.494] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:46:0) after 1m0s
[01:01:54.680] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:46:0)
[01:01:54.680] Timer tick, asking Buildbucket for the build status
[01:01:54.838] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:54.838] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:47:0) after 1m0s
[01:02:54.942] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:47:0)
[01:02:54.942] Timer tick, asking Buildbucket for the build status
[01:02:55.089] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:55.090] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:48:0) after 1m0s
[01:03:55.172] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:48:0)
[01:03:55.172] Timer tick, asking Buildbucket for the build status
[01:03:55.255] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:55.255] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:49:0) after 1m0s
[01:04:55.281] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:49:0)
[01:04:55.281] Timer tick, asking Buildbucket for the build status
[01:04:55.399] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:55.399] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:50:0) after 1m0s
[01:05:55.523] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:50:0)
[01:05:55.524] Timer tick, asking Buildbucket for the build status
[01:05:55.745] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:55.745] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:51:0) after 1m0s
[01:06:55.738] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:51:0)
[01:06:55.738] Timer tick, asking Buildbucket for the build status
[01:06:55.857] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:55.857] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:52:0) after 1m0s
[01:07:55.925] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:52:0)
[01:07:55.925] Timer tick, asking Buildbucket for the build status
[01:07:56.095] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:56.095] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:53:0) after 1m0s
[01:08:56.207] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:53:0)
[01:08:56.207] Timer tick, asking Buildbucket for the build status
[01:08:56.507] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:56.507] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:54:0) after 1m0s
[01:09:56.666] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:54:0)
[01:09:56.666] Timer tick, asking Buildbucket for the build status
[01:09:56.823] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:56.823] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:55:0) after 1m0s
[01:10:57.064] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:55:0)
[01:10:57.064] Timer tick, asking Buildbucket for the build status
[01:10:57.399] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:57.399] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:56:0) after 1m0s
[01:11:57.514] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:56:0)
[01:11:57.514] Timer tick, asking Buildbucket for the build status
[01:11:57.652] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:57.652] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:57:0) after 1m0s
[01:12:57.930] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:57:0)
[01:12:57.930] Timer tick, asking Buildbucket for the build status
[01:12:58.134] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:58.134] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:58:0) after 1m0s
[01:13:58.313] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:58:0)
[01:13:58.313] Timer tick, asking Buildbucket for the build status
[01:13:58.464] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:58.464] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:59:0) after 1m0s
[01:14:58.504] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:59:0)
[01:14:58.504] Timer tick, asking Buildbucket for the build status
[01:14:58.605] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:58.605] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:60:0) after 1m0s
[01:15:58.855] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:60:0)
[01:15:58.855] Timer tick, asking Buildbucket for the build status
[01:15:59.036] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:59.036] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:61:0) after 1m0s
[01:16:59.070] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:61:0)
[01:16:59.070] Timer tick, asking Buildbucket for the build status
[01:16:59.306] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:59.306] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:62:0) after 1m0s
[01:17:59.344] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:62:0)
[01:17:59.344] Timer tick, asking Buildbucket for the build status
[01:17:59.500] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:59.500] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:63:0) after 1m0s
[01:18:59.728] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:63:0)
[01:18:59.728] Timer tick, asking Buildbucket for the build status
[01:18:59.839] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:59.839] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:64:0) after 1m0s
[01:19:59.982] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:64:0)
[01:19:59.982] Timer tick, asking Buildbucket for the build status
[01:20:00.124] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:00.124] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:65:0) after 1m0s
[01:21:00.171] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:65:0)
[01:21:00.171] Timer tick, asking Buildbucket for the build status
[01:21:00.364] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:00.364] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:66:0) after 1m0s
[01:22:00.504] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:66:0)
[01:22:00.504] Timer tick, asking Buildbucket for the build status
[01:22:01.267] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:01.267] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:67:0) after 1m0s
[01:23:01.320] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:67:0)
[01:23:01.320] Timer tick, asking Buildbucket for the build status
[01:23:01.430] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:01.430] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:68:0) after 1m0s
[01:24:01.748] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:68:0)
[01:24:01.748] Timer tick, asking Buildbucket for the build status
[01:24:01.894] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:01.894] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:69:0) after 1m0s
[01:25:01.921] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:69:0)
[01:25:01.921] Timer tick, asking Buildbucket for the build status
[01:25:02.028] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:02.028] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:70:0) after 1m0s
[01:26:02.087] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:70:0)
[01:26:02.087] Timer tick, asking Buildbucket for the build status
[01:26:02.154] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:02.154] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:71:0) after 1m0s
[01:27:02.311] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:71:0)
[01:27:02.311] Timer tick, asking Buildbucket for the build status
[01:27:02.501] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:02.501] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:72:0) after 1m0s
[01:28:02.530] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:72:0)
[01:28:02.530] Timer tick, asking Buildbucket for the build status
[01:28:02.645] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:02.645] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:73:0) after 1m0s
[01:29:02.755] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:73:0)
[01:29:02.755] Timer tick, asking Buildbucket for the build status
[01:29:02.998] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:02.998] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:74:0) after 1m0s
[01:30:03.098] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:74:0)
[01:30:03.098] Timer tick, asking Buildbucket for the build status
[01:30:03.257] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:03.258] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:75:0) after 1m0s
[01:31:03.263] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:75:0)
[01:31:03.263] Timer tick, asking Buildbucket for the build status
[01:31:03.386] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:03.386] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:76:0) after 1m0s
[01:32:03.456] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:76:0)
[01:32:03.456] Timer tick, asking Buildbucket for the build status
[01:32:03.608] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:03.608] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:77:0) after 1m0s
[01:33:03.718] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:77:0)
[01:33:03.718] Timer tick, asking Buildbucket for the build status
[01:33:03.806] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:03.806] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:78:0) after 1m0s
[01:34:03.860] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:78:0)
[01:34:03.860] Timer tick, asking Buildbucket for the build status
[01:34:03.957] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:03.957] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:79:0) after 1m0s
[01:35:04.045] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:79:0)
[01:35:04.045] Timer tick, asking Buildbucket for the build status
[01:35:04.167] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:04.167] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:80:0) after 1m0s
[01:36:04.257] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:80:0)
[01:36:04.257] Timer tick, asking Buildbucket for the build status
[01:36:04.385] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:04.385] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:81:0) after 1m0s
[01:37:04.616] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:81:0)
[01:37:04.616] Timer tick, asking Buildbucket for the build status
[01:37:04.858] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:04.858] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:82:0) after 1m0s
[01:38:05.252] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:82:0)
[01:38:05.252] Timer tick, asking Buildbucket for the build status
[01:38:05.382] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:05.382] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:83:0) after 1m0s
[01:39:05.458] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:83:0)
[01:39:05.458] Timer tick, asking Buildbucket for the build status
[01:39:05.559] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:05.559] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:84:0) after 1m0s
[01:40:05.713] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:84:0)
[01:40:05.713] Timer tick, asking Buildbucket for the build status
[01:40:05.850] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:05.850] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:85:0) after 1m0s
[01:41:05.980] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:85:0)
[01:41:05.980] Timer tick, asking Buildbucket for the build status
[01:41:06.120] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:06.120] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:86:0) after 1m0s
[01:42:06.248] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:86:0)
[01:42:06.248] Timer tick, asking Buildbucket for the build status
[01:42:06.347] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:06.347] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:87:0) after 1m0s
[01:43:06.489] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:87:0)
[01:43:06.489] Timer tick, asking Buildbucket for the build status
[01:43:07.232] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:07.232] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:88:0) after 1m0s
[01:44:07.256] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:88:0)
[01:44:07.257] Timer tick, asking Buildbucket for the build status
[01:44:07.561] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:07.561] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:89:0) after 1m0s
[01:45:07.538] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:89:0)
[01:45:07.538] Timer tick, asking Buildbucket for the build status
[01:45:07.908] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:07.908] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:90:0) after 1m0s
[01:46:07.949] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:90:0)
[01:46:07.949] Timer tick, asking Buildbucket for the build status
[01:46:08.082] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:08.082] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:91:0) after 1m0s
[01:47:08.179] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:91:0)
[01:47:08.179] Timer tick, asking Buildbucket for the build status
[01:47:08.321] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:08.321] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:92:0) after 1m0s
[01:48:08.401] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:92:0)
[01:48:08.401] Timer tick, asking Buildbucket for the build status
[01:48:08.538] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:08.538] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:93:0) after 1m0s
[01:49:08.582] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:93:0)
[01:49:08.582] Timer tick, asking Buildbucket for the build status
[01:49:08.885] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:08.885] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:94:0) after 1m0s
[01:50:08.870] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:94:0)
[01:50:08.870] Timer tick, asking Buildbucket for the build status
[01:50:09.302] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:09.302] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:95:0) after 1m0s
[01:51:09.399] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:95:0)
[01:51:09.399] Timer tick, asking Buildbucket for the build status
[01:51:09.848] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:09.848] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:96:0) after 1m0s
[01:52:09.895] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:96:0)
[01:52:09.895] Timer tick, asking Buildbucket for the build status
[01:52:10.149] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:10.149] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:97:0) after 1m0s
[01:53:10.330] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:97:0)
[01:53:10.330] Timer tick, asking Buildbucket for the build status
[01:53:10.734] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:10.734] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:98:0) after 1m0s
[01:54:10.774] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:98:0)
[01:54:10.774] Timer tick, asking Buildbucket for the build status
[01:54:10.865] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:10.865] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:99:0) after 1m0s
[01:55:10.993] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:99:0)
[01:55:10.993] Timer tick, asking Buildbucket for the build status
[01:55:11.092] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:11.092] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:100:0) after 1m0s
[01:56:11.173] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:100:0)
[01:56:11.173] Timer tick, asking Buildbucket for the build status
[01:56:11.314] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:11.314] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:101:0) after 1m0s
[01:57:11.442] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:101:0)
[01:57:11.442] Timer tick, asking Buildbucket for the build status
[01:57:11.671] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:11.671] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:102:0) after 1m0s
[01:58:11.835] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:102:0)
[01:58:11.835] Timer tick, asking Buildbucket for the build status
[01:58:12.102] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:12.102] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:103:0) after 1m0s
[01:59:12.251] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:103:0)
[01:59:12.251] Timer tick, asking Buildbucket for the build status
[01:59:12.358] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:12.358] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:104:0) after 1m0s
[02:00:12.431] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:104:0)
[02:00:12.431] Timer tick, asking Buildbucket for the build status
[02:00:12.544] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:12.544] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:105:0) after 1m0s
[02:01:12.700] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:105:0)
[02:01:12.700] Timer tick, asking Buildbucket for the build status
[02:01:12.819] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:12.819] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:106:0) after 1m0s
[02:02:12.874] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:106:0)
[02:02:12.874] Timer tick, asking Buildbucket for the build status
[02:02:13.033] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:13.033] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:107:0) after 1m0s
[02:03:13.147] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:107:0)
[02:03:13.147] Timer tick, asking Buildbucket for the build status
[02:03:13.328] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:13.328] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:108:0) after 1m0s
[02:04:13.390] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:108:0)
[02:04:13.390] Timer tick, asking Buildbucket for the build status
[02:04:13.787] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:13.787] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:109:0) after 1m0s
[02:05:13.908] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:109:0)
[02:05:13.908] Timer tick, asking Buildbucket for the build status
[02:05:14.385] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:14.385] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:110:0) after 1m0s
[02:06:14.554] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:110:0)
[02:06:14.554] Timer tick, asking Buildbucket for the build status
[02:06:14.934] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:14.934] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:111:0) after 1m0s
[02:07:15.112] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:111:0)
[02:07:15.112] Timer tick, asking Buildbucket for the build status
[02:07:15.233] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:15.233] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:112:0) after 1m0s
[02:08:15.390] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:112:0)
[02:08:15.390] Timer tick, asking Buildbucket for the build status
[02:08:16.045] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:16.045] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:113:0) after 1m0s
[02:09:16.065] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:113:0)
[02:09:16.065] Timer tick, asking Buildbucket for the build status
[02:09:16.394] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:16.394] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:114:0) after 1m0s
[02:10:16.430] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:114:0)
[02:10:16.430] Timer tick, asking Buildbucket for the build status
[02:10:17.687] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:17.687] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:115:0) after 1m0s
[02:11:17.759] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:115:0)
[02:11:17.759] Timer tick, asking Buildbucket for the build status
[02:11:18.823] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:18.823] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:116:0) after 1m0s
[02:12:18.923] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:116:0)
[02:12:18.923] Timer tick, asking Buildbucket for the build status
[02:12:19.029] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:19.029] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:117:0) after 1m0s
[02:13:19.025] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:117:0)
[02:13:19.025] Timer tick, asking Buildbucket for the build status
[02:13:19.111] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:19.111] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:118:0) after 1m0s
[02:14:19.140] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:118:0)
[02:14:19.140] Timer tick, asking Buildbucket for the build status
[02:14:19.280] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:19.280] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:119:0) after 1m0s
[02:15:19.342] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:119:0)
[02:15:19.342] Timer tick, asking Buildbucket for the build status
[02:15:20.232] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:20.232] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:120:0) after 1m0s
[02:16:20.286] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:120:0)
[02:16:20.286] Timer tick, asking Buildbucket for the build status
[02:16:20.420] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:20.420] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:121:0) after 1m0s
[02:17:20.445] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:121:0)
[02:17:20.445] Timer tick, asking Buildbucket for the build status
[02:17:20.554] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:20.555] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:122:0) after 1m0s
[02:18:20.600] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:122:0)
[02:18:20.600] Timer tick, asking Buildbucket for the build status
[02:18:20.710] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:20.710] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:123:0) after 1m0s
[02:19:20.868] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:123:0)
[02:19:20.868] Timer tick, asking Buildbucket for the build status
[02:19:21.036] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:21.036] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:124:0) after 1m0s
[02:20:21.132] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:124:0)
[02:20:21.132] Timer tick, asking Buildbucket for the build status
[02:20:21.300] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:21.300] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:125:0) after 1m0s
[02:21:21.388] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:125:0)
[02:21:21.388] Timer tick, asking Buildbucket for the build status
[02:21:21.606] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:21.606] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:126:0) after 1m0s
[02:22:21.676] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:126:0)
[02:22:21.676] Timer tick, asking Buildbucket for the build status
[02:22:21.962] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:21.962] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:127:0) after 1m0s
[02:23:22.041] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:127:0)
[02:23:22.041] Timer tick, asking Buildbucket for the build status
[02:23:22.193] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:22.193] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:128:0) after 1m0s
[02:24:22.238] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:128:0)
[02:24:22.238] Timer tick, asking Buildbucket for the build status
[02:24:22.370] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:22.370] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:129:0) after 1m0s
[02:25:22.419] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:129:0)
[02:25:22.419] Timer tick, asking Buildbucket for the build status
[02:25:22.546] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:22.546] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:130:0) after 1m0s
[02:26:22.647] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:130:0)
[02:26:22.647] Timer tick, asking Buildbucket for the build status
[02:26:23.290] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:23.290] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:131:0) after 1m0s
[02:27:23.330] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:131:0)
[02:27:23.331] Timer tick, asking Buildbucket for the build status
[02:27:23.535] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:23.535] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:132:0) after 1m0s
[02:28:23.682] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:132:0)
[02:28:23.682] Timer tick, asking Buildbucket for the build status
[02:28:23.791] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:23.791] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:133:0) after 1m0s
[02:29:23.839] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:133:0)
[02:29:23.839] Timer tick, asking Buildbucket for the build status
[02:29:23.923] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:23.923] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:134:0) after 1m0s
[02:30:23.982] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:134:0)
[02:30:23.982] Timer tick, asking Buildbucket for the build status
[02:30:24.114] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:24.114] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:135:0) after 1m0s
[02:31:24.215] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:135:0)
[02:31:24.215] Timer tick, asking Buildbucket for the build status
[02:31:24.672] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:24.672] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:136:0) after 1m0s
[02:32:24.736] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:136:0)
[02:32:24.736] Timer tick, asking Buildbucket for the build status
[02:32:24.816] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:24.816] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:137:0) after 1m0s
[02:33:24.939] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:137:0)
[02:33:24.939] Timer tick, asking Buildbucket for the build status
[02:33:25.054] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:25.054] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:138:0) after 1m0s
[02:34:25.157] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:138:0)
[02:34:25.157] Timer tick, asking Buildbucket for the build status
[02:34:25.492] Build 8887799768252851440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:25.492] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053229830221802544:139:0) after 1m0s
[02:34:51.616] Received PubSub notification, asking Buildbucket for the build status
[02:34:51.670] Build 8887799768252851440: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:34:51.670] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1582338891057736",
"created_by": "project:chromium",
"created_ts": "1582330653863448",
"id": "8887799768252851440",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4a7df26e0691615743677d7c329cdf090fac51d9\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-72-m2wm\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 26908, \"got_angle_revision\": \"8df468102d9ed066e3186723b017fac75b40e749\", \"got_dawn_revision\": \"bc34d908f60d458c6d9e416a7404eac4703e1192\", \"got_nacl_revision\": \"530e1f0dae34020864c81e5cd52be54d9c656690\", \"got_revision\": \"4a7df26e0691615743677d7c329cdf090fac51d9\", \"got_revision_cp\": \"refs/heads/master@{#743724}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"847856089dc3f740f46f6f6af1be4c7cde50cdb2\", \"got_v8_revision\": \"de47ef6c23c6846f3da46a515383d00d76f533ae\", \"got_v8_revision_cp\": \"refs/heads/8.2.149@{#1}\", \"got_webrtc_revision\": \"1dea1ea412021819bddbc9400dcca7d9dd2eba74\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30581}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4a7df26e0691615743677d7c329cdf090fac51d9\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_33498e86c0181efb6d75c3f73059d9522f6d5d2b3b1c7a2dc2a1c6b75cd205cd_v2\", \"builder_361cbaa79261c75a92fc63a8f8c6fc117764238b3277286fa51086e6da3301df_v2\", \"builder_93045653dd8238f9b5a16956c3abf0c7402036195ded7f89ac6ed546092c13e3_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-72-m2wm\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4825-3d129d6\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1582330663064767",
"status": "COMPLETED",
"status_changed_ts": "1582338891314131",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26908",
"builder:Deterministic Linux",
"buildset:commit/git/4a7df26e0691615743677d7c329cdf090fac51d9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4a7df26e0691615743677d7c329cdf090fac51d9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053229830221802544",
"scheduler_job_id:chromium/Deterministic Linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8887799768252851440/+/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:4a8313374fa82d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1582338891319828",
"url": "https://ci.chromium.org/b/8887799768252851440",
"utcnow_ts": "1582338891662520"
}
}
[02:34:51.670] Invocation finished in 2h17m19.067817042s with status SUCCEEDED