[19:31:10.456] New invocation is queued and will start shortly
[19:31:11.644] Starting the invocation (attempt 1)
[19:31:11.735] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/de7d69922bcbda49075ae5547c6f5202f1195e52"
[19:31:11.735] Popped gitiles commit info from properties and tags
[19:31:11.735] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:31:11.735] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:31:11.735] Buildbucket request:
{
"requestId": "8971982368163373648",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "de7d69922bcbda49075ae5547c6f5202f1195e52",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8971982368163373648"
},
{
"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"
}
}
[19:31:12.334] Scheduled build:
{
"id": "8806552306021354225",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 11739,
"createdBy": "project:chromium",
"createTime": "2022-08-06T19:31:11.867651936Z",
"updateTime": "2022-08-06T19:31:11.867651936Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "de7d69922bcbda49075ae5547c6f5202f1195e52",
"ref": "refs/heads/main"
}
}
}
[19:31:12.334] Task URL: https://cr-buildbucket.appspot.com/build/8806552306021354225
[19:31:12.335] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:2:0) after 7m36s
[19:38:48.601] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:2:0)
[19:38:48.627] Build status: SCHEDULED
[19:38:48.627] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:3:0) after 1m57s
[19:40:45.710] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:3:0)
[19:40:45.745] Build status: SCHEDULED
[19:40:45.745] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:4:0) after 2m53s
[19:43:38.855] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:4:0)
[19:43:38.891] Build status: SCHEDULED
[19:43:38.891] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:5:0) after 6m3s
[19:43:56.717] Received PubSub notification, asking Buildbucket for the build status
[19:43:56.736] Build status: STARTED
[19:49:42.007] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:5:0)
[19:49:42.034] Build status: STARTED
[19:49:42.034] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:7:0) after 8m30s
[19:58:12.268] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:7:0)
[19:58:12.292] Build status: STARTED
[19:58:12.292] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:8:0) after 4m36s
[20:02:48.581] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:8:0)
[20:02:48.629] Build status: STARTED
[20:02:48.629] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:9:0) after 4m7s
[20:06:55.763] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:9:0)
[20:06:55.813] Build status: STARTED
[20:06:55.813] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:10:0) after 5m3s
[20:11:58.835] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:10:0)
[20:11:58.861] Build status: STARTED
[20:11:58.861] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:11:0) after 3m6s
[20:15:04.869] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:11:0)
[20:15:04.890] Build status: STARTED
[20:15:04.890] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:12:0) after 7m29s
[20:22:34.027] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:12:0)
[20:22:34.059] Build status: STARTED
[20:22:34.059] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:13:0) after 6m26s
[20:29:00.163] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:13:0)
[20:29:00.223] Build status: STARTED
[20:29:00.223] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:14:0) after 8m35s
[20:37:35.264] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:14:0)
[20:37:35.288] Build status: STARTED
[20:37:35.288] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:15:0) after 6m27s
[20:44:02.323] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:15:0)
[20:44:02.357] Build status: STARTED
[20:44:02.357] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:16:0) after 4m45s
[20:48:47.360] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:16:0)
[20:48:47.386] Build status: STARTED
[20:48:47.386] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:17:0) after 2m7s
[20:50:54.410] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:17:0)
[20:50:54.432] Build status: STARTED
[20:50:54.432] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:18:0) after 4m25s
[20:55:19.439] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:18:0)
[20:55:19.471] Build status: STARTED
[20:55:19.472] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:19:0) after 4m10s
[20:59:29.492] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:19:0)
[20:59:29.511] Build status: STARTED
[20:59:29.511] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:20:0) after 4m57s
[21:04:27.908] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:20:0)
[21:04:27.933] Build status: STARTED
[21:04:27.933] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:21:0) after 1m17s
[21:05:44.959] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:21:0)
[21:05:44.983] Build status: STARTED
[21:05:44.983] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:22:0) after 1m58s
[21:07:43.119] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:22:0)
[21:07:43.154] Build status: STARTED
[21:07:43.154] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:23:0) after 7m58s
[21:15:41.276] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:23:0)
[21:15:41.296] Build status: STARTED
[21:15:41.296] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:24:0) after 9m13s
[21:24:54.352] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:24:0)
[21:24:54.370] Build status: STARTED
[21:24:54.370] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:25:0) after 8m10s
[21:33:04.457] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:25:0)
[21:33:04.482] Build status: STARTED
[21:33:04.482] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:26:0) after 1m50s
[21:34:54.546] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:26:0)
[21:34:54.578] Build status: STARTED
[21:34:54.578] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:27:0) after 9m2s
[21:43:56.632] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:27:0)
[21:43:56.666] Build status: STARTED
[21:43:56.666] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:28:0) after 3m43s
[21:47:39.770] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:28:0)
[21:47:39.821] Build status: STARTED
[21:47:39.821] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:29:0) after 2m50s
[21:50:29.883] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:29:0)
[21:50:29.915] Build status: STARTED
[21:50:29.915] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:30:0) after 1m38s
[21:52:07.939] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:30:0)
[21:52:07.973] Build status: STARTED
[21:52:07.973] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:31:0) after 2m41s
[21:54:48.996] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:31:0)
[21:54:49.019] Build status: STARTED
[21:54:49.019] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:32:0) after 1m5s
[21:55:54.162] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:32:0)
[21:55:54.185] Build status: STARTED
[21:55:54.185] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:33:0) after 5m26s
[22:01:20.471] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:33:0)
[22:01:20.498] Build status: STARTED
[22:01:20.498] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:34:0) after 4m3s
[22:05:23.688] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:34:0)
[22:05:23.714] Build status: STARTED
[22:05:23.714] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:35:0) after 9m25s
[22:14:48.867] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:35:0)
[22:14:48.887] Build status: STARTED
[22:14:48.887] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:36:0) after 8m26s
[22:23:14.908] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:36:0)
[22:23:14.928] Build status: STARTED
[22:23:14.928] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:37:0) after 3m3s
[22:26:17.952] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:37:0)
[22:26:17.973] Build status: STARTED
[22:26:17.973] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:38:0) after 6m33s
[22:32:51.275] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:38:0)
[22:32:51.313] Build status: STARTED
[22:32:51.313] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:39:0) after 1m19s
[22:34:10.477] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:39:0)
[22:34:10.506] Build status: STARTED
[22:34:10.506] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:40:0) after 9m0s
[22:43:10.546] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:40:0)
[22:43:10.581] Build status: STARTED
[22:43:10.581] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:41:0) after 8m42s
[22:51:53.559] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:41:0)
[22:51:53.582] Build status: STARTED
[22:51:53.582] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:42:0) after 2m7s
[22:54:00.802] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:42:0)
[22:54:00.836] Build status: STARTED
[22:54:00.836] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:43:0) after 7m59s
[23:01:59.857] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:43:0)
[23:01:59.892] Build status: STARTED
[23:01:59.892] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:44:0) after 1m0s
[23:03:00.595] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:44:0)
[23:03:00.622] Build status: STARTED
[23:03:00.622] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:45:0) after 6m20s
[23:09:21.076] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:45:0)
[23:09:21.113] Build status: STARTED
[23:09:21.113] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:46:0) after 3m35s
[23:12:56.199] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:46:0)
[23:12:56.224] Build status: STARTED
[23:12:56.224] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:47:0) after 1m25s
[23:14:21.246] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:47:0)
[23:14:21.273] Build status: STARTED
[23:14:21.273] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:48:0) after 2m30s
[23:16:51.298] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:48:0)
[23:16:51.342] Build status: STARTED
[23:16:51.342] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:49:0) after 2m12s
[23:19:03.483] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:49:0)
[23:19:03.518] Build status: STARTED
[23:19:03.519] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:50:0) after 7m30s
[23:26:34.714] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:50:0)
[23:26:34.747] Build status: STARTED
[23:26:34.748] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:51:0) after 2m36s
[23:29:12.050] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:51:0)
[23:29:12.072] Build status: STARTED
[23:29:12.072] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:52:0) after 9m44s
[23:38:56.096] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:52:0)
[23:38:56.135] Build status: STARTED
[23:38:56.135] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:53:0) after 2m40s
[23:41:36.238] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:53:0)
[23:41:36.259] Build status: STARTED
[23:41:36.259] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:54:0) after 7m29s
[23:49:06.776] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:54:0)
[23:49:06.797] Build status: STARTED
[23:49:06.797] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:55:0) after 6m48s
[23:55:54.935] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:55:0)
[23:55:54.965] Build status: STARTED
[23:55:54.965] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:56:0) after 8m19s
[00:04:14.000] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:56:0)
[00:04:14.027] Build status: STARTED
[00:04:14.027] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:57:0) after 9m31s
[00:13:45.095] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:57:0)
[00:13:45.129] Build status: STARTED
[00:13:45.129] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:58:0) after 7m36s
[00:21:21.206] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:58:0)
[00:21:21.231] Build status: STARTED
[00:21:21.231] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:59:0) after 9m39s
[00:31:00.370] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:59:0)
[00:31:00.401] Build status: STARTED
[00:31:00.401] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:60:0) after 9m34s
[00:40:34.429] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:60:0)
[00:40:34.452] Build status: STARTED
[00:40:34.452] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:61:0) after 1m21s
[00:41:55.546] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:61:0)
[00:41:55.579] Build status: STARTED
[00:41:55.579] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:62:0) after 5m20s
[00:47:15.600] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:62:0)
[00:47:15.622] Build status: STARTED
[00:47:15.622] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:63:0) after 9m51s
[00:57:06.708] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:63:0)
[00:57:06.732] Build status: STARTED
[00:57:06.732] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:64:0) after 7m55s
[01:05:01.754] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:64:0)
[01:05:01.777] Build status: STARTED
[01:05:01.777] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:65:0) after 1m48s
[01:06:49.801] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:65:0)
[01:06:49.826] Build status: STARTED
[01:06:49.826] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:66:0) after 2m12s
[01:09:01.848] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:66:0)
[01:09:01.884] Build status: STARTED
[01:09:01.884] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:67:0) after 8m54s
[01:17:55.904] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:67:0)
[01:17:55.941] Build status: STARTED
[01:17:55.941] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:68:0) after 7m38s
[01:25:34.091] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:68:0)
[01:25:34.114] Build status: STARTED
[01:25:34.114] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:69:0) after 6m59s
[01:32:33.358] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:69:0)
[01:32:33.378] Build status: STARTED
[01:32:33.378] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:70:0) after 1m8s
[01:33:41.398] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:70:0)
[01:33:41.433] Build status: STARTED
[01:33:41.434] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:71:0) after 3m39s
[01:37:20.525] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:71:0)
[01:37:20.560] Build status: STARTED
[01:37:20.560] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:72:0) after 1m57s
[01:39:17.746] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:72:0)
[01:39:17.777] Build status: STARTED
[01:39:17.777] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:73:0) after 3m37s
[01:42:54.839] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:73:0)
[01:42:54.861] Build status: STARTED
[01:42:54.861] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:74:0) after 5m27s
[01:48:22.075] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:74:0)
[01:48:22.097] Build status: STARTED
[01:48:22.097] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:75:0) after 3m37s
[01:51:59.124] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:75:0)
[01:51:59.148] Build status: STARTED
[01:51:59.148] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:76:0) after 4m6s
[01:56:05.212] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:76:0)
[01:56:05.236] Build status: STARTED
[01:56:05.236] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:77:0) after 4m39s
[02:00:44.269] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:77:0)
[02:00:44.326] Build status: STARTED
[02:00:44.326] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:78:0) after 5m43s
[02:06:27.350] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:78:0)
[02:06:27.384] Build status: STARTED
[02:06:27.384] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:79:0) after 3m7s
[02:09:34.809] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:79:0)
[02:09:34.908] Build status: STARTED
[02:09:34.908] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:80:0) after 7m24s
[02:16:59.065] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:80:0)
[02:16:59.096] Build status: STARTED
[02:16:59.096] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:81:0) after 8m17s
[02:25:16.476] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:81:0)
[02:25:16.536] Build status: STARTED
[02:25:16.536] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:82:0) after 5m23s
[02:30:39.575] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:82:0)
[02:30:39.613] Build status: STARTED
[02:30:39.613] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:83:0) after 3m10s
[02:33:49.674] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:83:0)
[02:33:49.706] Build status: STARTED
[02:33:49.706] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:84:0) after 2m10s
[02:35:59.730] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:84:0)
[02:35:59.752] Build status: STARTED
[02:35:59.752] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:85:0) after 2m27s
[02:38:26.878] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:85:0)
[02:38:26.912] Build status: STARTED
[02:38:26.912] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:86:0) after 9m54s
[02:48:21.034] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:86:0)
[02:48:21.056] Build status: STARTED
[02:48:21.056] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:87:0) after 9m6s
[02:57:27.185] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:87:0)
[02:57:27.206] Build status: STARTED
[02:57:27.206] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:88:0) after 2m48s
[03:00:15.278] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:88:0)
[03:00:15.316] Build status: STARTED
[03:00:15.316] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:89:0) after 6m31s
[03:06:46.344] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:89:0)
[03:06:46.403] Build status: STARTED
[03:06:46.403] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:90:0) after 3m28s
[03:10:14.464] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:90:0)
[03:10:14.496] Build status: STARTED
[03:10:14.496] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:91:0) after 2m18s
[03:12:32.523] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:91:0)
[03:12:32.561] Build status: STARTED
[03:12:32.561] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:92:0) after 2m42s
[03:15:14.629] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:92:0)
[03:15:14.669] Build status: STARTED
[03:15:14.669] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:93:0) after 5m34s
[03:20:48.727] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:93:0)
[03:20:48.749] Build status: STARTED
[03:20:48.749] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:94:0) after 4m16s
[03:25:04.899] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:94:0)
[03:25:04.922] Build status: STARTED
[03:25:04.922] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:95:0) after 4m55s
[03:29:59.903] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:95:0)
[03:29:59.941] Build status: STARTED
[03:29:59.941] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:96:0) after 3m50s
[03:33:50.064] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:96:0)
[03:33:50.089] Build status: STARTED
[03:33:50.089] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:97:0) after 1m54s
[03:35:44.235] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:97:0)
[03:35:44.274] Build status: STARTED
[03:35:44.274] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:98:0) after 5m6s
[03:40:50.295] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:98:0)
[03:40:50.319] Build status: STARTED
[03:40:50.319] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:99:0) after 4m55s
[03:45:45.341] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:99:0)
[03:45:45.388] Build status: STARTED
[03:45:45.388] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:100:0) after 5m6s
[03:50:51.517] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:100:0)
[03:50:51.541] Build status: STARTED
[03:50:51.541] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:101:0) after 6m32s
[03:57:23.585] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:101:0)
[03:57:23.609] Build status: STARTED
[03:57:23.609] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:102:0) after 4m56s
[04:02:19.604] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:102:0)
[04:02:19.656] Build status: STARTED
[04:02:19.656] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:103:0) after 4m32s
[04:06:51.680] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:103:0)
[04:06:51.702] Build status: STARTED
[04:06:51.702] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:104:0) after 4m24s
[04:11:15.742] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:104:0)
[04:11:15.771] Build status: STARTED
[04:11:15.771] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:105:0) after 2m36s
[04:13:51.792] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:105:0)
[04:13:51.816] Build status: STARTED
[04:13:51.816] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:106:0) after 6m36s
[04:20:28.064] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:106:0)
[04:20:28.085] Build status: STARTED
[04:20:28.085] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:107:0) after 2m48s
[04:23:16.108] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:107:0)
[04:23:16.149] Build status: STARTED
[04:23:16.149] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:108:0) after 4m43s
[04:27:59.217] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:108:0)
[04:27:59.245] Build status: STARTED
[04:27:59.245] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:109:0) after 4m46s
[04:32:45.267] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:109:0)
[04:32:45.292] Build status: STARTED
[04:32:45.292] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:110:0) after 5m52s
[04:38:37.318] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:110:0)
[04:38:37.362] Build status: STARTED
[04:38:37.362] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:111:0) after 2m42s
[04:41:19.386] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:111:0)
[04:41:19.413] Build status: STARTED
[04:41:19.413] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:112:0) after 4m8s
[04:45:27.643] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:112:0)
[04:45:27.665] Build status: STARTED
[04:45:27.665] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:113:0) after 4m12s
[04:49:39.700] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:113:0)
[04:49:39.725] Build status: STARTED
[04:49:39.725] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:114:0) after 5m58s
[04:55:37.775] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:114:0)
[04:55:37.797] Build status: STARTED
[04:55:37.797] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:115:0) after 1m8s
[04:56:46.056] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:115:0)
[04:56:46.088] Build status: STARTED
[04:56:46.088] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:116:0) after 5m58s
[05:02:44.122] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:116:0)
[05:02:44.147] Build status: STARTED
[05:02:44.147] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:117:0) after 7m42s
[05:10:26.183] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:117:0)
[05:10:26.228] Build status: STARTED
[05:10:26.228] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:118:0) after 6m15s
[05:16:41.254] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:118:0)
[05:16:41.281] Build status: STARTED
[05:16:41.281] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:119:0) after 7m43s
[05:24:24.333] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:119:0)
[05:24:24.356] Build status: STARTED
[05:24:24.356] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:120:0) after 1m43s
[05:26:07.376] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:120:0)
[05:26:07.398] Build status: STARTED
[05:26:07.398] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:121:0) after 2m51s
[05:28:58.498] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:121:0)
[05:28:58.523] Build status: STARTED
[05:28:58.523] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:122:0) after 8m59s
[05:37:57.579] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:122:0)
[05:37:57.613] Build status: STARTED
[05:37:57.613] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8971982368163373648:123:0) after 9m12s
[05:44:47.622] Received PubSub notification, asking Buildbucket for the build status
[05:44:47.647] Build:
{
"id": "8806552306021354225",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 11739,
"createdBy": "project:chromium",
"createTime": "2022-08-06T19:31:11.867651936Z",
"startTime": "2022-08-06T19:43:56.286758Z",
"endTime": "2022-08-07T05:44:47.262063145Z",
"updateTime": "2022-08-07T05:44:47.262063145Z",
"status": "CANCELED",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "de7d69922bcbda49075ae5547c6f5202f1195e52",
"ref": "refs/heads/main"
}
}
}
[05:44:47.647] Invocation finished in 10h13m37.206545958s with status ABORTED