[04:00:06.249] New invocation is queued and will start shortly
[04:00:07.386] Starting the invocation (attempt 1)
[04:00:07.411] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/849f811b08ad3e46c608f68e84ed0300bc9f3ade"
[04:00:07.411] Popped gitiles commit info from properties and tags
[04:00:07.411] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:00:07.411] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:00:07.412] Buildbucket request:
{
"requestId": "8870300552762928144",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-code-coverage"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "849f811b08ad3e46c608f68e84ed0300bc9f3ade",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8870300552762928144"
},
{
"key": "scheduler_job_id",
"value": "chromium/win10-code-coverage"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:00:08.018] Scheduled build:
{
"id": "8704870490825502529",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-code-coverage"
},
"number": 16904,
"createdBy": "project:chromium",
"createTime": "2025-09-02T04:00:07.465967905Z",
"updateTime": "2025-09-02T04:00:07.465967905Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "849f811b08ad3e46c608f68e84ed0300bc9f3ade",
"ref": "refs/heads/main"
}
},
"canary": true
}
[04:00:08.018] Task URL: https://cr-buildbucket.appspot.com/build/8704870490825502529
[04:00:08.018] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:2:0) after 9m3s
[04:00:09.262] Received PubSub notification, asking Buildbucket for the build status
[04:00:09.283] Build status: SCHEDULED
[04:00:16.716] Received PubSub notification, asking Buildbucket for the build status
[04:00:16.735] Build status: STARTED
[04:09:11.138] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:2:0)
[04:09:11.168] Build status: STARTED
[04:09:11.168] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:5:0) after 9m20s
[04:18:31.182] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:5:0)
[04:18:31.217] Build status: STARTED
[04:18:31.217] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:6:0) after 7m44s
[04:26:15.406] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:6:0)
[04:26:15.436] Build status: STARTED
[04:26:15.436] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:7:0) after 9m22s
[04:35:37.738] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:7:0)
[04:35:37.766] Build status: STARTED
[04:35:37.768] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:8:0) after 4m59s
[04:40:36.783] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:8:0)
[04:40:36.804] Build status: STARTED
[04:40:36.804] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:9:0) after 7m35s
[04:48:11.821] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:9:0)
[04:48:11.837] Build status: STARTED
[04:48:11.837] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:10:0) after 1m27s
[04:49:38.854] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:10:0)
[04:49:39.013] Build status: STARTED
[04:49:39.013] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:11:0) after 8m0s
[04:57:39.393] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:11:0)
[04:57:39.408] Build status: STARTED
[04:57:39.408] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:12:0) after 3m36s
[05:01:15.785] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:12:0)
[05:01:15.840] Build status: STARTED
[05:01:15.840] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:13:0) after 8m16s
[05:09:31.854] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:13:0)
[05:09:31.871] Build status: STARTED
[05:09:31.871] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:14:0) after 4m4s
[05:13:35.891] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:14:0)
[05:13:35.968] Build status: STARTED
[05:13:35.968] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:15:0) after 2m27s
[05:16:03.243] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:15:0)
[05:16:03.312] Build status: STARTED
[05:16:03.312] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:16:0) after 7m46s
[05:23:49.441] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:16:0)
[05:23:49.499] Build status: STARTED
[05:23:49.499] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:17:0) after 1m22s
[05:25:11.511] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:17:0)
[05:25:11.529] Build status: STARTED
[05:25:11.529] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:18:0) after 4m5s
[05:29:16.677] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:18:0)
[05:29:16.695] Build status: STARTED
[05:29:16.695] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:19:0) after 7m26s
[05:36:42.711] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:19:0)
[05:36:42.787] Build status: STARTED
[05:36:42.787] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:20:0) after 4m43s
[05:41:25.801] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:20:0)
[05:41:25.816] Build status: STARTED
[05:41:25.816] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:21:0) after 2m41s
[05:44:06.929] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:21:0)
[05:44:06.948] Build status: STARTED
[05:44:06.948] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:22:0) after 4m22s
[05:48:28.980] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:22:0)
[05:48:29.005] Build status: STARTED
[05:48:29.005] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:23:0) after 2m20s
[05:50:49.023] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:23:0)
[05:50:49.075] Build status: STARTED
[05:50:49.075] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:24:0) after 2m1s
[05:52:50.103] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:24:0)
[05:52:50.118] Build status: STARTED
[05:52:50.118] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:25:0) after 8m57s
[06:01:47.109] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:25:0)
[06:01:47.240] Build status: STARTED
[06:01:47.240] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:26:0) after 7m46s
[06:09:33.549] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:26:0)
[06:09:33.641] Build status: STARTED
[06:09:33.641] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:27:0) after 9m39s
[06:19:13.108] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:27:0)
[06:19:13.140] Build status: STARTED
[06:19:13.140] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:28:0) after 4m21s
[06:23:34.323] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:28:0)
[06:23:34.346] Build status: STARTED
[06:23:34.346] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:29:0) after 7m30s
[06:31:04.365] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:29:0)
[06:31:04.380] Build status: STARTED
[06:31:04.380] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:30:0) after 2m7s
[06:33:11.403] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:30:0)
[06:33:11.420] Build status: STARTED
[06:33:11.420] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:31:0) after 2m7s
[06:35:18.535] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:31:0)
[06:35:18.793] Build status: STARTED
[06:35:18.793] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:32:0) after 4m9s
[06:39:27.778] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:32:0)
[06:39:27.799] Build status: STARTED
[06:39:27.799] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:33:0) after 8m51s
[06:48:18.921] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:33:0)
[06:48:18.947] Build status: STARTED
[06:48:18.947] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:34:0) after 5m25s
[06:53:43.964] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:34:0)
[06:53:43.984] Build status: STARTED
[06:53:43.984] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:35:0) after 9m7s
[07:02:51.074] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:35:0)
[07:02:51.101] Build status: STARTED
[07:02:51.101] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:36:0) after 5m54s
[07:08:45.217] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:36:0)
[07:08:45.252] Build status: STARTED
[07:08:45.252] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:37:0) after 1m48s
[07:10:33.561] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:37:0)
[07:10:33.580] Build status: STARTED
[07:10:33.580] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:38:0) after 3m1s
[07:13:34.595] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:38:0)
[07:13:34.611] Build status: STARTED
[07:13:34.611] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:39:0) after 8m13s
[07:21:47.629] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:39:0)
[07:21:47.649] Build status: STARTED
[07:21:47.649] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:40:0) after 1m48s
[07:23:36.325] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:40:0)
[07:23:36.344] Build status: STARTED
[07:23:36.344] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:41:0) after 3m59s
[07:27:35.347] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:41:0)
[07:27:35.362] Build status: STARTED
[07:27:35.362] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:42:0) after 3m10s
[07:30:45.378] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:42:0)
[07:30:45.396] Build status: STARTED
[07:30:45.396] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:43:0) after 1m21s
[07:32:06.472] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:43:0)
[07:32:06.506] Build status: STARTED
[07:32:06.506] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:44:0) after 6m29s
[07:38:35.525] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:44:0)
[07:38:35.539] Build status: STARTED
[07:38:35.539] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:45:0) after 8m25s
[07:47:00.601] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:45:0)
[07:47:00.617] Build status: STARTED
[07:47:00.617] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:46:0) after 3m28s
[07:50:28.775] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:46:0)
[07:50:28.789] Build status: STARTED
[07:50:28.789] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:47:0) after 1m3s
[07:51:31.808] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:47:0)
[07:51:31.874] Build status: STARTED
[07:51:31.874] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:48:0) after 5m14s
[07:56:45.893] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:48:0)
[07:56:45.906] Build status: STARTED
[07:56:45.906] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:49:0) after 3m11s
[07:59:56.926] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:49:0)
[07:59:56.943] Build status: STARTED
[07:59:56.943] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:50:0) after 8m21s
[08:08:17.943] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:50:0)
[08:08:17.969] Build status: STARTED
[08:08:17.970] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:51:0) after 4m7s
[08:12:25.549] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:51:0)
[08:12:25.568] Build status: STARTED
[08:12:25.568] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:52:0) after 8m49s
[08:21:15.042] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:52:0)
[08:21:15.085] Build status: STARTED
[08:21:15.085] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:53:0) after 8m48s
[08:30:03.755] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:53:0)
[08:30:03.775] Build status: STARTED
[08:30:03.775] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:54:0) after 6m46s
[08:36:50.085] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:54:0)
[08:36:50.156] Build status: STARTED
[08:36:50.156] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:55:0) after 1m39s
[08:38:29.172] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:55:0)
[08:38:29.191] Build status: STARTED
[08:38:29.191] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:56:0) after 5m13s
[08:43:42.209] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:56:0)
[08:43:42.259] Build status: STARTED
[08:43:42.259] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:57:0) after 1m49s
[08:45:31.497] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:57:0)
[08:45:31.523] Build status: STARTED
[08:45:31.523] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:58:0) after 8m47s
[08:54:18.646] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:58:0)
[08:54:18.664] Build status: STARTED
[08:54:18.664] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:59:0) after 5m34s
[08:59:52.775] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:59:0)
[08:59:52.793] Build status: STARTED
[08:59:52.793] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:60:0) after 6m57s
[09:06:49.809] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:60:0)
[09:06:49.826] Build status: STARTED
[09:06:49.826] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:61:0) after 1m45s
[09:08:34.853] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:61:0)
[09:08:34.889] Build status: STARTED
[09:08:34.889] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:62:0) after 9m5s
[09:17:39.903] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:62:0)
[09:17:39.935] Build status: STARTED
[09:17:39.935] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:63:0) after 9m23s
[09:27:02.953] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:63:0)
[09:27:02.967] Build status: STARTED
[09:27:02.967] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:64:0) after 9m50s
[09:36:52.989] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:64:0)
[09:36:53.006] Build status: STARTED
[09:36:53.006] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:65:0) after 7m49s
[09:44:42.072] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:65:0)
[09:44:42.090] Build status: STARTED
[09:44:42.090] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:66:0) after 9m2s
[09:53:44.110] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:66:0)
[09:53:44.132] Build status: STARTED
[09:53:44.132] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:67:0) after 4m23s
[09:58:07.178] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:67:0)
[09:58:07.246] Build status: STARTED
[09:58:07.246] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:68:0) after 2m36s
[10:00:43.263] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:68:0)
[10:00:43.312] Build status: STARTED
[10:00:43.312] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:69:0) after 9m3s
[10:09:46.326] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:69:0)
[10:09:46.345] Build status: STARTED
[10:09:46.345] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:70:0) after 4m57s
[10:14:43.377] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:70:0)
[10:14:43.430] Build status: STARTED
[10:14:43.430] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:71:0) after 8m53s
[10:23:36.448] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:71:0)
[10:23:36.477] Build status: STARTED
[10:23:36.477] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:72:0) after 2m23s
[10:25:59.562] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:72:0)
[10:25:59.584] Build status: STARTED
[10:25:59.584] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:73:0) after 9m46s
[10:35:45.597] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:73:0)
[10:35:45.681] Build status: STARTED
[10:35:45.681] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:74:0) after 8m26s
[10:44:11.705] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:74:0)
[10:44:11.776] Build status: STARTED
[10:44:11.777] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:75:0) after 4m27s
[10:48:38.795] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:75:0)
[10:48:38.810] Build status: STARTED
[10:48:38.810] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:76:0) after 9m41s
[10:58:19.829] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:76:0)
[10:58:19.852] Build status: STARTED
[10:58:19.852] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:77:0) after 3m57s
[11:02:16.862] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:77:0)
[11:02:16.878] Build status: STARTED
[11:02:16.878] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:78:0) after 7m43s
[11:09:59.956] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:78:0)
[11:09:59.974] Build status: STARTED
[11:09:59.974] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:79:0) after 4m54s
[11:14:54.023] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:79:0)
[11:14:54.089] Build status: STARTED
[11:14:54.089] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:80:0) after 3m10s
[11:18:04.121] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:80:0)
[11:18:04.140] Build status: STARTED
[11:18:04.140] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:81:0) after 5m46s
[11:23:50.306] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:81:0)
[11:23:50.323] Build status: STARTED
[11:23:50.323] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:82:0) after 4m31s
[11:28:21.340] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:82:0)
[11:28:21.465] Build status: STARTED
[11:28:21.465] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:83:0) after 5m12s
[11:33:33.451] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:83:0)
[11:33:33.465] Build status: STARTED
[11:33:33.465] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:84:0) after 9m21s
[11:42:54.485] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:84:0)
[11:42:54.614] Build status: STARTED
[11:42:54.614] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:85:0) after 9m55s
[11:52:49.671] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:85:0)
[11:52:49.689] Build status: STARTED
[11:52:49.689] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:86:0) after 5m6s
[11:57:55.744] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:86:0)
[11:57:55.765] Build status: STARTED
[11:57:55.765] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:87:0) after 5m49s
[12:03:44.780] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:87:0)
[12:03:44.800] Build status: STARTED
[12:03:44.800] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:88:0) after 3m12s
[12:06:56.846] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:88:0)
[12:06:56.867] Build status: STARTED
[12:06:56.867] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:89:0) after 1m49s
[12:08:45.886] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:89:0)
[12:08:45.949] Build status: STARTED
[12:08:45.949] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:90:0) after 9m55s
[12:18:40.966] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:90:0)
[12:18:40.984] Build status: STARTED
[12:18:40.984] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:91:0) after 7m15s
[12:25:56.001] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:91:0)
[12:25:56.019] Build status: STARTED
[12:25:56.019] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:92:0) after 2m12s
[12:28:08.043] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:92:0)
[12:28:08.060] Build status: STARTED
[12:28:08.060] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:93:0) after 1m16s
[12:29:24.128] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:93:0)
[12:29:24.153] Build status: STARTED
[12:29:24.153] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:94:0) after 1m39s
[12:31:03.173] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:94:0)
[12:31:03.312] Build status: STARTED
[12:31:03.312] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:95:0) after 4m43s
[12:35:46.329] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:95:0)
[12:35:46.354] Build status: STARTED
[12:35:46.354] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:96:0) after 5m9s
[12:40:55.373] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:96:0)
[12:40:55.390] Build status: STARTED
[12:40:55.390] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:97:0) after 9m53s
[12:50:48.412] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:97:0)
[12:50:48.428] Build status: STARTED
[12:50:48.428] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:98:0) after 9m45s
[13:00:33.401] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:98:0)
[13:00:33.484] Build status: STARTED
[13:00:33.484] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:99:0) after 5m41s
[13:06:14.550] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:99:0)
[13:06:14.572] Build status: STARTED
[13:06:14.572] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:100:0) after 1m47s
[13:08:01.589] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:100:0)
[13:08:01.610] Build status: STARTED
[13:08:01.610] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:101:0) after 5m27s
[13:13:28.704] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:101:0)
[13:13:28.784] Build status: STARTED
[13:13:28.784] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:102:0) after 6m29s
[13:19:57.804] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:102:0)
[13:19:57.873] Build status: STARTED
[13:19:57.873] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:103:0) after 8m13s
[13:28:10.930] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:103:0)
[13:28:10.946] Build status: STARTED
[13:28:10.946] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:104:0) after 8m32s
[13:36:43.078] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:104:0)
[13:36:43.101] Build status: STARTED
[13:36:43.102] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:105:0) after 7m6s
[13:43:49.170] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:105:0)
[13:43:49.186] Build status: STARTED
[13:43:49.186] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:106:0) after 9m38s
[13:53:27.215] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:106:0)
[13:53:27.235] Build status: STARTED
[13:53:27.235] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:107:0) after 4m35s
[13:58:02.252] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:107:0)
[13:58:02.270] Build status: STARTED
[13:58:02.270] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:108:0) after 1m30s
[13:59:32.291] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:108:0)
[13:59:32.339] Build status: STARTED
[13:59:32.339] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:109:0) after 7m42s
[14:07:14.404] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:109:0)
[14:07:14.428] Build status: STARTED
[14:07:14.428] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:110:0) after 5m27s
[14:12:41.447] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:110:0)
[14:12:41.463] Build status: STARTED
[14:12:41.463] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8870300552762928144:111:0) after 7m28s
[14:19:38.924] Received PubSub notification, asking Buildbucket for the build status
[14:19:38.993] Build:
{
"id": "8704870490825502529",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-code-coverage"
},
"number": 16904,
"createdBy": "project:chromium",
"createTime": "2025-09-02T04:00:07.465967905Z",
"startTime": "2025-09-02T04:00:15.260779713Z",
"endTime": "2025-09-02T14:19:38.369902918Z",
"updateTime": "2025-09-02T14:19:38.369902918Z",
"status": "INFRA_FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "849f811b08ad3e46c608f68e84ed0300bc9f3ade",
"ref": "refs/heads/main"
}
},
"canary": true
}
[14:19:38.993] Invocation finished in 10h19m32.759716087s with status FAILED