[01:29:59.651] New invocation is queued and will start shortly
[01:30:00.746] Starting the invocation (attempt 1)
[01:30:00.883] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/23cbb491c39fa9aca6448ee2e3c9182b56c3274d"
[01:30:00.883] Popped gitiles commit info from properties and tags
[01:30:00.883] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:30:00.883] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:30:00.884] Buildbucket request:
{
"requestId": "8991800528819561040",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dll)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "23cbb491c39fa9aca6448ee2e3c9182b56c3274d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8991800528819561040"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTWin(dll)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[01:30:01.538] Scheduled build:
{
"id": "8826370466761349105",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dll)"
},
"number": 9498,
"createdBy": "project:chromium",
"createTime": "2021-12-31T01:30:00.971749615Z",
"updateTime": "2021-12-31T01:30:00.971749615Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "23cbb491c39fa9aca6448ee2e3c9182b56c3274d",
"ref": "refs/heads/main"
}
}
}
[01:30:01.538] Task URL: https://cr-buildbucket.appspot.com/build/8826370466761349105
[01:30:01.538] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:2:0) after 2m23s
[01:32:24.558] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:2:0)
[01:32:24.679] Build status: SCHEDULED
[01:32:24.679] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:3:0) after 7m38s
[01:40:02.696] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:3:0)
[01:40:02.712] Build status: SCHEDULED
[01:40:02.712] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:4:0) after 3m1s
[01:43:03.944] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:4:0)
[01:43:03.965] Build status: SCHEDULED
[01:43:03.965] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:5:0) after 3m26s
[01:46:29.963] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:5:0)
[01:46:29.987] Build status: SCHEDULED
[01:46:29.987] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:6:0) after 5m50s
[01:52:20.162] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:6:0)
[01:52:20.179] Build status: SCHEDULED
[01:52:20.179] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:7:0) after 4m33s
[01:56:53.276] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:7:0)
[01:56:53.295] Build status: SCHEDULED
[01:56:53.295] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:8:0) after 7m54s
[02:04:47.515] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:8:0)
[02:04:47.537] Build status: SCHEDULED
[02:04:47.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:9:0) after 2m20s
[02:07:07.557] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:9:0)
[02:07:07.582] Build status: SCHEDULED
[02:07:07.582] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:10:0) after 7m22s
[02:14:29.603] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:10:0)
[02:14:29.620] Build status: SCHEDULED
[02:14:29.620] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:11:0) after 6m48s
[02:21:17.628] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:11:0)
[02:21:17.647] Build status: SCHEDULED
[02:21:17.647] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:12:0) after 8m27s
[02:28:13.869] Received PubSub notification, asking Buildbucket for the build status
[02:28:13.891] Build status: STARTED
[02:29:44.672] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:12:0)
[02:29:44.698] Build status: STARTED
[02:29:44.699] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:14:0) after 9m23s
[02:39:07.847] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:14:0)
[02:39:07.869] Build status: STARTED
[02:39:07.869] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:15:0) after 5m51s
[02:44:58.891] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:15:0)
[02:44:58.917] Build status: STARTED
[02:44:58.917] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:16:0) after 3m2s
[02:48:00.983] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:16:0)
[02:48:01.002] Build status: STARTED
[02:48:01.002] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:17:0) after 5m5s
[02:53:06.026] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:17:0)
[02:53:06.073] Build status: STARTED
[02:53:06.073] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:18:0) after 6m36s
[02:59:42.094] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:18:0)
[02:59:42.126] Build status: STARTED
[02:59:42.126] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:19:0) after 4m2s
[03:03:44.212] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:19:0)
[03:03:44.232] Build status: STARTED
[03:03:44.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:20:0) after 5m20s
[03:09:05.173] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:20:0)
[03:09:05.197] Build status: STARTED
[03:09:05.197] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:21:0) after 5m31s
[03:14:36.221] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:21:0)
[03:14:36.238] Build status: STARTED
[03:14:36.238] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:22:0) after 1m57s
[03:16:33.347] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:22:0)
[03:16:33.375] Build status: STARTED
[03:16:33.375] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:23:0) after 2m28s
[03:19:01.591] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:23:0)
[03:19:01.621] Build status: STARTED
[03:19:01.621] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:24:0) after 2m47s
[03:21:48.741] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:24:0)
[03:21:48.774] Build status: STARTED
[03:21:48.774] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:25:0) after 8m33s
[03:30:22.037] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:25:0)
[03:30:22.063] Build status: STARTED
[03:30:22.063] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:26:0) after 2m57s
[03:33:19.752] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:26:0)
[03:33:19.791] Build status: STARTED
[03:33:19.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:27:0) after 3m12s
[03:36:32.079] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:27:0)
[03:36:32.098] Build status: STARTED
[03:36:32.098] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:28:0) after 4m6s
[03:40:38.144] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:28:0)
[03:40:38.173] Build status: STARTED
[03:40:38.173] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:29:0) after 8m7s
[03:48:45.194] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:29:0)
[03:48:45.223] Build status: STARTED
[03:48:45.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:30:0) after 1m14s
[03:49:59.721] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:30:0)
[03:49:59.758] Build status: STARTED
[03:49:59.758] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:31:0) after 9m25s
[03:59:24.993] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:31:0)
[03:59:25.026] Build status: STARTED
[03:59:25.026] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:32:0) after 2m34s
[04:01:59.051] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:32:0)
[04:01:59.069] Build status: STARTED
[04:01:59.069] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:33:0) after 1m37s
[04:03:36.090] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:33:0)
[04:03:36.118] Build status: STARTED
[04:03:36.118] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:34:0) after 3m7s
[04:06:43.140] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:34:0)
[04:06:43.184] Build status: STARTED
[04:06:43.184] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:35:0) after 3m10s
[04:09:53.258] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:35:0)
[04:09:53.291] Build status: STARTED
[04:09:53.291] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:36:0) after 8m48s
[04:18:41.412] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:36:0)
[04:18:41.443] Build status: STARTED
[04:18:41.443] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:37:0) after 5m49s
[04:24:30.570] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:37:0)
[04:24:30.736] Build status: STARTED
[04:24:30.736] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:38:0) after 3m9s
[04:27:40.079] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:38:0)
[04:27:40.140] Build status: STARTED
[04:27:40.140] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:39:0) after 2m7s
[04:29:47.371] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:39:0)
[04:29:47.431] Build status: STARTED
[04:29:47.431] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:40:0) after 1m38s
[04:31:25.777] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:40:0)
[04:31:25.800] Build status: STARTED
[04:31:25.800] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:41:0) after 5m7s
[04:36:33.089] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:41:0)
[04:36:33.136] Build status: STARTED
[04:36:33.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:42:0) after 1m46s
[04:38:19.273] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:42:0)
[04:38:19.300] Build status: STARTED
[04:38:19.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:43:0) after 6m56s
[04:45:15.316] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:43:0)
[04:45:15.335] Build status: STARTED
[04:45:15.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:44:0) after 8m22s
[04:53:37.396] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:44:0)
[04:53:37.455] Build status: STARTED
[04:53:37.455] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:45:0) after 7m11s
[05:00:48.489] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:45:0)
[05:00:48.555] Build status: STARTED
[05:00:48.555] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:46:0) after 3m28s
[05:04:16.573] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:46:0)
[05:04:16.632] Build status: STARTED
[05:04:16.632] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:47:0) after 8m39s
[05:12:55.659] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:47:0)
[05:12:55.690] Build status: STARTED
[05:12:55.690] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:48:0) after 9m56s
[05:22:51.806] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:48:0)
[05:22:51.853] Build status: STARTED
[05:22:51.853] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:49:0) after 5m47s
[05:28:38.886] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:49:0)
[05:28:38.910] Build status: STARTED
[05:28:38.910] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:50:0) after 7m33s
[05:36:12.133] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:50:0)
[05:36:12.152] Build status: STARTED
[05:36:12.152] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:51:0) after 6m59s
[05:43:11.224] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:51:0)
[05:43:11.249] Build status: STARTED
[05:43:11.249] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:52:0) after 9m37s
[05:52:48.270] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:52:0)
[05:52:48.288] Build status: STARTED
[05:52:48.288] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:53:0) after 8m50s
[06:01:38.903] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:53:0)
[06:01:38.922] Build status: STARTED
[06:01:38.922] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:54:0) after 5m23s
[06:07:02.031] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:54:0)
[06:07:02.056] Build status: STARTED
[06:07:02.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:55:0) after 4m6s
[06:11:08.137] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:55:0)
[06:11:08.210] Build status: STARTED
[06:11:08.210] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:56:0) after 5m40s
[06:16:48.231] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:56:0)
[06:16:48.257] Build status: STARTED
[06:16:48.257] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:57:0) after 5m12s
[06:22:00.279] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:57:0)
[06:22:00.296] Build status: STARTED
[06:22:00.296] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:58:0) after 7m46s
[06:29:46.318] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:58:0)
[06:29:46.347] Build status: STARTED
[06:29:46.347] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:59:0) after 9m17s
[06:39:03.370] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:59:0)
[06:39:03.389] Build status: STARTED
[06:39:03.389] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:60:0) after 6m58s
[06:46:01.437] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:60:0)
[06:46:01.458] Build status: STARTED
[06:46:01.458] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:61:0) after 7m19s
[06:53:20.590] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:61:0)
[06:53:20.614] Build status: STARTED
[06:53:20.614] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:62:0) after 9m22s
[07:02:42.682] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:62:0)
[07:02:42.705] Build status: STARTED
[07:02:42.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:63:0) after 4m35s
[07:07:17.727] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:63:0)
[07:07:17.746] Build status: STARTED
[07:07:17.746] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:64:0) after 1m58s
[07:09:15.769] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:64:0)
[07:09:15.868] Build status: STARTED
[07:09:15.868] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:65:0) after 7m6s
[07:16:21.933] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:65:0)
[07:16:21.952] Build status: STARTED
[07:16:21.952] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:66:0) after 2m58s
[07:19:20.225] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:66:0)
[07:19:20.257] Build status: STARTED
[07:19:20.257] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:67:0) after 1m33s
[07:20:53.279] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:67:0)
[07:20:53.300] Build status: STARTED
[07:20:53.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:68:0) after 2m31s
[07:23:24.325] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:68:0)
[07:23:24.343] Build status: STARTED
[07:23:24.343] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:69:0) after 6m37s
[07:30:01.372] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:69:0)
[07:30:01.393] Build status: STARTED
[07:30:01.393] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:70:0) after 6m40s
[07:36:42.180] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:70:0)
[07:36:42.196] Build status: STARTED
[07:36:42.196] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:71:0) after 3m18s
[07:40:01.505] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:71:0)
[07:40:01.526] Build status: STARTED
[07:40:01.526] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:72:0) after 4m36s
[07:44:37.547] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:72:0)
[07:44:37.610] Build status: STARTED
[07:44:37.610] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:73:0) after 4m4s
[07:48:41.739] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:73:0)
[07:48:41.775] Build status: STARTED
[07:48:41.775] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:74:0) after 1m45s
[07:50:26.886] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:74:0)
[07:50:26.926] Build status: STARTED
[07:50:26.926] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:75:0) after 8m9s
[07:58:36.311] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:75:0)
[07:58:36.342] Build status: STARTED
[07:58:36.342] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:76:0) after 2m40s
[08:01:16.396] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:76:0)
[08:01:16.415] Build status: STARTED
[08:01:16.415] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:77:0) after 3m1s
[08:04:17.709] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:77:0)
[08:04:17.737] Build status: STARTED
[08:04:17.737] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:78:0) after 6m39s
[08:10:56.925] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:78:0)
[08:10:56.949] Build status: STARTED
[08:10:56.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:79:0) after 1m5s
[08:12:02.045] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:79:0)
[08:12:02.066] Build status: STARTED
[08:12:02.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:80:0) after 6m24s
[08:18:26.073] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:80:0)
[08:18:26.095] Build status: STARTED
[08:18:26.095] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:81:0) after 3m0s
[08:21:26.120] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:81:0)
[08:21:26.148] Build status: STARTED
[08:21:26.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:82:0) after 2m12s
[08:23:38.156] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:82:0)
[08:23:38.176] Build status: STARTED
[08:23:38.176] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:83:0) after 3m34s
[08:27:12.215] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:83:0)
[08:27:12.269] Build status: STARTED
[08:27:12.269] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:84:0) after 8m14s
[08:35:26.295] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:84:0)
[08:35:26.326] Build status: STARTED
[08:35:26.326] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:85:0) after 6m35s
[08:42:01.359] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:85:0)
[08:42:01.381] Build status: STARTED
[08:42:01.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:86:0) after 4m14s
[08:46:15.603] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:86:0)
[08:46:15.671] Build status: STARTED
[08:46:15.671] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:87:0) after 1m37s
[08:47:52.810] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:87:0)
[08:47:52.833] Build status: STARTED
[08:47:52.833] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:88:0) after 8m23s
[08:56:16.279] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:88:0)
[08:56:16.309] Build status: STARTED
[08:56:16.309] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:89:0) after 4m5s
[09:00:21.518] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:89:0)
[09:00:21.544] Build status: STARTED
[09:00:21.544] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:90:0) after 4m51s
[09:05:12.569] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:90:0)
[09:05:12.587] Build status: STARTED
[09:05:12.587] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:91:0) after 4m43s
[09:09:55.791] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:91:0)
[09:09:55.845] Build status: STARTED
[09:09:55.845] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:92:0) after 8m1s
[09:17:56.872] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:92:0)
[09:17:56.898] Build status: STARTED
[09:17:56.898] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:93:0) after 2m4s
[09:20:00.965] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:93:0)
[09:20:00.988] Build status: STARTED
[09:20:00.988] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:94:0) after 6m49s
[09:26:50.050] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:94:0)
[09:26:50.074] Build status: STARTED
[09:26:50.074] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:95:0) after 6m22s
[09:33:12.307] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:95:0)
[09:33:12.328] Build status: STARTED
[09:33:12.328] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:96:0) after 4m30s
[09:37:42.349] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:96:0)
[09:37:42.397] Build status: STARTED
[09:37:42.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:97:0) after 7m58s
[09:45:40.555] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:97:0)
[09:45:40.581] Build status: STARTED
[09:45:40.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:98:0) after 4m48s
[09:50:28.704] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:98:0)
[09:50:28.737] Build status: STARTED
[09:50:28.737] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:99:0) after 6m14s
[09:56:42.758] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:99:0)
[09:56:42.776] Build status: STARTED
[09:56:42.776] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:100:0) after 6m48s
[10:03:31.452] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:100:0)
[10:03:31.475] Build status: STARTED
[10:03:31.475] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:101:0) after 8m52s
[10:12:23.502] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:101:0)
[10:12:23.520] Build status: STARTED
[10:12:23.520] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:102:0) after 4m3s
[10:16:26.895] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:102:0)
[10:16:26.943] Build status: STARTED
[10:16:26.943] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:103:0) after 4m8s
[10:20:34.982] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:103:0)
[10:20:35.056] Build status: STARTED
[10:20:35.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:104:0) after 3m26s
[10:24:01.930] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:104:0)
[10:24:01.962] Build status: STARTED
[10:24:01.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:105:0) after 8m11s
[10:32:12.983] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:105:0)
[10:32:13.004] Build status: STARTED
[10:32:13.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:106:0) after 7m18s
[10:39:31.024] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:106:0)
[10:39:31.046] Build status: STARTED
[10:39:31.046] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:107:0) after 4m0s
[10:43:31.073] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:107:0)
[10:43:31.099] Build status: STARTED
[10:43:31.099] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:108:0) after 2m53s
[10:46:24.292] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:108:0)
[10:46:24.311] Build status: STARTED
[10:46:24.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:109:0) after 1m31s
[10:47:55.335] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:109:0)
[10:47:55.376] Build status: STARTED
[10:47:55.376] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:110:0) after 4m0s
[10:51:55.402] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:110:0)
[10:51:55.445] Build status: STARTED
[10:51:55.445] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:111:0) after 6m53s
[10:58:48.670] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:111:0)
[10:58:48.700] Build status: STARTED
[10:58:48.700] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:112:0) after 8m13s
[11:07:01.776] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:112:0)
[11:07:01.799] Build status: STARTED
[11:07:01.800] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:113:0) after 8m11s
[11:15:12.944] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:113:0)
[11:15:12.963] Build status: STARTED
[11:15:12.963] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:114:0) after 7m20s
[11:22:32.983] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:114:0)
[11:22:33.047] Build status: STARTED
[11:22:33.047] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:115:0) after 6m28s
[11:29:01.223] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:115:0)
[11:29:01.254] Build status: STARTED
[11:29:01.254] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:116:0) after 9m19s
[11:38:20.276] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:116:0)
[11:38:20.294] Build status: STARTED
[11:38:20.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:117:0) after 2m1s
[11:40:21.438] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:117:0)
[11:40:21.529] Build status: STARTED
[11:40:21.529] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:118:0) after 4m38s
[11:44:59.917] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:118:0)
[11:44:59.980] Build status: STARTED
[11:44:59.980] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:119:0) after 1m46s
[11:46:46.011] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:119:0)
[11:46:46.044] Build status: STARTED
[11:46:46.044] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:120:0) after 3m21s
[11:50:08.042] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:120:0)
[11:50:08.070] Build status: STARTED
[11:50:08.070] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:121:0) after 7m1s
[11:57:09.096] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:121:0)
[11:57:09.117] Build status: STARTED
[11:57:09.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:122:0) after 6m51s
[12:04:01.224] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:122:0)
[12:04:01.261] Build status: STARTED
[12:04:01.261] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:123:0) after 5m21s
[12:09:22.384] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:123:0)
[12:09:22.419] Build status: STARTED
[12:09:22.419] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:124:0) after 4m39s
[12:14:01.690] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:124:0)
[12:14:01.732] Build status: STARTED
[12:14:01.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8991800528819561040:125:0) after 4m17s
[12:18:08.259] Received PubSub notification, asking Buildbucket for the build status
[12:18:08.278] Build:
{
"id": "8826370466761349105",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dll)"
},
"number": 9498,
"createdBy": "project:chromium",
"createTime": "2021-12-31T01:30:00.971749615Z",
"startTime": "2021-12-31T02:28:13.161297Z",
"endTime": "2021-12-31T12:18:07.795611348Z",
"updateTime": "2021-12-31T12:18:07.795611348Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "23cbb491c39fa9aca6448ee2e3c9182b56c3274d",
"ref": "refs/heads/main"
}
}
}
[12:18:08.278] Invocation finished in 10h48m8.653960933s with status FAILED