[04:38:50.525] New invocation is queued and will start shortly
[04:38:51.600] Starting the invocation (attempt 1)
[04:38:51.623] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/920f2b001d0f753d80700d629bbe5b2359b65eac"
[04:38:51.623] Popped gitiles commit info from properties and tags
[04:38:51.623] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:38:51.623] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:38:51.623] Buildbucket request:
{
"requestId": "8926196443847816560",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "920f2b001d0f753d80700d629bbe5b2359b65eac",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8926196443847816560"
},
{
"key": "scheduler_job_id",
"value": "chromium/Android x64 Builder All Targets (dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:38:52.169] Scheduled build:
{
"id": "8760766381989835473",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"number": 3543,
"createdBy": "project:chromium",
"createTime": "2023-12-25T04:38:51.668903698Z",
"updateTime": "2023-12-25T04:38:51.668903698Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "920f2b001d0f753d80700d629bbe5b2359b65eac",
"ref": "refs/heads/main"
}
}
}
[04:38:52.169] Task URL: https://cr-buildbucket.appspot.com/build/8760766381989835473
[04:38:52.169] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:2:0) after 6m28s
[04:38:53.081] Received PubSub notification, asking Buildbucket for the build status
[04:38:53.106] Build status: SCHEDULED
[04:45:20.196] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:2:0)
[04:45:20.233] Build status: SCHEDULED
[04:45:20.233] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:4:0) after 9m7s
[04:48:06.283] Received PubSub notification, asking Buildbucket for the build status
[04:48:06.306] Build status: STARTED
[04:54:27.252] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:4:0)
[04:54:27.268] Build status: STARTED
[04:54:27.268] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:6:0) after 1m21s
[04:55:48.285] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:6:0)
[04:55:48.365] Build status: STARTED
[04:55:48.365] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:7:0) after 4m0s
[04:59:48.377] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:7:0)
[04:59:48.454] Build status: STARTED
[04:59:48.454] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:8:0) after 3m0s
[05:02:48.470] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:8:0)
[05:02:48.488] Build status: STARTED
[05:02:48.488] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:9:0) after 2m6s
[05:04:54.557] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:9:0)
[05:04:54.576] Build status: STARTED
[05:04:54.576] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:10:0) after 3m39s
[05:08:33.651] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:10:0)
[05:08:33.695] Build status: STARTED
[05:08:33.695] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:11:0) after 7m21s
[05:15:54.712] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:11:0)
[05:15:54.757] Build status: STARTED
[05:15:54.757] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:12:0) after 5m7s
[05:21:01.734] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:12:0)
[05:21:01.764] Build status: STARTED
[05:21:01.764] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:13:0) after 3m24s
[05:24:25.777] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:13:0)
[05:24:25.804] Build status: STARTED
[05:24:25.804] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:14:0) after 9m50s
[05:34:15.818] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:14:0)
[05:34:15.836] Build status: STARTED
[05:34:15.836] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:15:0) after 8m1s
[05:42:16.858] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:15:0)
[05:42:16.899] Build status: STARTED
[05:42:16.899] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:16:0) after 9m21s
[05:51:37.968] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:16:0)
[05:51:37.990] Build status: STARTED
[05:51:37.990] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:17:0) after 4m5s
[05:55:43.049] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:17:0)
[05:55:43.064] Build status: STARTED
[05:55:43.064] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:18:0) after 7m25s
[06:03:08.086] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:18:0)
[06:03:08.133] Build status: STARTED
[06:03:08.133] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:19:0) after 9m20s
[06:12:28.168] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:19:0)
[06:12:28.184] Build status: STARTED
[06:12:28.184] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:20:0) after 9m12s
[06:21:40.403] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:20:0)
[06:21:40.429] Build status: STARTED
[06:21:40.429] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:21:0) after 1m33s
[06:23:13.444] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:21:0)
[06:23:13.459] Build status: STARTED
[06:23:13.459] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:22:0) after 1m59s
[06:25:12.537] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:22:0)
[06:25:12.559] Build status: STARTED
[06:25:12.559] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:23:0) after 2m29s
[06:27:41.577] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:23:0)
[06:27:41.592] Build status: STARTED
[06:27:41.592] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:24:0) after 2m16s
[06:29:57.622] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:24:0)
[06:29:57.638] Build status: STARTED
[06:29:57.638] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:25:0) after 5m25s
[06:35:22.675] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:25:0)
[06:35:22.692] Build status: STARTED
[06:35:22.692] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:26:0) after 3m32s
[06:38:55.073] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:26:0)
[06:38:55.098] Build status: STARTED
[06:38:55.098] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:27:0) after 7m34s
[06:46:29.124] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:27:0)
[06:46:29.147] Build status: STARTED
[06:46:29.147] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:28:0) after 7m33s
[06:54:02.165] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:28:0)
[06:54:02.195] Build status: STARTED
[06:54:02.195] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:29:0) after 1m44s
[06:55:46.299] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:29:0)
[06:55:46.374] Build status: STARTED
[06:55:46.374] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:30:0) after 6m17s
[07:02:03.498] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:30:0)
[07:02:03.538] Build status: STARTED
[07:02:03.538] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:31:0) after 5m58s
[07:08:01.557] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:31:0)
[07:08:01.667] Build status: STARTED
[07:08:01.668] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:32:0) after 2m28s
[07:10:29.687] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:32:0)
[07:10:29.704] Build status: STARTED
[07:10:29.704] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:33:0) after 2m0s
[07:12:29.828] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:33:0)
[07:12:29.916] Build status: STARTED
[07:12:29.916] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:34:0) after 3m58s
[07:16:27.960] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:34:0)
[07:16:27.986] Build status: STARTED
[07:16:27.987] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:35:0) after 5m48s
[07:22:16.012] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:35:0)
[07:22:16.031] Build status: STARTED
[07:22:16.031] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:36:0) after 5m51s
[07:28:07.060] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:36:0)
[07:28:07.099] Build status: STARTED
[07:28:07.099] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:37:0) after 1m5s
[07:29:12.119] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:37:0)
[07:29:12.146] Build status: STARTED
[07:29:12.146] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:38:0) after 5m38s
[07:34:50.185] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:38:0)
[07:34:50.206] Build status: STARTED
[07:34:50.206] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:39:0) after 2m17s
[07:37:07.273] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:39:0)
[07:37:07.345] Build status: STARTED
[07:37:07.345] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:40:0) after 5m4s
[07:42:11.722] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:40:0)
[07:42:11.736] Build status: STARTED
[07:42:11.736] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:41:0) after 1m26s
[07:43:37.943] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:41:0)
[07:43:37.960] Build status: STARTED
[07:43:37.960] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:42:0) after 5m35s
[07:49:13.582] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:42:0)
[07:49:13.606] Build status: STARTED
[07:49:13.606] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:43:0) after 7m15s
[07:56:28.628] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:43:0)
[07:56:28.644] Build status: STARTED
[07:56:28.644] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:44:0) after 2m19s
[07:58:47.659] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:44:0)
[07:58:47.677] Build status: STARTED
[07:58:47.677] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:45:0) after 1m36s
[08:00:23.691] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:45:0)
[08:00:23.737] Build status: STARTED
[08:00:23.737] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:46:0) after 1m41s
[08:02:04.937] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:46:0)
[08:02:04.988] Build status: STARTED
[08:02:04.990] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:47:0) after 8m28s
[08:10:33.273] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:47:0)
[08:10:33.293] Build status: STARTED
[08:10:33.293] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:48:0) after 6m10s
[08:16:43.275] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:48:0)
[08:16:43.303] Build status: STARTED
[08:16:43.303] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:49:0) after 4m55s
[08:21:38.332] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:49:0)
[08:21:38.354] Build status: STARTED
[08:21:38.354] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:50:0) after 6m42s
[08:28:20.380] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:50:0)
[08:28:20.399] Build status: STARTED
[08:28:20.399] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:51:0) after 7m27s
[08:35:47.417] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:51:0)
[08:35:47.440] Build status: STARTED
[08:35:47.440] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:52:0) after 1m30s
[08:37:17.663] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:52:0)
[08:37:17.681] Build status: STARTED
[08:37:17.681] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:53:0) after 1m18s
[08:38:36.201] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:53:0)
[08:38:36.255] Build status: STARTED
[08:38:36.255] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8926196443847816560:54:0) after 9m44s
[08:43:42.335] Received PubSub notification, asking Buildbucket for the build status
[08:43:42.359] Build:
{
"id": "8760766381989835473",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"number": 3543,
"createdBy": "project:chromium",
"createTime": "2023-12-25T04:38:51.668903698Z",
"startTime": "2023-12-25T04:48:05.110188Z",
"endTime": "2023-12-25T08:43:41.210942Z",
"updateTime": "2023-12-25T08:43:41.210942Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "920f2b001d0f753d80700d629bbe5b2359b65eac",
"ref": "refs/heads/main"
}
}
}
[08:43:42.359] Invocation finished in 4h4m51.845894929s with status SUCCEEDED