[21:59:06.160] New invocation is queued and will start shortly
[21:59:07.284] Starting the invocation (attempt 1)
[21:59:07.384] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/81e09249e051df8075c94ea5e36fb08021c16517"
[21:59:07.384] Popped gitiles commit info from properties and tags
[21:59:07.384] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:59:07.384] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:59:07.385] Buildbucket request:
{
"requestId": "8971791867380789312",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "81e09249e051df8075c94ea5e36fb08021c16517",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8971791867380789312"
},
{
"key": "scheduler_job_id",
"value": "chromium/Win 10 Fast Ring"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:59:07.921] Scheduled build:
{
"id": "8806361805324221521",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 11744,
"createdBy": "project:chromium",
"createTime": "2022-08-08T21:59:07.489118124Z",
"updateTime": "2022-08-08T21:59:07.489118124Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "81e09249e051df8075c94ea5e36fb08021c16517",
"ref": "refs/heads/main"
}
}
}
[21:59:07.921] Task URL: https://cr-buildbucket.appspot.com/build/8806361805324221521
[21:59:07.921] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:2:0) after 8m44s
[22:05:45.814] Received PubSub notification, asking Buildbucket for the build status
[22:05:45.853] Build status: STARTED
[22:07:52.073] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:2:0)
[22:07:52.098] Build status: STARTED
[22:07:52.098] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:4:0) after 5m2s
[22:12:54.147] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:4:0)
[22:12:54.178] Build status: STARTED
[22:12:54.179] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:5:0) after 9m54s
[22:22:48.211] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:5:0)
[22:22:48.234] Build status: STARTED
[22:22:48.234] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:6:0) after 6m5s
[22:28:53.329] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:6:0)
[22:28:53.369] Build status: STARTED
[22:28:53.369] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:7:0) after 2m3s
[22:30:56.555] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:7:0)
[22:30:56.588] Build status: STARTED
[22:30:56.588] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:8:0) after 4m5s
[22:35:01.877] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:8:0)
[22:35:01.900] Build status: STARTED
[22:35:01.900] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:9:0) after 9m50s
[22:44:51.989] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:9:0)
[22:44:52.012] Build status: STARTED
[22:44:52.012] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:10:0) after 7m2s
[22:51:54.044] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:10:0)
[22:51:54.066] Build status: STARTED
[22:51:54.066] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:11:0) after 1m19s
[22:53:13.192] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:11:0)
[22:53:13.216] Build status: STARTED
[22:53:13.217] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:12:0) after 5m21s
[22:58:34.349] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:12:0)
[22:58:34.372] Build status: STARTED
[22:58:34.372] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:13:0) after 8m5s
[23:06:39.675] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:13:0)
[23:06:39.707] Build status: STARTED
[23:06:39.707] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:14:0) after 8m10s
[23:14:49.813] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:14:0)
[23:14:49.837] Build status: STARTED
[23:14:49.837] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:15:0) after 5m52s
[23:20:41.893] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:15:0)
[23:20:41.963] Build status: STARTED
[23:20:41.963] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:16:0) after 6m19s
[23:27:01.087] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:16:0)
[23:27:01.108] Build status: STARTED
[23:27:01.108] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:17:0) after 1m16s
[23:28:17.143] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:17:0)
[23:28:17.170] Build status: STARTED
[23:28:17.170] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:18:0) after 2m34s
[23:30:51.314] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:18:0)
[23:30:51.341] Build status: STARTED
[23:30:51.341] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:19:0) after 7m24s
[23:38:15.519] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:19:0)
[23:38:15.545] Build status: STARTED
[23:38:15.545] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:20:0) after 7m19s
[23:45:34.671] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:20:0)
[23:45:34.690] Build status: STARTED
[23:45:34.690] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:21:0) after 1m30s
[23:47:04.717] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:21:0)
[23:47:04.746] Build status: STARTED
[23:47:04.746] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:22:0) after 1m41s
[23:48:45.780] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:22:0)
[23:48:45.802] Build status: STARTED
[23:48:45.802] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:23:0) after 2m54s
[23:51:39.885] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:23:0)
[23:51:39.907] Build status: STARTED
[23:51:39.907] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:24:0) after 3m14s
[23:54:53.884] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:24:0)
[23:54:53.906] Build status: STARTED
[23:54:53.906] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:25:0) after 3m53s
[23:58:47.121] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:25:0)
[23:58:47.145] Build status: STARTED
[23:58:47.145] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:26:0) after 4m56s
[00:03:43.229] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:26:0)
[00:03:43.255] Build status: STARTED
[00:03:43.255] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:27:0) after 8m51s
[00:12:34.371] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:27:0)
[00:12:34.393] Build status: STARTED
[00:12:34.393] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:28:0) after 4m18s
[00:16:52.515] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:28:0)
[00:16:52.533] Build status: STARTED
[00:16:52.533] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:29:0) after 3m50s
[00:20:42.553] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:29:0)
[00:20:42.573] Build status: STARTED
[00:20:42.573] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:30:0) after 5m7s
[00:25:49.793] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:30:0)
[00:25:49.827] Build status: STARTED
[00:25:49.827] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:31:0) after 8m32s
[00:34:22.191] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:31:0)
[00:34:22.223] Build status: STARTED
[00:34:22.223] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:32:0) after 6m46s
[00:41:08.231] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:32:0)
[00:41:08.257] Build status: STARTED
[00:41:08.257] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:33:0) after 7m41s
[00:48:49.512] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:33:0)
[00:48:49.536] Build status: STARTED
[00:48:49.536] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:34:0) after 9m26s
[00:58:15.578] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:34:0)
[00:58:15.610] Build status: STARTED
[00:58:15.610] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:35:0) after 4m45s
[01:03:00.935] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:35:0)
[01:03:01.014] Build status: STARTED
[01:03:01.014] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:36:0) after 8m54s
[01:11:55.059] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:36:0)
[01:11:55.099] Build status: STARTED
[01:11:55.099] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:37:0) after 4m20s
[01:16:15.134] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:37:0)
[01:16:15.170] Build status: STARTED
[01:16:15.170] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:38:0) after 4m58s
[01:21:13.218] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:38:0)
[01:21:13.241] Build status: STARTED
[01:21:13.241] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:39:0) after 8m6s
[01:29:19.351] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:39:0)
[01:29:19.375] Build status: STARTED
[01:29:19.375] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:40:0) after 9m35s
[01:38:54.525] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:40:0)
[01:38:54.559] Build status: STARTED
[01:38:54.559] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:41:0) after 8m20s
[01:47:14.750] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:41:0)
[01:47:14.773] Build status: STARTED
[01:47:14.773] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:42:0) after 8m27s
[01:55:41.865] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:42:0)
[01:55:41.890] Build status: STARTED
[01:55:41.890] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:43:0) after 9m53s
[02:05:35.009] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:43:0)
[02:05:35.051] Build status: STARTED
[02:05:35.051] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:44:0) after 4m58s
[02:10:33.078] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:44:0)
[02:10:33.148] Build status: STARTED
[02:10:33.148] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:45:0) after 5m5s
[02:15:38.474] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:45:0)
[02:15:38.495] Build status: STARTED
[02:15:38.495] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:46:0) after 4m2s
[02:19:40.990] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:46:0)
[02:19:41.019] Build status: STARTED
[02:19:41.019] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:47:0) after 9m56s
[02:29:37.055] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:47:0)
[02:29:37.083] Build status: STARTED
[02:29:37.083] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:48:0) after 9m15s
[02:38:52.271] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:48:0)
[02:38:52.297] Build status: STARTED
[02:38:52.297] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:49:0) after 6m39s
[02:45:31.338] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:49:0)
[02:45:31.363] Build status: STARTED
[02:45:31.363] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:50:0) after 6m14s
[02:51:45.599] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:50:0)
[02:51:45.662] Build status: STARTED
[02:51:45.662] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:51:0) after 6m26s
[02:58:11.930] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:51:0)
[02:58:11.957] Build status: STARTED
[02:58:11.957] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:52:0) after 9m43s
[03:07:55.003] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:52:0)
[03:07:55.030] Build status: STARTED
[03:07:55.030] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:53:0) after 8m58s
[03:16:53.126] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:53:0)
[03:16:53.168] Build status: STARTED
[03:16:53.168] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:54:0) after 5m15s
[03:22:08.193] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:54:0)
[03:22:08.213] Build status: STARTED
[03:22:08.213] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:55:0) after 8m10s
[03:30:18.624] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:55:0)
[03:30:18.648] Build status: STARTED
[03:30:18.648] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:56:0) after 3m28s
[03:33:46.778] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:56:0)
[03:33:46.803] Build status: STARTED
[03:33:46.803] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:57:0) after 2m29s
[03:36:16.274] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:57:0)
[03:36:16.302] Build status: STARTED
[03:36:16.302] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:58:0) after 6m47s
[03:43:03.429] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:58:0)
[03:43:03.458] Build status: STARTED
[03:43:03.458] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:59:0) after 2m37s
[03:45:40.493] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:59:0)
[03:45:40.518] Build status: STARTED
[03:45:40.518] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:60:0) after 5m48s
[03:51:28.555] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:60:0)
[03:51:28.588] Build status: STARTED
[03:51:28.588] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:61:0) after 1m17s
[03:52:45.672] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:61:0)
[03:52:45.751] Build status: STARTED
[03:52:45.751] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:62:0) after 2m8s
[03:54:53.780] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:62:0)
[03:54:53.817] Build status: STARTED
[03:54:53.817] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:63:0) after 2m57s
[03:57:50.932] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:63:0)
[03:57:51.025] Build status: STARTED
[03:57:51.025] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:64:0) after 5m17s
[04:03:08.062] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:64:0)
[04:03:08.087] Build status: STARTED
[04:03:08.087] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:65:0) after 4m22s
[04:07:30.332] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:65:0)
[04:07:30.356] Build status: STARTED
[04:07:30.356] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:66:0) after 9m37s
[04:17:07.490] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:66:0)
[04:17:07.517] Build status: STARTED
[04:17:07.517] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:67:0) after 4m26s
[04:21:33.675] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:67:0)
[04:21:33.702] Build status: STARTED
[04:21:33.703] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:68:0) after 9m30s
[04:31:04.224] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:68:0)
[04:31:04.259] Build status: STARTED
[04:31:04.259] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:69:0) after 4m30s
[04:35:34.316] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:69:0)
[04:35:34.339] Build status: STARTED
[04:35:34.339] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:70:0) after 4m57s
[04:40:31.427] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:70:0)
[04:40:31.451] Build status: STARTED
[04:40:31.451] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:71:0) after 1m17s
[04:41:48.539] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:71:0)
[04:41:48.560] Build status: STARTED
[04:41:48.560] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:72:0) after 9m31s
[04:51:19.650] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:72:0)
[04:51:19.673] Build status: STARTED
[04:51:19.673] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:73:0) after 9m42s
[05:01:01.698] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:73:0)
[05:01:01.756] Build status: STARTED
[05:01:01.756] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:74:0) after 3m29s
[05:04:30.817] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:74:0)
[05:04:30.928] Build status: STARTED
[05:04:30.928] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:75:0) after 2m7s
[05:06:37.960] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:75:0)
[05:06:37.997] Build status: STARTED
[05:06:37.997] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:76:0) after 9m40s
[05:16:18.438] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:76:0)
[05:16:18.492] Build status: STARTED
[05:16:18.492] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:77:0) after 6m25s
[05:22:43.713] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:77:0)
[05:22:43.734] Build status: STARTED
[05:22:43.734] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:78:0) after 6m58s
[05:29:41.760] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:78:0)
[05:29:41.783] Build status: STARTED
[05:29:41.783] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:79:0) after 4m31s
[05:34:12.814] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:79:0)
[05:34:12.840] Build status: STARTED
[05:34:12.840] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:80:0) after 3m47s
[05:38:00.053] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:80:0)
[05:38:00.091] Build status: STARTED
[05:38:00.091] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:81:0) after 4m51s
[05:42:51.121] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:81:0)
[05:42:51.143] Build status: STARTED
[05:42:51.143] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:82:0) after 5m5s
[05:47:56.168] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:82:0)
[05:47:56.205] Build status: STARTED
[05:47:56.205] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:83:0) after 7m21s
[05:55:17.251] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:83:0)
[05:55:17.275] Build status: STARTED
[05:55:17.275] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:84:0) after 3m3s
[05:58:20.304] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:84:0)
[05:58:20.349] Build status: STARTED
[05:58:20.349] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:85:0) after 1m36s
[05:59:56.531] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:85:0)
[05:59:56.606] Build status: STARTED
[05:59:56.606] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:86:0) after 7m13s
[06:07:09.647] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:86:0)
[06:07:09.674] Build status: STARTED
[06:07:09.674] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:87:0) after 1m1s
[06:08:10.998] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:87:0)
[06:08:11.023] Build status: STARTED
[06:08:11.023] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:88:0) after 4m31s
[06:12:42.169] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:88:0)
[06:12:42.221] Build status: STARTED
[06:12:42.222] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:89:0) after 1m30s
[06:14:12.516] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:89:0)
[06:14:12.539] Build status: STARTED
[06:14:12.539] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:90:0) after 9m4s
[06:23:16.763] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:90:0)
[06:23:16.930] Build status: STARTED
[06:23:16.930] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:91:0) after 1m36s
[06:24:53.081] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:91:0)
[06:24:53.157] Build status: STARTED
[06:24:53.157] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:92:0) after 2m53s
[06:27:46.386] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:92:0)
[06:27:46.434] Build status: STARTED
[06:27:46.434] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:93:0) after 6m46s
[06:34:32.558] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:93:0)
[06:34:32.584] Build status: STARTED
[06:34:32.584] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:94:0) after 8m18s
[06:42:50.615] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:94:0)
[06:42:50.638] Build status: STARTED
[06:42:50.638] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:95:0) after 9m2s
[06:51:52.681] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:95:0)
[06:51:52.705] Build status: STARTED
[06:51:52.705] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:96:0) after 5m26s
[06:57:18.752] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:96:0)
[06:57:18.781] Build status: STARTED
[06:57:18.781] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:97:0) after 7m18s
[07:04:37.014] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:97:0)
[07:04:37.048] Build status: STARTED
[07:04:37.048] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:98:0) after 6m56s
[07:11:33.447] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:98:0)
[07:11:33.478] Build status: STARTED
[07:11:33.478] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:99:0) after 7m48s
[07:19:21.801] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:99:0)
[07:19:21.828] Build status: STARTED
[07:19:21.828] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:100:0) after 5m27s
[07:24:48.859] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:100:0)
[07:24:48.896] Build status: STARTED
[07:24:48.896] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:101:0) after 7m13s
[07:32:01.924] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:101:0)
[07:32:01.962] Build status: STARTED
[07:32:01.962] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:102:0) after 1m20s
[07:33:22.032] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:102:0)
[07:33:22.077] Build status: STARTED
[07:33:22.077] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:103:0) after 9m10s
[07:42:32.290] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:103:0)
[07:42:32.339] Build status: STARTED
[07:42:32.339] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:104:0) after 4m8s
[07:46:40.497] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:104:0)
[07:46:40.533] Build status: STARTED
[07:46:40.533] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:105:0) after 8m30s
[07:55:10.976] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:105:0)
[07:55:11.004] Build status: STARTED
[07:55:11.004] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:106:0) after 2m35s
[07:57:46.014] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:106:0)
[07:57:46.049] Build status: STARTED
[07:57:46.049] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:107:0) after 4m3s
[08:01:49.215] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:107:0)
[08:01:49.268] Build status: STARTED
[08:01:49.268] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:108:0) after 2m21s
[08:04:10.620] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:108:0)
[08:04:10.642] Build status: STARTED
[08:04:10.642] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971791867380789312:109:0) after 2m37s
[08:06:29.528] Received PubSub notification, asking Buildbucket for the build status
[08:06:29.574] Build:
{
"id": "8806361805324221521",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 11744,
"createdBy": "project:chromium",
"createTime": "2022-08-08T21:59:07.489118124Z",
"startTime": "2022-08-08T22:05:44.936404Z",
"endTime": "2022-08-09T08:06:29.266957064Z",
"updateTime": "2022-08-09T08:06:29.266957064Z",
"status": "CANCELED",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "81e09249e051df8075c94ea5e36fb08021c16517",
"ref": "refs/heads/main"
}
}
}
[08:06:29.574] Invocation finished in 10h7m23.430316114s with status ABORTED