[09:34:06.817] New invocation is queued and will start shortly
[09:34:07.874] Starting the invocation (attempt 1)
[09:34:07.918] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6af88ef002cb62086078a7c7d39822d02c9ab6a8"
[09:34:07.918] Popped gitiles commit info from properties and tags
[09:34:07.918] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:34:07.918] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:34:07.918] Buildbucket request:
{
"requestId": "8960604714196784848",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6af88ef002cb62086078a7c7d39822d02c9ab6a8",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8960604714196784848"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTWin64"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[09:34:08.387] Scheduled build:
{
"id": "8795174652310365921",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"number": 2896,
"createdBy": "project:chromium",
"createTime": "2022-12-10T09:34:07.992500906Z",
"updateTime": "2022-12-10T09:34:07.992500906Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6af88ef002cb62086078a7c7d39822d02c9ab6a8",
"ref": "refs/heads/main"
}
},
"canary": true
}
[09:34:08.387] Task URL: https://cr-buildbucket.appspot.com/build/8795174652310365921
[09:34:08.387] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:2:0) after 4m35s
[09:34:16.102] Received PubSub notification, asking Buildbucket for the build status
[09:34:16.126] Build status: STARTED
[09:38:43.406] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:2:0)
[09:38:43.430] Build status: STARTED
[09:38:43.430] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:4:0) after 4m1s
[09:42:44.450] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:4:0)
[09:42:44.473] Build status: STARTED
[09:42:44.473] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:5:0) after 9m29s
[09:52:13.493] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:5:0)
[09:52:13.514] Build status: STARTED
[09:52:13.514] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:6:0) after 5m18s
[09:57:31.532] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:6:0)
[09:57:31.560] Build status: STARTED
[09:57:31.560] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:7:0) after 7m47s
[10:05:18.579] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:7:0)
[10:05:18.613] Build status: STARTED
[10:05:18.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:8:0) after 6m27s
[10:11:46.061] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:8:0)
[10:11:46.088] Build status: STARTED
[10:11:46.088] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:9:0) after 2m23s
[10:14:09.389] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:9:0)
[10:14:09.425] Build status: STARTED
[10:14:09.425] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:10:0) after 1m48s
[10:15:57.452] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:10:0)
[10:15:57.513] Build status: STARTED
[10:15:57.513] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:11:0) after 4m22s
[10:20:19.532] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:11:0)
[10:20:19.554] Build status: STARTED
[10:20:19.554] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:12:0) after 1m12s
[10:21:31.570] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:12:0)
[10:21:31.594] Build status: STARTED
[10:21:31.595] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:13:0) after 9m37s
[10:31:08.754] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:13:0)
[10:31:08.784] Build status: STARTED
[10:31:08.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:14:0) after 8m52s
[10:40:00.980] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:14:0)
[10:40:01.027] Build status: STARTED
[10:40:01.027] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:15:0) after 8m3s
[10:48:04.028] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:15:0)
[10:48:04.057] Build status: STARTED
[10:48:04.057] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:16:0) after 9m42s
[10:57:46.404] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:16:0)
[10:57:46.434] Build status: STARTED
[10:57:46.434] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:17:0) after 5m1s
[11:02:47.590] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:17:0)
[11:02:47.618] Build status: STARTED
[11:02:47.618] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:18:0) after 6m14s
[11:09:01.733] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:18:0)
[11:09:01.755] Build status: STARTED
[11:09:01.755] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:19:0) after 8m56s
[11:17:57.924] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:19:0)
[11:17:57.943] Build status: STARTED
[11:17:57.943] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:20:0) after 7m48s
[11:25:46.439] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:20:0)
[11:25:46.465] Build status: STARTED
[11:25:46.465] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:21:0) after 8m53s
[11:34:39.481] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:21:0)
[11:34:39.505] Build status: STARTED
[11:34:39.505] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:22:0) after 7m16s
[11:41:55.523] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:22:0)
[11:41:55.549] Build status: STARTED
[11:41:55.549] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:23:0) after 7m35s
[11:49:30.613] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:23:0)
[11:49:30.640] Build status: STARTED
[11:49:30.640] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:24:0) after 4m54s
[11:54:24.658] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:24:0)
[11:54:24.679] Build status: STARTED
[11:54:24.679] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:25:0) after 3m14s
[11:57:38.704] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:25:0)
[11:57:38.731] Build status: STARTED
[11:57:38.731] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:26:0) after 6m7s
[12:03:45.752] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:26:0)
[12:03:45.792] Build status: STARTED
[12:03:45.792] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:27:0) after 2m33s
[12:06:18.818] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:27:0)
[12:06:18.843] Build status: STARTED
[12:06:18.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:28:0) after 7m40s
[12:13:58.868] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:28:0)
[12:13:58.894] Build status: STARTED
[12:13:58.894] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:29:0) after 6m20s
[12:20:18.914] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:29:0)
[12:20:18.950] Build status: STARTED
[12:20:18.950] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:30:0) after 7m2s
[12:27:20.976] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:30:0)
[12:27:21.017] Build status: STARTED
[12:27:21.017] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:31:0) after 6m43s
[12:34:04.036] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:31:0)
[12:34:04.066] Build status: STARTED
[12:34:04.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:32:0) after 2m24s
[12:36:28.087] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:32:0)
[12:36:28.108] Build status: STARTED
[12:36:28.108] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:33:0) after 9m13s
[12:45:41.126] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:33:0)
[12:45:41.152] Build status: STARTED
[12:45:41.152] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:34:0) after 1m26s
[12:47:07.179] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:34:0)
[12:47:07.203] Build status: STARTED
[12:47:07.203] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:35:0) after 4m29s
[12:51:36.224] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:35:0)
[12:51:36.248] Build status: STARTED
[12:51:36.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:36:0) after 2m26s
[12:54:02.463] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:36:0)
[12:54:02.488] Build status: STARTED
[12:54:02.488] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:37:0) after 5m44s
[12:59:46.542] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:37:0)
[12:59:46.623] Build status: STARTED
[12:59:46.623] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:38:0) after 9m46s
[13:09:32.915] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:38:0)
[13:09:32.938] Build status: STARTED
[13:09:32.938] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:39:0) after 3m22s
[13:12:54.956] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:39:0)
[13:12:54.986] Build status: STARTED
[13:12:54.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:40:0) after 2m44s
[13:15:39.014] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:40:0)
[13:15:39.050] Build status: STARTED
[13:15:39.050] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:41:0) after 4m34s
[13:20:13.436] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:41:0)
[13:20:13.478] Build status: STARTED
[13:20:13.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:42:0) after 2m47s
[13:23:00.957] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:42:0)
[13:23:00.984] Build status: STARTED
[13:23:00.984] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:43:0) after 8m24s
[13:31:25.201] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:43:0)
[13:31:25.223] Build status: STARTED
[13:31:25.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:44:0) after 2m29s
[13:33:55.040] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:44:0)
[13:33:55.112] Build status: STARTED
[13:33:55.112] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:45:0) after 6m56s
[13:40:51.449] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:45:0)
[13:40:51.476] Build status: STARTED
[13:40:51.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:46:0) after 4m46s
[13:45:37.748] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:46:0)
[13:45:37.775] Build status: STARTED
[13:45:37.775] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:47:0) after 8m13s
[13:53:50.803] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:47:0)
[13:53:50.838] Build status: STARTED
[13:53:50.838] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:48:0) after 3m18s
[13:57:09.933] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:48:0)
[13:57:09.956] Build status: STARTED
[13:57:09.956] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:49:0) after 5m45s
[14:02:54.934] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:49:0)
[14:02:54.960] Build status: STARTED
[14:02:54.960] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:50:0) after 7m54s
[14:10:48.985] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:50:0)
[14:10:49.012] Build status: STARTED
[14:10:49.012] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:51:0) after 4m55s
[14:15:44.044] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:51:0)
[14:15:44.069] Build status: STARTED
[14:15:44.069] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:52:0) after 3m34s
[14:19:18.129] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:52:0)
[14:19:18.155] Build status: STARTED
[14:19:18.156] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:53:0) after 5m58s
[14:25:16.208] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:53:0)
[14:25:16.365] Build status: STARTED
[14:25:16.365] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:54:0) after 8m0s
[14:33:16.388] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:54:0)
[14:33:16.416] Build status: STARTED
[14:33:16.416] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:55:0) after 8m7s
[14:41:23.505] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:55:0)
[14:41:23.530] Build status: STARTED
[14:41:23.530] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:56:0) after 7m33s
[14:48:56.619] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:56:0)
[14:48:56.647] Build status: STARTED
[14:48:56.647] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:57:0) after 4m26s
[14:53:22.680] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:57:0)
[14:53:22.698] Build status: STARTED
[14:53:22.698] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:58:0) after 5m38s
[14:59:00.923] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:58:0)
[14:59:00.949] Build status: STARTED
[14:59:00.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:59:0) after 1m6s
[15:00:06.968] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:59:0)
[15:00:07.020] Build status: STARTED
[15:00:07.020] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:60:0) after 9m10s
[15:09:17.042] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:60:0)
[15:09:17.066] Build status: STARTED
[15:09:17.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:61:0) after 6m55s
[15:16:12.191] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:61:0)
[15:16:12.212] Build status: STARTED
[15:16:12.212] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:62:0) after 6m51s
[15:23:03.232] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:62:0)
[15:23:03.255] Build status: STARTED
[15:23:03.255] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:63:0) after 7m3s
[15:30:06.470] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:63:0)
[15:30:06.495] Build status: STARTED
[15:30:06.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:64:0) after 6m6s
[15:36:12.644] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:64:0)
[15:36:12.687] Build status: STARTED
[15:36:12.687] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:65:0) after 6m31s
[15:42:43.716] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:65:0)
[15:42:43.737] Build status: STARTED
[15:42:43.737] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:66:0) after 9m2s
[15:51:45.759] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:66:0)
[15:51:45.784] Build status: STARTED
[15:51:45.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:67:0) after 6m11s
[15:57:56.802] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:67:0)
[15:57:56.851] Build status: STARTED
[15:57:56.851] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:68:0) after 8m38s
[16:06:35.160] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:68:0)
[16:06:35.205] Build status: STARTED
[16:06:35.205] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:69:0) after 4m29s
[16:11:04.425] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:69:0)
[16:11:04.459] Build status: STARTED
[16:11:04.459] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:70:0) after 3m56s
[16:15:00.534] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:70:0)
[16:15:00.559] Build status: STARTED
[16:15:00.559] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:71:0) after 7m34s
[16:22:34.579] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:71:0)
[16:22:34.599] Build status: STARTED
[16:22:34.599] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:72:0) after 5m57s
[16:28:31.615] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:72:0)
[16:28:31.638] Build status: STARTED
[16:28:31.638] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:73:0) after 9m52s
[16:38:24.221] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:73:0)
[16:38:24.247] Build status: STARTED
[16:38:24.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:74:0) after 8m4s
[16:46:28.461] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:74:0)
[16:46:28.482] Build status: STARTED
[16:46:28.482] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:75:0) after 1m39s
[16:48:07.544] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:75:0)
[16:48:07.568] Build status: STARTED
[16:48:07.568] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:76:0) after 5m9s
[16:53:16.587] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:76:0)
[16:53:16.623] Build status: STARTED
[16:53:16.623] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:77:0) after 9m25s
[17:02:41.655] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:77:0)
[17:02:41.682] Build status: STARTED
[17:02:41.682] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:78:0) after 5m18s
[17:07:59.703] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:78:0)
[17:07:59.725] Build status: STARTED
[17:07:59.725] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:79:0) after 6m23s
[17:14:22.755] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:79:0)
[17:14:22.780] Build status: STARTED
[17:14:22.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:80:0) after 5m15s
[17:19:37.806] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:80:0)
[17:19:37.840] Build status: STARTED
[17:19:37.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:81:0) after 8m47s
[17:28:24.859] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:81:0)
[17:28:24.883] Build status: STARTED
[17:28:24.883] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:82:0) after 3m53s
[17:32:17.931] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:82:0)
[17:32:17.989] Build status: STARTED
[17:32:17.989] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:83:0) after 2m10s
[17:34:28.355] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:83:0)
[17:34:28.381] Build status: STARTED
[17:34:28.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:84:0) after 6m51s
[17:41:19.405] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:84:0)
[17:41:19.430] Build status: STARTED
[17:41:19.430] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:85:0) after 1m29s
[17:42:48.451] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:85:0)
[17:42:48.480] Build status: STARTED
[17:42:48.480] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:86:0) after 9m10s
[17:51:58.504] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:86:0)
[17:51:58.528] Build status: STARTED
[17:51:58.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:87:0) after 1m17s
[17:53:15.831] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:87:0)
[17:53:15.857] Build status: STARTED
[17:53:15.857] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:88:0) after 8m48s
[18:02:03.877] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:88:0)
[18:02:03.901] Build status: STARTED
[18:02:03.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:89:0) after 5m56s
[18:08:00.042] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:89:0)
[18:08:00.073] Build status: STARTED
[18:08:00.073] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:90:0) after 7m51s
[18:15:51.168] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:90:0)
[18:15:51.193] Build status: STARTED
[18:15:51.193] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:91:0) after 8m32s
[18:24:23.219] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:91:0)
[18:24:23.247] Build status: STARTED
[18:24:23.247] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:92:0) after 9m26s
[18:33:49.287] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:92:0)
[18:33:49.357] Build status: STARTED
[18:33:49.358] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:93:0) after 7m46s
[18:41:35.376] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:93:0)
[18:41:35.399] Build status: STARTED
[18:41:35.399] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:94:0) after 1m30s
[18:43:05.421] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:94:0)
[18:43:05.443] Build status: STARTED
[18:43:05.443] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:95:0) after 6m20s
[18:49:25.613] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:95:0)
[18:49:25.641] Build status: STARTED
[18:49:25.641] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8960604714196784848:96:0) after 8m29s
[18:53:14.987] Received PubSub notification, asking Buildbucket for the build status
[18:53:15.034] Build:
{
"id": "8795174652310365921",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"number": 2896,
"createdBy": "project:chromium",
"createTime": "2022-12-10T09:34:07.992500906Z",
"startTime": "2022-12-10T09:34:15.500927Z",
"endTime": "2022-12-10T18:53:14.522416747Z",
"updateTime": "2022-12-10T18:53:14.522416747Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6af88ef002cb62086078a7c7d39822d02c9ab6a8",
"ref": "refs/heads/main"
}
},
"canary": true
}
[18:53:15.034] Invocation finished in 9h19m8.22458967s with status SUCCEEDED