[11:32:45.251] New invocation is queued and will start shortly
[11:32:46.465] Starting the invocation (attempt 1)
[11:32:46.508] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bd065990bb23aaf6e11cf8d05586862c83731a74"
[11:32:46.508] Popped gitiles commit info from properties and tags
[11:32:46.508] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:32:46.508] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:32:46.508] Buildbucket request:
{
"requestId": "8966939037635533824",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "bd065990bb23aaf6e11cf8d05586862c83731a74",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8966939037635533824"
},
{
"key": "scheduler_job_id",
"value": "chromium/Win 10 Fast Ring"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[11:32:47.011] Scheduled build:
{
"id": "8801508975552161361",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 11877,
"createdBy": "project:chromium",
"createTime": "2022-10-01T11:32:46.604981269Z",
"updateTime": "2022-10-01T11:32:46.604981269Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "bd065990bb23aaf6e11cf8d05586862c83731a74",
"ref": "refs/heads/main"
}
}
}
[11:32:47.011] Task URL: https://cr-buildbucket.appspot.com/build/8801508975552161361
[11:32:47.011] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:2:0) after 3m2s
[11:35:49.032] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:2:0)
[11:35:49.072] Build status: SCHEDULED
[11:35:49.073] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:3:0) after 8m28s
[11:40:04.768] Received PubSub notification, asking Buildbucket for the build status
[11:40:04.802] Build status: STARTED
[11:44:17.411] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:3:0)
[11:44:17.439] Build status: STARTED
[11:44:17.439] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:5:0) after 4m32s
[11:48:49.476] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:5:0)
[11:48:49.506] Build status: STARTED
[11:48:49.506] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:6:0) after 6m36s
[11:55:25.541] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:6:0)
[11:55:25.589] Build status: STARTED
[11:55:25.589] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:7:0) after 4m17s
[11:59:42.609] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:7:0)
[11:59:42.641] Build status: STARTED
[11:59:42.641] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:8:0) after 1m25s
[12:01:07.888] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:8:0)
[12:01:07.925] Build status: STARTED
[12:01:07.925] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:9:0) after 7m48s
[12:08:55.974] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:9:0)
[12:08:55.998] Build status: STARTED
[12:08:55.998] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:10:0) after 9m51s
[12:19:16.926] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:10:0)
[12:19:16.952] Build status: STARTED
[12:19:16.953] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:11:0) after 9m44s
[12:29:00.998] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:11:0)
[12:29:01.052] Build status: STARTED
[12:29:01.053] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:12:0) after 7m13s
[12:36:14.075] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:12:0)
[12:36:14.096] Build status: STARTED
[12:36:14.096] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:13:0) after 4m21s
[12:40:35.121] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:13:0)
[12:40:35.146] Build status: STARTED
[12:40:35.146] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:14:0) after 5m55s
[12:46:30.170] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:14:0)
[12:46:30.192] Build status: STARTED
[12:46:30.192] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:15:0) after 7m11s
[12:53:41.218] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:15:0)
[12:53:41.245] Build status: STARTED
[12:53:41.245] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:16:0) after 9m37s
[13:03:18.291] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:16:0)
[13:03:18.320] Build status: STARTED
[13:03:18.320] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:17:0) after 4m35s
[13:07:53.349] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:17:0)
[13:07:53.377] Build status: STARTED
[13:07:53.377] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:18:0) after 2m1s
[13:09:54.397] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:18:0)
[13:09:55.102] Build status: STARTED
[13:09:55.102] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:19:0) after 7m32s
[13:17:27.128] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:19:0)
[13:17:27.154] Build status: STARTED
[13:17:27.154] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:20:0) after 6m32s
[13:23:59.595] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:20:0)
[13:23:59.620] Build status: STARTED
[13:23:59.620] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:21:0) after 6m31s
[13:30:30.643] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:21:0)
[13:30:30.668] Build status: STARTED
[13:30:30.668] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:22:0) after 2m24s
[13:32:54.733] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:22:0)
[13:32:54.914] Build status: STARTED
[13:32:54.914] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:23:0) after 3m12s
[13:36:06.937] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:23:0)
[13:36:06.961] Build status: STARTED
[13:36:06.961] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:24:0) after 3m34s
[13:39:40.981] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:24:0)
[13:39:41.003] Build status: STARTED
[13:39:41.003] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:25:0) after 2m48s
[13:42:29.929] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:25:0)
[13:42:30.032] Build status: STARTED
[13:42:30.033] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:26:0) after 3m56s
[13:46:26.397] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:26:0)
[13:46:26.419] Build status: STARTED
[13:46:26.419] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:27:0) after 6m3s
[13:52:29.714] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:27:0)
[13:52:29.741] Build status: STARTED
[13:52:29.741] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:28:0) after 8m54s
[14:01:23.765] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:28:0)
[14:01:23.791] Build status: STARTED
[14:01:23.791] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:29:0) after 7m52s
[14:09:16.061] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:29:0)
[14:09:16.094] Build status: STARTED
[14:09:16.094] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:30:0) after 4m14s
[14:13:30.117] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:30:0)
[14:13:30.146] Build status: STARTED
[14:13:30.146] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:31:0) after 6m22s
[14:19:52.169] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:31:0)
[14:19:52.192] Build status: STARTED
[14:19:52.192] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:32:0) after 5m2s
[14:24:54.416] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:32:0)
[14:24:54.439] Build status: STARTED
[14:24:54.439] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:33:0) after 9m3s
[14:33:57.462] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:33:0)
[14:33:57.502] Build status: STARTED
[14:33:57.502] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:34:0) after 8m0s
[14:41:57.529] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:34:0)
[14:41:57.560] Build status: STARTED
[14:41:57.560] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:35:0) after 2m8s
[14:44:06.007] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:35:0)
[14:44:06.032] Build status: STARTED
[14:44:06.032] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:36:0) after 7m36s
[14:51:42.068] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:36:0)
[14:51:42.089] Build status: STARTED
[14:51:42.089] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:37:0) after 5m16s
[14:56:58.211] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:37:0)
[14:56:58.236] Build status: STARTED
[14:56:58.236] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:38:0) after 7m8s
[15:04:06.273] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:38:0)
[15:04:06.296] Build status: STARTED
[15:04:06.296] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:39:0) after 4m6s
[15:08:12.395] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:39:0)
[15:08:12.422] Build status: STARTED
[15:08:12.422] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:40:0) after 7m51s
[15:16:03.470] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:40:0)
[15:16:03.513] Build status: STARTED
[15:16:03.513] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:41:0) after 6m51s
[15:22:54.587] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:41:0)
[15:22:54.610] Build status: STARTED
[15:22:54.611] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:42:0) after 5m43s
[15:28:37.643] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:42:0)
[15:28:37.665] Build status: STARTED
[15:28:37.665] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:43:0) after 4m51s
[15:33:28.687] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:43:0)
[15:33:28.715] Build status: STARTED
[15:33:28.715] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:44:0) after 8m11s
[15:41:39.740] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:44:0)
[15:41:39.768] Build status: STARTED
[15:41:39.768] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:45:0) after 5m47s
[15:47:26.791] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:45:0)
[15:47:26.822] Build status: STARTED
[15:47:26.822] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:46:0) after 4m58s
[15:52:25.034] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:46:0)
[15:52:25.059] Build status: STARTED
[15:52:25.059] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:47:0) after 1m36s
[15:54:01.084] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:47:0)
[15:54:01.107] Build status: STARTED
[15:54:01.107] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:48:0) after 9m34s
[16:03:35.196] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:48:0)
[16:03:35.224] Build status: STARTED
[16:03:35.224] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:49:0) after 5m23s
[16:08:58.420] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:49:0)
[16:08:58.449] Build status: STARTED
[16:08:58.449] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:50:0) after 7m24s
[16:16:22.695] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:50:0)
[16:16:22.800] Build status: STARTED
[16:16:22.800] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:51:0) after 7m34s
[16:23:56.828] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:51:0)
[16:23:56.854] Build status: STARTED
[16:23:56.855] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:52:0) after 9m28s
[16:33:24.884] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:52:0)
[16:33:24.911] Build status: STARTED
[16:33:24.911] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:53:0) after 8m27s
[16:41:51.931] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:53:0)
[16:41:51.958] Build status: STARTED
[16:41:51.958] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:54:0) after 5m50s
[16:47:42.365] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:54:0)
[16:47:42.411] Build status: STARTED
[16:47:42.411] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:55:0) after 9m26s
[16:57:08.435] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:55:0)
[16:57:08.462] Build status: STARTED
[16:57:08.462] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:56:0) after 6m0s
[17:03:08.496] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:56:0)
[17:03:08.519] Build status: STARTED
[17:03:08.519] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:57:0) after 4m38s
[17:07:46.542] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:57:0)
[17:07:46.570] Build status: STARTED
[17:07:46.570] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:58:0) after 5m51s
[17:13:37.837] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:58:0)
[17:13:37.873] Build status: STARTED
[17:13:37.873] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:59:0) after 4m9s
[17:17:46.905] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:59:0)
[17:17:46.932] Build status: STARTED
[17:17:46.932] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:60:0) after 4m13s
[17:21:59.965] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:60:0)
[17:21:59.991] Build status: STARTED
[17:21:59.991] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:61:0) after 7m50s
[17:29:50.013] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:61:0)
[17:29:50.055] Build status: STARTED
[17:29:50.056] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:62:0) after 5m51s
[17:35:41.145] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:62:0)
[17:35:41.179] Build status: STARTED
[17:35:41.179] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:63:0) after 1m36s
[17:37:17.203] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:63:0)
[17:37:17.231] Build status: STARTED
[17:37:17.231] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:64:0) after 2m0s
[17:39:17.342] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:64:0)
[17:39:17.399] Build status: STARTED
[17:39:17.399] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:65:0) after 4m58s
[17:44:15.421] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:65:0)
[17:44:15.444] Build status: STARTED
[17:44:15.444] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:66:0) after 8m6s
[17:52:21.737] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:66:0)
[17:52:21.761] Build status: STARTED
[17:52:21.761] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:67:0) after 1m34s
[17:53:55.786] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:67:0)
[17:53:55.813] Build status: STARTED
[17:53:55.813] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:68:0) after 8m35s
[18:02:30.838] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:68:0)
[18:02:30.866] Build status: STARTED
[18:02:30.866] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:69:0) after 7m3s
[18:09:34.043] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:69:0)
[18:09:34.072] Build status: STARTED
[18:09:34.072] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:70:0) after 4m40s
[18:14:14.100] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:70:0)
[18:14:14.127] Build status: STARTED
[18:14:14.127] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:71:0) after 2m10s
[18:16:24.156] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:71:0)
[18:16:24.185] Build status: STARTED
[18:16:24.185] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:72:0) after 7m16s
[18:23:40.731] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:72:0)
[18:23:40.762] Build status: STARTED
[18:23:40.762] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:73:0) after 6m12s
[18:29:52.861] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:73:0)
[18:29:52.912] Build status: STARTED
[18:29:52.912] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:74:0) after 8m8s
[18:38:00.939] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:74:0)
[18:38:00.969] Build status: STARTED
[18:38:00.969] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:75:0) after 2m10s
[18:40:11.036] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:75:0)
[18:40:11.062] Build status: STARTED
[18:40:11.062] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:76:0) after 3m26s
[18:43:37.092] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:76:0)
[18:43:37.113] Build status: STARTED
[18:43:37.113] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:77:0) after 2m44s
[18:46:21.139] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:77:0)
[18:46:21.169] Build status: STARTED
[18:46:21.169] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:78:0) after 4m23s
[18:50:44.343] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:78:0)
[18:50:44.366] Build status: STARTED
[18:50:44.366] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:79:0) after 3m45s
[18:54:29.762] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:79:0)
[18:54:29.790] Build status: STARTED
[18:54:29.790] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:80:0) after 9m21s
[19:03:50.821] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:80:0)
[19:03:50.851] Build status: STARTED
[19:03:50.851] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:81:0) after 8m44s
[19:12:34.906] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:81:0)
[19:12:34.939] Build status: STARTED
[19:12:34.939] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:82:0) after 3m11s
[19:15:46.168] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:82:0)
[19:15:46.197] Build status: STARTED
[19:15:46.197] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:83:0) after 1m48s
[19:17:34.243] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:83:0)
[19:17:34.270] Build status: STARTED
[19:17:34.270] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:84:0) after 8m50s
[19:26:24.604] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:84:0)
[19:26:24.634] Build status: STARTED
[19:26:24.634] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:85:0) after 9m14s
[19:35:38.664] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:85:0)
[19:35:38.697] Build status: STARTED
[19:35:38.697] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:86:0) after 5m33s
[19:41:11.729] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:86:0)
[19:41:11.754] Build status: STARTED
[19:41:11.754] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:87:0) after 7m37s
[19:48:49.848] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:87:0)
[19:48:49.874] Build status: STARTED
[19:48:49.874] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:88:0) after 4m44s
[19:53:33.905] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:88:0)
[19:53:33.945] Build status: STARTED
[19:53:33.945] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:89:0) after 4m21s
[19:57:54.975] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:89:0)
[19:57:55.001] Build status: STARTED
[19:57:55.001] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:90:0) after 9m9s
[20:07:04.366] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:90:0)
[20:07:04.390] Build status: STARTED
[20:07:04.390] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:91:0) after 8m37s
[20:15:41.445] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:91:0)
[20:15:41.465] Build status: STARTED
[20:15:41.466] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:92:0) after 7m29s
[20:23:10.489] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:92:0)
[20:23:10.512] Build status: STARTED
[20:23:10.512] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:93:0) after 3m33s
[20:26:43.545] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:93:0)
[20:26:43.567] Build status: STARTED
[20:26:43.567] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:94:0) after 7m19s
[20:34:02.604] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:94:0)
[20:34:02.650] Build status: STARTED
[20:34:02.650] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:95:0) after 8m19s
[20:42:21.677] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:95:0)
[20:42:21.700] Build status: STARTED
[20:42:21.700] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:96:0) after 5m4s
[20:47:25.732] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:96:0)
[20:47:25.752] Build status: STARTED
[20:47:25.752] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:97:0) after 1m4s
[20:48:29.779] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:97:0)
[20:48:29.822] Build status: STARTED
[20:48:29.822] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:98:0) after 6m25s
[20:54:54.987] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:98:0)
[20:54:55.011] Build status: STARTED
[20:54:55.011] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:99:0) after 7m23s
[21:02:18.016] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:99:0)
[21:02:18.049] Build status: STARTED
[21:02:18.049] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:100:0) after 3m29s
[21:05:47.414] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:100:0)
[21:05:47.437] Build status: STARTED
[21:05:47.437] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:101:0) after 9m27s
[21:15:14.494] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:101:0)
[21:15:14.517] Build status: STARTED
[21:15:14.517] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:102:0) after 2m21s
[21:17:35.544] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:102:0)
[21:17:35.567] Build status: STARTED
[21:17:35.567] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:103:0) after 2m37s
[21:20:12.594] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:103:0)
[21:20:12.623] Build status: STARTED
[21:20:12.623] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:104:0) after 3m21s
[21:23:33.749] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:104:0)
[21:23:33.773] Build status: STARTED
[21:23:33.773] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:105:0) after 6m44s
[21:30:17.809] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:105:0)
[21:30:17.831] Build status: STARTED
[21:30:17.832] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:106:0) after 5m45s
[21:36:02.900] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:106:0)
[21:36:02.926] Build status: STARTED
[21:36:02.926] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8966939037635533824:107:0) after 7m43s
[21:40:21.267] Received PubSub notification, asking Buildbucket for the build status
[21:40:21.288] Build:
{
"id": "8801508975552161361",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 11877,
"createdBy": "project:chromium",
"createTime": "2022-10-01T11:32:46.604981269Z",
"startTime": "2022-10-01T11:40:04.283657Z",
"endTime": "2022-10-01T21:40:21.020915604Z",
"updateTime": "2022-10-01T21:40:21.020915604Z",
"status": "CANCELED",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "bd065990bb23aaf6e11cf8d05586862c83731a74",
"ref": "refs/heads/main"
}
}
}
[21:40:21.288] Invocation finished in 10h7m36.054697868s with status ABORTED