[17:08:20.230] New invocation is queued and will start shortly
[17:08:21.409] Starting the invocation (attempt 1)
[17:08:21.444] Popped buildset tag "buildset:commit/gitiles/android.googlesource.com/platform/libcore/+/95199ebf5d81e81b96bdec6fb7f9490e8cf887f5"
[17:08:21.444] Popped gitiles commit info from properties and tags
[17:08:21.444] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:08:21.444] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:08:21.444] Buildbucket request:
{
"requestId": "8998898653716324768",
"builder": {
"project": "art",
"bucket": "ci",
"builder": "angler-armv8-debug"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "a318a7b86421714e64560c97e9f1279f2abfce7e"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@a318a7b86421714e64560c97e9f1279f2abfce7e",
"title": "a318a7b86421714e64560c97e9f1279f2abfce7e",
"url": "https://android.googlesource.com/platform/libcore/+/a318a7b86421714e64560c97e9f1279f2abfce7e"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "abf6953bd4366062338fb0083580343853d4c39b"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@abf6953bd4366062338fb0083580343853d4c39b",
"title": "abf6953bd4366062338fb0083580343853d4c39b",
"url": "https://android.googlesource.com/platform/libcore/+/abf6953bd4366062338fb0083580343853d4c39b"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "dff1a44312fbe23973d7ec4013da240c325a0071"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@dff1a44312fbe23973d7ec4013da240c325a0071",
"title": "dff1a44312fbe23973d7ec4013da240c325a0071",
"url": "https://android.googlesource.com/platform/libcore/+/dff1a44312fbe23973d7ec4013da240c325a0071"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "ddc765922f3174185d31dbc36e4c9f379ef138d8"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@ddc765922f3174185d31dbc36e4c9f379ef138d8",
"title": "ddc765922f3174185d31dbc36e4c9f379ef138d8",
"url": "https://android.googlesource.com/platform/libcore/+/ddc765922f3174185d31dbc36e4c9f379ef138d8"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/art",
"revision": "af9aa668c6cdd2ca4e946c8bab87e9e64d0f37d6"
},
"id": "https://android.googlesource.com/platform/art/+/refs/heads/master@af9aa668c6cdd2ca4e946c8bab87e9e64d0f37d6",
"title": "af9aa668c6cdd2ca4e946c8bab87e9e64d0f37d6",
"url": "https://android.googlesource.com/platform/art/+/af9aa668c6cdd2ca4e946c8bab87e9e64d0f37d6"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/art",
"revision": "8ed59b840fe8140258e3612eff267b76280f1b8b"
},
"id": "https://android.googlesource.com/platform/art/+/refs/heads/master@8ed59b840fe8140258e3612eff267b76280f1b8b",
"title": "8ed59b840fe8140258e3612eff267b76280f1b8b",
"url": "https://android.googlesource.com/platform/art/+/8ed59b840fe8140258e3612eff267b76280f1b8b"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "ae30775f49b99b12fd7c0bd32ab7b8ddb290d36e"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@ae30775f49b99b12fd7c0bd32ab7b8ddb290d36e",
"title": "ae30775f49b99b12fd7c0bd32ab7b8ddb290d36e",
"url": "https://android.googlesource.com/platform/libcore/+/ae30775f49b99b12fd7c0bd32ab7b8ddb290d36e"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "95199ebf5d81e81b96bdec6fb7f9490e8cf887f5"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@95199ebf5d81e81b96bdec6fb7f9490e8cf887f5",
"title": "95199ebf5d81e81b96bdec6fb7f9490e8cf887f5",
"url": "https://android.googlesource.com/platform/libcore/+/95199ebf5d81e81b96bdec6fb7f9490e8cf887f5"
}
]
}
},
"gitilesCommit": {
"host": "android.googlesource.com",
"project": "platform/libcore",
"id": "95199ebf5d81e81b96bdec6fb7f9490e8cf887f5",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8998898653716324768"
},
{
"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"
}
}
[17:08:21.913] Scheduled build:
{
"id": "8833468591720529665",
"builder": {
"project": "art",
"bucket": "ci",
"builder": "angler-armv8-debug"
},
"number": 2071,
"createdBy": "project:art",
"createTime": "2021-10-13T17:08:21.502716184Z",
"updateTime": "2021-10-13T17:08:21.707606936Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "android.googlesource.com",
"project": "platform/libcore",
"id": "95199ebf5d81e81b96bdec6fb7f9490e8cf887f5",
"ref": "refs/heads/master"
}
}
}
[17:08:21.913] Task URL: https://cr-buildbucket.appspot.com/build/8833468591720529665
[17:08:21.913] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:2:0) after 1m19s
[17:08:28.806] Received PubSub notification, asking Buildbucket for the build status
[17:08:28.978] Build status: STARTED
[17:09:41.041] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:2:0)
[17:09:41.078] Build status: STARTED
[17:09:41.078] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:4:0) after 4m43s
[17:14:24.098] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:4:0)
[17:14:24.131] Build status: STARTED
[17:14:24.131] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:5:0) after 3m20s
[17:17:44.145] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:5:0)
[17:17:44.189] Build status: STARTED
[17:17:44.189] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:6:0) after 2m45s
[17:20:29.341] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:6:0)
[17:20:29.381] Build status: STARTED
[17:20:29.381] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:7:0) after 2m5s
[17:22:34.810] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:7:0)
[17:22:34.840] Build status: STARTED
[17:22:34.840] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:8:0) after 5m28s
[17:28:02.956] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:8:0)
[17:28:02.987] Build status: STARTED
[17:28:02.987] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:9:0) after 6m54s
[17:34:57.014] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:9:0)
[17:34:57.078] Build status: STARTED
[17:34:57.078] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:10:0) after 3m49s
[17:38:46.400] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:10:0)
[17:38:46.433] Build status: STARTED
[17:38:46.433] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:11:0) after 3m1s
[17:41:47.499] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:11:0)
[17:41:47.546] Build status: STARTED
[17:41:47.546] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:12:0) after 6m7s
[17:47:54.604] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:12:0)
[17:47:54.649] Build status: STARTED
[17:47:54.649] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:13:0) after 4m43s
[17:52:38.146] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:13:0)
[17:52:38.182] Build status: STARTED
[17:52:38.182] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:14:0) after 8m30s
[18:01:08.306] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:14:0)
[18:01:08.345] Build status: STARTED
[18:01:08.346] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:15:0) after 7m32s
[18:08:40.351] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:15:0)
[18:08:40.386] Build status: STARTED
[18:08:40.386] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:16:0) after 3m37s
[18:12:17.406] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:16:0)
[18:12:17.437] Build status: STARTED
[18:12:17.437] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:17:0) after 3m43s
[18:16:00.510] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:17:0)
[18:16:00.548] Build status: STARTED
[18:16:00.548] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:18:0) after 9m44s
[18:25:44.676] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:18:0)
[18:25:44.719] Build status: STARTED
[18:25:44.719] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:19:0) after 6m41s
[18:32:25.740] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:19:0)
[18:32:25.780] Build status: STARTED
[18:32:25.780] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:20:0) after 1m31s
[18:33:56.827] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:20:0)
[18:33:56.879] Build status: STARTED
[18:33:56.879] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:21:0) after 9m54s
[18:43:50.989] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:21:0)
[18:43:51.020] Build status: STARTED
[18:43:51.020] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:22:0) after 6m16s
[18:50:07.038] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:22:0)
[18:50:07.083] Build status: STARTED
[18:50:07.083] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:23:0) after 7m5s
[18:57:12.138] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:23:0)
[18:57:12.173] Build status: STARTED
[18:57:12.173] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:24:0) after 6m16s
[19:03:28.465] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:24:0)
[19:03:28.538] Build status: STARTED
[19:03:28.538] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:25:0) after 3m53s
[19:07:22.415] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:25:0)
[19:07:22.446] Build status: STARTED
[19:07:22.446] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:26:0) after 6m58s
[19:14:20.849] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:26:0)
[19:14:20.881] Build status: STARTED
[19:14:20.881] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:27:0) after 4m26s
[19:18:47.001] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:27:0)
[19:18:47.032] Build status: STARTED
[19:18:47.032] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:28:0) after 2m15s
[19:21:02.315] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:28:0)
[19:21:02.369] Build status: STARTED
[19:21:02.369] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:29:0) after 9m53s
[19:30:55.376] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:29:0)
[19:30:55.406] Build status: STARTED
[19:30:55.406] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:30:0) after 5m26s
[19:36:21.717] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:30:0)
[19:36:21.751] Build status: STARTED
[19:36:21.751] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:31:0) after 1m20s
[19:37:42.000] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:31:0)
[19:37:42.040] Build status: STARTED
[19:37:42.040] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:32:0) after 3m57s
[19:41:39.163] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:32:0)
[19:41:39.209] Build status: STARTED
[19:41:39.209] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:33:0) after 5m35s
[19:47:14.292] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:33:0)
[19:47:14.333] Build status: STARTED
[19:47:14.333] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:34:0) after 4m8s
[19:51:22.414] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:34:0)
[19:51:22.491] Build status: STARTED
[19:51:22.491] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:35:0) after 9m2s
[20:00:24.806] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:35:0)
[20:00:24.877] Build status: STARTED
[20:00:24.877] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:36:0) after 5m34s
[20:05:59.052] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:36:0)
[20:05:59.083] Build status: STARTED
[20:05:59.083] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:37:0) after 6m54s
[20:12:53.302] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:37:0)
[20:12:53.391] Build status: STARTED
[20:12:53.391] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:38:0) after 7m14s
[20:20:07.644] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:38:0)
[20:20:07.675] Build status: STARTED
[20:20:07.675] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:39:0) after 4m40s
[20:24:48.015] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:39:0)
[20:24:48.042] Build status: STARTED
[20:24:48.042] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:40:0) after 2m41s
[20:27:29.061] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:40:0)
[20:27:29.093] Build status: STARTED
[20:27:29.093] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:41:0) after 4m32s
[20:32:01.317] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:41:0)
[20:32:01.354] Build status: STARTED
[20:32:01.354] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:42:0) after 7m29s
[20:39:30.374] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:42:0)
[20:39:30.407] Build status: STARTED
[20:39:30.407] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:43:0) after 5m15s
[20:44:46.124] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:43:0)
[20:44:46.156] Build status: STARTED
[20:44:46.156] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:44:0) after 8m11s
[20:52:57.181] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:44:0)
[20:52:57.207] Build status: STARTED
[20:52:57.207] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:45:0) after 1m46s
[20:54:43.375] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:45:0)
[20:54:43.407] Build status: STARTED
[20:54:43.407] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:46:0) after 6m43s
[21:01:26.519] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:46:0)
[21:01:26.574] Build status: STARTED
[21:01:26.574] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8998898653716324768:47:0) after 7m33s
[21:05:53.517] Received PubSub notification, asking Buildbucket for the build status
[21:05:53.547] Build:
{
"id": "8833468591720529665",
"builder": {
"project": "art",
"bucket": "ci",
"builder": "angler-armv8-debug"
},
"number": 2071,
"createdBy": "project:art",
"createTime": "2021-10-13T17:08:21.502716184Z",
"startTime": "2021-10-13T17:08:27.189312Z",
"endTime": "2021-10-13T21:05:52.065171Z",
"updateTime": "2021-10-13T21:05:52.760736Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "android.googlesource.com",
"project": "platform/libcore",
"id": "95199ebf5d81e81b96bdec6fb7f9490e8cf887f5",
"ref": "refs/heads/master"
}
}
}
[21:05:53.547] Invocation finished in 3h57m33.332607393s with status SUCCEEDED