[17:15:10.993] New invocation is queued and will start shortly
[17:15:12.579] Starting the invocation (attempt 1)
[17:15:12.622] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:15:12.622] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:15:12.622] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9017470601116856416",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2f91f082de8c08c52cef39f930081040bacf9fd8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9017470601116856416",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/2f91f082de8c08c52cef39f930081040bacf9fd8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2f91f082de8c08c52cef39f930081040bacf9fd8",
"gitiles_ref:refs/heads/master"
]
}
[17:15:13.274] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1616433312717690",
"id": "8852040538642917504",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2f91f082de8c08c52cef39f930081040bacf9fd8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1616433313150614",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/18105",
"builder:Windows deterministic",
"buildset:commit/git/2f91f082de8c08c52cef39f930081040bacf9fd8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2f91f082de8c08c52cef39f930081040bacf9fd8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017470601116856416",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852040538642917504/+/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": "1616433313150723",
"url": "https://ci.chromium.org/b/8852040538642917504",
"utcnow_ts": "1616433313265605"
}
}
[17:15:13.274] Task URL: https://ci.chromium.org/b/8852040538642917504
[17:15:13.274] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:2:0) after 1m0s
[17:16:13.343] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:2:0)
[17:16:13.343] Timer tick, asking Buildbucket for the build status
[17:16:13.424] Build 8852040538642917504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:16:13.424] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:3:0) after 1m0s
[17:17:11.875] Received PubSub notification, asking Buildbucket for the build status
[17:17:12.078] Build 8852040538642917504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:13.601] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:3:0)
[17:17:13.601] Timer tick, asking Buildbucket for the build status
[17:17:13.719] Build 8852040538642917504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:13.719] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:5:0) after 1m0s
[17:18:13.737] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:5:0)
[17:18:13.768] Build status: STARTED
[17:18:13.768] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:6:0) after 9m38s
[17:27:51.791] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:6:0)
[17:27:51.826] Build status: STARTED
[17:27:51.826] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:7:0) after 3m54s
[17:31:45.848] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:7:0)
[17:31:45.848] Timer tick, asking Buildbucket for the build status
[17:31:46.168] Build 8852040538642917504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:46.168] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:8:0) after 1m0s
[17:32:46.275] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:8:0)
[17:32:46.275] Timer tick, asking Buildbucket for the build status
[17:32:47.522] Build 8852040538642917504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:47.522] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:9:0) after 1m0s
[17:33:47.593] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:9:0)
[17:33:47.593] Timer tick, asking Buildbucket for the build status
[17:33:47.657] Build 8852040538642917504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:47.657] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:10:0) after 1m0s
[17:34:47.795] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:10:0)
[17:34:47.875] Build status: STARTED
[17:34:47.875] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:11:0) after 2m0s
[17:36:47.915] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:11:0)
[17:36:47.915] Timer tick, asking Buildbucket for the build status
[17:36:48.010] Build 8852040538642917504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:48.010] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:12:0) after 1m0s
[17:37:48.095] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:12:0)
[17:37:48.095] Timer tick, asking Buildbucket for the build status
[17:37:48.558] Build 8852040538642917504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:48.558] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:13:0) after 1m0s
[17:38:48.759] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:13:0)
[17:38:48.784] Build status: STARTED
[17:38:48.784] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:14:0) after 1m2s
[17:39:50.826] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:14:0)
[17:39:50.826] Timer tick, asking Buildbucket for the build status
[17:39:50.929] Build 8852040538642917504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:50.929] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:15:0) after 1m0s
[17:40:50.976] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:15:0)
[17:40:50.976] Timer tick, asking Buildbucket for the build status
[17:40:51.559] Build 8852040538642917504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:51.559] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:16:0) after 1m0s
[17:41:51.609] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:16:0)
[17:41:51.640] Build status: STARTED
[17:41:51.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:17:0) after 3m8s
[17:44:59.730] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:17:0)
[17:44:59.730] Timer tick, asking Buildbucket for the build status
[17:44:59.983] Build 8852040538642917504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:59.983] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:18:0) after 1m0s
[17:46:00.004] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:18:0)
[17:46:00.033] Build status: STARTED
[17:46:00.034] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:19:0) after 3m39s
[17:49:39.097] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:19:0)
[17:49:39.097] Timer tick, asking Buildbucket for the build status
[17:49:39.397] Build 8852040538642917504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:39.397] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:20:0) after 1m0s
[17:50:39.476] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:20:0)
[17:50:39.504] Build status: STARTED
[17:50:39.504] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:21:0) after 2m41s
[17:53:20.546] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:21:0)
[17:53:20.546] Timer tick, asking Buildbucket for the build status
[17:53:20.704] Build 8852040538642917504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:20.704] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:22:0) after 1m0s
[17:54:20.775] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:22:0)
[17:54:20.775] Timer tick, asking Buildbucket for the build status
[17:54:20.877] Build 8852040538642917504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:20.877] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:23:0) after 1m0s
[17:55:20.896] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:23:0)
[17:55:20.896] Timer tick, asking Buildbucket for the build status
[17:55:21.450] Build 8852040538642917504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:21.450] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:24:0) after 1m0s
[17:56:21.577] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:24:0)
[17:56:21.615] Build status: STARTED
[17:56:21.615] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:25:0) after 8m55s
[18:05:16.698] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:25:0)
[18:05:16.698] Timer tick, asking Buildbucket for the build status
[18:05:17.240] Build 8852040538642917504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:17.240] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:26:0) after 1m0s
[18:06:17.304] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:26:0)
[18:06:17.304] Timer tick, asking Buildbucket for the build status
[18:06:18.760] Build 8852040538642917504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:18.760] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:27:0) after 1m0s
[18:07:18.816] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:27:0)
[18:07:18.842] Build status: STARTED
[18:07:18.842] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:28:0) after 6m30s
[18:13:48.849] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:28:0)
[18:13:48.876] Build status: STARTED
[18:13:48.876] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:29:0) after 9m55s
[18:23:44.200] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:29:0)
[18:23:44.243] Build status: STARTED
[18:23:44.244] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:30:0) after 7m14s
[18:30:58.284] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:30:0)
[18:30:58.346] Build status: STARTED
[18:30:58.346] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:31:0) after 9m7s
[18:40:05.380] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:31:0)
[18:40:05.408] Build status: STARTED
[18:40:05.408] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:32:0) after 6m9s
[18:46:14.553] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:32:0)
[18:46:14.581] Build status: STARTED
[18:46:14.581] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:33:0) after 2m15s
[18:48:29.611] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:33:0)
[18:48:29.656] Build status: STARTED
[18:48:29.656] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:34:0) after 5m8s
[18:53:37.698] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:34:0)
[18:53:37.725] Build status: STARTED
[18:53:37.725] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:35:0) after 9m15s
[19:02:52.734] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:35:0)
[19:02:52.762] Build status: STARTED
[19:02:52.762] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:36:0) after 7m2s
[19:09:54.783] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:36:0)
[19:09:54.814] Build status: STARTED
[19:09:54.814] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:37:0) after 2m4s
[19:11:58.832] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:37:0)
[19:11:58.857] Build status: STARTED
[19:11:58.857] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:38:0) after 6m27s
[19:18:25.894] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:38:0)
[19:18:25.927] Build status: STARTED
[19:18:25.927] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:39:0) after 3m31s
[19:21:57.079] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:39:0)
[19:21:57.127] Build status: STARTED
[19:21:57.127] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:40:0) after 8m2s
[19:29:59.148] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:40:0)
[19:29:59.181] Build status: STARTED
[19:29:59.181] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:41:0) after 7m48s
[19:37:47.208] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:41:0)
[19:37:47.241] Build status: STARTED
[19:37:47.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:42:0) after 1m46s
[19:39:33.421] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:42:0)
[19:39:33.450] Build status: STARTED
[19:39:33.450] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:43:0) after 6m59s
[19:46:32.570] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:43:0)
[19:46:32.596] Build status: STARTED
[19:46:32.596] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:44:0) after 6m15s
[19:52:47.776] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:44:0)
[19:52:47.805] Build status: STARTED
[19:52:47.805] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:45:0) after 2m40s
[19:55:27.916] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:45:0)
[19:55:27.942] Build status: STARTED
[19:55:27.942] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:46:0) after 1m32s
[19:56:59.939] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:46:0)
[19:56:59.966] Build status: STARTED
[19:56:59.966] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:47:0) after 8m49s
[20:05:49.018] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:47:0)
[20:05:49.089] Build status: STARTED
[20:05:49.089] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:48:0) after 6m21s
[20:12:10.597] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:48:0)
[20:12:10.886] Build status: STARTED
[20:12:10.886] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:49:0) after 7m56s
[20:20:07.153] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:49:0)
[20:20:07.196] Build status: STARTED
[20:20:07.196] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:50:0) after 3m47s
[20:23:54.346] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:50:0)
[20:23:54.375] Build status: STARTED
[20:23:54.375] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:51:0) after 9m24s
[20:33:18.493] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:51:0)
[20:33:18.583] Build status: STARTED
[20:33:18.583] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:52:0) after 4m55s
[20:38:13.634] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:52:0)
[20:38:13.662] Build status: STARTED
[20:38:13.662] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:53:0) after 7m41s
[20:45:54.721] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:53:0)
[20:45:54.748] Build status: STARTED
[20:45:54.748] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:54:0) after 6m49s
[20:52:43.801] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:54:0)
[20:52:43.827] Build status: STARTED
[20:52:43.827] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:55:0) after 9m21s
[21:02:04.878] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:55:0)
[21:02:04.906] Build status: STARTED
[21:02:04.906] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:56:0) after 8m3s
[21:10:07.944] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:56:0)
[21:10:07.976] Build status: STARTED
[21:10:07.976] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:57:0) after 5m16s
[21:15:23.962] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:57:0)
[21:15:23.992] Build status: STARTED
[21:15:23.992] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:58:0) after 2m37s
[21:18:01.319] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:58:0)
[21:18:01.346] Build status: STARTED
[21:18:01.346] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:59:0) after 3m9s
[21:21:10.559] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:59:0)
[21:21:10.594] Build status: STARTED
[21:21:10.594] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:60:0) after 7m58s
[21:29:08.662] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:60:0)
[21:29:08.692] Build status: STARTED
[21:29:08.692] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:61:0) after 1m40s
[21:30:48.757] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:61:0)
[21:30:48.795] Build status: STARTED
[21:30:48.795] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:62:0) after 5m31s
[21:36:19.908] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:62:0)
[21:36:19.937] Build status: STARTED
[21:36:19.937] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:63:0) after 4m31s
[21:40:51.015] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:63:0)
[21:40:51.102] Build status: STARTED
[21:40:51.102] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:64:0) after 6m32s
[21:47:23.354] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:64:0)
[21:47:23.387] Build status: STARTED
[21:47:23.387] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:65:0) after 6m40s
[21:54:03.451] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:65:0)
[21:54:03.484] Build status: STARTED
[21:54:03.485] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:66:0) after 1m15s
[21:55:18.524] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:66:0)
[21:55:18.557] Build status: STARTED
[21:55:18.557] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:67:0) after 7m20s
[22:02:39.048] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:67:0)
[22:02:39.112] Build status: STARTED
[22:02:39.112] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:68:0) after 3m13s
[22:05:52.237] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:68:0)
[22:05:52.268] Build status: STARTED
[22:05:52.268] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:69:0) after 3m13s
[22:09:05.411] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:69:0)
[22:09:05.478] Build status: STARTED
[22:09:05.478] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:70:0) after 6m4s
[22:15:09.572] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:70:0)
[22:15:09.637] Build status: STARTED
[22:15:09.637] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017470601116856416:71:0) after 9m59s
[22:23:44.658] Received PubSub notification, asking Buildbucket for the build status
[22:23:44.693] Build:
{
"id": "8852040538642917504",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Windows deterministic"
},
"number": 18105,
"createdBy": "project:chromium",
"createTime": "2021-03-22T17:15:12.717690Z",
"startTime": "2021-03-22T17:17:11.308011Z",
"endTime": "2021-03-22T22:23:43.911625Z",
"updateTime": "2021-03-22T22:23:44.347973Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2f91f082de8c08c52cef39f930081040bacf9fd8",
"ref": "refs/heads/master"
}
}
}
[22:23:44.693] Invocation finished in 5h8m33.71834312s with status SUCCEEDED