[13:31:59.815] New invocation is queued and will start shortly
[13:32:01.174] Starting the invocation (attempt 1)
[13:32:01.215] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/204afda39c4030ff670568e35d6849228fcc5164"
[13:32:01.215] Popped gitiles commit info from properties and tags
[13:32:01.215] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:32:01.215] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:32:01.216] Buildbucket request:
{
"requestId": "8947906172580612592",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTChromeOS"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "204afda39c4030ff670568e35d6849228fcc5164",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8947906172580612592"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTChromeOS"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[13:32:01.739] Scheduled build:
{
"id": "8782476110335163921",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTChromeOS"
},
"number": 4662,
"createdBy": "project:chromium",
"createTime": "2023-04-29T13:32:01.329503972Z",
"updateTime": "2023-04-29T13:32:01.329503972Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "204afda39c4030ff670568e35d6849228fcc5164",
"ref": "refs/heads/main"
}
},
"canary": true
}
[13:32:01.739] Task URL: https://cr-buildbucket.appspot.com/build/8782476110335163921
[13:32:01.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:2:0) after 1m5s
[13:32:05.073] Received PubSub notification, asking Buildbucket for the build status
[13:32:05.101] Build status: STARTED
[13:33:06.755] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:2:0)
[13:33:06.781] Build status: STARTED
[13:33:06.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:4:0) after 1m59s
[13:35:05.799] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:4:0)
[13:35:05.835] Build status: STARTED
[13:35:05.835] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:5:0) after 1m56s
[13:37:01.936] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:5:0)
[13:37:01.955] Build status: STARTED
[13:37:01.955] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:6:0) after 5m4s
[13:42:06.280] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:6:0)
[13:42:06.319] Build status: STARTED
[13:42:06.319] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:7:0) after 3m12s
[13:45:18.337] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:7:0)
[13:45:18.366] Build status: STARTED
[13:45:18.366] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:8:0) after 9m19s
[13:54:37.616] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:8:0)
[13:54:37.692] Build status: STARTED
[13:54:37.692] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:9:0) after 3m24s
[13:58:02.045] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:9:0)
[13:58:02.100] Build status: STARTED
[13:58:02.100] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:10:0) after 6m12s
[14:04:14.261] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:10:0)
[14:04:14.281] Build status: STARTED
[14:04:14.281] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:11:0) after 8m35s
[14:12:49.377] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:11:0)
[14:12:49.397] Build status: STARTED
[14:12:49.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:12:0) after 6m21s
[14:19:10.429] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:12:0)
[14:19:10.448] Build status: STARTED
[14:19:10.448] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:13:0) after 2m55s
[14:22:05.505] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:13:0)
[14:22:05.523] Build status: STARTED
[14:22:05.523] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:14:0) after 7m54s
[14:29:59.540] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:14:0)
[14:29:59.560] Build status: STARTED
[14:29:59.560] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:15:0) after 4m15s
[14:34:14.683] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:15:0)
[14:34:14.699] Build status: STARTED
[14:34:14.699] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:16:0) after 2m39s
[14:36:53.723] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:16:0)
[14:36:53.743] Build status: STARTED
[14:36:53.743] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:17:0) after 6m10s
[14:43:03.826] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:17:0)
[14:43:03.844] Build status: STARTED
[14:43:03.844] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:18:0) after 7m59s
[14:51:02.928] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:18:0)
[14:51:02.951] Build status: STARTED
[14:51:02.951] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:19:0) after 8m23s
[14:59:26.256] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:19:0)
[14:59:26.318] Build status: STARTED
[14:59:26.318] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:20:0) after 8m45s
[15:08:11.344] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:20:0)
[15:08:11.367] Build status: STARTED
[15:08:11.367] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:21:0) after 9m49s
[15:18:00.465] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:21:0)
[15:18:00.484] Build status: STARTED
[15:18:00.484] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:22:0) after 2m56s
[15:20:56.502] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:22:0)
[15:20:56.519] Build status: STARTED
[15:20:56.519] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:23:0) after 5m25s
[15:26:21.641] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:23:0)
[15:26:21.659] Build status: STARTED
[15:26:21.659] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:24:0) after 9m2s
[15:35:24.054] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:24:0)
[15:35:24.074] Build status: STARTED
[15:35:24.074] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:25:0) after 4m21s
[15:39:45.094] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:25:0)
[15:39:45.115] Build status: STARTED
[15:39:45.115] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:26:0) after 5m23s
[15:45:08.314] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:26:0)
[15:45:08.334] Build status: STARTED
[15:45:08.334] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:27:0) after 7m46s
[15:52:54.538] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:27:0)
[15:52:54.578] Build status: STARTED
[15:52:54.578] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:28:0) after 6m30s
[15:59:24.705] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:28:0)
[15:59:24.729] Build status: STARTED
[15:59:24.729] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:29:0) after 7m33s
[16:06:58.343] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:29:0)
[16:06:58.365] Build status: STARTED
[16:06:58.365] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:30:0) after 5m31s
[16:12:29.673] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:30:0)
[16:12:29.697] Build status: STARTED
[16:12:29.697] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:31:0) after 5m54s
[16:18:23.835] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:31:0)
[16:18:23.861] Build status: STARTED
[16:18:23.861] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:32:0) after 8m46s
[16:27:10.006] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:32:0)
[16:27:10.081] Build status: STARTED
[16:27:10.081] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:33:0) after 4m47s
[16:31:57.286] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:33:0)
[16:31:57.568] Build status: STARTED
[16:31:57.568] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:34:0) after 8m14s
[16:40:11.625] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:34:0)
[16:40:11.646] Build status: STARTED
[16:40:11.646] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:35:0) after 2m33s
[16:42:44.670] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:35:0)
[16:42:44.721] Build status: STARTED
[16:42:44.721] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:36:0) after 4m49s
[16:47:34.048] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:36:0)
[16:47:34.069] Build status: STARTED
[16:47:34.069] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:37:0) after 8m23s
[16:55:57.107] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:37:0)
[16:55:57.136] Build status: STARTED
[16:55:57.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:38:0) after 1m10s
[16:57:07.154] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:38:0)
[16:57:07.174] Build status: STARTED
[16:57:07.174] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:39:0) after 5m10s
[17:02:17.205] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:39:0)
[17:02:17.228] Build status: STARTED
[17:02:17.228] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:40:0) after 7m17s
[17:09:34.249] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:40:0)
[17:09:34.276] Build status: STARTED
[17:09:34.276] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:41:0) after 9m34s
[17:19:08.296] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:41:0)
[17:19:08.319] Build status: STARTED
[17:19:08.319] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:42:0) after 8m17s
[17:27:25.385] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:42:0)
[17:27:25.496] Build status: STARTED
[17:27:25.496] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:43:0) after 2m12s
[17:29:37.516] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:43:0)
[17:29:37.537] Build status: STARTED
[17:29:37.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:44:0) after 8m47s
[17:38:24.562] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:44:0)
[17:38:24.581] Build status: STARTED
[17:38:24.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:45:0) after 3m54s
[17:42:18.571] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:45:0)
[17:42:18.591] Build status: STARTED
[17:42:18.591] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:46:0) after 8m21s
[17:50:39.622] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:46:0)
[17:50:39.644] Build status: STARTED
[17:50:39.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:47:0) after 8m45s
[17:59:24.763] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:47:0)
[17:59:24.787] Build status: STARTED
[17:59:24.787] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:48:0) after 8m39s
[18:08:03.856] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:48:0)
[18:08:03.880] Build status: STARTED
[18:08:03.880] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:49:0) after 8m56s
[18:16:59.923] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:49:0)
[18:16:59.947] Build status: STARTED
[18:16:59.947] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:50:0) after 4m26s
[18:21:26.081] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:50:0)
[18:21:26.104] Build status: STARTED
[18:21:26.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:51:0) after 3m12s
[18:24:38.172] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:51:0)
[18:24:38.189] Build status: STARTED
[18:24:38.189] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:52:0) after 9m42s
[18:34:20.208] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:52:0)
[18:34:20.227] Build status: STARTED
[18:34:20.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:53:0) after 3m2s
[18:37:22.287] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:53:0)
[18:37:22.304] Build status: STARTED
[18:37:22.304] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:54:0) after 1m56s
[18:39:18.496] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:54:0)
[18:39:18.518] Build status: STARTED
[18:39:18.518] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:55:0) after 2m56s
[18:42:14.696] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:55:0)
[18:42:14.720] Build status: STARTED
[18:42:14.720] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:56:0) after 4m55s
[18:47:09.876] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:56:0)
[18:47:09.897] Build status: STARTED
[18:47:09.897] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:57:0) after 9m6s
[18:56:15.917] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:57:0)
[18:56:15.934] Build status: STARTED
[18:56:15.934] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:58:0) after 9m12s
[19:05:27.915] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:58:0)
[19:05:27.937] Build status: STARTED
[19:05:27.937] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:59:0) after 3m19s
[19:08:46.950] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:59:0)
[19:08:46.973] Build status: STARTED
[19:08:46.973] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:60:0) after 1m0s
[19:09:47.130] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:60:0)
[19:09:47.151] Build status: STARTED
[19:09:47.151] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:61:0) after 7m28s
[19:17:15.170] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:61:0)
[19:17:15.192] Build status: STARTED
[19:17:15.192] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:62:0) after 1m20s
[19:18:35.295] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:62:0)
[19:18:35.327] Build status: STARTED
[19:18:35.327] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:63:0) after 6m56s
[19:25:31.465] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:63:0)
[19:25:31.484] Build status: STARTED
[19:25:31.484] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:64:0) after 7m52s
[19:33:23.557] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:64:0)
[19:33:23.577] Build status: STARTED
[19:33:23.577] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:65:0) after 6m28s
[19:39:51.762] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:65:0)
[19:39:51.785] Build status: STARTED
[19:39:51.785] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:66:0) after 5m0s
[19:44:51.803] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:66:0)
[19:44:51.822] Build status: STARTED
[19:44:51.822] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:67:0) after 6m52s
[19:51:43.842] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:67:0)
[19:51:43.863] Build status: STARTED
[19:51:43.863] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:68:0) after 7m58s
[19:59:41.891] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:68:0)
[19:59:41.906] Build status: STARTED
[19:59:41.906] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:69:0) after 4m40s
[20:04:22.123] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:69:0)
[20:04:22.141] Build status: STARTED
[20:04:22.141] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:70:0) after 1m53s
[20:06:15.766] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:70:0)
[20:06:15.787] Build status: STARTED
[20:06:15.787] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:71:0) after 6m31s
[20:12:46.822] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:71:0)
[20:12:46.842] Build status: STARTED
[20:12:46.842] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:72:0) after 9m52s
[20:22:38.895] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:72:0)
[20:22:38.932] Build status: STARTED
[20:22:38.932] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:73:0) after 4m23s
[20:27:01.951] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:73:0)
[20:27:01.971] Build status: STARTED
[20:27:01.971] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:74:0) after 4m39s
[20:31:40.995] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:74:0)
[20:31:41.018] Build status: STARTED
[20:31:41.018] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:75:0) after 2m7s
[20:33:48.060] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:75:0)
[20:33:48.091] Build status: STARTED
[20:33:48.091] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:76:0) after 5m2s
[20:38:50.117] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:76:0)
[20:38:50.135] Build status: STARTED
[20:38:50.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:77:0) after 5m7s
[20:43:57.159] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:77:0)
[20:43:57.180] Build status: STARTED
[20:43:57.180] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:78:0) after 9m24s
[20:53:21.281] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:78:0)
[20:53:21.300] Build status: STARTED
[20:53:21.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:79:0) after 1m53s
[20:55:14.385] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:79:0)
[20:55:14.406] Build status: STARTED
[20:55:14.406] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:80:0) after 1m49s
[20:57:03.439] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:80:0)
[20:57:03.460] Build status: STARTED
[20:57:03.460] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:81:0) after 2m11s
[20:59:14.479] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:81:0)
[20:59:14.509] Build status: STARTED
[20:59:14.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:82:0) after 5m5s
[21:04:19.484] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:82:0)
[21:04:19.645] Build status: STARTED
[21:04:19.645] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:83:0) after 9m19s
[21:13:38.739] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:83:0)
[21:13:38.769] Build status: STARTED
[21:13:38.769] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:84:0) after 2m6s
[21:15:44.806] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:84:0)
[21:15:44.828] Build status: STARTED
[21:15:44.828] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:85:0) after 4m30s
[21:20:14.931] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:85:0)
[21:20:14.955] Build status: STARTED
[21:20:14.955] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:86:0) after 7m38s
[21:27:52.975] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:86:0)
[21:27:53.003] Build status: STARTED
[21:27:53.003] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:87:0) after 8m4s
[21:35:57.032] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:87:0)
[21:35:57.054] Build status: STARTED
[21:35:57.054] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:88:0) after 8m20s
[21:44:17.181] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:88:0)
[21:44:17.314] Build status: STARTED
[21:44:17.314] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:89:0) after 5m53s
[21:50:10.344] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:89:0)
[21:50:10.365] Build status: STARTED
[21:50:10.365] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:90:0) after 7m22s
[21:57:32.488] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:90:0)
[21:57:32.515] Build status: STARTED
[21:57:32.515] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:91:0) after 7m55s
[22:05:27.803] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:91:0)
[22:05:27.827] Build status: STARTED
[22:05:27.827] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:92:0) after 6m40s
[22:12:07.880] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:92:0)
[22:12:07.900] Build status: STARTED
[22:12:07.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:93:0) after 7m19s
[22:19:26.943] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:93:0)
[22:19:26.990] Build status: STARTED
[22:19:26.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:94:0) after 3m13s
[22:22:40.461] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:94:0)
[22:22:40.489] Build status: STARTED
[22:22:40.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:95:0) after 9m32s
[22:32:12.575] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:95:0)
[22:32:12.598] Build status: STARTED
[22:32:12.598] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:96:0) after 9m40s
[22:41:52.619] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:96:0)
[22:41:52.641] Build status: STARTED
[22:41:52.641] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:97:0) after 4m4s
[22:45:59.703] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:97:0)
[22:45:59.729] Build status: STARTED
[22:45:59.729] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:98:0) after 2m45s
[22:48:44.756] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:98:0)
[22:48:44.776] Build status: STARTED
[22:48:44.776] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:99:0) after 5m15s
[22:53:59.999] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:99:0)
[22:54:00.019] Build status: STARTED
[22:54:00.019] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:100:0) after 4m59s
[22:58:59.042] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:100:0)
[22:58:59.063] Build status: STARTED
[22:58:59.064] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:101:0) after 8m40s
[23:07:39.217] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:101:0)
[23:07:39.239] Build status: STARTED
[23:07:39.239] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:102:0) after 8m25s
[23:16:04.461] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:102:0)
[23:16:04.489] Build status: STARTED
[23:16:04.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:103:0) after 4m12s
[23:20:16.640] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:103:0)
[23:20:16.658] Build status: STARTED
[23:20:16.658] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:104:0) after 5m56s
[23:26:12.679] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:104:0)
[23:26:12.714] Build status: STARTED
[23:26:12.714] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:105:0) after 6m29s
[23:32:41.732] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:105:0)
[23:32:41.751] Build status: STARTED
[23:32:41.751] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:106:0) after 8m55s
[23:41:36.775] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:106:0)
[23:41:36.795] Build status: STARTED
[23:41:36.795] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8947906172580612592:107:0) after 9m23s
[23:44:03.311] Received PubSub notification, asking Buildbucket for the build status
[23:44:03.331] Build:
{
"id": "8782476110335163921",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTChromeOS"
},
"number": 4662,
"createdBy": "project:chromium",
"createTime": "2023-04-29T13:32:01.329503972Z",
"startTime": "2023-04-29T13:32:04.178338Z",
"endTime": "2023-04-29T23:44:03.073426406Z",
"updateTime": "2023-04-29T23:44:03.073426406Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "204afda39c4030ff670568e35d6849228fcc5164",
"ref": "refs/heads/main"
}
},
"canary": true
}
[23:44:03.331] Invocation finished in 10h12m3.527376169s with status SUCCEEDED