[11:46:56.749] New invocation is queued and will start shortly
[11:46:57.895] Starting the invocation (attempt 1)
[11:46:57.931] Popped buildset tag "buildset:commit/gitiles/android.googlesource.com/platform/libcore/+/96e7e26b26f0d5e2fe4a556a95c0fce83cd4f079"
[11:46:57.931] Popped gitiles commit info from properties and tags
[11:46:57.931] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:46:57.931] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:46:57.931] Buildbucket request:
{
"requestId": "8968568890164469616",
"builder": {
"project": "art",
"bucket": "ci",
"builder": "angler-armv8-debug"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8968568890164469616",
"job": "art/angler-armv8-debug",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "bab67b63ebbc17e005e546e264fc3ea4a4799c02"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@bab67b63ebbc17e005e546e264fc3ea4a4799c02",
"title": "bab67b63ebbc17e005e546e264fc3ea4a4799c02",
"url": "https://android.googlesource.com/platform/libcore/+/bab67b63ebbc17e005e546e264fc3ea4a4799c02"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "b364f52e64702a46e5bba8c26489300c60b93230"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@b364f52e64702a46e5bba8c26489300c60b93230",
"title": "b364f52e64702a46e5bba8c26489300c60b93230",
"url": "https://android.googlesource.com/platform/libcore/+/b364f52e64702a46e5bba8c26489300c60b93230"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "62888a31420971ec31bfdfb316025410e9937fc1"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@62888a31420971ec31bfdfb316025410e9937fc1",
"title": "62888a31420971ec31bfdfb316025410e9937fc1",
"url": "https://android.googlesource.com/platform/libcore/+/62888a31420971ec31bfdfb316025410e9937fc1"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/art",
"revision": "3377268208f0fe262119faa2a93e0b0be454ade6"
},
"id": "https://android.googlesource.com/platform/art/+/refs/heads/master@3377268208f0fe262119faa2a93e0b0be454ade6",
"title": "3377268208f0fe262119faa2a93e0b0be454ade6",
"url": "https://android.googlesource.com/platform/art/+/3377268208f0fe262119faa2a93e0b0be454ade6"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "96e7e26b26f0d5e2fe4a556a95c0fce83cd4f079"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@96e7e26b26f0d5e2fe4a556a95c0fce83cd4f079",
"title": "96e7e26b26f0d5e2fe4a556a95c0fce83cd4f079",
"url": "https://android.googlesource.com/platform/libcore/+/96e7e26b26f0d5e2fe4a556a95c0fce83cd4f079"
}
]
}
},
"gitilesCommit": {
"host": "android.googlesource.com",
"project": "platform/libcore",
"id": "96e7e26b26f0d5e2fe4a556a95c0fce83cd4f079",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8968568890164469616"
},
{
"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"
}
}
[11:46:58.492] Scheduled build:
{
"id": "8803138828216069553",
"builder": {
"project": "art",
"bucket": "ci",
"builder": "angler-armv8-debug"
},
"number": 2865,
"createdBy": "project:art",
"createTime": "2022-09-13T11:46:57.979592416Z",
"updateTime": "2022-09-13T11:46:57.979592416Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "android.googlesource.com",
"project": "platform/libcore",
"id": "96e7e26b26f0d5e2fe4a556a95c0fce83cd4f079",
"ref": "refs/heads/master"
}
}
}
[11:46:58.492] Task URL: https://cr-buildbucket.appspot.com/build/8803138828216069553
[11:46:58.492] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:2:0) after 8m28s
[11:47:38.809] Received PubSub notification, asking Buildbucket for the build status
[11:47:38.833] Build status: STARTED
[11:55:26.511] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:2:0)
[11:55:26.533] Build status: STARTED
[11:55:26.533] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:4:0) after 7m22s
[12:02:48.658] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:4:0)
[12:02:48.684] Build status: STARTED
[12:02:48.684] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:5:0) after 5m2s
[12:07:50.704] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:5:0)
[12:07:50.736] Build status: STARTED
[12:07:50.736] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:6:0) after 8m40s
[12:16:30.942] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:6:0)
[12:16:30.973] Build status: STARTED
[12:16:30.973] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:7:0) after 7m52s
[12:24:23.035] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:7:0)
[12:24:23.087] Build status: STARTED
[12:24:23.087] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:8:0) after 1m33s
[12:25:56.248] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:8:0)
[12:25:56.332] Build status: STARTED
[12:25:56.332] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:9:0) after 7m26s
[12:33:22.336] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:9:0)
[12:33:22.365] Build status: STARTED
[12:33:22.365] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:10:0) after 8m52s
[12:42:14.585] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:10:0)
[12:42:14.608] Build status: STARTED
[12:42:14.608] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:11:0) after 1m41s
[12:43:55.632] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:11:0)
[12:43:55.662] Build status: STARTED
[12:43:55.662] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:12:0) after 8m1s
[12:51:56.822] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:12:0)
[12:51:56.848] Build status: STARTED
[12:51:56.848] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:13:0) after 8m24s
[13:00:21.005] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:13:0)
[13:00:21.037] Build status: STARTED
[13:00:21.037] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:14:0) after 5m10s
[13:05:31.082] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:14:0)
[13:05:31.111] Build status: STARTED
[13:05:31.111] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:15:0) after 1m4s
[13:06:35.306] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:15:0)
[13:06:35.334] Build status: STARTED
[13:06:35.334] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:16:0) after 4m1s
[13:10:36.359] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:16:0)
[13:10:36.391] Build status: STARTED
[13:10:36.391] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:17:0) after 6m6s
[13:16:42.415] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:17:0)
[13:16:42.453] Build status: STARTED
[13:16:42.453] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:18:0) after 1m30s
[13:18:12.634] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:18:0)
[13:18:12.661] Build status: STARTED
[13:18:12.661] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:19:0) after 7m29s
[13:25:41.790] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:19:0)
[13:25:41.812] Build status: STARTED
[13:25:41.812] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:20:0) after 8m39s
[13:34:20.948] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:20:0)
[13:34:20.975] Build status: STARTED
[13:34:20.975] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:21:0) after 5m12s
[13:39:33.093] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:21:0)
[13:39:33.117] Build status: STARTED
[13:39:33.117] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:22:0) after 2m44s
[13:42:17.306] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:22:0)
[13:42:17.349] Build status: STARTED
[13:42:17.349] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:23:0) after 2m45s
[13:45:02.366] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:23:0)
[13:45:02.400] Build status: STARTED
[13:45:02.400] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:24:0) after 8m14s
[13:53:16.736] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:24:0)
[13:53:16.773] Build status: STARTED
[13:53:16.773] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:25:0) after 5m41s
[13:58:58.047] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:25:0)
[13:58:58.078] Build status: STARTED
[13:58:58.078] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:26:0) after 1m33s
[14:00:31.219] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:26:0)
[14:00:31.258] Build status: STARTED
[14:00:31.258] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:27:0) after 2m57s
[14:03:28.397] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:27:0)
[14:03:28.427] Build status: STARTED
[14:03:28.427] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:28:0) after 8m59s
[14:12:27.656] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:28:0)
[14:12:27.694] Build status: STARTED
[14:12:27.694] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:29:0) after 5m59s
[14:18:26.929] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:29:0)
[14:18:27.027] Build status: STARTED
[14:18:27.027] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:30:0) after 5m47s
[14:24:14.089] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:30:0)
[14:24:14.124] Build status: STARTED
[14:24:14.124] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:31:0) after 2m5s
[14:26:19.248] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:31:0)
[14:26:19.282] Build status: STARTED
[14:26:19.282] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:32:0) after 8m17s
[14:34:36.774] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:32:0)
[14:34:36.804] Build status: STARTED
[14:34:36.804] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:33:0) after 6m18s
[14:40:54.832] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:33:0)
[14:40:54.861] Build status: STARTED
[14:40:54.861] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:34:0) after 8m54s
[14:49:49.263] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:34:0)
[14:49:49.295] Build status: STARTED
[14:49:49.296] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:35:0) after 3m1s
[14:52:50.323] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:35:0)
[14:52:50.349] Build status: STARTED
[14:52:50.349] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:36:0) after 1m3s
[14:53:53.697] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:36:0)
[14:53:53.730] Build status: STARTED
[14:53:53.730] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:37:0) after 3m15s
[14:57:09.090] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:37:0)
[14:57:09.273] Build status: STARTED
[14:57:09.273] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:38:0) after 9m52s
[15:07:01.464] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:38:0)
[15:07:01.498] Build status: STARTED
[15:07:01.498] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:39:0) after 3m31s
[15:10:32.520] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:39:0)
[15:10:32.549] Build status: STARTED
[15:10:32.549] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:40:0) after 3m9s
[15:13:41.768] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:40:0)
[15:13:41.829] Build status: STARTED
[15:13:41.829] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:41:0) after 9m9s
[15:22:50.930] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:41:0)
[15:22:50.963] Build status: STARTED
[15:22:50.963] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:42:0) after 5m17s
[15:28:08.083] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:42:0)
[15:28:08.114] Build status: STARTED
[15:28:08.114] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:43:0) after 5m6s
[15:33:14.232] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:43:0)
[15:33:14.261] Build status: STARTED
[15:33:14.261] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:44:0) after 8m37s
[15:41:51.290] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:44:0)
[15:41:51.327] Build status: STARTED
[15:41:51.327] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:45:0) after 7m9s
[15:49:00.358] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:45:0)
[15:49:00.386] Build status: STARTED
[15:49:00.386] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:46:0) after 7m24s
[15:56:24.656] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:46:0)
[15:56:24.692] Build status: STARTED
[15:56:24.692] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:47:0) after 5m18s
[16:01:42.719] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:47:0)
[16:01:42.745] Build status: STARTED
[16:01:42.745] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:48:0) after 9m29s
[16:11:12.019] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:48:0)
[16:11:12.059] Build status: STARTED
[16:11:12.059] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:49:0) after 1m25s
[16:12:37.246] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:49:0)
[16:12:37.274] Build status: STARTED
[16:12:37.274] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:50:0) after 1m58s
[16:14:35.303] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:50:0)
[16:14:35.333] Build status: STARTED
[16:14:35.333] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:51:0) after 9m57s
[16:24:32.365] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:51:0)
[16:24:32.396] Build status: STARTED
[16:24:32.396] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:52:0) after 8m58s
[16:33:30.450] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:52:0)
[16:33:30.487] Build status: STARTED
[16:33:30.487] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:53:0) after 3m36s
[16:37:06.563] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:53:0)
[16:37:06.597] Build status: STARTED
[16:37:06.597] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:54:0) after 8m31s
[16:45:37.607] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:54:0)
[16:45:37.640] Build status: STARTED
[16:45:37.640] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:55:0) after 4m3s
[16:49:40.648] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:55:0)
[16:49:40.681] Build status: STARTED
[16:49:40.681] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:56:0) after 4m21s
[16:54:01.719] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:56:0)
[16:54:01.747] Build status: STARTED
[16:54:01.747] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:57:0) after 3m33s
[16:57:34.769] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:57:0)
[16:57:34.800] Build status: STARTED
[16:57:34.800] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:58:0) after 9m55s
[17:07:29.881] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:58:0)
[17:07:29.919] Build status: STARTED
[17:07:29.919] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8968568890164469616:59:0) after 3m1s
[17:07:57.174] Received PubSub notification, asking Buildbucket for the build status
[17:07:57.203] Build:
{
"id": "8803138828216069553",
"builder": {
"project": "art",
"bucket": "ci",
"builder": "angler-armv8-debug"
},
"number": 2865,
"createdBy": "project:art",
"createTime": "2022-09-13T11:46:57.979592416Z",
"startTime": "2022-09-13T11:47:38.155374Z",
"endTime": "2022-09-13T17:07:56.719958858Z",
"updateTime": "2022-09-13T17:07:56.719958858Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "android.googlesource.com",
"project": "platform/libcore",
"id": "96e7e26b26f0d5e2fe4a556a95c0fce83cd4f079",
"ref": "refs/heads/master"
}
}
}
[17:07:57.203] Invocation finished in 5h21m0.465109258s with status SUCCEEDED