[19:28:54.606] New invocation is queued and will start shortly
[19:28:56.039] Starting the invocation (attempt 1)
[19:28:56.076] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/107bed12107567d902e108caaf2d6351ccae4a07"
[19:28:56.076] Popped gitiles commit info from properties and tags
[19:28:56.076] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:28:56.076] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:28:56.076] Buildbucket request:
{
"requestId": "9003419657952940064",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64(dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "107bed12107567d902e108caaf2d6351ccae4a07",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9003419657952940064"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTWin64(dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:28:56.635] Scheduled build:
{
"id": "8837989595674084145",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64(dbg)"
},
"number": 7602,
"createdBy": "project:chromium",
"createTime": "2021-08-24T19:28:56.147910647Z",
"updateTime": "2021-08-24T19:28:56.385118530Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "107bed12107567d902e108caaf2d6351ccae4a07",
"ref": "refs/heads/main"
}
}
}
[19:28:56.635] Task URL: https://cr-buildbucket.appspot.com/build/8837989595674084145
[19:28:56.635] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:2:0) after 6m45s
[19:35:41.806] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:2:0)
[19:35:41.872] Build status: SCHEDULED
[19:35:41.872] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:3:0) after 3m58s
[19:39:39.901] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:3:0)
[19:39:39.929] Build status: SCHEDULED
[19:39:39.929] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:4:0) after 1m59s
[19:41:38.954] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:4:0)
[19:41:38.984] Build status: SCHEDULED
[19:41:38.984] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:5:0) after 2m5s
[19:43:44.000] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:5:0)
[19:43:44.030] Build status: SCHEDULED
[19:43:44.030] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:6:0) after 4m14s
[19:47:58.098] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:6:0)
[19:47:58.136] Build status: SCHEDULED
[19:47:58.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:7:0) after 1m12s
[19:49:10.193] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:7:0)
[19:49:10.232] Build status: SCHEDULED
[19:49:10.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:8:0) after 1m21s
[19:50:31.357] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:8:0)
[19:50:31.403] Build status: SCHEDULED
[19:50:31.404] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:9:0) after 4m35s
[19:55:06.858] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:9:0)
[19:55:06.896] Build status: SCHEDULED
[19:55:06.896] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:10:0) after 1m55s
[19:57:02.023] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:10:0)
[19:57:02.061] Build status: SCHEDULED
[19:57:02.061] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:11:0) after 2m16s
[19:59:18.186] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:11:0)
[19:59:18.233] Build status: SCHEDULED
[19:59:18.233] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:12:0) after 2m10s
[20:01:28.502] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:12:0)
[20:01:28.546] Build status: SCHEDULED
[20:01:28.546] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:13:0) after 8m35s
[20:10:03.723] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:13:0)
[20:10:03.774] Build status: SCHEDULED
[20:10:03.774] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:14:0) after 5m5s
[20:13:28.157] Received PubSub notification, asking Buildbucket for the build status
[20:13:28.234] Build status: STARTED
[20:15:08.815] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:14:0)
[20:15:08.906] Build status: STARTED
[20:15:08.906] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:16:0) after 4m9s
[20:19:17.946] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:16:0)
[20:19:17.975] Build status: STARTED
[20:19:17.975] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:17:0) after 1m42s
[20:21:00.226] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:17:0)
[20:21:00.265] Build status: STARTED
[20:21:00.265] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:18:0) after 7m37s
[20:28:37.416] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:18:0)
[20:28:37.454] Build status: STARTED
[20:28:37.454] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:19:0) after 3m1s
[20:31:38.605] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:19:0)
[20:31:38.654] Build status: STARTED
[20:31:38.654] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:20:0) after 5m50s
[20:37:28.679] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:20:0)
[20:37:28.718] Build status: STARTED
[20:37:28.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:21:0) after 6m51s
[20:44:19.748] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:21:0)
[20:44:19.780] Build status: STARTED
[20:44:19.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:22:0) after 1m21s
[20:45:41.061] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:22:0)
[20:45:41.094] Build status: STARTED
[20:45:41.094] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:23:0) after 2m15s
[20:47:56.224] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:23:0)
[20:47:56.256] Build status: STARTED
[20:47:56.256] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:24:0) after 2m9s
[20:50:05.288] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:24:0)
[20:50:05.396] Build status: STARTED
[20:50:05.396] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:25:0) after 2m43s
[20:52:48.435] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:25:0)
[20:52:48.475] Build status: STARTED
[20:52:48.475] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:26:0) after 4m54s
[20:57:43.327] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:26:0)
[20:57:43.353] Build status: STARTED
[20:57:43.353] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:27:0) after 3m54s
[21:01:37.488] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:27:0)
[21:01:37.582] Build status: STARTED
[21:01:37.582] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:28:0) after 8m2s
[21:09:39.687] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:28:0)
[21:09:39.723] Build status: STARTED
[21:09:39.723] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:29:0) after 6m26s
[21:16:05.763] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:29:0)
[21:16:05.799] Build status: STARTED
[21:16:05.799] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:30:0) after 7m54s
[21:24:00.101] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:30:0)
[21:24:00.146] Build status: STARTED
[21:24:00.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:31:0) after 8m53s
[21:32:53.228] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:31:0)
[21:32:53.256] Build status: STARTED
[21:32:53.256] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:32:0) after 9m58s
[21:42:51.284] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:32:0)
[21:42:51.313] Build status: STARTED
[21:42:51.313] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:33:0) after 2m22s
[21:45:13.321] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:33:0)
[21:45:13.357] Build status: STARTED
[21:45:13.357] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:34:0) after 1m30s
[21:46:43.459] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:34:0)
[21:46:43.487] Build status: STARTED
[21:46:43.488] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:35:0) after 5m16s
[21:51:59.516] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:35:0)
[21:51:59.545] Build status: STARTED
[21:51:59.545] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:36:0) after 5m29s
[21:57:28.538] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:36:0)
[21:57:28.571] Build status: STARTED
[21:57:28.571] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:37:0) after 2m41s
[22:00:09.613] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:37:0)
[22:00:09.700] Build status: STARTED
[22:00:09.701] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:38:0) after 5m54s
[22:06:03.734] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:38:0)
[22:06:03.777] Build status: STARTED
[22:06:03.777] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:39:0) after 5m35s
[22:11:38.852] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:39:0)
[22:11:38.957] Build status: STARTED
[22:11:38.957] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:40:0) after 5m11s
[22:16:50.267] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:40:0)
[22:16:50.301] Build status: STARTED
[22:16:50.301] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:41:0) after 6m40s
[22:23:30.354] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:41:0)
[22:23:30.389] Build status: STARTED
[22:23:30.389] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:42:0) after 4m55s
[22:28:25.772] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:42:0)
[22:28:25.870] Build status: STARTED
[22:28:25.870] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:43:0) after 9m52s
[22:38:18.429] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:43:0)
[22:38:18.462] Build status: STARTED
[22:38:18.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:44:0) after 2m21s
[22:40:39.498] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:44:0)
[22:40:39.586] Build status: STARTED
[22:40:39.586] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:45:0) after 9m2s
[22:49:41.565] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:45:0)
[22:49:41.598] Build status: STARTED
[22:49:41.598] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:46:0) after 5m21s
[22:55:02.712] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:46:0)
[22:55:02.747] Build status: STARTED
[22:55:02.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:47:0) after 4m21s
[22:59:24.002] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:47:0)
[22:59:24.041] Build status: STARTED
[22:59:24.041] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:48:0) after 7m37s
[23:07:01.179] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:48:0)
[23:07:01.301] Build status: STARTED
[23:07:01.301] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:49:0) after 1m18s
[23:08:19.390] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:49:0)
[23:08:19.422] Build status: STARTED
[23:08:19.422] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:50:0) after 1m4s
[23:09:23.446] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:50:0)
[23:09:23.483] Build status: STARTED
[23:09:23.483] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:51:0) after 6m15s
[23:15:38.508] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:51:0)
[23:15:38.541] Build status: STARTED
[23:15:38.541] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:52:0) after 3m38s
[23:19:16.800] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:52:0)
[23:19:16.858] Build status: STARTED
[23:19:16.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:53:0) after 3m13s
[23:22:29.888] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:53:0)
[23:22:29.924] Build status: STARTED
[23:22:29.924] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:54:0) after 7m33s
[23:30:03.038] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:54:0)
[23:30:03.084] Build status: STARTED
[23:30:03.084] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:55:0) after 2m50s
[23:32:53.118] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:55:0)
[23:32:53.142] Build status: STARTED
[23:32:53.142] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:56:0) after 8m53s
[23:41:46.238] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:56:0)
[23:41:46.269] Build status: STARTED
[23:41:46.269] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:57:0) after 9m56s
[23:51:42.295] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:57:0)
[23:51:42.323] Build status: STARTED
[23:51:42.323] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:58:0) after 1m54s
[23:53:36.710] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:58:0)
[23:53:36.741] Build status: STARTED
[23:53:36.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:59:0) after 4m47s
[23:58:23.798] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:59:0)
[23:58:23.832] Build status: STARTED
[23:58:23.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:60:0) after 5m46s
[00:04:09.876] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:60:0)
[00:04:09.928] Build status: STARTED
[00:04:09.928] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:61:0) after 7m59s
[00:12:09.058] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:61:0)
[00:12:09.088] Build status: STARTED
[00:12:09.088] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:62:0) after 3m55s
[00:16:04.335] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:62:0)
[00:16:04.381] Build status: STARTED
[00:16:04.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:63:0) after 3m58s
[00:20:02.871] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:63:0)
[00:20:02.952] Build status: STARTED
[00:20:02.952] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:64:0) after 5m25s
[00:25:28.031] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:64:0)
[00:25:28.059] Build status: STARTED
[00:25:28.059] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:65:0) after 3m9s
[00:28:37.193] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:65:0)
[00:28:37.227] Build status: STARTED
[00:28:37.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:66:0) after 7m35s
[00:36:12.345] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:66:0)
[00:36:12.373] Build status: STARTED
[00:36:12.373] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:67:0) after 5m12s
[00:41:24.398] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:67:0)
[00:41:24.446] Build status: STARTED
[00:41:24.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:68:0) after 3m15s
[00:44:39.440] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:68:0)
[00:44:39.467] Build status: STARTED
[00:44:39.467] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:69:0) after 3m5s
[00:47:44.514] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:69:0)
[00:47:44.544] Build status: STARTED
[00:47:44.544] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:70:0) after 4m55s
[00:52:39.669] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:70:0)
[00:52:39.711] Build status: STARTED
[00:52:39.711] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:71:0) after 4m1s
[00:56:40.747] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:71:0)
[00:56:40.783] Build status: STARTED
[00:56:40.783] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:72:0) after 9m17s
[01:05:57.982] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:72:0)
[01:05:58.027] Build status: STARTED
[01:05:58.027] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:73:0) after 3m50s
[01:09:48.151] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:73:0)
[01:09:48.266] Build status: STARTED
[01:09:48.266] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:74:0) after 7m5s
[01:16:53.298] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:74:0)
[01:16:53.334] Build status: STARTED
[01:16:53.334] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:75:0) after 4m44s
[01:21:37.507] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:75:0)
[01:21:37.538] Build status: STARTED
[01:21:37.538] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:76:0) after 1m23s
[01:23:01.010] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:76:0)
[01:23:01.043] Build status: STARTED
[01:23:01.043] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:77:0) after 2m47s
[01:25:48.087] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:77:0)
[01:25:48.115] Build status: STARTED
[01:25:48.115] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:78:0) after 4m32s
[01:30:20.757] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:78:0)
[01:30:20.790] Build status: STARTED
[01:30:20.790] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:79:0) after 5m17s
[01:35:37.960] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:79:0)
[01:35:38.099] Build status: STARTED
[01:35:38.099] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:80:0) after 4m23s
[01:40:01.378] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:80:0)
[01:40:01.413] Build status: STARTED
[01:40:01.413] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:81:0) after 7m22s
[01:47:23.600] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:81:0)
[01:47:23.630] Build status: STARTED
[01:47:23.630] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:82:0) after 8m37s
[01:56:00.767] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:82:0)
[01:56:00.796] Build status: STARTED
[01:56:00.796] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:83:0) after 4m46s
[02:00:46.878] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:83:0)
[02:00:46.912] Build status: STARTED
[02:00:46.912] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:84:0) after 8m59s
[02:09:46.077] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:84:0)
[02:09:46.116] Build status: STARTED
[02:09:46.116] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:85:0) after 6m20s
[02:16:06.395] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:85:0)
[02:16:06.453] Build status: STARTED
[02:16:06.453] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:86:0) after 8m57s
[02:25:03.867] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:86:0)
[02:25:03.905] Build status: STARTED
[02:25:03.905] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:87:0) after 7m35s
[02:32:39.039] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:87:0)
[02:32:39.122] Build status: STARTED
[02:32:39.122] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:88:0) after 8m20s
[02:40:59.280] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:88:0)
[02:40:59.312] Build status: STARTED
[02:40:59.312] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:89:0) after 6m45s
[02:47:44.404] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:89:0)
[02:47:44.431] Build status: STARTED
[02:47:44.431] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:90:0) after 1m3s
[02:48:47.645] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:90:0)
[02:48:47.678] Build status: STARTED
[02:48:47.678] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:91:0) after 7m45s
[02:56:32.733] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:91:0)
[02:56:32.769] Build status: STARTED
[02:56:32.769] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:92:0) after 2m6s
[02:58:38.924] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:92:0)
[02:58:38.955] Build status: STARTED
[02:58:38.956] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:93:0) after 4m14s
[03:02:53.279] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:93:0)
[03:02:53.309] Build status: STARTED
[03:02:53.309] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:94:0) after 1m27s
[03:04:20.443] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:94:0)
[03:04:20.474] Build status: STARTED
[03:04:20.474] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:95:0) after 2m1s
[03:06:21.672] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:95:0)
[03:06:21.697] Build status: STARTED
[03:06:21.697] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:96:0) after 6m24s
[03:12:45.766] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:96:0)
[03:12:45.800] Build status: STARTED
[03:12:45.800] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:97:0) after 6m56s
[03:19:41.831] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:97:0)
[03:19:41.908] Build status: STARTED
[03:19:41.908] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:98:0) after 2m51s
[03:22:32.936] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:98:0)
[03:22:32.976] Build status: STARTED
[03:22:32.976] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:99:0) after 9m39s
[03:32:12.145] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:99:0)
[03:32:12.177] Build status: STARTED
[03:32:12.177] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:100:0) after 9m55s
[03:42:07.362] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:100:0)
[03:42:07.391] Build status: STARTED
[03:42:07.391] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:101:0) after 9m40s
[03:51:47.510] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:101:0)
[03:51:47.540] Build status: STARTED
[03:51:47.540] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:102:0) after 4m57s
[03:56:44.937] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:102:0)
[03:56:44.968] Build status: STARTED
[03:56:44.968] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:103:0) after 2m27s
[03:59:12.556] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:103:0)
[03:59:12.590] Build status: STARTED
[03:59:12.590] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:104:0) after 2m7s
[04:01:19.627] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:104:0)
[04:01:19.663] Build status: STARTED
[04:01:19.663] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:105:0) after 6m29s
[04:07:48.759] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:105:0)
[04:07:48.790] Build status: STARTED
[04:07:48.790] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:106:0) after 5m3s
[04:12:52.000] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:106:0)
[04:12:52.029] Build status: STARTED
[04:12:52.029] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:107:0) after 2m48s
[04:15:40.036] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:107:0)
[04:15:40.065] Build status: STARTED
[04:15:40.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:108:0) after 2m18s
[04:17:58.247] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:108:0)
[04:17:58.274] Build status: STARTED
[04:17:58.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:109:0) after 9m56s
[04:27:54.303] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:109:0)
[04:27:54.333] Build status: STARTED
[04:27:54.333] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:110:0) after 2m33s
[04:30:27.360] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:110:0)
[04:30:27.393] Build status: STARTED
[04:30:27.393] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:111:0) after 9m49s
[04:40:16.446] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:111:0)
[04:40:16.480] Build status: STARTED
[04:40:16.481] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:112:0) after 4m19s
[04:44:35.648] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:112:0)
[04:44:35.706] Build status: STARTED
[04:44:35.707] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:113:0) after 6m51s
[04:51:26.736] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:113:0)
[04:51:26.764] Build status: STARTED
[04:51:26.764] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:114:0) after 4m16s
[04:55:42.848] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:114:0)
[04:55:42.883] Build status: STARTED
[04:55:42.883] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:115:0) after 5m8s
[05:00:50.912] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:115:0)
[05:00:50.941] Build status: STARTED
[05:00:50.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:116:0) after 1m57s
[05:02:48.116] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:116:0)
[05:02:48.158] Build status: STARTED
[05:02:48.158] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:117:0) after 2m51s
[05:05:39.569] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:117:0)
[05:05:39.601] Build status: STARTED
[05:05:39.601] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:118:0) after 5m1s
[05:10:40.630] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:118:0)
[05:10:40.661] Build status: STARTED
[05:10:40.661] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:119:0) after 9m18s
[05:19:58.699] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:119:0)
[05:19:58.888] Build status: STARTED
[05:19:58.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):9003419657952940064:120:0) after 8m59s
[05:20:06.272] Received PubSub notification, asking Buildbucket for the build status
[05:20:06.300] Build:
{
"id": "8837989595674084145",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64(dbg)"
},
"number": 7602,
"createdBy": "project:chromium",
"createTime": "2021-08-24T19:28:56.147910647Z",
"startTime": "2021-08-24T20:13:27.201763Z",
"endTime": "2021-08-25T05:20:05.478098260Z",
"updateTime": "2021-08-25T05:20:05.478830946Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "107bed12107567d902e108caaf2d6351ccae4a07",
"ref": "refs/heads/main"
}
}
}
[05:20:06.300] Invocation finished in 9h51m11.709832211s with status FAILED