[01:01:04.968] New invocation is queued and will start shortly
[01:01:06.331] Starting the invocation (attempt 1)
[01:01:06.370] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c8a4aca6024b2aedbe6b3befa73e967157fa83c4"
[01:01:06.370] Popped gitiles commit info from properties and tags
[01:01:06.370] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:01:06.370] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:01:06.371] Buildbucket request:
{
"requestId": "8910808659783513376",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c8a4aca6024b2aedbe6b3befa73e967157fa83c4",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8910808659783513376"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTWin(dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[01:01:07.454] Scheduled build:
{
"id": "8745378597541157985",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 15896,
"createdBy": "project:chromium",
"createTime": "2024-06-12T01:01:06.484122676Z",
"updateTime": "2024-06-12T01:01:06.484122676Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c8a4aca6024b2aedbe6b3befa73e967157fa83c4",
"ref": "refs/heads/main"
}
}
}
[01:01:07.454] Task URL: https://cr-buildbucket.appspot.com/build/8745378597541157985
[01:01:07.454] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:2:0) after 7m2s
[01:01:08.227] Received PubSub notification, asking Buildbucket for the build status
[01:01:08.245] Build status: SCHEDULED
[01:08:09.509] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:2:0)
[01:08:09.588] Build status: STARTED
[01:08:09.588] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:4:0) after 2m1s
[01:08:12.771] Received PubSub notification, asking Buildbucket for the build status
[01:08:12.796] Build status: STARTED
[01:10:10.705] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:4:0)
[01:10:10.723] Build status: STARTED
[01:10:10.723] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:6:0) after 9m41s
[01:19:51.790] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:6:0)
[01:19:51.809] Build status: STARTED
[01:19:51.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:7:0) after 1m19s
[01:21:10.847] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:7:0)
[01:21:10.881] Build status: STARTED
[01:21:10.881] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:8:0) after 5m46s
[01:26:56.929] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:8:0)
[01:26:57.005] Build status: STARTED
[01:26:57.005] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:9:0) after 5m0s
[01:31:57.043] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:9:0)
[01:31:57.061] Build status: STARTED
[01:31:57.061] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:10:0) after 6m0s
[01:37:57.093] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:10:0)
[01:37:57.128] Build status: STARTED
[01:37:57.128] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:11:0) after 5m28s
[01:43:25.157] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:11:0)
[01:43:25.260] Build status: STARTED
[01:43:25.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:12:0) after 1m34s
[01:44:59.499] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:12:0)
[01:44:59.524] Build status: STARTED
[01:44:59.524] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:13:0) after 3m31s
[01:48:30.601] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:13:0)
[01:48:30.673] Build status: STARTED
[01:48:30.673] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:14:0) after 4m21s
[01:52:51.791] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:14:0)
[01:52:51.808] Build status: STARTED
[01:52:51.808] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:15:0) after 3m58s
[01:56:49.872] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:15:0)
[01:56:49.946] Build status: STARTED
[01:56:49.946] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:16:0) after 5m0s
[02:01:50.432] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:16:0)
[02:01:50.451] Build status: STARTED
[02:01:50.451] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:17:0) after 7m36s
[02:09:26.480] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:17:0)
[02:09:26.514] Build status: STARTED
[02:09:26.514] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:18:0) after 1m13s
[02:10:39.639] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:18:0)
[02:10:39.660] Build status: STARTED
[02:10:39.660] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:19:0) after 2m12s
[02:12:51.796] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:19:0)
[02:12:51.811] Build status: STARTED
[02:12:51.811] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:20:0) after 9m45s
[02:22:36.839] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:20:0)
[02:22:36.856] Build status: STARTED
[02:22:36.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:21:0) after 7m35s
[02:30:12.081] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:21:0)
[02:30:12.096] Build status: STARTED
[02:30:12.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:22:0) after 1m11s
[02:31:23.281] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:22:0)
[02:31:23.297] Build status: STARTED
[02:31:23.297] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:23:0) after 2m21s
[02:33:44.321] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:23:0)
[02:33:44.339] Build status: STARTED
[02:33:44.340] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:24:0) after 2m17s
[02:36:01.426] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:24:0)
[02:36:01.445] Build status: STARTED
[02:36:01.445] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:25:0) after 8m39s
[02:44:40.566] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:25:0)
[02:44:40.593] Build status: STARTED
[02:44:40.593] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:26:0) after 4m1s
[02:48:41.920] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:26:0)
[02:48:41.937] Build status: STARTED
[02:48:41.937] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:27:0) after 5m37s
[02:54:18.961] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:27:0)
[02:54:18.978] Build status: STARTED
[02:54:18.978] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:28:0) after 4m3s
[02:58:22.004] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:28:0)
[02:58:22.030] Build status: STARTED
[02:58:22.030] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:29:0) after 4m29s
[03:02:51.065] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:29:0)
[03:02:51.133] Build status: STARTED
[03:02:51.133] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:30:0) after 1m49s
[03:04:40.158] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:30:0)
[03:04:40.183] Build status: STARTED
[03:04:40.183] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:31:0) after 8m19s
[03:12:59.218] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:31:0)
[03:12:59.280] Build status: STARTED
[03:12:59.280] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:32:0) after 5m7s
[03:18:06.318] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:32:0)
[03:18:06.335] Build status: STARTED
[03:18:06.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:33:0) after 7m40s
[03:25:46.389] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:33:0)
[03:25:46.406] Build status: STARTED
[03:25:46.406] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:34:0) after 4m7s
[03:29:53.452] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:34:0)
[03:29:53.468] Build status: STARTED
[03:29:53.468] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:35:0) after 3m59s
[03:33:52.502] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:35:0)
[03:33:52.613] Build status: STARTED
[03:33:52.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:36:0) after 5m48s
[03:39:40.663] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:36:0)
[03:39:40.681] Build status: STARTED
[03:39:40.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:37:0) after 5m15s
[03:44:55.833] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:37:0)
[03:44:55.853] Build status: STARTED
[03:44:55.853] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:38:0) after 4m31s
[03:49:26.926] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:38:0)
[03:49:26.942] Build status: STARTED
[03:49:26.942] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:39:0) after 5m35s
[03:55:02.016] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:39:0)
[03:55:02.030] Build status: STARTED
[03:55:02.030] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:40:0) after 8m13s
[04:03:15.080] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:40:0)
[04:03:15.103] Build status: STARTED
[04:03:15.103] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:41:0) after 4m12s
[04:07:27.193] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:41:0)
[04:07:27.317] Build status: STARTED
[04:07:27.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:42:0) after 2m33s
[04:10:00.360] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:42:0)
[04:10:00.379] Build status: STARTED
[04:10:00.379] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:43:0) after 9m1s
[04:19:01.406] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:43:0)
[04:19:01.426] Build status: STARTED
[04:19:01.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:44:0) after 5m16s
[04:24:17.881] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:44:0)
[04:24:17.982] Build status: STARTED
[04:24:17.982] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:45:0) after 4m22s
[04:28:40.030] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:45:0)
[04:28:40.052] Build status: STARTED
[04:28:40.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:46:0) after 8m19s
[04:36:59.076] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:46:0)
[04:36:59.097] Build status: STARTED
[04:36:59.097] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:47:0) after 9m29s
[04:46:28.135] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:47:0)
[04:46:28.154] Build status: STARTED
[04:46:28.154] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:48:0) after 1m23s
[04:47:51.180] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:48:0)
[04:47:51.220] Build status: STARTED
[04:47:51.220] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:49:0) after 8m2s
[04:55:53.269] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:49:0)
[04:55:53.286] Build status: STARTED
[04:55:53.287] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:50:0) after 2m1s
[04:57:54.310] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:50:0)
[04:57:54.326] Build status: STARTED
[04:57:54.326] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:51:0) after 3m13s
[05:01:07.622] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:51:0)
[05:01:07.639] Build status: STARTED
[05:01:07.639] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:52:0) after 6m18s
[05:07:25.803] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:52:0)
[05:07:25.866] Build status: STARTED
[05:07:25.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:53:0) after 1m52s
[05:09:18.201] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:53:0)
[05:09:18.229] Build status: STARTED
[05:09:18.229] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:54:0) after 8m9s
[05:17:27.427] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:54:0)
[05:17:27.472] Build status: STARTED
[05:17:27.472] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:55:0) after 6m25s
[05:23:52.582] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:55:0)
[05:23:52.598] Build status: STARTED
[05:23:52.598] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:56:0) after 5m31s
[05:29:23.628] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:56:0)
[05:29:23.644] Build status: STARTED
[05:29:23.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:57:0) after 1m24s
[05:30:47.946] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:57:0)
[05:30:48.027] Build status: STARTED
[05:30:48.027] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:58:0) after 1m34s
[05:32:22.257] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:58:0)
[05:32:22.344] Build status: STARTED
[05:32:22.344] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:59:0) after 2m29s
[05:34:51.731] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:59:0)
[05:34:51.764] Build status: STARTED
[05:34:51.764] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:60:0) after 9m21s
[05:44:12.772] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:60:0)
[05:44:12.806] Build status: STARTED
[05:44:12.806] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:61:0) after 6m0s
[05:50:12.963] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:61:0)
[05:50:13.113] Build status: STARTED
[05:50:13.113] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:62:0) after 7m52s
[05:58:05.216] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:62:0)
[05:58:05.235] Build status: STARTED
[05:58:05.235] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:63:0) after 8m22s
[06:06:27.281] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:63:0)
[06:06:27.348] Build status: STARTED
[06:06:27.348] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:64:0) after 1m0s
[06:07:27.509] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:64:0)
[06:07:27.526] Build status: STARTED
[06:07:27.526] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:65:0) after 2m28s
[06:09:55.680] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:65:0)
[06:09:55.699] Build status: STARTED
[06:09:55.699] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:66:0) after 4m18s
[06:14:13.761] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:66:0)
[06:14:13.777] Build status: STARTED
[06:14:13.777] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:67:0) after 9m50s
[06:24:03.816] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:67:0)
[06:24:03.839] Build status: STARTED
[06:24:03.839] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:68:0) after 6m39s
[06:30:42.988] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:68:0)
[06:30:43.007] Build status: STARTED
[06:30:43.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:69:0) after 9m45s
[06:40:28.039] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:69:0)
[06:40:28.056] Build status: STARTED
[06:40:28.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:70:0) after 6m42s
[06:47:10.159] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:70:0)
[06:47:10.175] Build status: STARTED
[06:47:10.175] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:71:0) after 9m56s
[06:57:06.200] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:71:0)
[06:57:06.226] Build status: STARTED
[06:57:06.226] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:72:0) after 9m39s
[07:06:45.407] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:72:0)
[07:06:45.426] Build status: STARTED
[07:06:45.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:73:0) after 3m27s
[07:10:12.459] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:73:0)
[07:10:12.479] Build status: STARTED
[07:10:12.479] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:74:0) after 3m49s
[07:14:01.555] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:74:0)
[07:14:01.575] Build status: STARTED
[07:14:01.575] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:75:0) after 1m26s
[07:15:27.727] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:75:0)
[07:15:27.752] Build status: STARTED
[07:15:27.752] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:76:0) after 9m15s
[07:24:42.798] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:76:0)
[07:24:42.878] Build status: STARTED
[07:24:42.878] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:77:0) after 7m56s
[07:32:38.988] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:77:0)
[07:32:39.025] Build status: STARTED
[07:32:39.025] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:78:0) after 5m23s
[07:38:02.069] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:78:0)
[07:38:02.087] Build status: STARTED
[07:38:02.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:79:0) after 4m26s
[07:42:28.120] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:79:0)
[07:42:28.138] Build status: STARTED
[07:42:28.138] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:80:0) after 2m29s
[07:44:57.428] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:80:0)
[07:44:57.462] Build status: STARTED
[07:44:57.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:81:0) after 8m49s
[07:53:46.598] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:81:0)
[07:53:46.619] Build status: STARTED
[07:53:46.619] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:82:0) after 2m42s
[07:56:28.703] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:82:0)
[07:56:28.719] Build status: STARTED
[07:56:28.719] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:83:0) after 5m28s
[08:01:56.717] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:83:0)
[08:01:56.758] Build status: STARTED
[08:01:56.758] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:84:0) after 9m34s
[08:11:31.336] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:84:0)
[08:11:31.372] Build status: STARTED
[08:11:31.372] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:85:0) after 1m9s
[08:12:40.407] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:85:0)
[08:12:40.433] Build status: STARTED
[08:12:40.433] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:86:0) after 3m40s
[08:16:20.538] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:86:0)
[08:16:20.558] Build status: STARTED
[08:16:20.558] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:87:0) after 4m54s
[08:21:14.590] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:87:0)
[08:21:14.608] Build status: STARTED
[08:21:14.608] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:88:0) after 6m22s
[08:27:36.640] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:88:0)
[08:27:36.670] Build status: STARTED
[08:27:36.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:89:0) after 7m7s
[08:34:43.701] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:89:0)
[08:34:43.739] Build status: STARTED
[08:34:43.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:90:0) after 1m43s
[08:36:26.779] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:90:0)
[08:36:26.804] Build status: STARTED
[08:36:26.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:91:0) after 1m25s
[08:37:52.172] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:91:0)
[08:37:52.190] Build status: STARTED
[08:37:52.190] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:92:0) after 9m10s
[08:47:02.475] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:92:0)
[08:47:02.491] Build status: STARTED
[08:47:02.491] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:93:0) after 2m57s
[08:49:59.529] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:93:0)
[08:49:59.548] Build status: STARTED
[08:49:59.548] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:94:0) after 6m27s
[08:56:26.615] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:94:0)
[08:56:26.632] Build status: STARTED
[08:56:26.632] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:95:0) after 7m35s
[09:04:01.880] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:95:0)
[09:04:01.901] Build status: STARTED
[09:04:01.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:96:0) after 2m32s
[09:06:33.981] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:96:0)
[09:06:34.039] Build status: STARTED
[09:06:34.039] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:97:0) after 6m12s
[09:12:46.291] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:97:0)
[09:12:46.340] Build status: STARTED
[09:12:46.340] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:98:0) after 3m0s
[09:15:46.498] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:98:0)
[09:15:46.516] Build status: STARTED
[09:15:46.516] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:99:0) after 7m8s
[09:22:54.550] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:99:0)
[09:22:54.618] Build status: STARTED
[09:22:54.618] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:100:0) after 7m31s
[09:30:25.678] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:100:0)
[09:30:25.714] Build status: STARTED
[09:30:25.714] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:101:0) after 9m16s
[09:39:41.745] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:101:0)
[09:39:41.766] Build status: STARTED
[09:39:41.766] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:102:0) after 2m55s
[09:42:36.791] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:102:0)
[09:42:36.807] Build status: STARTED
[09:42:36.807] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:103:0) after 2m3s
[09:44:39.798] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:103:0)
[09:44:39.815] Build status: STARTED
[09:44:39.815] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:104:0) after 3m18s
[09:47:57.864] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:104:0)
[09:47:57.928] Build status: STARTED
[09:47:57.928] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:105:0) after 8m22s
[09:56:20.150] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:105:0)
[09:56:20.170] Build status: STARTED
[09:56:20.170] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:106:0) after 6m51s
[10:03:11.228] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:106:0)
[10:03:11.247] Build status: STARTED
[10:03:11.247] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:107:0) after 7m34s
[10:10:45.262] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:107:0)
[10:10:45.358] Build status: STARTED
[10:10:45.358] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:108:0) after 9m47s
[10:20:32.408] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:108:0)
[10:20:32.424] Build status: STARTED
[10:20:32.424] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:109:0) after 2m26s
[10:22:58.482] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:109:0)
[10:22:58.575] Build status: STARTED
[10:22:58.575] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:110:0) after 1m10s
[10:24:08.700] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:110:0)
[10:24:08.836] Build status: STARTED
[10:24:08.836] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:111:0) after 6m25s
[10:30:33.963] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:111:0)
[10:30:33.979] Build status: STARTED
[10:30:33.979] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:112:0) after 5m58s
[10:36:32.324] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:112:0)
[10:36:32.344] Build status: STARTED
[10:36:32.344] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:113:0) after 3m33s
[10:40:05.655] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:113:0)
[10:40:05.675] Build status: STARTED
[10:40:05.675] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:114:0) after 1m5s
[10:41:10.855] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:114:0)
[10:41:10.877] Build status: STARTED
[10:41:10.877] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:115:0) after 2m46s
[10:43:57.049] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:115:0)
[10:43:57.145] Build status: STARTED
[10:43:57.145] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:116:0) after 6m11s
[10:50:08.201] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:116:0)
[10:50:08.251] Build status: STARTED
[10:50:08.251] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:117:0) after 5m57s
[10:56:05.386] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:117:0)
[10:56:05.407] Build status: STARTED
[10:56:05.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:118:0) after 2m17s
[10:58:22.658] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:118:0)
[10:58:22.690] Build status: STARTED
[10:58:22.691] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8910808659783513376:119:0) after 8m30s
[11:05:56.449] Received PubSub notification, asking Buildbucket for the build status
[11:05:56.466] Build:
{
"id": "8745378597541157985",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 15896,
"createdBy": "project:chromium",
"createTime": "2024-06-12T01:01:06.484122676Z",
"startTime": "2024-06-12T01:07:53.385051988Z",
"endTime": "2024-06-12T11:05:55.978072432Z",
"updateTime": "2024-06-12T11:05:55.978072432Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c8a4aca6024b2aedbe6b3befa73e967157fa83c4",
"ref": "refs/heads/main"
}
}
}
[11:05:56.466] Invocation finished in 10h4m51.503730963s with status SUCCEEDED