[22:53:08.100] New invocation is queued and will start shortly
[22:53:09.146] Starting the invocation (attempt 1)
[22:53:09.177] Popped buildset tag "buildset:commit/gitiles/android.googlesource.com/platform/art/+/3c38671b48926b1cca5f329ba8726098e557210a"
[22:53:09.177] Popped gitiles commit info from properties and tags
[22:53:09.177] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:53:09.178] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:53:09.178] Buildbucket request:
{
"requestId": "8951494747480818960",
"builder": {
"project": "art",
"bucket": "ci",
"builder": "angler-armv8-debug"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8951494747480818960",
"job": "art/angler-armv8-debug",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/external/vogar",
"revision": "5b2cd760309e5a46d50cebe2406bce5f92de10e7"
},
"id": "https://android.googlesource.com/platform/external/vogar/+/refs/heads/master@5b2cd760309e5a46d50cebe2406bce5f92de10e7",
"title": "5b2cd760309e5a46d50cebe2406bce5f92de10e7",
"url": "https://android.googlesource.com/platform/external/vogar/+/5b2cd760309e5a46d50cebe2406bce5f92de10e7"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "ee652ed06037a4d38ac8bd822868ae31d2d6c3a6"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@ee652ed06037a4d38ac8bd822868ae31d2d6c3a6",
"title": "ee652ed06037a4d38ac8bd822868ae31d2d6c3a6",
"url": "https://android.googlesource.com/platform/libcore/+/ee652ed06037a4d38ac8bd822868ae31d2d6c3a6"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "cb89eca6d568e8c330f9e3c61b714fbfd0a304a5"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@cb89eca6d568e8c330f9e3c61b714fbfd0a304a5",
"title": "cb89eca6d568e8c330f9e3c61b714fbfd0a304a5",
"url": "https://android.googlesource.com/platform/libcore/+/cb89eca6d568e8c330f9e3c61b714fbfd0a304a5"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "3f29822448849ed59f9bab82825070be1c24118d"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@3f29822448849ed59f9bab82825070be1c24118d",
"title": "3f29822448849ed59f9bab82825070be1c24118d",
"url": "https://android.googlesource.com/platform/libcore/+/3f29822448849ed59f9bab82825070be1c24118d"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "f5caedf05c1d707ae350e2f0cfe7dc2beda02dee"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@f5caedf05c1d707ae350e2f0cfe7dc2beda02dee",
"title": "f5caedf05c1d707ae350e2f0cfe7dc2beda02dee",
"url": "https://android.googlesource.com/platform/libcore/+/f5caedf05c1d707ae350e2f0cfe7dc2beda02dee"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "836453a4ca71640ff5d8cc67a3da00a0a7f887fc"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@836453a4ca71640ff5d8cc67a3da00a0a7f887fc",
"title": "836453a4ca71640ff5d8cc67a3da00a0a7f887fc",
"url": "https://android.googlesource.com/platform/libcore/+/836453a4ca71640ff5d8cc67a3da00a0a7f887fc"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/art",
"revision": "c65ec92536364131ef038843a32240578f72a8e6"
},
"id": "https://android.googlesource.com/platform/art/+/refs/heads/master@c65ec92536364131ef038843a32240578f72a8e6",
"title": "c65ec92536364131ef038843a32240578f72a8e6",
"url": "https://android.googlesource.com/platform/art/+/c65ec92536364131ef038843a32240578f72a8e6"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "72f5ed87dca0095fff74c6054c754dbd61fb4f62"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@72f5ed87dca0095fff74c6054c754dbd61fb4f62",
"title": "72f5ed87dca0095fff74c6054c754dbd61fb4f62",
"url": "https://android.googlesource.com/platform/libcore/+/72f5ed87dca0095fff74c6054c754dbd61fb4f62"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "1c198903d975d03678fa842e5554fda1f9c9e3b2"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@1c198903d975d03678fa842e5554fda1f9c9e3b2",
"title": "1c198903d975d03678fa842e5554fda1f9c9e3b2",
"url": "https://android.googlesource.com/platform/libcore/+/1c198903d975d03678fa842e5554fda1f9c9e3b2"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/art",
"revision": "3c38671b48926b1cca5f329ba8726098e557210a"
},
"id": "https://android.googlesource.com/platform/art/+/refs/heads/master@3c38671b48926b1cca5f329ba8726098e557210a",
"title": "3c38671b48926b1cca5f329ba8726098e557210a",
"url": "https://android.googlesource.com/platform/art/+/3c38671b48926b1cca5f329ba8726098e557210a"
}
]
}
},
"gitilesCommit": {
"host": "android.googlesource.com",
"project": "platform/art",
"id": "3c38671b48926b1cca5f329ba8726098e557210a",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8951494747480818960"
},
{
"key": "scheduler_job_id",
"value": "art/angler-armv8-debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[22:53:09.831] Scheduled build:
{
"id": "8786064685357915313",
"builder": {
"project": "art",
"bucket": "ci",
"builder": "angler-armv8-debug"
},
"number": 3347,
"createdBy": "project:art",
"createTime": "2023-03-20T22:53:09.498477434Z",
"updateTime": "2023-03-20T22:53:09.498477434Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "android.googlesource.com",
"project": "platform/art",
"id": "3c38671b48926b1cca5f329ba8726098e557210a",
"ref": "refs/heads/master"
}
}
}
[22:53:09.831] Task URL: https://cr-buildbucket.appspot.com/build/8786064685357915313
[22:53:09.831] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:2:0) after 8m20s
[22:55:45.722] Received PubSub notification, asking Buildbucket for the build status
[22:55:45.754] Build status: STARTED
[23:01:29.849] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:2:0)
[23:01:29.878] Build status: STARTED
[23:01:29.878] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:4:0) after 7m25s
[23:08:54.864] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:4:0)
[23:08:54.887] Build status: STARTED
[23:08:54.887] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:5:0) after 7m25s
[23:16:19.953] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:5:0)
[23:16:19.973] Build status: STARTED
[23:16:19.973] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:6:0) after 1m53s
[23:18:13.011] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:6:0)
[23:18:13.035] Build status: STARTED
[23:18:13.035] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:7:0) after 2m58s
[23:21:11.053] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:7:0)
[23:21:11.075] Build status: STARTED
[23:21:11.075] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:8:0) after 8m31s
[23:29:42.094] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:8:0)
[23:29:42.205] Build status: STARTED
[23:29:42.205] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:9:0) after 3m14s
[23:32:56.226] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:9:0)
[23:32:56.251] Build status: STARTED
[23:32:56.251] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:10:0) after 7m16s
[23:40:12.292] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:10:0)
[23:40:12.313] Build status: STARTED
[23:40:12.313] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:11:0) after 4m48s
[23:45:00.320] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:11:0)
[23:45:00.346] Build status: STARTED
[23:45:00.346] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:12:0) after 8m34s
[23:53:34.365] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:12:0)
[23:53:34.398] Build status: STARTED
[23:53:34.398] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:13:0) after 5m28s
[23:59:02.760] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:13:0)
[23:59:02.781] Build status: STARTED
[23:59:02.781] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:14:0) after 9m38s
[00:08:41.204] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:14:0)
[00:08:41.230] Build status: STARTED
[00:08:41.230] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:15:0) after 9m1s
[00:17:42.321] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:15:0)
[00:17:42.341] Build status: STARTED
[00:17:42.341] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:16:0) after 6m25s
[00:24:07.366] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:16:0)
[00:24:07.385] Build status: STARTED
[00:24:07.385] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:17:0) after 7m41s
[00:31:48.453] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:17:0)
[00:31:48.473] Build status: STARTED
[00:31:48.473] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:18:0) after 9m3s
[00:40:51.490] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:18:0)
[00:40:51.540] Build status: STARTED
[00:40:51.540] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:19:0) after 2m5s
[00:42:56.619] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:19:0)
[00:42:56.648] Build status: STARTED
[00:42:56.648] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:20:0) after 2m58s
[00:45:54.669] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:20:0)
[00:45:54.695] Build status: STARTED
[00:45:54.695] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:21:0) after 1m49s
[00:47:43.714] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:21:0)
[00:47:43.739] Build status: STARTED
[00:47:43.739] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:22:0) after 1m6s
[00:48:49.757] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:22:0)
[00:48:49.778] Build status: STARTED
[00:48:49.778] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:23:0) after 3m44s
[00:52:33.796] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:23:0)
[00:52:33.820] Build status: STARTED
[00:52:33.820] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:24:0) after 2m3s
[00:54:36.850] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:24:0)
[00:54:36.878] Build status: STARTED
[00:54:36.878] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:25:0) after 8m53s
[01:03:30.087] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:25:0)
[01:03:30.122] Build status: STARTED
[01:03:30.122] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:26:0) after 4m38s
[01:08:08.259] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:26:0)
[01:08:08.352] Build status: STARTED
[01:08:08.352] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:27:0) after 8m25s
[01:16:33.360] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:27:0)
[01:16:33.410] Build status: STARTED
[01:16:33.410] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:28:0) after 9m17s
[01:25:50.427] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:28:0)
[01:25:50.456] Build status: STARTED
[01:25:50.456] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:29:0) after 9m59s
[01:35:49.922] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:29:0)
[01:35:49.948] Build status: STARTED
[01:35:49.948] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:30:0) after 4m9s
[01:39:58.964] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:30:0)
[01:39:58.995] Build status: STARTED
[01:39:58.995] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:31:0) after 2m46s
[01:42:45.022] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:31:0)
[01:42:45.044] Build status: STARTED
[01:42:45.044] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:32:0) after 4m25s
[01:47:10.111] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:32:0)
[01:47:10.131] Build status: STARTED
[01:47:10.131] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:33:0) after 4m30s
[01:51:40.218] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:33:0)
[01:51:40.240] Build status: STARTED
[01:51:40.240] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:34:0) after 4m10s
[01:55:51.394] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:34:0)
[01:55:51.442] Build status: STARTED
[01:55:51.442] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:35:0) after 1m2s
[01:56:53.560] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:35:0)
[01:56:53.595] Build status: STARTED
[01:56:53.595] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:36:0) after 8m37s
[02:05:30.799] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:36:0)
[02:05:30.825] Build status: STARTED
[02:05:30.825] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:37:0) after 3m37s
[02:09:07.846] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:37:0)
[02:09:07.867] Build status: STARTED
[02:09:07.867] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:38:0) after 5m55s
[02:15:03.053] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:38:0)
[02:15:03.085] Build status: STARTED
[02:15:03.085] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:39:0) after 3m27s
[02:18:30.159] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:39:0)
[02:18:30.183] Build status: STARTED
[02:18:30.183] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:40:0) after 4m0s
[02:22:30.408] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:40:0)
[02:22:30.441] Build status: STARTED
[02:22:30.441] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:41:0) after 9m38s
[02:32:09.149] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:41:0)
[02:32:09.172] Build status: STARTED
[02:32:09.172] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:42:0) after 7m0s
[02:39:09.170] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:42:0)
[02:39:09.189] Build status: STARTED
[02:39:09.189] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:43:0) after 9m5s
[02:48:14.602] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:43:0)
[02:48:14.636] Build status: STARTED
[02:48:14.636] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:44:0) after 2m57s
[02:51:11.729] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:44:0)
[02:51:11.769] Build status: STARTED
[02:51:11.769] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8951494747480818960:45:0) after 3m56s
[02:52:50.086] Received PubSub notification, asking Buildbucket for the build status
[02:52:50.111] Build:
{
"id": "8786064685357915313",
"builder": {
"project": "art",
"bucket": "ci",
"builder": "angler-armv8-debug"
},
"number": 3347,
"createdBy": "project:art",
"createTime": "2023-03-20T22:53:09.498477434Z",
"startTime": "2023-03-20T22:55:45.067713Z",
"endTime": "2023-03-21T02:52:49.790293403Z",
"updateTime": "2023-03-21T02:52:49.790293403Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "android.googlesource.com",
"project": "platform/art",
"id": "3c38671b48926b1cca5f329ba8726098e557210a",
"ref": "refs/heads/master"
}
}
}
[02:52:50.111] Invocation finished in 3h59m42.020977347s with status SUCCEEDED