[05:48:38.271] New invocation is queued and will start shortly
[05:48:39.351] Starting the invocation (attempt 1)
[05:48:39.380] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3eb21188b8bb9602f929fa272b3bb3578df6cabd"
[05:48:39.380] Popped gitiles commit info from properties and tags
[05:48:39.380] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:48:39.381] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:48:39.381] Buildbucket request:
{
"requestId": "8942680700565053216",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "3eb21188b8bb9602f929fa272b3bb3578df6cabd",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8942680700565053216"
},
{
"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"
}
}
[05:48:39.867] Scheduled build:
{
"id": "8777250638602543105",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"number": 4148,
"createdBy": "project:chromium",
"createTime": "2023-06-26T05:48:39.512386324Z",
"updateTime": "2023-06-26T05:48:39.512386324Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "3eb21188b8bb9602f929fa272b3bb3578df6cabd",
"ref": "refs/heads/main"
}
}
}
[05:48:39.867] Task URL: https://cr-buildbucket.appspot.com/build/8777250638602543105
[05:48:39.867] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:2:0) after 8m31s
[05:48:54.726] Received PubSub notification, asking Buildbucket for the build status
[05:48:54.751] Build status: STARTED
[05:57:10.919] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:2:0)
[05:57:10.934] Build status: STARTED
[05:57:10.934] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:4:0) after 7m28s
[06:04:38.972] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:4:0)
[06:04:38.990] Build status: STARTED
[06:04:38.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:5:0) after 2m18s
[06:06:57.238] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:5:0)
[06:06:57.260] Build status: STARTED
[06:06:57.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:6:0) after 5m41s
[06:12:38.484] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:6:0)
[06:12:38.500] Build status: STARTED
[06:12:38.501] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:7:0) after 1m11s
[06:13:49.585] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:7:0)
[06:13:49.602] Build status: STARTED
[06:13:49.602] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:8:0) after 4m25s
[06:18:14.619] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:8:0)
[06:18:14.654] Build status: STARTED
[06:18:14.654] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:9:0) after 5m23s
[06:23:37.711] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:9:0)
[06:23:37.742] Build status: STARTED
[06:23:37.743] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:10:0) after 6m55s
[06:30:32.892] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:10:0)
[06:30:32.911] Build status: STARTED
[06:30:32.911] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:11:0) after 1m47s
[06:32:20.195] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:11:0)
[06:32:20.233] Build status: STARTED
[06:32:20.234] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:12:0) after 4m8s
[06:36:28.252] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:12:0)
[06:36:28.311] Build status: STARTED
[06:36:28.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:13:0) after 9m55s
[06:46:23.408] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:13:0)
[06:46:23.429] Build status: STARTED
[06:46:23.429] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:14:0) after 3m51s
[06:50:14.518] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:14:0)
[06:50:14.550] Build status: STARTED
[06:50:14.550] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:15:0) after 1m25s
[06:51:39.672] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:15:0)
[06:51:39.688] Build status: STARTED
[06:51:39.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:16:0) after 3m56s
[06:55:35.672] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:16:0)
[06:55:35.687] Build status: STARTED
[06:55:35.687] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:17:0) after 5m33s
[07:01:08.704] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:17:0)
[07:01:08.721] Build status: STARTED
[07:01:08.721] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:18:0) after 8m29s
[07:09:37.751] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:18:0)
[07:09:37.768] Build status: STARTED
[07:09:37.768] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:19:0) after 3m33s
[07:13:11.034] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:19:0)
[07:13:11.052] Build status: STARTED
[07:13:11.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:20:0) after 5m49s
[07:19:00.078] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:20:0)
[07:19:00.095] Build status: STARTED
[07:19:00.095] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:21:0) after 4m55s
[07:23:55.526] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:21:0)
[07:23:55.543] Build status: STARTED
[07:23:55.543] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:22:0) after 3m34s
[07:27:29.677] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:22:0)
[07:27:29.697] Build status: STARTED
[07:27:29.697] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:23:0) after 9m28s
[07:36:57.863] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:23:0)
[07:36:57.880] Build status: STARTED
[07:36:57.880] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:24:0) after 6m28s
[07:43:25.904] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:24:0)
[07:43:25.924] Build status: STARTED
[07:43:25.924] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:25:0) after 6m24s
[07:49:50.162] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:25:0)
[07:49:50.186] Build status: STARTED
[07:49:50.186] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:26:0) after 7m15s
[07:57:05.304] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:26:0)
[07:57:05.324] Build status: STARTED
[07:57:05.324] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:27:0) after 1m34s
[07:58:39.413] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:27:0)
[07:58:39.431] Build status: STARTED
[07:58:39.431] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:28:0) after 2m18s
[08:00:57.497] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:28:0)
[08:00:57.521] Build status: STARTED
[08:00:57.521] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:29:0) after 6m36s
[08:07:33.627] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:29:0)
[08:07:33.643] Build status: STARTED
[08:07:33.643] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:30:0) after 4m16s
[08:11:49.686] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:30:0)
[08:11:49.707] Build status: STARTED
[08:11:49.707] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:31:0) after 8m54s
[08:20:43.736] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:31:0)
[08:20:43.763] Build status: STARTED
[08:20:43.763] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:32:0) after 7m15s
[08:27:58.954] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:32:0)
[08:27:58.972] Build status: STARTED
[08:27:58.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:33:0) after 5m56s
[08:33:55.105] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:33:0)
[08:33:55.133] Build status: STARTED
[08:33:55.133] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:34:0) after 4m9s
[08:38:04.445] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:34:0)
[08:38:04.462] Build status: STARTED
[08:38:04.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:35:0) after 6m34s
[08:44:38.577] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:35:0)
[08:44:38.596] Build status: STARTED
[08:44:38.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:36:0) after 8m8s
[08:52:46.639] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:36:0)
[08:52:46.656] Build status: STARTED
[08:52:46.656] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:37:0) after 9m8s
[09:01:54.630] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:37:0)
[09:01:54.646] Build status: STARTED
[09:01:54.646] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:38:0) after 8m28s
[09:10:22.667] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:38:0)
[09:10:22.684] Build status: STARTED
[09:10:22.684] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:39:0) after 6m43s
[09:17:05.800] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:39:0)
[09:17:05.821] Build status: STARTED
[09:17:05.821] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:40:0) after 1m21s
[09:18:26.839] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:40:0)
[09:18:26.856] Build status: STARTED
[09:18:26.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:41:0) after 7m16s
[09:25:42.949] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:41:0)
[09:25:42.969] Build status: STARTED
[09:25:42.969] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:42:0) after 7m27s
[09:33:10.239] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:42:0)
[09:33:10.254] Build status: STARTED
[09:33:10.254] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:43:0) after 2m51s
[09:36:01.895] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:43:0)
[09:36:01.913] Build status: STARTED
[09:36:01.913] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:44:0) after 5m39s
[09:41:41.075] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:44:0)
[09:41:41.090] Build status: STARTED
[09:41:41.090] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:45:0) after 8m18s
[09:49:59.269] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:45:0)
[09:49:59.443] Build status: STARTED
[09:49:59.443] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:46:0) after 2m19s
[09:52:18.461] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:46:0)
[09:52:18.478] Build status: STARTED
[09:52:18.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:47:0) after 1m29s
[09:53:47.501] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:47:0)
[09:53:47.521] Build status: STARTED
[09:53:47.521] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:48:0) after 2m9s
[09:55:56.824] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:48:0)
[09:55:56.846] Build status: STARTED
[09:55:56.846] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:49:0) after 4m45s
[10:00:42.260] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:49:0)
[10:00:42.277] Build status: STARTED
[10:00:42.277] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:50:0) after 5m42s
[10:06:24.482] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:50:0)
[10:06:24.515] Build status: STARTED
[10:06:24.515] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:51:0) after 2m50s
[10:09:14.551] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:51:0)
[10:09:14.567] Build status: STARTED
[10:09:14.567] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:52:0) after 8m47s
[10:18:01.667] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:52:0)
[10:18:01.693] Build status: STARTED
[10:18:01.693] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:53:0) after 1m27s
[10:19:28.701] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:53:0)
[10:19:28.719] Build status: STARTED
[10:19:28.719] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:54:0) after 7m11s
[10:26:39.745] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:54:0)
[10:26:39.763] Build status: STARTED
[10:26:39.763] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:55:0) after 3m36s
[10:30:15.998] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:55:0)
[10:30:16.022] Build status: STARTED
[10:30:16.022] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:56:0) after 7m11s
[10:37:27.038] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:56:0)
[10:37:27.055] Build status: STARTED
[10:37:27.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:57:0) after 6m38s
[10:44:05.135] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:57:0)
[10:44:05.149] Build status: STARTED
[10:44:05.149] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:58:0) after 9m0s
[10:53:05.173] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:58:0)
[10:53:05.190] Build status: STARTED
[10:53:05.190] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:59:0) after 3m56s
[10:57:01.403] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:59:0)
[10:57:01.433] Build status: STARTED
[10:57:01.433] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:60:0) after 9m54s
[11:06:55.460] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:60:0)
[11:06:55.481] Build status: STARTED
[11:06:55.481] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:61:0) after 6m47s
[11:13:42.471] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:61:0)
[11:13:42.490] Build status: STARTED
[11:13:42.490] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:62:0) after 7m37s
[11:21:19.705] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:62:0)
[11:21:19.719] Build status: STARTED
[11:21:19.719] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:63:0) after 8m31s
[11:29:50.899] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:63:0)
[11:29:50.914] Build status: STARTED
[11:29:50.914] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:64:0) after 5m0s
[11:34:51.018] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:64:0)
[11:34:51.055] Build status: STARTED
[11:34:51.055] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:65:0) after 8m19s
[11:43:10.286] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:65:0)
[11:43:10.304] Build status: STARTED
[11:43:10.304] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:66:0) after 9m11s
[11:52:21.343] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:66:0)
[11:52:21.361] Build status: STARTED
[11:52:21.361] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:67:0) after 2m36s
[11:54:57.552] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:67:0)
[11:54:57.569] Build status: STARTED
[11:54:57.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:68:0) after 3m13s
[11:58:10.587] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:68:0)
[11:58:10.664] Build status: STARTED
[11:58:10.664] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:69:0) after 1m32s
[11:59:42.690] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:69:0)
[11:59:42.735] Build status: STARTED
[11:59:42.735] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:70:0) after 2m37s
[12:02:19.970] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:70:0)
[12:02:19.989] Build status: STARTED
[12:02:19.989] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:71:0) after 2m11s
[12:04:31.007] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:71:0)
[12:04:31.025] Build status: STARTED
[12:04:31.025] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:72:0) after 9m49s
[12:14:20.099] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:72:0)
[12:14:20.121] Build status: STARTED
[12:14:20.121] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:73:0) after 9m11s
[12:23:31.238] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:73:0)
[12:23:31.275] Build status: STARTED
[12:23:31.275] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:74:0) after 7m8s
[12:30:39.308] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:74:0)
[12:30:39.332] Build status: STARTED
[12:30:39.332] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:75:0) after 9m23s
[12:40:02.437] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:75:0)
[12:40:02.467] Build status: STARTED
[12:40:02.467] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:76:0) after 3m13s
[12:43:15.695] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:76:0)
[12:43:15.717] Build status: STARTED
[12:43:15.717] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:77:0) after 9m3s
[12:52:18.832] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:77:0)
[12:52:18.851] Build status: STARTED
[12:52:18.851] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:78:0) after 6m13s
[12:58:31.876] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:78:0)
[12:58:31.899] Build status: STARTED
[12:58:31.899] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:79:0) after 8m59s
[13:07:30.951] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:79:0)
[13:07:30.969] Build status: STARTED
[13:07:30.969] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:80:0) after 4m22s
[13:11:53.281] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:80:0)
[13:11:53.302] Build status: STARTED
[13:11:53.302] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:81:0) after 2m35s
[13:14:28.358] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:81:0)
[13:14:28.377] Build status: STARTED
[13:14:28.377] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:82:0) after 7m37s
[13:22:05.396] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:82:0)
[13:22:05.414] Build status: STARTED
[13:22:05.414] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:83:0) after 4m14s
[13:26:19.544] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:83:0)
[13:26:19.564] Build status: STARTED
[13:26:19.564] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:84:0) after 2m0s
[13:28:19.616] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:84:0)
[13:28:19.640] Build status: STARTED
[13:28:19.640] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:85:0) after 9m4s
[13:37:23.660] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:85:0)
[13:37:23.682] Build status: STARTED
[13:37:23.682] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:86:0) after 6m56s
[13:44:19.701] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:86:0)
[13:44:19.719] Build status: STARTED
[13:44:19.719] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:87:0) after 8m31s
[13:52:50.801] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:87:0)
[13:52:50.828] Build status: STARTED
[13:52:50.828] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:88:0) after 8m46s
[14:01:37.023] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:88:0)
[14:01:37.064] Build status: STARTED
[14:01:37.064] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:89:0) after 7m24s
[14:09:01.084] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:89:0)
[14:09:01.107] Build status: STARTED
[14:09:01.107] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:90:0) after 3m40s
[14:12:41.128] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:90:0)
[14:12:41.145] Build status: STARTED
[14:12:41.145] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:91:0) after 5m54s
[14:18:35.497] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:91:0)
[14:18:35.517] Build status: STARTED
[14:18:35.517] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:92:0) after 3m56s
[14:22:31.540] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:92:0)
[14:22:31.559] Build status: STARTED
[14:22:31.559] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:93:0) after 6m11s
[14:28:42.841] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:93:0)
[14:28:42.865] Build status: STARTED
[14:28:42.865] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:94:0) after 2m33s
[14:31:16.064] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:94:0)
[14:31:16.103] Build status: STARTED
[14:31:16.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:95:0) after 6m38s
[14:37:54.536] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:95:0)
[14:37:54.556] Build status: STARTED
[14:37:54.556] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:96:0) after 2m2s
[14:39:56.776] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:96:0)
[14:39:56.803] Build status: STARTED
[14:39:56.803] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:97:0) after 2m9s
[14:42:05.821] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:97:0)
[14:42:05.837] Build status: STARTED
[14:42:05.837] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:98:0) after 4m13s
[14:46:18.962] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:98:0)
[14:46:18.981] Build status: STARTED
[14:46:18.981] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:99:0) after 9m41s
[14:56:00.004] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:99:0)
[14:56:00.024] Build status: STARTED
[14:56:00.024] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:100:0) after 4m52s
[15:00:52.279] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:100:0)
[15:00:52.325] Build status: STARTED
[15:00:52.325] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:101:0) after 4m21s
[15:05:13.344] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:101:0)
[15:05:13.408] Build status: STARTED
[15:05:13.408] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:102:0) after 2m5s
[15:07:18.488] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:102:0)
[15:07:18.505] Build status: STARTED
[15:07:18.505] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:103:0) after 5m6s
[15:12:24.575] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:103:0)
[15:12:24.646] Build status: STARTED
[15:12:24.646] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:104:0) after 4m38s
[15:17:02.759] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:104:0)
[15:17:02.784] Build status: STARTED
[15:17:02.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:105:0) after 7m21s
[15:24:24.030] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:105:0)
[15:24:24.051] Build status: STARTED
[15:24:24.051] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:106:0) after 7m53s
[15:32:17.069] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:106:0)
[15:32:17.087] Build status: STARTED
[15:32:17.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:107:0) after 2m50s
[15:35:07.312] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:107:0)
[15:35:07.474] Build status: STARTED
[15:35:07.474] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:108:0) after 3m18s
[15:38:25.589] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:108:0)
[15:38:25.606] Build status: STARTED
[15:38:25.606] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:109:0) after 3m5s
[15:41:30.982] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:109:0)
[15:41:30.998] Build status: STARTED
[15:41:30.998] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:110:0) after 5m45s
[15:47:16.031] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:110:0)
[15:47:16.051] Build status: STARTED
[15:47:16.051] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:111:0) after 8m17s
[15:55:33.116] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:111:0)
[15:55:33.150] Build status: STARTED
[15:55:33.150] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:112:0) after 7m21s
[16:02:54.449] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:112:0)
[16:02:54.485] Build status: STARTED
[16:02:54.485] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:113:0) after 7m36s
[16:10:30.517] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:113:0)
[16:10:30.540] Build status: STARTED
[16:10:30.540] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:114:0) after 4m36s
[16:15:06.570] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:114:0)
[16:15:06.591] Build status: STARTED
[16:15:06.591] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:115:0) after 7m47s
[16:22:53.706] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:115:0)
[16:22:53.732] Build status: STARTED
[16:22:53.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:116:0) after 9m54s
[16:32:47.771] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:116:0)
[16:32:47.791] Build status: STARTED
[16:32:47.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:117:0) after 2m12s
[16:35:00.022] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:117:0)
[16:35:00.040] Build status: STARTED
[16:35:00.040] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8942680700565053216:118:0) after 9m33s
[16:39:41.957] Received PubSub notification, asking Buildbucket for the build status
[16:39:41.999] Build:
{
"id": "8777250638602543105",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"number": 4148,
"createdBy": "project:chromium",
"createTime": "2023-06-26T05:48:39.512386324Z",
"startTime": "2023-06-26T05:48:54.205290Z",
"endTime": "2023-06-26T16:39:41.628927914Z",
"updateTime": "2023-06-26T16:39:41.628927914Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "3eb21188b8bb9602f929fa272b3bb3578df6cabd",
"ref": "refs/heads/main"
}
}
}
[16:39:41.999] Invocation finished in 10h51m3.741414335s with status SUCCEEDED