[18:16:28.681] New invocation is queued and will start shortly
[18:16:30.015] Starting the invocation (attempt 1)
[18:16:30.054] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e98d77931e4bb820ca4bfe6e3cc0eb0e77f77822"
[18:16:30.054] Popped gitiles commit info from properties and tags
[18:16:30.054] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:16:30.055] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:16:30.056] Buildbucket request:
{
"requestId": "8932396193323910144",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e98d77931e4bb820ca4bfe6e3cc0eb0e77f77822",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8932396193323910144"
},
{
"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"
}
}
[18:16:30.631] Scheduled build:
{
"id": "8766966131141092241",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"number": 5047,
"createdBy": "project:chromium",
"createTime": "2023-10-17T18:16:30.135229061Z",
"updateTime": "2023-10-17T18:16:30.135229061Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e98d77931e4bb820ca4bfe6e3cc0eb0e77f77822",
"ref": "refs/heads/main"
}
}
}
[18:16:30.631] Task URL: https://cr-buildbucket.appspot.com/build/8766966131141092241
[18:16:30.631] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:2:0) after 3m48s
[18:16:31.560] Received PubSub notification, asking Buildbucket for the build status
[18:16:31.592] Build status: SCHEDULED
[18:20:18.736] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:2:0)
[18:20:18.780] Build status: SCHEDULED
[18:20:18.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:4:0) after 1m1s
[18:20:38.926] Received PubSub notification, asking Buildbucket for the build status
[18:20:38.948] Build status: STARTED
[18:21:19.807] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:4:0)
[18:21:19.835] Build status: STARTED
[18:21:19.835] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:6:0) after 7m34s
[18:28:53.863] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:6:0)
[18:28:53.883] Build status: STARTED
[18:28:53.883] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:7:0) after 5m48s
[18:34:42.033] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:7:0)
[18:34:42.123] Build status: STARTED
[18:34:42.123] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:8:0) after 7m29s
[18:42:11.136] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:8:0)
[18:42:11.174] Build status: STARTED
[18:42:11.174] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:9:0) after 2m21s
[18:44:32.338] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:9:0)
[18:44:32.416] Build status: STARTED
[18:44:32.416] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:10:0) after 9m52s
[18:54:24.515] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:10:0)
[18:54:24.540] Build status: STARTED
[18:54:24.540] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:11:0) after 3m18s
[18:57:42.630] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:11:0)
[18:57:42.649] Build status: STARTED
[18:57:42.649] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:12:0) after 8m50s
[19:06:32.677] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:12:0)
[19:06:32.729] Build status: STARTED
[19:06:32.729] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:13:0) after 8m16s
[19:14:48.712] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:13:0)
[19:14:48.741] Build status: STARTED
[19:14:48.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:14:0) after 1m58s
[19:16:46.761] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:14:0)
[19:16:46.777] Build status: STARTED
[19:16:46.778] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:15:0) after 4m9s
[19:20:55.918] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:15:0)
[19:20:56.028] Build status: STARTED
[19:20:56.028] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:16:0) after 2m27s
[19:23:23.040] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:16:0)
[19:23:23.128] Build status: STARTED
[19:23:23.128] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:17:0) after 1m9s
[19:24:32.207] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:17:0)
[19:24:32.238] Build status: STARTED
[19:24:32.238] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:18:0) after 1m41s
[19:26:13.265] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:18:0)
[19:26:13.287] Build status: STARTED
[19:26:13.287] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:19:0) after 3m9s
[19:29:22.388] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:19:0)
[19:29:22.428] Build status: STARTED
[19:29:22.428] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:20:0) after 4m26s
[19:33:48.509] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:20:0)
[19:33:48.529] Build status: STARTED
[19:33:48.529] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:21:0) after 6m28s
[19:40:16.560] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:21:0)
[19:40:16.581] Build status: STARTED
[19:40:16.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:22:0) after 7m51s
[19:48:07.757] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:22:0)
[19:48:07.775] Build status: STARTED
[19:48:07.775] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:23:0) after 8m21s
[19:56:29.640] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:23:0)
[19:56:29.659] Build status: STARTED
[19:56:29.659] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:24:0) after 5m32s
[20:02:01.696] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:24:0)
[20:02:01.720] Build status: STARTED
[20:02:01.720] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:25:0) after 4m21s
[20:06:22.800] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:25:0)
[20:06:22.834] Build status: STARTED
[20:06:22.834] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:26:0) after 7m3s
[20:13:25.865] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:26:0)
[20:13:25.909] Build status: STARTED
[20:13:25.909] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:27:0) after 8m51s
[20:22:17.022] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:27:0)
[20:22:17.041] Build status: STARTED
[20:22:17.041] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:28:0) after 1m56s
[20:24:13.073] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:28:0)
[20:24:13.089] Build status: STARTED
[20:24:13.089] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:29:0) after 4m12s
[20:28:25.225] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:29:0)
[20:28:25.309] Build status: STARTED
[20:28:25.309] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:30:0) after 3m29s
[20:31:54.335] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:30:0)
[20:31:54.381] Build status: STARTED
[20:31:54.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:31:0) after 8m15s
[20:40:09.403] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:31:0)
[20:40:09.422] Build status: STARTED
[20:40:09.422] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:32:0) after 3m25s
[20:43:34.451] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:32:0)
[20:43:34.469] Build status: STARTED
[20:43:34.469] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:33:0) after 2m33s
[20:46:07.493] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:33:0)
[20:46:07.513] Build status: STARTED
[20:46:07.513] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:34:0) after 1m34s
[20:47:41.542] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:34:0)
[20:47:41.611] Build status: STARTED
[20:47:41.611] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:35:0) after 5m25s
[20:53:06.654] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:35:0)
[20:53:06.691] Build status: STARTED
[20:53:06.692] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:36:0) after 9m5s
[21:02:11.746] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:36:0)
[21:02:11.841] Build status: STARTED
[21:02:11.841] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:37:0) after 1m19s
[21:03:30.874] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:37:0)
[21:03:30.892] Build status: STARTED
[21:03:30.892] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:38:0) after 1m57s
[21:05:27.951] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:38:0)
[21:05:27.993] Build status: STARTED
[21:05:27.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:39:0) after 4m24s
[21:09:52.095] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:39:0)
[21:09:52.116] Build status: STARTED
[21:09:52.116] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:40:0) after 9m52s
[21:19:44.143] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:40:0)
[21:19:44.164] Build status: STARTED
[21:19:44.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:41:0) after 4m12s
[21:23:56.338] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:41:0)
[21:23:56.354] Build status: STARTED
[21:23:56.354] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:42:0) after 4m19s
[21:28:15.458] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:42:0)
[21:28:15.476] Build status: STARTED
[21:28:15.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:43:0) after 5m44s
[21:33:59.576] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:43:0)
[21:33:59.617] Build status: STARTED
[21:33:59.617] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:44:0) after 2m57s
[21:36:56.987] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:44:0)
[21:36:57.080] Build status: STARTED
[21:36:57.080] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:45:0) after 3m37s
[21:40:34.189] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:45:0)
[21:40:34.271] Build status: STARTED
[21:40:34.271] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:46:0) after 9m50s
[21:50:24.324] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:46:0)
[21:50:24.344] Build status: STARTED
[21:50:24.344] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:47:0) after 1m35s
[21:51:59.372] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:47:0)
[21:51:59.388] Build status: STARTED
[21:51:59.388] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:48:0) after 9m0s
[22:00:59.430] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:48:0)
[22:00:59.453] Build status: STARTED
[22:00:59.453] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:49:0) after 7m21s
[22:08:20.765] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:49:0)
[22:08:20.781] Build status: STARTED
[22:08:20.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:50:0) after 3m18s
[22:11:38.953] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:50:0)
[22:11:39.029] Build status: STARTED
[22:11:39.029] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:51:0) after 8m28s
[22:20:07.134] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:51:0)
[22:20:07.156] Build status: STARTED
[22:20:07.156] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:52:0) after 6m15s
[22:26:22.514] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:52:0)
[22:26:22.583] Build status: STARTED
[22:26:22.583] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:53:0) after 2m20s
[22:28:42.577] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:53:0)
[22:28:42.602] Build status: STARTED
[22:28:42.602] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:54:0) after 3m21s
[22:32:03.623] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:54:0)
[22:32:03.647] Build status: STARTED
[22:32:03.647] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:55:0) after 8m54s
[22:40:57.673] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:55:0)
[22:40:57.695] Build status: STARTED
[22:40:57.695] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:56:0) after 9m23s
[22:50:21.123] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:56:0)
[22:50:21.150] Build status: STARTED
[22:50:21.150] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:57:0) after 1m3s
[22:51:24.174] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:57:0)
[22:51:24.197] Build status: STARTED
[22:51:24.197] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:58:0) after 1m14s
[22:52:38.393] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:58:0)
[22:52:38.410] Build status: STARTED
[22:52:38.410] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:59:0) after 7m6s
[22:59:44.682] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:59:0)
[22:59:44.699] Build status: STARTED
[22:59:44.699] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:60:0) after 8m18s
[23:08:02.775] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:60:0)
[23:08:02.805] Build status: STARTED
[23:08:02.805] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:61:0) after 6m7s
[23:14:10.091] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:61:0)
[23:14:10.264] Build status: STARTED
[23:14:10.264] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:62:0) after 7m47s
[23:21:57.349] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:62:0)
[23:21:57.400] Build status: STARTED
[23:21:57.400] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:63:0) after 4m17s
[23:26:14.966] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:63:0)
[23:26:14.985] Build status: STARTED
[23:26:14.985] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:64:0) after 8m49s
[23:35:04.103] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:64:0)
[23:35:04.130] Build status: STARTED
[23:35:04.131] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:65:0) after 8m30s
[23:43:34.250] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:65:0)
[23:43:34.272] Build status: STARTED
[23:43:34.272] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:66:0) after 1m37s
[23:45:11.427] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:66:0)
[23:45:11.447] Build status: STARTED
[23:45:11.447] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:67:0) after 9m1s
[23:54:12.663] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:67:0)
[23:54:12.715] Build status: STARTED
[23:54:12.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:68:0) after 9m44s
[00:03:56.775] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:68:0)
[00:03:56.799] Build status: STARTED
[00:03:56.799] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:69:0) after 5m44s
[00:09:40.928] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:69:0)
[00:09:40.947] Build status: STARTED
[00:09:40.947] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:70:0) after 1m34s
[00:11:15.180] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:70:0)
[00:11:15.240] Build status: STARTED
[00:11:15.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:71:0) after 5m22s
[00:16:37.274] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:71:0)
[00:16:37.291] Build status: STARTED
[00:16:37.291] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:72:0) after 1m2s
[00:17:39.448] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:72:0)
[00:17:39.471] Build status: STARTED
[00:17:39.471] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:73:0) after 3m50s
[00:21:29.971] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:73:0)
[00:21:29.988] Build status: STARTED
[00:21:29.989] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:74:0) after 2m50s
[00:24:20.018] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:74:0)
[00:24:20.121] Build status: STARTED
[00:24:20.121] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:75:0) after 6m16s
[00:30:36.331] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:75:0)
[00:30:36.351] Build status: STARTED
[00:30:36.352] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:76:0) after 3m1s
[00:33:37.390] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:76:0)
[00:33:37.408] Build status: STARTED
[00:33:37.408] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:77:0) after 1m38s
[00:35:15.436] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:77:0)
[00:35:15.571] Build status: STARTED
[00:35:15.571] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:78:0) after 2m48s
[00:38:03.601] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:78:0)
[00:38:03.647] Build status: STARTED
[00:38:03.647] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:79:0) after 6m58s
[00:45:01.739] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:79:0)
[00:45:01.758] Build status: STARTED
[00:45:01.758] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:80:0) after 3m16s
[00:48:17.994] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:80:0)
[00:48:18.078] Build status: STARTED
[00:48:18.078] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:81:0) after 2m28s
[00:50:46.208] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:81:0)
[00:50:46.228] Build status: STARTED
[00:50:46.228] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:82:0) after 7m59s
[00:58:45.322] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:82:0)
[00:58:45.343] Build status: STARTED
[00:58:45.343] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:83:0) after 7m38s
[01:06:23.455] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:83:0)
[01:06:23.482] Build status: STARTED
[01:06:23.482] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:84:0) after 8m17s
[01:14:40.591] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:84:0)
[01:14:40.756] Build status: STARTED
[01:14:40.756] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:85:0) after 6m18s
[01:20:58.764] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:85:0)
[01:20:58.781] Build status: STARTED
[01:20:58.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:86:0) after 6m38s
[01:27:36.999] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:86:0)
[01:27:37.020] Build status: STARTED
[01:27:37.020] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:87:0) after 2m32s
[01:30:09.056] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:87:0)
[01:30:09.080] Build status: STARTED
[01:30:09.080] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:88:0) after 7m23s
[01:37:32.441] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:88:0)
[01:37:32.465] Build status: STARTED
[01:37:32.465] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:89:0) after 9m47s
[01:47:19.493] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:89:0)
[01:47:19.509] Build status: STARTED
[01:47:19.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:90:0) after 8m20s
[01:55:39.532] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:90:0)
[01:55:39.549] Build status: STARTED
[01:55:39.549] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:91:0) after 1m54s
[01:57:33.884] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:91:0)
[01:57:33.901] Build status: STARTED
[01:57:33.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:92:0) after 5m38s
[02:03:12.252] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:92:0)
[02:03:12.272] Build status: STARTED
[02:03:12.272] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:93:0) after 6m15s
[02:09:27.332] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:93:0)
[02:09:27.360] Build status: STARTED
[02:09:27.360] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:94:0) after 2m23s
[02:11:50.338] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:94:0)
[02:11:50.356] Build status: STARTED
[02:11:50.356] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:95:0) after 4m27s
[02:16:17.500] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:95:0)
[02:16:17.519] Build status: STARTED
[02:16:17.519] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:96:0) after 2m17s
[02:18:34.553] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:96:0)
[02:18:34.573] Build status: STARTED
[02:18:34.573] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:97:0) after 9m14s
[02:27:48.625] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:97:0)
[02:27:48.644] Build status: STARTED
[02:27:48.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:98:0) after 9m7s
[02:36:56.005] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:98:0)
[02:36:56.024] Build status: STARTED
[02:36:56.024] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:99:0) after 9m13s
[02:46:09.112] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:99:0)
[02:46:09.138] Build status: STARTED
[02:46:09.138] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:100:0) after 5m4s
[02:51:13.209] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:100:0)
[02:51:13.232] Build status: STARTED
[02:51:13.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:101:0) after 3m24s
[02:54:37.703] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:101:0)
[02:54:37.720] Build status: STARTED
[02:54:37.720] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8932396193323910144:102:0) after 2m21s
[02:54:55.525] Received PubSub notification, asking Buildbucket for the build status
[02:54:55.544] Build:
{
"id": "8766966131141092241",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"number": 5047,
"createdBy": "project:chromium",
"createTime": "2023-10-17T18:16:30.135229061Z",
"startTime": "2023-10-17T18:20:37.783024Z",
"endTime": "2023-10-18T02:54:55.084791959Z",
"updateTime": "2023-10-18T02:54:55.084791959Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e98d77931e4bb820ca4bfe6e3cc0eb0e77f77822",
"ref": "refs/heads/main"
}
}
}
[02:54:55.544] Invocation finished in 8h38m26.874113649s with status SUCCEEDED