[11:11:28.793] New invocation is queued and will start shortly
[11:11:29.946] Starting the invocation (attempt 1)
[11:11:29.999] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/77d9362f58a21e89619192ca916faa680310fbe6"
[11:11:29.999] Popped gitiles commit info from properties and tags
[11:11:29.999] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:11:30.003] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:11:30.003] Buildbucket request:
{
"requestId": "8966034406438101904",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "77d9362f58a21e89619192ca916faa680310fbe6",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8966034406438101904"
},
{
"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"
}
}
[11:11:30.553] Scheduled build:
{
"id": "8800604344403356561",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 10415,
"createdBy": "project:chromium",
"createTime": "2022-10-11T11:11:30.097187357Z",
"updateTime": "2022-10-11T11:11:30.097187357Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "77d9362f58a21e89619192ca916faa680310fbe6",
"ref": "refs/heads/main"
}
}
}
[11:11:30.553] Task URL: https://cr-buildbucket.appspot.com/build/8800604344403356561
[11:11:30.553] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:2:0) after 6m16s
[11:17:46.634] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:2:0)
[11:17:46.667] Build status: SCHEDULED
[11:17:46.667] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:3:0) after 2m26s
[11:20:12.792] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:3:0)
[11:20:12.819] Build status: SCHEDULED
[11:20:12.819] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:4:0) after 1m20s
[11:21:32.844] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:4:0)
[11:21:32.868] Build status: SCHEDULED
[11:21:32.868] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:5:0) after 4m9s
[11:25:42.093] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:5:0)
[11:25:42.116] Build status: SCHEDULED
[11:25:42.116] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:6:0) after 2m20s
[11:28:02.196] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:6:0)
[11:28:02.218] Build status: SCHEDULED
[11:28:02.218] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:7:0) after 1m19s
[11:29:21.242] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:7:0)
[11:29:21.269] Build status: SCHEDULED
[11:29:21.269] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:8:0) after 7m56s
[11:37:17.271] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:8:0)
[11:37:17.316] Build status: SCHEDULED
[11:37:17.316] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:9:0) after 2m19s
[11:38:01.339] Received PubSub notification, asking Buildbucket for the build status
[11:38:01.379] Build status: STARTED
[11:39:36.400] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:9:0)
[11:39:36.435] Build status: STARTED
[11:39:36.435] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:11:0) after 8m53s
[11:48:29.462] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:11:0)
[11:48:29.487] Build status: STARTED
[11:48:29.487] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:12:0) after 1m12s
[11:49:41.692] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:12:0)
[11:49:41.720] Build status: STARTED
[11:49:41.720] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:13:0) after 8m41s
[11:58:23.007] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:13:0)
[11:58:23.114] Build status: STARTED
[11:58:23.114] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:14:0) after 4m47s
[12:03:10.153] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:14:0)
[12:03:10.287] Build status: STARTED
[12:03:10.287] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:15:0) after 4m16s
[12:07:26.567] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:15:0)
[12:07:26.606] Build status: STARTED
[12:07:26.606] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:16:0) after 1m34s
[12:09:00.707] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:16:0)
[12:09:00.731] Build status: STARTED
[12:09:00.731] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:17:0) after 7m6s
[12:16:06.811] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:17:0)
[12:16:06.846] Build status: STARTED
[12:16:06.846] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:18:0) after 6m10s
[12:22:16.877] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:18:0)
[12:22:16.905] Build status: STARTED
[12:22:16.905] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:19:0) after 9m6s
[12:31:23.032] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:19:0)
[12:31:23.056] Build status: STARTED
[12:31:23.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:20:0) after 4m54s
[12:36:17.051] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:20:0)
[12:36:17.073] Build status: STARTED
[12:36:17.074] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:21:0) after 8m0s
[12:44:17.216] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:21:0)
[12:44:17.243] Build status: STARTED
[12:44:17.243] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:22:0) after 2m5s
[12:46:22.583] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:22:0)
[12:46:22.612] Build status: STARTED
[12:46:22.612] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:23:0) after 6m54s
[12:53:16.835] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:23:0)
[12:53:16.861] Build status: STARTED
[12:53:16.861] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:24:0) after 5m22s
[12:58:38.979] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:24:0)
[12:58:39.003] Build status: STARTED
[12:58:39.003] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:25:0) after 8m20s
[13:06:59.500] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:25:0)
[13:06:59.535] Build status: STARTED
[13:06:59.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:26:0) after 1m38s
[13:08:37.891] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:26:0)
[13:08:37.913] Build status: STARTED
[13:08:37.913] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:27:0) after 5m50s
[13:14:27.938] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:27:0)
[13:14:27.962] Build status: STARTED
[13:14:27.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:28:0) after 9m58s
[13:24:26.129] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:28:0)
[13:24:26.161] Build status: STARTED
[13:24:26.161] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:29:0) after 1m28s
[13:25:54.425] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:29:0)
[13:25:54.489] Build status: STARTED
[13:25:54.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:30:0) after 3m4s
[13:28:58.501] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:30:0)
[13:28:58.580] Build status: STARTED
[13:28:58.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:31:0) after 4m2s
[13:33:00.625] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:31:0)
[13:33:00.658] Build status: STARTED
[13:33:00.659] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:32:0) after 7m12s
[13:40:12.857] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:32:0)
[13:40:12.888] Build status: STARTED
[13:40:12.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:33:0) after 6m6s
[13:46:19.100] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:33:0)
[13:46:19.123] Build status: STARTED
[13:46:19.123] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:34:0) after 3m46s
[13:50:05.331] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:34:0)
[13:50:05.380] Build status: STARTED
[13:50:05.380] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:35:0) after 5m24s
[13:55:29.693] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:35:0)
[13:55:29.714] Build status: STARTED
[13:55:29.714] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:36:0) after 2m36s
[13:58:05.761] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:36:0)
[13:58:05.793] Build status: STARTED
[13:58:05.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:37:0) after 3m17s
[14:01:22.832] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:37:0)
[14:01:22.856] Build status: STARTED
[14:01:22.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:38:0) after 2m57s
[14:04:19.949] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:38:0)
[14:04:19.982] Build status: STARTED
[14:04:19.982] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:39:0) after 7m40s
[14:12:00.014] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:39:0)
[14:12:00.043] Build status: STARTED
[14:12:00.043] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:40:0) after 2m1s
[14:14:01.100] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:40:0)
[14:14:01.123] Build status: STARTED
[14:14:01.123] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:41:0) after 1m40s
[14:15:41.348] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:41:0)
[14:15:41.424] Build status: STARTED
[14:15:41.424] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:42:0) after 9m59s
[14:25:40.557] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:42:0)
[14:25:40.581] Build status: STARTED
[14:25:40.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:43:0) after 2m16s
[14:27:56.807] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:43:0)
[14:27:56.836] Build status: STARTED
[14:27:56.836] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:44:0) after 7m48s
[14:35:44.892] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:44:0)
[14:35:44.921] Build status: STARTED
[14:35:44.921] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:45:0) after 6m38s
[14:42:23.144] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:45:0)
[14:42:23.172] Build status: STARTED
[14:42:23.172] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:46:0) after 9m24s
[14:51:47.209] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:46:0)
[14:51:47.237] Build status: STARTED
[14:51:47.237] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:47:0) after 6m13s
[14:58:00.716] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:47:0)
[14:58:00.741] Build status: STARTED
[14:58:00.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:48:0) after 3m26s
[15:01:26.918] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:48:0)
[15:01:26.953] Build status: STARTED
[15:01:26.953] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:49:0) after 7m33s
[15:08:59.964] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:49:0)
[15:09:00.030] Build status: STARTED
[15:09:00.030] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:50:0) after 9m49s
[15:18:49.277] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:50:0)
[15:18:49.332] Build status: STARTED
[15:18:49.332] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:51:0) after 7m54s
[15:26:43.496] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:51:0)
[15:26:43.543] Build status: STARTED
[15:26:43.543] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:52:0) after 2m11s
[15:28:54.570] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:52:0)
[15:28:54.607] Build status: STARTED
[15:28:54.607] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:53:0) after 2m51s
[15:31:45.648] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:53:0)
[15:31:45.671] Build status: STARTED
[15:31:45.672] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:54:0) after 4m10s
[15:35:55.705] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:54:0)
[15:35:55.731] Build status: STARTED
[15:35:55.731] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:55:0) after 7m34s
[15:43:29.820] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:55:0)
[15:43:29.840] Build status: STARTED
[15:43:29.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:56:0) after 8m1s
[15:51:30.908] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:56:0)
[15:51:30.959] Build status: STARTED
[15:51:30.959] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:57:0) after 2m52s
[15:54:23.109] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:57:0)
[15:54:23.135] Build status: STARTED
[15:54:23.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:58:0) after 4m52s
[15:59:15.271] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:58:0)
[15:59:15.293] Build status: STARTED
[15:59:15.293] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:59:0) after 4m23s
[16:03:38.479] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:59:0)
[16:03:38.517] Build status: STARTED
[16:03:38.517] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:60:0) after 8m3s
[16:11:42.176] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:60:0)
[16:11:42.200] Build status: STARTED
[16:11:42.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:61:0) after 3m19s
[16:15:01.244] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:61:0)
[16:15:01.506] Build status: STARTED
[16:15:01.506] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:62:0) after 7m15s
[16:22:16.567] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:62:0)
[16:22:16.598] Build status: STARTED
[16:22:16.598] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:63:0) after 4m30s
[16:26:47.144] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:63:0)
[16:26:47.168] Build status: STARTED
[16:26:47.168] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:64:0) after 6m44s
[16:33:31.663] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:64:0)
[16:33:31.690] Build status: STARTED
[16:33:31.690] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:65:0) after 5m17s
[16:38:48.998] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:65:0)
[16:38:49.025] Build status: STARTED
[16:38:49.025] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:66:0) after 5m34s
[16:44:23.115] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:66:0)
[16:44:23.174] Build status: STARTED
[16:44:23.174] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:67:0) after 7m7s
[16:51:30.368] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:67:0)
[16:51:30.394] Build status: STARTED
[16:51:30.394] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:68:0) after 6m51s
[16:58:21.643] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:68:0)
[16:58:21.671] Build status: STARTED
[16:58:21.674] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:69:0) after 7m12s
[17:05:33.877] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:69:0)
[17:05:33.975] Build status: STARTED
[17:05:33.976] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:70:0) after 9m8s
[17:14:41.998] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:70:0)
[17:14:42.030] Build status: STARTED
[17:14:42.030] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:71:0) after 5m54s
[17:20:36.495] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:71:0)
[17:20:36.521] Build status: STARTED
[17:20:36.521] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:72:0) after 5m55s
[17:26:32.111] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:72:0)
[17:26:32.154] Build status: STARTED
[17:26:32.154] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:73:0) after 1m17s
[17:27:49.423] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:73:0)
[17:27:49.450] Build status: STARTED
[17:27:49.450] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:74:0) after 5m14s
[17:33:03.486] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:74:0)
[17:33:03.510] Build status: STARTED
[17:33:03.510] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:75:0) after 3m59s
[17:37:02.563] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:75:0)
[17:37:02.642] Build status: STARTED
[17:37:02.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:76:0) after 4m16s
[17:41:18.820] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:76:0)
[17:41:18.849] Build status: STARTED
[17:41:18.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:77:0) after 3m45s
[17:45:03.902] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:77:0)
[17:45:04.137] Build status: STARTED
[17:45:04.137] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:78:0) after 5m20s
[17:50:24.210] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:78:0)
[17:50:24.264] Build status: STARTED
[17:50:24.264] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:79:0) after 1m38s
[17:52:02.452] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:79:0)
[17:52:02.475] Build status: STARTED
[17:52:02.475] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:80:0) after 3m21s
[17:55:23.605] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:80:0)
[17:55:23.643] Build status: STARTED
[17:55:23.643] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:81:0) after 7m16s
[18:02:39.966] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:81:0)
[18:02:39.991] Build status: STARTED
[18:02:39.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:82:0) after 7m46s
[18:10:26.276] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:82:0)
[18:10:26.299] Build status: STARTED
[18:10:26.299] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:83:0) after 9m41s
[18:20:07.551] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:83:0)
[18:20:07.582] Build status: STARTED
[18:20:07.582] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:84:0) after 7m47s
[18:27:54.656] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:84:0)
[18:27:54.677] Build status: STARTED
[18:27:54.677] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:85:0) after 7m14s
[18:35:08.655] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:85:0)
[18:35:08.677] Build status: STARTED
[18:35:08.677] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:86:0) after 4m22s
[18:39:30.708] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:86:0)
[18:39:30.734] Build status: STARTED
[18:39:30.734] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:87:0) after 6m22s
[18:45:52.814] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:87:0)
[18:45:52.839] Build status: STARTED
[18:45:52.839] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:88:0) after 4m23s
[18:50:15.952] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:88:0)
[18:50:16.052] Build status: STARTED
[18:50:16.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:89:0) after 1m16s
[18:51:32.087] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:89:0)
[18:51:32.118] Build status: STARTED
[18:51:32.118] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:90:0) after 1m0s
[18:52:32.179] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:90:0)
[18:52:32.203] Build status: STARTED
[18:52:32.203] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:91:0) after 1m44s
[18:54:16.569] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:91:0)
[18:54:16.632] Build status: STARTED
[18:54:16.632] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:92:0) after 1m29s
[18:55:45.938] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:92:0)
[18:55:45.966] Build status: STARTED
[18:55:45.966] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:93:0) after 4m27s
[19:00:13.021] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:93:0)
[19:00:13.079] Build status: STARTED
[19:00:13.079] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:94:0) after 4m53s
[19:05:06.231] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:94:0)
[19:05:06.257] Build status: STARTED
[19:05:06.257] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:95:0) after 9m12s
[19:14:18.472] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:95:0)
[19:14:18.497] Build status: STARTED
[19:14:18.497] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:96:0) after 5m59s
[19:20:17.746] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:96:0)
[19:20:17.801] Build status: STARTED
[19:20:17.801] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:97:0) after 2m9s
[19:22:26.827] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:97:0)
[19:22:26.858] Build status: STARTED
[19:22:26.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:98:0) after 8m10s
[19:30:37.123] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:98:0)
[19:30:37.148] Build status: STARTED
[19:30:37.149] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:99:0) after 1m26s
[19:32:03.363] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:99:0)
[19:32:03.384] Build status: STARTED
[19:32:03.384] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:100:0) after 4m34s
[19:36:37.771] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:100:0)
[19:36:37.813] Build status: STARTED
[19:36:37.813] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:101:0) after 6m22s
[19:42:59.839] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:101:0)
[19:42:59.921] Build status: STARTED
[19:42:59.921] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:102:0) after 3m6s
[19:46:05.965] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:102:0)
[19:46:05.989] Build status: STARTED
[19:46:05.989] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:103:0) after 4m4s
[19:50:10.242] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:103:0)
[19:50:10.269] Build status: STARTED
[19:50:10.269] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:104:0) after 1m54s
[19:52:04.303] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:104:0)
[19:52:04.333] Build status: STARTED
[19:52:04.333] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:105:0) after 1m33s
[19:53:37.502] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:105:0)
[19:53:37.525] Build status: STARTED
[19:53:37.525] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:106:0) after 1m55s
[19:55:32.794] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:106:0)
[19:55:32.817] Build status: STARTED
[19:55:32.817] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:107:0) after 3m13s
[19:58:45.846] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:107:0)
[19:58:45.874] Build status: STARTED
[19:58:45.874] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:108:0) after 7m45s
[20:06:31.306] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:108:0)
[20:06:31.336] Build status: STARTED
[20:06:31.336] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:109:0) after 3m46s
[20:10:17.364] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:109:0)
[20:10:17.387] Build status: STARTED
[20:10:17.387] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:110:0) after 4m52s
[20:15:09.752] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:110:0)
[20:15:09.777] Build status: STARTED
[20:15:09.777] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:111:0) after 6m41s
[20:21:50.904] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:111:0)
[20:21:50.934] Build status: STARTED
[20:21:50.935] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:112:0) after 1m28s
[20:23:19.485] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:112:0)
[20:23:19.525] Build status: STARTED
[20:23:19.525] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:113:0) after 4m24s
[20:27:43.922] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:113:0)
[20:27:43.945] Build status: STARTED
[20:27:43.945] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:114:0) after 1m49s
[20:29:33.241] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:114:0)
[20:29:33.362] Build status: STARTED
[20:29:33.362] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:115:0) after 1m30s
[20:31:03.494] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:115:0)
[20:31:03.531] Build status: STARTED
[20:31:03.531] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:116:0) after 4m6s
[20:35:09.758] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:116:0)
[20:35:09.781] Build status: STARTED
[20:35:09.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:117:0) after 5m47s
[20:41:15.066] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:117:0)
[20:41:15.096] Build status: STARTED
[20:41:15.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:118:0) after 2m34s
[20:43:49.127] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:118:0)
[20:43:49.151] Build status: STARTED
[20:43:49.151] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:119:0) after 3m45s
[20:47:34.231] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:119:0)
[20:47:34.255] Build status: STARTED
[20:47:34.255] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:120:0) after 2m46s
[20:50:20.348] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:120:0)
[20:50:20.383] Build status: STARTED
[20:50:20.383] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:121:0) after 4m9s
[20:54:29.364] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:121:0)
[20:54:29.391] Build status: STARTED
[20:54:29.391] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:122:0) after 9m0s
[21:03:29.636] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:122:0)
[21:03:29.658] Build status: STARTED
[21:03:29.658] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:123:0) after 5m45s
[21:09:14.891] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:123:0)
[21:09:14.912] Build status: STARTED
[21:09:14.912] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:124:0) after 5m55s
[21:15:09.942] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:124:0)
[21:15:10.013] Build status: STARTED
[21:15:10.013] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:125:0) after 8m53s
[21:24:03.374] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:125:0)
[21:24:03.399] Build status: STARTED
[21:24:03.399] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8966034406438101904:126:0) after 5m38s
[21:29:36.993] Received PubSub notification, asking Buildbucket for the build status
[21:29:37.019] Build:
{
"id": "8800604344403356561",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 10415,
"createdBy": "project:chromium",
"createTime": "2022-10-11T11:11:30.097187357Z",
"startTime": "2022-10-11T11:38:00.687609Z",
"endTime": "2022-10-11T21:29:36.567242989Z",
"updateTime": "2022-10-11T21:29:36.567242989Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "77d9362f58a21e89619192ca916faa680310fbe6",
"ref": "refs/heads/main"
}
}
}
[21:29:37.019] Invocation finished in 10h18m8.245752538s with status FAILED