[00:10:33.102] New invocation is queued and will start shortly
[00:10:34.179] Starting the invocation (attempt 1)
[00:10:34.215] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/20f9241ab6176dedc12441d429e84d5dc6bf9fde"
[00:10:34.215] Popped gitiles commit info from properties and tags
[00:10:34.215] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:10:34.215] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:10:34.215] Buildbucket request:
{
"requestId": "9004307908262626928",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "20f9241ab6176dedc12441d429e84d5dc6bf9fde",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9004307908262626928"
},
{
"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"
}
}
[00:10:34.842] Scheduled build:
{
"id": "8838877846339323472",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"number": 289,
"createdBy": "project:chromium",
"createTime": "2021-08-15T00:10:34.301629Z",
"updateTime": "2021-08-15T00:10:34.731632Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "20f9241ab6176dedc12441d429e84d5dc6bf9fde",
"ref": "refs/heads/main"
}
}
}
[00:10:34.842] Task URL: https://cr-buildbucket.appspot.com/build/8838877846339323472
[00:10:34.842] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:2:0) after 7m21s
[00:17:55.891] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:2:0)
[00:17:55.920] Build status: SCHEDULED
[00:17:55.920] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:3:0) after 7m29s
[00:25:24.937] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:3:0)
[00:25:24.967] Build status: SCHEDULED
[00:25:24.967] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:4:0) after 6m55s
[00:32:19.983] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:4:0)
[00:32:20.011] Build status: SCHEDULED
[00:32:20.011] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:5:0) after 3m49s
[00:36:09.275] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:5:0)
[00:36:09.309] Build status: SCHEDULED
[00:36:09.309] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:6:0) after 4m55s
[00:38:52.721] Received PubSub notification, asking Buildbucket for the build status
[00:38:52.745] Build status: STARTED
[00:41:04.639] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:6:0)
[00:41:04.679] Build status: STARTED
[00:41:04.679] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:8:0) after 2m33s
[00:43:37.694] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:8:0)
[00:43:37.793] Build status: STARTED
[00:43:37.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:9:0) after 8m49s
[00:52:27.390] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:9:0)
[00:52:27.566] Build status: STARTED
[00:52:27.566] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:10:0) after 3m19s
[00:55:46.586] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:10:0)
[00:55:46.622] Build status: STARTED
[00:55:46.622] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:11:0) after 8m16s
[01:04:02.850] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:11:0)
[01:04:02.914] Build status: STARTED
[01:04:02.914] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:12:0) after 2m30s
[01:06:33.137] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:12:0)
[01:06:33.173] Build status: STARTED
[01:06:33.173] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:13:0) after 1m7s
[01:07:40.440] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:13:0)
[01:07:40.473] Build status: STARTED
[01:07:40.473] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:14:0) after 9m44s
[01:17:24.495] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:14:0)
[01:17:24.528] Build status: STARTED
[01:17:24.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:15:0) after 3m6s
[01:20:30.565] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:15:0)
[01:20:30.592] Build status: STARTED
[01:20:30.592] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:16:0) after 5m55s
[01:26:25.608] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:16:0)
[01:26:25.635] Build status: STARTED
[01:26:25.635] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:17:0) after 9m4s
[01:35:29.622] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:17:0)
[01:35:29.694] Build status: STARTED
[01:35:29.694] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:18:0) after 7m20s
[01:42:49.722] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:18:0)
[01:42:49.752] Build status: STARTED
[01:42:49.752] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:19:0) after 3m18s
[01:46:07.836] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:19:0)
[01:46:07.865] Build status: STARTED
[01:46:07.865] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:20:0) after 3m46s
[01:49:53.886] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:20:0)
[01:49:53.997] Build status: STARTED
[01:49:53.998] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:21:0) after 9m44s
[01:59:38.024] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:21:0)
[01:59:38.064] Build status: STARTED
[01:59:38.064] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:22:0) after 8m43s
[02:08:21.621] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:22:0)
[02:08:21.650] Build status: STARTED
[02:08:21.650] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:23:0) after 4m5s
[02:12:26.789] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:23:0)
[02:12:26.816] Build status: STARTED
[02:12:26.816] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:24:0) after 3m2s
[02:15:29.542] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:24:0)
[02:15:29.569] Build status: STARTED
[02:15:29.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:25:0) after 9m45s
[02:25:14.589] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:25:0)
[02:25:14.618] Build status: STARTED
[02:25:14.618] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:26:0) after 1m35s
[02:26:49.739] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:26:0)
[02:26:49.768] Build status: STARTED
[02:26:49.768] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:27:0) after 6m30s
[02:33:19.787] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:27:0)
[02:33:19.904] Build status: STARTED
[02:33:19.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:28:0) after 6m9s
[02:39:30.149] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:28:0)
[02:39:30.177] Build status: STARTED
[02:39:30.177] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:29:0) after 2m46s
[02:42:16.823] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:29:0)
[02:42:16.865] Build status: STARTED
[02:42:16.865] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:30:0) after 7m22s
[02:49:38.887] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:30:0)
[02:49:38.921] Build status: STARTED
[02:49:38.921] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:31:0) after 1m55s
[02:51:34.141] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:31:0)
[02:51:34.166] Build status: STARTED
[02:51:34.166] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:32:0) after 7m8s
[02:58:42.503] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:32:0)
[02:58:42.527] Build status: STARTED
[02:58:42.527] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:33:0) after 6m4s
[03:04:46.564] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:33:0)
[03:04:46.594] Build status: STARTED
[03:04:46.594] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:34:0) after 1m52s
[03:06:39.059] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:34:0)
[03:06:39.090] Build status: STARTED
[03:06:39.090] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:35:0) after 4m27s
[03:11:06.174] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:35:0)
[03:11:06.289] Build status: STARTED
[03:11:06.289] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:36:0) after 2m21s
[03:13:27.324] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:36:0)
[03:13:27.356] Build status: STARTED
[03:13:27.356] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:37:0) after 8m48s
[03:22:15.450] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:37:0)
[03:22:15.478] Build status: STARTED
[03:22:15.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:38:0) after 9m2s
[03:31:17.500] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:38:0)
[03:31:17.528] Build status: STARTED
[03:31:17.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:39:0) after 8m54s
[03:40:11.550] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:39:0)
[03:40:11.582] Build status: STARTED
[03:40:11.582] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:40:0) after 7m28s
[03:47:39.597] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:40:0)
[03:47:39.623] Build status: STARTED
[03:47:39.623] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:41:0) after 8m3s
[03:55:42.647] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:41:0)
[03:55:42.672] Build status: STARTED
[03:55:42.672] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:42:0) after 6m25s
[04:02:07.968] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:42:0)
[04:02:08.248] Build status: STARTED
[04:02:08.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:43:0) after 3m30s
[04:05:38.267] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:43:0)
[04:05:38.298] Build status: STARTED
[04:05:38.298] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:44:0) after 1m12s
[04:06:50.335] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:44:0)
[04:06:50.358] Build status: STARTED
[04:06:50.358] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:45:0) after 1m46s
[04:08:36.438] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:45:0)
[04:08:36.519] Build status: STARTED
[04:08:36.519] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:46:0) after 7m11s
[04:15:47.780] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:46:0)
[04:15:47.806] Build status: STARTED
[04:15:47.806] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:47:0) after 2m16s
[04:18:03.928] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:47:0)
[04:18:03.958] Build status: STARTED
[04:18:03.958] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:48:0) after 2m29s
[04:20:33.173] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:48:0)
[04:20:33.202] Build status: STARTED
[04:20:33.202] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:49:0) after 1m12s
[04:21:45.218] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:49:0)
[04:21:45.247] Build status: STARTED
[04:21:45.247] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:50:0) after 3m9s
[04:24:54.237] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:50:0)
[04:24:54.264] Build status: STARTED
[04:24:54.264] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:51:0) after 7m26s
[04:32:20.318] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:51:0)
[04:32:20.346] Build status: STARTED
[04:32:20.346] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:52:0) after 4m44s
[04:37:04.366] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:52:0)
[04:37:04.397] Build status: STARTED
[04:37:04.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:53:0) after 5m46s
[04:42:50.616] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:53:0)
[04:42:50.644] Build status: STARTED
[04:42:50.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:54:0) after 5m31s
[04:48:21.663] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:54:0)
[04:48:21.688] Build status: STARTED
[04:48:21.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:55:0) after 1m43s
[04:50:04.912] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:55:0)
[04:50:04.963] Build status: STARTED
[04:50:04.963] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:56:0) after 7m14s
[04:57:18.997] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:56:0)
[04:57:19.052] Build status: STARTED
[04:57:19.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:57:0) after 1m7s
[04:58:26.382] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:57:0)
[04:58:26.412] Build status: STARTED
[04:58:26.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:58:0) after 7m20s
[05:05:47.083] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:58:0)
[05:05:47.119] Build status: STARTED
[05:05:47.119] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:59:0) after 5m16s
[05:11:03.326] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:59:0)
[05:11:03.361] Build status: STARTED
[05:11:03.361] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:60:0) after 2m0s
[05:13:03.381] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:60:0)
[05:13:03.413] Build status: STARTED
[05:13:03.413] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:61:0) after 8m4s
[05:21:07.434] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:61:0)
[05:21:07.459] Build status: STARTED
[05:21:07.459] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:62:0) after 7m3s
[05:28:10.477] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:62:0)
[05:28:10.504] Build status: STARTED
[05:28:10.504] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:63:0) after 8m31s
[05:36:41.583] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:63:0)
[05:36:41.611] Build status: STARTED
[05:36:41.611] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:64:0) after 5m1s
[05:41:42.757] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:64:0)
[05:41:42.788] Build status: STARTED
[05:41:42.788] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:65:0) after 5m20s
[05:47:02.810] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:65:0)
[05:47:02.839] Build status: STARTED
[05:47:02.839] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:66:0) after 1m57s
[05:48:59.900] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:66:0)
[05:48:59.925] Build status: STARTED
[05:48:59.925] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:67:0) after 3m12s
[05:52:11.946] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:67:0)
[05:52:11.971] Build status: STARTED
[05:52:11.971] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:68:0) after 6m32s
[05:58:43.991] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:68:0)
[05:58:44.021] Build status: STARTED
[05:58:44.021] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:69:0) after 4m26s
[06:03:10.041] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:69:0)
[06:03:10.072] Build status: STARTED
[06:03:10.072] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:70:0) after 7m53s
[06:11:03.096] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:70:0)
[06:11:03.123] Build status: STARTED
[06:11:03.123] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:71:0) after 9m34s
[06:20:37.142] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:71:0)
[06:20:37.191] Build status: STARTED
[06:20:37.191] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:72:0) after 4m51s
[06:25:28.687] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:72:0)
[06:25:28.735] Build status: STARTED
[06:25:28.735] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:73:0) after 1m0s
[06:26:28.755] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:73:0)
[06:26:28.795] Build status: STARTED
[06:26:28.795] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:74:0) after 9m12s
[06:35:40.844] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:74:0)
[06:35:40.874] Build status: STARTED
[06:35:40.874] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:75:0) after 4m51s
[06:40:31.907] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:75:0)
[06:40:31.938] Build status: STARTED
[06:40:31.938] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:76:0) after 2m30s
[06:43:02.080] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:76:0)
[06:43:02.133] Build status: STARTED
[06:43:02.133] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:77:0) after 4m44s
[06:47:46.253] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:77:0)
[06:47:46.284] Build status: STARTED
[06:47:46.284] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:78:0) after 7m31s
[06:55:17.304] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:78:0)
[06:55:17.332] Build status: STARTED
[06:55:17.332] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:79:0) after 7m28s
[07:02:45.579] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:79:0)
[07:02:45.609] Build status: STARTED
[07:02:45.609] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:80:0) after 4m36s
[07:07:21.815] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:80:0)
[07:07:21.843] Build status: STARTED
[07:07:21.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:81:0) after 1m31s
[07:08:53.182] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:81:0)
[07:08:53.209] Build status: STARTED
[07:08:53.209] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:82:0) after 9m17s
[07:18:10.482] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:82:0)
[07:18:10.512] Build status: STARTED
[07:18:10.512] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:83:0) after 5m53s
[07:24:03.764] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:83:0)
[07:24:03.806] Build status: STARTED
[07:24:03.806] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:84:0) after 9m56s
[07:34:00.291] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:84:0)
[07:34:01.275] Build status: STARTED
[07:34:01.275] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:85:0) after 3m5s
[07:37:06.770] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:85:0)
[07:37:06.802] Build status: STARTED
[07:37:06.802] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:86:0) after 2m46s
[07:39:53.133] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:86:0)
[07:39:53.162] Build status: STARTED
[07:39:53.162] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:87:0) after 8m56s
[07:48:49.300] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:87:0)
[07:48:49.325] Build status: STARTED
[07:48:49.325] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:88:0) after 4m18s
[07:53:07.347] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:88:0)
[07:53:07.374] Build status: STARTED
[07:53:07.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:89:0) after 3m52s
[07:56:59.429] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:89:0)
[07:56:59.459] Build status: STARTED
[07:56:59.459] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:90:0) after 1m34s
[07:58:33.828] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:90:0)
[07:58:33.858] Build status: STARTED
[07:58:33.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:9004307908262626928:91:0) after 4m51s
[08:01:17.815] Received PubSub notification, asking Buildbucket for the build status
[08:01:17.845] Build:
{
"id": "8838877846339323472",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"number": 289,
"createdBy": "project:chromium",
"createTime": "2021-08-15T00:10:34.301629Z",
"startTime": "2021-08-15T00:38:51.336022Z",
"endTime": "2021-08-15T08:01:17.371645623Z",
"updateTime": "2021-08-15T08:01:17.372173914Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "20f9241ab6176dedc12441d429e84d5dc6bf9fde",
"ref": "refs/heads/main"
}
}
}
[08:01:17.845] Invocation finished in 7h50m44.761246533s with status SUCCEEDED