[20:14:17.532] New invocation is queued and will start shortly
[20:14:18.726] Starting the invocation (attempt 1)
[20:14:18.756] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/55d12c6aee94f1639a5fbba646ba8d292276aa23"
[20:14:18.756] Popped gitiles commit info from properties and tags
[20:14:18.756] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:14:18.756] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:14:18.756] Buildbucket request:
{
"requestId": "8945162953354107472",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTChromeOS"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "55d12c6aee94f1639a5fbba646ba8d292276aa23",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8945162953354107472"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTChromeOS"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:14:19.144] Scheduled build:
{
"id": "8779732891348109313",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTChromeOS"
},
"number": 4753,
"createdBy": "project:chromium",
"createTime": "2023-05-29T20:14:18.822158172Z",
"updateTime": "2023-05-29T20:14:18.822158172Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "55d12c6aee94f1639a5fbba646ba8d292276aa23",
"ref": "refs/heads/main"
}
}
}
[20:14:19.144] Task URL: https://cr-buildbucket.appspot.com/build/8779732891348109313
[20:14:19.144] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:2:0) after 2m33s
[20:14:28.845] Received PubSub notification, asking Buildbucket for the build status
[20:14:28.906] Build status: STARTED
[20:16:52.189] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:2:0)
[20:16:52.218] Build status: STARTED
[20:16:52.218] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:4:0) after 3m31s
[20:20:23.379] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:4:0)
[20:20:23.402] Build status: STARTED
[20:20:23.402] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:5:0) after 9m51s
[20:30:14.746] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:5:0)
[20:30:14.812] Build status: STARTED
[20:30:14.812] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:6:0) after 4m51s
[20:35:06.134] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:6:0)
[20:35:06.151] Build status: STARTED
[20:35:06.151] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:7:0) after 9m13s
[20:44:19.152] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:7:0)
[20:44:19.191] Build status: STARTED
[20:44:19.192] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:8:0) after 4m24s
[20:48:43.203] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:8:0)
[20:48:43.231] Build status: STARTED
[20:48:43.231] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:9:0) after 2m58s
[20:51:41.309] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:9:0)
[20:51:41.335] Build status: STARTED
[20:51:41.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:10:0) after 5m10s
[20:56:51.346] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:10:0)
[20:56:51.365] Build status: STARTED
[20:56:51.365] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:11:0) after 4m16s
[21:01:07.471] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:11:0)
[21:01:07.542] Build status: STARTED
[21:01:07.542] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:12:0) after 9m34s
[21:10:41.562] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:12:0)
[21:10:41.683] Build status: STARTED
[21:10:41.683] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:13:0) after 6m32s
[21:17:13.693] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:13:0)
[21:17:13.714] Build status: STARTED
[21:17:13.714] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:14:0) after 1m11s
[21:18:24.891] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:14:0)
[21:18:24.913] Build status: STARTED
[21:18:24.913] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:15:0) after 7m43s
[21:26:08.068] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:15:0)
[21:26:08.089] Build status: STARTED
[21:26:08.089] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:16:0) after 6m3s
[21:32:11.108] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:16:0)
[21:32:11.129] Build status: STARTED
[21:32:11.129] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:17:0) after 7m4s
[21:39:15.180] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:17:0)
[21:39:15.207] Build status: STARTED
[21:39:15.207] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:18:0) after 8m29s
[21:47:44.229] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:18:0)
[21:47:44.252] Build status: STARTED
[21:47:44.252] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:19:0) after 5m10s
[21:52:54.354] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:19:0)
[21:52:54.376] Build status: STARTED
[21:52:54.376] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:20:0) after 2m28s
[21:55:22.496] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:20:0)
[21:55:22.517] Build status: STARTED
[21:55:22.517] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:21:0) after 2m17s
[21:57:39.806] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:21:0)
[21:57:39.845] Build status: STARTED
[21:57:39.845] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:22:0) after 7m20s
[22:04:59.865] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:22:0)
[22:04:59.901] Build status: STARTED
[22:04:59.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:23:0) after 3m8s
[22:08:07.923] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:23:0)
[22:08:07.941] Build status: STARTED
[22:08:07.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:24:0) after 3m52s
[22:11:59.963] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:24:0)
[22:11:59.982] Build status: STARTED
[22:11:59.983] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:25:0) after 6m40s
[22:18:40.003] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:25:0)
[22:18:40.064] Build status: STARTED
[22:18:40.064] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:26:0) after 4m8s
[22:22:48.114] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:26:0)
[22:22:48.138] Build status: STARTED
[22:22:48.138] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:27:0) after 9m36s
[22:32:24.159] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:27:0)
[22:32:24.193] Build status: STARTED
[22:32:24.193] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:28:0) after 6m43s
[22:39:07.202] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:28:0)
[22:39:07.222] Build status: STARTED
[22:39:07.222] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:29:0) after 9m44s
[22:48:51.206] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:29:0)
[22:48:51.225] Build status: STARTED
[22:48:51.225] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:30:0) after 7m39s
[22:56:30.358] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:30:0)
[22:56:30.442] Build status: STARTED
[22:56:30.442] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:31:0) after 8m48s
[23:05:54.610] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:31:0)
[23:05:54.651] Build status: STARTED
[23:05:54.651] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:32:0) after 2m34s
[23:08:28.693] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:32:0)
[23:08:28.711] Build status: STARTED
[23:08:28.711] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:33:0) after 2m58s
[23:11:26.734] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:33:0)
[23:11:26.770] Build status: STARTED
[23:11:26.770] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:34:0) after 1m57s
[23:13:23.775] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:34:0)
[23:13:23.793] Build status: STARTED
[23:13:23.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:35:0) after 2m34s
[23:15:57.824] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:35:0)
[23:15:57.900] Build status: STARTED
[23:15:57.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:36:0) after 7m37s
[23:23:34.918] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:36:0)
[23:23:35.015] Build status: STARTED
[23:23:35.015] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:37:0) after 3m29s
[23:27:04.033] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:37:0)
[23:27:04.052] Build status: STARTED
[23:27:04.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:38:0) after 7m33s
[23:34:37.084] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:38:0)
[23:34:37.129] Build status: STARTED
[23:34:37.129] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:39:0) after 4m25s
[23:39:02.246] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:39:0)
[23:39:02.271] Build status: STARTED
[23:39:02.271] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:40:0) after 3m27s
[23:42:29.317] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:40:0)
[23:42:29.335] Build status: STARTED
[23:42:29.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:41:0) after 4m14s
[23:46:43.370] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:41:0)
[23:46:43.400] Build status: STARTED
[23:46:43.400] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:42:0) after 5m44s
[23:52:27.583] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:42:0)
[23:52:27.602] Build status: STARTED
[23:52:27.602] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:43:0) after 7m3s
[23:59:30.669] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:43:0)
[23:59:30.687] Build status: STARTED
[23:59:30.687] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:44:0) after 5m21s
[00:04:51.704] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:44:0)
[00:04:51.723] Build status: STARTED
[00:04:51.723] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:45:0) after 1m0s
[00:05:51.868] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:45:0)
[00:05:51.893] Build status: STARTED
[00:05:51.893] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:46:0) after 2m11s
[00:08:03.098] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:46:0)
[00:08:03.114] Build status: STARTED
[00:08:03.115] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:47:0) after 7m5s
[00:15:08.251] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:47:0)
[00:15:08.355] Build status: STARTED
[00:15:08.355] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:48:0) after 9m55s
[00:25:03.453] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:48:0)
[00:25:03.473] Build status: STARTED
[00:25:03.473] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:49:0) after 5m3s
[00:30:06.601] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:49:0)
[00:30:06.633] Build status: STARTED
[00:30:06.633] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:50:0) after 9m8s
[00:39:14.759] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:50:0)
[00:39:14.779] Build status: STARTED
[00:39:14.779] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:51:0) after 6m32s
[00:45:46.901] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:51:0)
[00:45:46.940] Build status: STARTED
[00:45:46.940] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:52:0) after 5m45s
[00:51:31.981] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:52:0)
[00:51:32.001] Build status: STARTED
[00:51:32.001] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:53:0) after 4m11s
[00:55:43.053] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:53:0)
[00:55:43.085] Build status: STARTED
[00:55:43.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:54:0) after 8m26s
[01:04:09.218] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:54:0)
[01:04:09.278] Build status: STARTED
[01:04:09.278] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:55:0) after 3m0s
[01:07:09.298] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:55:0)
[01:07:09.381] Build status: STARTED
[01:07:09.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:56:0) after 2m17s
[01:09:26.499] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:56:0)
[01:09:26.523] Build status: STARTED
[01:09:26.523] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:57:0) after 3m17s
[01:12:43.542] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:57:0)
[01:12:43.564] Build status: STARTED
[01:12:43.564] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:58:0) after 1m48s
[01:14:31.583] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:58:0)
[01:14:31.604] Build status: STARTED
[01:14:31.604] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:59:0) after 8m56s
[01:23:27.670] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:59:0)
[01:23:27.693] Build status: STARTED
[01:23:27.694] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:60:0) after 6m57s
[01:30:24.882] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:60:0)
[01:30:24.981] Build status: STARTED
[01:30:24.981] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:61:0) after 6m54s
[01:37:19.089] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:61:0)
[01:37:19.133] Build status: STARTED
[01:37:19.133] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:62:0) after 8m1s
[01:45:20.171] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:62:0)
[01:45:20.201] Build status: STARTED
[01:45:20.201] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:63:0) after 9m19s
[01:54:39.519] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:63:0)
[01:54:39.546] Build status: STARTED
[01:54:39.547] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:64:0) after 2m43s
[01:57:22.588] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:64:0)
[01:57:22.605] Build status: STARTED
[01:57:22.605] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:65:0) after 5m6s
[02:02:28.679] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:65:0)
[02:02:28.699] Build status: STARTED
[02:02:28.699] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:66:0) after 4m42s
[02:07:10.730] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:66:0)
[02:07:10.888] Build status: STARTED
[02:07:10.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:67:0) after 3m32s
[02:10:42.912] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:67:0)
[02:10:42.931] Build status: STARTED
[02:10:42.931] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:68:0) after 9m33s
[02:20:16.040] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:68:0)
[02:20:16.061] Build status: STARTED
[02:20:16.061] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:69:0) after 6m51s
[02:27:07.328] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:69:0)
[02:27:07.419] Build status: STARTED
[02:27:07.419] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:70:0) after 3m4s
[02:30:11.484] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:70:0)
[02:30:11.507] Build status: STARTED
[02:30:11.508] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:71:0) after 5m42s
[02:35:53.610] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:71:0)
[02:35:53.632] Build status: STARTED
[02:35:53.632] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:72:0) after 4m44s
[02:40:37.693] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:72:0)
[02:40:37.718] Build status: STARTED
[02:40:37.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:73:0) after 5m28s
[02:46:05.739] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:73:0)
[02:46:05.757] Build status: STARTED
[02:46:05.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:74:0) after 4m29s
[02:50:34.777] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:74:0)
[02:50:34.798] Build status: STARTED
[02:50:34.798] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:75:0) after 1m56s
[02:52:30.819] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:75:0)
[02:52:30.841] Build status: STARTED
[02:52:30.841] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:76:0) after 9m26s
[03:01:56.878] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:76:0)
[03:01:56.897] Build status: STARTED
[03:01:56.897] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:77:0) after 8m20s
[03:10:16.920] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:77:0)
[03:10:16.945] Build status: STARTED
[03:10:16.945] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:78:0) after 1m36s
[03:11:53.020] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:78:0)
[03:11:53.116] Build status: STARTED
[03:11:53.116] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:79:0) after 6m23s
[03:18:16.257] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:79:0)
[03:18:16.277] Build status: STARTED
[03:18:16.277] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:80:0) after 2m47s
[03:21:03.298] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:80:0)
[03:21:03.316] Build status: STARTED
[03:21:03.316] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:81:0) after 9m3s
[03:30:06.588] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:81:0)
[03:30:06.614] Build status: STARTED
[03:30:06.614] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:82:0) after 7m54s
[03:38:00.636] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:82:0)
[03:38:00.654] Build status: STARTED
[03:38:00.654] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:83:0) after 2m37s
[03:40:37.778] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:83:0)
[03:40:37.805] Build status: STARTED
[03:40:37.805] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:84:0) after 1m27s
[03:42:04.822] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:84:0)
[03:42:04.889] Build status: STARTED
[03:42:04.889] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:85:0) after 4m41s
[03:46:45.938] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:85:0)
[03:46:45.991] Build status: STARTED
[03:46:45.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:86:0) after 9m34s
[03:56:20.016] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:86:0)
[03:56:20.040] Build status: STARTED
[03:56:20.040] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:87:0) after 1m18s
[03:57:38.210] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:87:0)
[03:57:38.227] Build status: STARTED
[03:57:38.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:88:0) after 2m9s
[03:59:47.256] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:88:0)
[03:59:47.280] Build status: STARTED
[03:59:47.280] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:89:0) after 5m39s
[04:05:26.409] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:89:0)
[04:05:26.427] Build status: STARTED
[04:05:26.427] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:90:0) after 9m33s
[04:14:59.450] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:90:0)
[04:14:59.471] Build status: STARTED
[04:14:59.471] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:91:0) after 2m26s
[04:17:25.597] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:91:0)
[04:17:25.625] Build status: STARTED
[04:17:25.625] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:92:0) after 6m23s
[04:23:48.710] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:92:0)
[04:23:48.740] Build status: STARTED
[04:23:48.740] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:93:0) after 1m34s
[04:25:22.724] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:93:0)
[04:25:22.747] Build status: STARTED
[04:25:22.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:94:0) after 6m20s
[04:31:42.767] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:94:0)
[04:31:42.794] Build status: STARTED
[04:31:42.794] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:95:0) after 8m11s
[04:39:53.813] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:95:0)
[04:39:53.836] Build status: STARTED
[04:39:53.836] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:96:0) after 3m39s
[04:43:32.861] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:96:0)
[04:43:32.908] Build status: STARTED
[04:43:32.908] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:97:0) after 2m20s
[04:45:53.874] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:97:0)
[04:45:53.890] Build status: STARTED
[04:45:53.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:98:0) after 7m57s
[04:53:50.918] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:98:0)
[04:53:50.958] Build status: STARTED
[04:53:50.958] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:99:0) after 8m47s
[05:02:37.999] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:99:0)
[05:02:38.017] Build status: STARTED
[05:02:38.017] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:100:0) after 4m57s
[05:07:35.122] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:100:0)
[05:07:35.162] Build status: STARTED
[05:07:35.162] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:101:0) after 5m21s
[05:12:56.186] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:101:0)
[05:12:56.203] Build status: STARTED
[05:12:56.203] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:102:0) after 5m43s
[05:18:39.397] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:102:0)
[05:18:39.416] Build status: STARTED
[05:18:39.416] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:103:0) after 7m23s
[05:26:02.554] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:103:0)
[05:26:02.574] Build status: STARTED
[05:26:02.574] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:104:0) after 9m59s
[05:36:01.580] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:104:0)
[05:36:01.639] Build status: STARTED
[05:36:01.639] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:105:0) after 1m15s
[05:37:16.728] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:105:0)
[05:37:16.745] Build status: STARTED
[05:37:16.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:106:0) after 3m39s
[05:40:55.753] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:106:0)
[05:40:55.776] Build status: STARTED
[05:40:55.776] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:107:0) after 1m29s
[05:42:24.813] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:107:0)
[05:42:24.830] Build status: STARTED
[05:42:24.830] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:108:0) after 3m7s
[05:45:31.833] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:108:0)
[05:45:31.904] Build status: STARTED
[05:45:31.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:109:0) after 3m39s
[05:49:10.898] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:109:0)
[05:49:10.915] Build status: STARTED
[05:49:10.915] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:110:0) after 3m26s
[05:52:36.935] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:110:0)
[05:52:36.952] Build status: STARTED
[05:52:36.952] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:111:0) after 7m25s
[06:00:02.034] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:111:0)
[06:00:02.051] Build status: STARTED
[06:00:02.051] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:112:0) after 1m50s
[06:01:52.177] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:112:0)
[06:01:52.243] Build status: STARTED
[06:01:52.243] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:113:0) after 3m48s
[06:05:40.262] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:113:0)
[06:05:40.280] Build status: STARTED
[06:05:40.280] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:114:0) after 3m8s
[06:08:48.397] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:114:0)
[06:08:48.417] Build status: STARTED
[06:08:48.417] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:115:0) after 5m2s
[06:13:50.447] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:115:0)
[06:13:50.483] Build status: STARTED
[06:13:50.483] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:116:0) after 1m31s
[06:15:21.510] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:116:0)
[06:15:21.537] Build status: STARTED
[06:15:21.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:117:0) after 4m23s
[06:19:44.591] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:117:0)
[06:19:44.611] Build status: STARTED
[06:19:44.612] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:118:0) after 1m21s
[06:21:05.649] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:118:0)
[06:21:05.692] Build status: STARTED
[06:21:05.692] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8945162953354107472:119:0) after 9m58s
[06:26:54.782] Received PubSub notification, asking Buildbucket for the build status
[06:26:54.805] Build:
{
"id": "8779732891348109313",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTChromeOS"
},
"number": 4753,
"createdBy": "project:chromium",
"createTime": "2023-05-29T20:14:18.822158172Z",
"startTime": "2023-05-29T20:14:27.467278Z",
"endTime": "2023-05-30T06:26:54.562395759Z",
"updateTime": "2023-05-30T06:26:54.562395759Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "55d12c6aee94f1639a5fbba646ba8d292276aa23",
"ref": "refs/heads/main"
}
}
}
[06:26:54.805] Invocation finished in 10h12m37.280368297s with status SUCCEEDED