[06:40:08.063] New invocation is queued and will start shortly
[06:40:09.134] Starting the invocation (attempt 1)
[06:40:09.165] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5f6904bd01bec615f7fff1575f2c9ac13af91de1"
[06:40:09.165] Popped gitiles commit info from properties and tags
[06:40:09.165] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:40:09.165] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:40:09.166] Buildbucket request:
{
"requestId": "8936607463925134224",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5f6904bd01bec615f7fff1575f2c9ac13af91de1",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8936607463925134224"
},
{
"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"
}
}
[06:40:09.813] Scheduled build:
{
"id": "8771177402052968433",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"number": 4572,
"createdBy": "project:chromium",
"createTime": "2023-09-01T06:40:09.227118875Z",
"updateTime": "2023-09-01T06:40:09.227118875Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5f6904bd01bec615f7fff1575f2c9ac13af91de1",
"ref": "refs/heads/main"
}
}
}
[06:40:09.813] Task URL: https://cr-buildbucket.appspot.com/build/8771177402052968433
[06:40:09.813] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:2:0) after 1m52s
[06:40:10.699] Received PubSub notification, asking Buildbucket for the build status
[06:40:10.728] Build status: SCHEDULED
[06:42:02.127] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:2:0)
[06:42:02.157] Build status: SCHEDULED
[06:42:02.157] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:4:0) after 3m2s
[06:45:04.553] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:4:0)
[06:45:04.573] Build status: SCHEDULED
[06:45:04.573] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:5:0) after 7m11s
[06:45:31.523] Received PubSub notification, asking Buildbucket for the build status
[06:45:31.624] Build status: STARTED
[06:52:15.645] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:5:0)
[06:52:15.681] Build status: STARTED
[06:52:15.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:7:0) after 8m7s
[07:00:22.702] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:7:0)
[07:00:22.724] Build status: STARTED
[07:00:22.724] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:8:0) after 5m53s
[07:06:15.780] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:8:0)
[07:06:15.853] Build status: STARTED
[07:06:15.853] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:9:0) after 2m40s
[07:08:56.012] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:9:0)
[07:08:56.038] Build status: STARTED
[07:08:56.038] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:10:0) after 2m22s
[07:11:18.036] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:10:0)
[07:11:18.115] Build status: STARTED
[07:11:18.115] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:11:0) after 3m1s
[07:14:19.185] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:11:0)
[07:14:19.232] Build status: STARTED
[07:14:19.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:12:0) after 4m35s
[07:18:54.350] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:12:0)
[07:18:54.371] Build status: STARTED
[07:18:54.371] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:13:0) after 1m42s
[07:20:36.382] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:13:0)
[07:20:36.466] Build status: STARTED
[07:20:36.466] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:14:0) after 7m32s
[07:28:08.492] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:14:0)
[07:28:08.522] Build status: STARTED
[07:28:08.522] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:15:0) after 1m19s
[07:29:27.553] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:15:0)
[07:29:27.575] Build status: STARTED
[07:29:27.575] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:16:0) after 4m45s
[07:34:12.641] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:16:0)
[07:34:12.670] Build status: STARTED
[07:34:12.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:17:0) after 3m44s
[07:37:56.722] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:17:0)
[07:37:56.763] Build status: STARTED
[07:37:56.763] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:18:0) after 6m0s
[07:43:56.815] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:18:0)
[07:43:56.860] Build status: STARTED
[07:43:56.860] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:19:0) after 8m46s
[07:52:43.088] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:19:0)
[07:52:43.113] Build status: STARTED
[07:52:43.113] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:20:0) after 1m46s
[07:54:29.563] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:20:0)
[07:54:29.580] Build status: STARTED
[07:54:29.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:21:0) after 4m30s
[07:58:59.723] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:21:0)
[07:58:59.739] Build status: STARTED
[07:58:59.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:22:0) after 4m21s
[08:03:20.791] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:22:0)
[08:03:20.856] Build status: STARTED
[08:03:20.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:23:0) after 1m18s
[08:04:38.878] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:23:0)
[08:04:38.901] Build status: STARTED
[08:04:38.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:24:0) after 6m29s
[08:11:08.151] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:24:0)
[08:11:08.169] Build status: STARTED
[08:11:08.169] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:25:0) after 4m45s
[08:15:53.321] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:25:0)
[08:15:53.339] Build status: STARTED
[08:15:53.339] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:26:0) after 7m41s
[08:23:34.365] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:26:0)
[08:23:34.383] Build status: STARTED
[08:23:34.383] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:27:0) after 1m55s
[08:25:29.425] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:27:0)
[08:25:29.450] Build status: STARTED
[08:25:29.450] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:28:0) after 6m55s
[08:32:24.655] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:28:0)
[08:32:24.694] Build status: STARTED
[08:32:24.694] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:29:0) after 1m4s
[08:33:28.826] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:29:0)
[08:33:28.843] Build status: STARTED
[08:33:28.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:30:0) after 2m48s
[08:36:17.139] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:30:0)
[08:36:17.179] Build status: STARTED
[08:36:17.179] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:31:0) after 2m3s
[08:38:20.278] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:31:0)
[08:38:20.298] Build status: STARTED
[08:38:20.298] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:32:0) after 3m7s
[08:41:27.340] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:32:0)
[08:41:27.366] Build status: STARTED
[08:41:27.366] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:33:0) after 2m0s
[08:43:27.386] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:33:0)
[08:43:27.404] Build status: STARTED
[08:43:27.404] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:34:0) after 5m1s
[08:48:28.565] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:34:0)
[08:48:28.592] Build status: STARTED
[08:48:28.592] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:35:0) after 5m50s
[08:54:18.615] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:35:0)
[08:54:18.632] Build status: STARTED
[08:54:18.632] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:36:0) after 8m26s
[09:02:44.632] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:36:0)
[09:02:44.787] Build status: STARTED
[09:02:44.787] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:37:0) after 3m22s
[09:06:06.811] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:37:0)
[09:06:06.834] Build status: STARTED
[09:06:06.835] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:38:0) after 8m35s
[09:14:41.938] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:38:0)
[09:14:41.983] Build status: STARTED
[09:14:41.983] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:39:0) after 2m26s
[09:17:08.061] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:39:0)
[09:17:08.129] Build status: STARTED
[09:17:08.129] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:40:0) after 9m44s
[09:26:52.375] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:40:0)
[09:26:52.398] Build status: STARTED
[09:26:52.398] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:41:0) after 1m25s
[09:28:17.426] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:41:0)
[09:28:17.444] Build status: STARTED
[09:28:17.444] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:42:0) after 3m56s
[09:32:13.468] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:42:0)
[09:32:13.499] Build status: STARTED
[09:32:13.499] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:43:0) after 4m46s
[09:36:59.678] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:43:0)
[09:36:59.724] Build status: STARTED
[09:36:59.724] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:44:0) after 5m27s
[09:42:27.048] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:44:0)
[09:42:27.170] Build status: STARTED
[09:42:27.170] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:45:0) after 3m20s
[09:45:47.194] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:45:0)
[09:45:47.210] Build status: STARTED
[09:45:47.210] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:46:0) after 9m4s
[09:54:51.302] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:46:0)
[09:54:51.318] Build status: STARTED
[09:54:51.318] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:47:0) after 3m55s
[09:58:46.478] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:47:0)
[09:58:46.500] Build status: STARTED
[09:58:46.500] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:48:0) after 4m17s
[10:03:03.646] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:48:0)
[10:03:03.666] Build status: STARTED
[10:03:03.666] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:49:0) after 4m17s
[10:07:20.866] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:49:0)
[10:07:20.896] Build status: STARTED
[10:07:20.896] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:50:0) after 4m6s
[10:11:26.964] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:50:0)
[10:11:26.990] Build status: STARTED
[10:11:26.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:51:0) after 5m12s
[10:16:39.020] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:51:0)
[10:16:39.096] Build status: STARTED
[10:16:39.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:52:0) after 3m33s
[10:20:12.119] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:52:0)
[10:20:12.142] Build status: STARTED
[10:20:12.142] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:53:0) after 9m45s
[10:29:57.167] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:53:0)
[10:29:57.200] Build status: STARTED
[10:29:57.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:54:0) after 9m23s
[10:39:20.275] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:54:0)
[10:39:20.292] Build status: STARTED
[10:39:20.292] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:55:0) after 3m4s
[10:42:24.433] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:55:0)
[10:42:24.457] Build status: STARTED
[10:42:24.457] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:56:0) after 4m22s
[10:46:46.550] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:56:0)
[10:46:46.627] Build status: STARTED
[10:46:46.627] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:57:0) after 9m21s
[10:56:07.652] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:57:0)
[10:56:07.670] Build status: STARTED
[10:56:07.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:58:0) after 7m37s
[11:03:44.717] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:58:0)
[11:03:44.740] Build status: STARTED
[11:03:44.740] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:59:0) after 3m47s
[11:07:31.829] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:59:0)
[11:07:31.855] Build status: STARTED
[11:07:31.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:60:0) after 2m21s
[11:09:52.947] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:60:0)
[11:09:52.964] Build status: STARTED
[11:09:52.964] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:61:0) after 5m23s
[11:15:15.961] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:61:0)
[11:15:15.994] Build status: STARTED
[11:15:15.994] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:62:0) after 2m33s
[11:17:49.094] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:62:0)
[11:17:49.189] Build status: STARTED
[11:17:49.189] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:63:0) after 7m35s
[11:25:24.231] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:63:0)
[11:25:24.270] Build status: STARTED
[11:25:24.270] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:64:0) after 4m18s
[11:29:42.443] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:64:0)
[11:29:42.460] Build status: STARTED
[11:29:42.460] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:65:0) after 4m14s
[11:33:56.578] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:65:0)
[11:33:56.620] Build status: STARTED
[11:33:56.620] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:66:0) after 8m52s
[11:42:48.624] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:66:0)
[11:42:48.642] Build status: STARTED
[11:42:48.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:67:0) after 1m25s
[11:44:13.711] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:67:0)
[11:44:13.729] Build status: STARTED
[11:44:13.729] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:68:0) after 6m13s
[11:50:27.215] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:68:0)
[11:50:27.233] Build status: STARTED
[11:50:27.233] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:69:0) after 5m19s
[11:55:46.256] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:69:0)
[11:55:46.281] Build status: STARTED
[11:55:46.281] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:70:0) after 1m7s
[11:56:53.398] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:70:0)
[11:56:53.415] Build status: STARTED
[11:56:53.415] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:71:0) after 9m10s
[12:06:03.593] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:71:0)
[12:06:03.627] Build status: STARTED
[12:06:03.627] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:72:0) after 7m43s
[12:13:46.762] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:72:0)
[12:13:46.786] Build status: STARTED
[12:13:46.786] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:73:0) after 4m32s
[12:18:19.059] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:73:0)
[12:18:19.086] Build status: STARTED
[12:18:19.086] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:74:0) after 9m19s
[12:27:38.266] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:74:0)
[12:27:38.283] Build status: STARTED
[12:27:38.283] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:75:0) after 6m5s
[12:33:43.286] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:75:0)
[12:33:43.308] Build status: STARTED
[12:33:43.308] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:76:0) after 6m39s
[12:40:22.368] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:76:0)
[12:40:22.399] Build status: STARTED
[12:40:22.399] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:77:0) after 9m26s
[12:49:48.495] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:77:0)
[12:49:48.513] Build status: STARTED
[12:49:48.513] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:78:0) after 8m45s
[12:58:33.549] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:78:0)
[12:58:33.601] Build status: STARTED
[12:58:33.601] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:79:0) after 8m51s
[13:07:24.629] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:79:0)
[13:07:24.649] Build status: STARTED
[13:07:24.649] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:80:0) after 2m48s
[13:10:12.674] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:80:0)
[13:10:12.692] Build status: STARTED
[13:10:12.692] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:81:0) after 1m59s
[13:12:11.721] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:81:0)
[13:12:11.768] Build status: STARTED
[13:12:11.768] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:82:0) after 9m9s
[13:21:20.823] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:82:0)
[13:21:20.843] Build status: STARTED
[13:21:20.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:83:0) after 5m39s
[13:27:00.093] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:83:0)
[13:27:00.111] Build status: STARTED
[13:27:00.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:84:0) after 3m35s
[13:30:35.270] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:84:0)
[13:30:35.294] Build status: STARTED
[13:30:35.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:85:0) after 8m25s
[13:39:00.513] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:85:0)
[13:39:00.529] Build status: STARTED
[13:39:00.529] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:86:0) after 5m8s
[13:44:08.552] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:86:0)
[13:44:08.570] Build status: STARTED
[13:44:08.570] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:87:0) after 3m41s
[13:47:49.850] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:87:0)
[13:47:49.874] Build status: STARTED
[13:47:49.874] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:88:0) after 6m54s
[13:54:43.914] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:88:0)
[13:54:43.929] Build status: STARTED
[13:54:43.929] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:89:0) after 1m33s
[13:56:17.069] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:89:0)
[13:56:17.104] Build status: STARTED
[13:56:17.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:90:0) after 5m50s
[14:02:07.338] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:90:0)
[14:02:07.377] Build status: STARTED
[14:02:07.377] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:91:0) after 1m3s
[14:03:10.452] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:91:0)
[14:03:10.483] Build status: STARTED
[14:03:10.483] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:92:0) after 2m57s
[14:06:07.533] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:92:0)
[14:06:07.550] Build status: STARTED
[14:06:07.550] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:93:0) after 1m30s
[14:07:37.838] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:93:0)
[14:07:37.882] Build status: STARTED
[14:07:37.882] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:94:0) after 7m49s
[14:15:26.880] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:94:0)
[14:15:26.913] Build status: STARTED
[14:15:26.913] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:95:0) after 1m29s
[14:16:55.906] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:95:0)
[14:16:55.934] Build status: STARTED
[14:16:55.934] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:96:0) after 5m10s
[14:22:06.240] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:96:0)
[14:22:06.257] Build status: STARTED
[14:22:06.257] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:97:0) after 5m55s
[14:28:01.430] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:97:0)
[14:28:01.513] Build status: STARTED
[14:28:01.513] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:98:0) after 5m41s
[14:33:43.604] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:98:0)
[14:33:43.636] Build status: STARTED
[14:33:43.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:99:0) after 8m45s
[14:42:28.722] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:99:0)
[14:42:28.754] Build status: STARTED
[14:42:28.754] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:100:0) after 6m10s
[14:48:38.925] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:100:0)
[14:48:38.946] Build status: STARTED
[14:48:38.946] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:101:0) after 5m10s
[14:53:48.972] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:101:0)
[14:53:48.996] Build status: STARTED
[14:53:48.996] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:102:0) after 9m0s
[15:02:49.118] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:102:0)
[15:02:49.211] Build status: STARTED
[15:02:49.211] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:103:0) after 5m17s
[15:08:06.246] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:103:0)
[15:08:06.261] Build status: STARTED
[15:08:06.261] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:104:0) after 1m55s
[15:10:01.384] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:104:0)
[15:10:01.414] Build status: STARTED
[15:10:01.414] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:105:0) after 1m47s
[15:11:48.443] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:105:0)
[15:11:48.465] Build status: STARTED
[15:11:48.465] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:106:0) after 5m25s
[15:17:13.496] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:106:0)
[15:17:13.514] Build status: STARTED
[15:17:13.514] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:107:0) after 2m8s
[15:19:21.864] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:107:0)
[15:19:21.888] Build status: STARTED
[15:19:21.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:108:0) after 8m48s
[15:28:10.082] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:108:0)
[15:28:10.102] Build status: STARTED
[15:28:10.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:109:0) after 1m18s
[15:29:28.459] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:109:0)
[15:29:28.510] Build status: STARTED
[15:29:28.510] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:110:0) after 6m52s
[15:36:20.711] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:110:0)
[15:36:20.741] Build status: STARTED
[15:36:20.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:111:0) after 9m40s
[15:46:01.304] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:111:0)
[15:46:01.387] Build status: STARTED
[15:46:01.387] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:112:0) after 8m19s
[15:54:20.509] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:112:0)
[15:54:20.530] Build status: STARTED
[15:54:20.530] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:113:0) after 6m37s
[16:00:57.663] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:113:0)
[16:00:57.728] Build status: STARTED
[16:00:57.728] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:114:0) after 8m37s
[16:09:34.817] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:114:0)
[16:09:34.853] Build status: STARTED
[16:09:34.853] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:115:0) after 4m47s
[16:14:22.145] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:115:0)
[16:14:22.274] Build status: STARTED
[16:14:22.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:116:0) after 8m35s
[16:22:57.317] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:116:0)
[16:22:57.343] Build status: STARTED
[16:22:57.343] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:117:0) after 1m36s
[16:24:33.494] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:117:0)
[16:24:33.574] Build status: STARTED
[16:24:33.574] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:118:0) after 6m14s
[16:30:47.887] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:118:0)
[16:30:47.923] Build status: STARTED
[16:30:47.923] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:119:0) after 6m30s
[16:37:18.045] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:119:0)
[16:37:18.078] Build status: STARTED
[16:37:18.078] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:120:0) after 1m7s
[16:38:25.114] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:120:0)
[16:38:25.154] Build status: STARTED
[16:38:25.154] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:121:0) after 9m33s
[16:47:58.211] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:121:0)
[16:47:58.227] Build status: STARTED
[16:47:58.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:122:0) after 5m18s
[16:53:16.261] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:122:0)
[16:53:16.305] Build status: STARTED
[16:53:16.305] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:123:0) after 9m22s
[17:02:39.136] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:123:0)
[17:02:39.163] Build status: STARTED
[17:02:39.163] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:124:0) after 1m25s
[17:04:04.278] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:124:0)
[17:04:04.297] Build status: STARTED
[17:04:04.297] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:125:0) after 6m57s
[17:11:01.591] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:125:0)
[17:11:01.611] Build status: STARTED
[17:11:01.611] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:126:0) after 3m25s
[17:14:26.636] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:126:0)
[17:14:26.706] Build status: STARTED
[17:14:26.706] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:127:0) after 7m31s
[17:21:57.836] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:127:0)
[17:21:57.910] Build status: STARTED
[17:21:57.910] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:128:0) after 1m35s
[17:23:32.934] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:128:0)
[17:23:32.953] Build status: STARTED
[17:23:32.953] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:129:0) after 3m0s
[17:26:33.612] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:129:0)
[17:26:33.649] Build status: STARTED
[17:26:33.649] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:130:0) after 9m3s
[17:35:36.667] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:130:0)
[17:35:36.685] Build status: STARTED
[17:35:36.685] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:131:0) after 1m24s
[17:37:00.756] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:131:0)
[17:37:00.778] Build status: STARTED
[17:37:00.778] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:132:0) after 8m2s
[17:45:02.906] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:132:0)
[17:45:02.926] Build status: STARTED
[17:45:02.926] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:133:0) after 4m5s
[17:49:07.986] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:133:0)
[17:49:08.009] Build status: STARTED
[17:49:08.009] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:134:0) after 2m28s
[17:51:36.074] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:134:0)
[17:51:36.105] Build status: STARTED
[17:51:36.105] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:135:0) after 5m46s
[17:57:22.159] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:135:0)
[17:57:22.188] Build status: STARTED
[17:57:22.188] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:136:0) after 3m56s
[18:01:18.601] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:136:0)
[18:01:18.622] Build status: STARTED
[18:01:18.622] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:137:0) after 9m10s
[18:10:28.825] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:137:0)
[18:10:28.844] Build status: STARTED
[18:10:28.845] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:138:0) after 9m4s
[18:19:33.141] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:138:0)
[18:19:33.173] Build status: STARTED
[18:19:33.173] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:139:0) after 2m8s
[18:21:41.229] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:139:0)
[18:21:41.278] Build status: STARTED
[18:21:41.278] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:140:0) after 5m30s
[18:27:11.518] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:140:0)
[18:27:11.538] Build status: STARTED
[18:27:11.538] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:141:0) after 6m7s
[18:33:18.811] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:141:0)
[18:33:18.840] Build status: STARTED
[18:33:18.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:142:0) after 3m53s
[18:37:11.909] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:142:0)
[18:37:11.932] Build status: STARTED
[18:37:11.932] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:143:0) after 4m50s
[18:42:02.077] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:143:0)
[18:42:02.102] Build status: STARTED
[18:42:02.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:144:0) after 9m40s
[18:51:42.150] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:144:0)
[18:51:42.223] Build status: STARTED
[18:51:42.224] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:145:0) after 5m35s
[18:57:17.298] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:145:0)
[18:57:17.336] Build status: STARTED
[18:57:17.336] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:146:0) after 5m45s
[19:03:02.325] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:146:0)
[19:03:02.360] Build status: STARTED
[19:03:02.360] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:147:0) after 9m59s
[19:13:01.527] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:147:0)
[19:13:01.546] Build status: STARTED
[19:13:01.546] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8936607463925134224:148:0) after 6m30s
[19:16:56.452] Received PubSub notification, asking Buildbucket for the build status
[19:16:58.655] Build:
{
"id": "8771177402052968433",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"number": 4572,
"createdBy": "project:chromium",
"createTime": "2023-09-01T06:40:09.227118875Z",
"startTime": "2023-09-01T06:45:30.851965Z",
"endTime": "2023-09-01T19:16:56.269741566Z",
"updateTime": "2023-09-01T19:16:56.269741566Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5f6904bd01bec615f7fff1575f2c9ac13af91de1",
"ref": "refs/heads/main"
}
}
}
[19:16:58.655] Invocation finished in 12h36m50.596271674s with status SUCCEEDED