[14:51:48.801] New invocation is queued and will start shortly
[14:51:49.863] Starting the invocation (attempt 1)
[14:51:49.897] Popped buildset tag "buildset:commit/gitiles/android.googlesource.com/platform/libcore/+/fdef4f02eb440abfcb6052c49b1bff8a0b117a97"
[14:51:49.897] Popped gitiles commit info from properties and tags
[14:51:49.897] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:51:49.897] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:51:49.897] Buildbucket request:
{
"requestId": "9007332760927412944",
"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": "882c7ba0f8fb84eb2a892bd29f02a41eda8dd7c9"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@882c7ba0f8fb84eb2a892bd29f02a41eda8dd7c9",
"title": "882c7ba0f8fb84eb2a892bd29f02a41eda8dd7c9",
"url": "https://android.googlesource.com/platform/libcore/+/882c7ba0f8fb84eb2a892bd29f02a41eda8dd7c9"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/art",
"revision": "38837d44f47a14ccd07e9de3c26d3e40b9768d0d"
},
"id": "https://android.googlesource.com/platform/art/+/refs/heads/master@38837d44f47a14ccd07e9de3c26d3e40b9768d0d",
"title": "38837d44f47a14ccd07e9de3c26d3e40b9768d0d",
"url": "https://android.googlesource.com/platform/art/+/38837d44f47a14ccd07e9de3c26d3e40b9768d0d"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "fdef4f02eb440abfcb6052c49b1bff8a0b117a97"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@fdef4f02eb440abfcb6052c49b1bff8a0b117a97",
"title": "fdef4f02eb440abfcb6052c49b1bff8a0b117a97",
"url": "https://android.googlesource.com/platform/libcore/+/fdef4f02eb440abfcb6052c49b1bff8a0b117a97"
}
]
}
},
"gitilesCommit": {
"host": "android.googlesource.com",
"project": "platform/libcore",
"id": "fdef4f02eb440abfcb6052c49b1bff8a0b117a97",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9007332760927412944"
},
{
"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"
}
}
[14:51:51.113] Scheduled build:
{
"id": "8841902699018569072",
"builder": {
"project": "art",
"bucket": "ci",
"builder": "angler-armv8-debug"
},
"number": 1884,
"createdBy": "project:art",
"createTime": "2021-07-12T14:51:49.990292Z",
"updateTime": "2021-07-12T14:51:50.918093Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "android.googlesource.com",
"project": "platform/libcore",
"id": "fdef4f02eb440abfcb6052c49b1bff8a0b117a97",
"ref": "refs/heads/master"
}
}
}
[14:51:51.113] Task URL: https://cr-buildbucket.appspot.com/build/8841902699018569072
[14:51:51.113] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:2:0) after 1m55s
[14:52:12.502] Received PubSub notification, asking Buildbucket for the build status
[14:52:12.530] Build status: STARTED
[14:53:46.225] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:2:0)
[14:53:46.259] Build status: STARTED
[14:53:46.259] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:4:0) after 6m12s
[14:59:58.267] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:4:0)
[14:59:58.293] Build status: STARTED
[14:59:58.293] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:5:0) after 5m33s
[15:05:31.329] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:5:0)
[15:05:31.489] Build status: STARTED
[15:05:31.489] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:6:0) after 2m17s
[15:07:48.704] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:6:0)
[15:07:48.744] Build status: STARTED
[15:07:48.744] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:7:0) after 9m41s
[15:17:29.948] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:7:0)
[15:17:29.978] Build status: STARTED
[15:17:29.978] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:8:0) after 9m4s
[15:26:33.999] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:8:0)
[15:26:34.033] Build status: STARTED
[15:26:34.033] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:9:0) after 8m54s
[15:35:28.057] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:9:0)
[15:35:28.163] Build status: STARTED
[15:35:28.163] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:10:0) after 5m32s
[15:41:00.419] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:10:0)
[15:41:00.454] Build status: STARTED
[15:41:00.454] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:11:0) after 8m7s
[15:49:07.578] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:11:0)
[15:49:07.630] Build status: STARTED
[15:49:07.630] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:12:0) after 2m12s
[15:51:19.707] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:12:0)
[15:51:19.739] Build status: STARTED
[15:51:19.739] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:13:0) after 8m35s
[15:59:54.759] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:13:0)
[15:59:54.786] Build status: STARTED
[15:59:54.786] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:14:0) after 2m30s
[16:02:24.774] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:14:0)
[16:02:24.800] Build status: STARTED
[16:02:24.800] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:15:0) after 2m33s
[16:04:57.825] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:15:0)
[16:04:57.855] Build status: STARTED
[16:04:57.855] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:16:0) after 3m40s
[16:08:37.976] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:16:0)
[16:08:38.011] Build status: STARTED
[16:08:38.011] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:17:0) after 4m15s
[16:12:53.034] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:17:0)
[16:12:53.084] Build status: STARTED
[16:12:53.084] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:18:0) after 3m28s
[16:16:21.139] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:18:0)
[16:16:21.245] Build status: STARTED
[16:16:21.245] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:19:0) after 5m56s
[16:22:17.375] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:19:0)
[16:22:17.408] Build status: STARTED
[16:22:17.408] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:20:0) after 8m6s
[16:30:23.430] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:20:0)
[16:30:23.460] Build status: STARTED
[16:30:23.460] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:21:0) after 5m2s
[16:35:25.681] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:21:0)
[16:35:25.709] Build status: STARTED
[16:35:25.709] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:22:0) after 2m49s
[16:38:14.731] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:22:0)
[16:38:14.761] Build status: STARTED
[16:38:14.761] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:23:0) after 6m9s
[16:44:23.785] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:23:0)
[16:44:23.811] Build status: STARTED
[16:44:23.811] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:24:0) after 9m7s
[16:53:30.857] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:24:0)
[16:53:30.889] Build status: STARTED
[16:53:30.889] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:25:0) after 7m37s
[17:01:07.927] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:25:0)
[17:01:07.959] Build status: STARTED
[17:01:07.959] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:26:0) after 4m51s
[17:05:59.313] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:26:0)
[17:05:59.339] Build status: STARTED
[17:05:59.339] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:27:0) after 6m25s
[17:12:24.349] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:27:0)
[17:12:24.396] Build status: STARTED
[17:12:24.396] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:28:0) after 4m13s
[17:16:37.419] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:28:0)
[17:16:37.454] Build status: STARTED
[17:16:37.454] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:29:0) after 3m15s
[17:19:52.476] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:29:0)
[17:19:52.508] Build status: STARTED
[17:19:52.508] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:30:0) after 8m6s
[17:27:58.527] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:30:0)
[17:27:58.558] Build status: STARTED
[17:27:58.558] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:31:0) after 9m35s
[17:37:33.607] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:31:0)
[17:37:33.634] Build status: STARTED
[17:37:33.634] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:32:0) after 2m13s
[17:39:46.759] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:32:0)
[17:39:46.791] Build status: STARTED
[17:39:46.791] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:33:0) after 1m30s
[17:41:17.021] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:33:0)
[17:41:17.051] Build status: STARTED
[17:41:17.051] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:34:0) after 8m19s
[17:49:36.108] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:34:0)
[17:49:36.176] Build status: STARTED
[17:49:36.176] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:35:0) after 3m38s
[17:53:14.265] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:35:0)
[17:53:14.324] Build status: STARTED
[17:53:14.324] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:36:0) after 5m26s
[17:58:40.364] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:36:0)
[17:58:40.392] Build status: STARTED
[17:58:40.392] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:37:0) after 5m34s
[18:04:14.420] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:37:0)
[18:04:14.572] Build status: STARTED
[18:04:14.572] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:38:0) after 4m55s
[18:09:09.692] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:38:0)
[18:09:09.744] Build status: STARTED
[18:09:09.744] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:39:0) after 7m50s
[18:16:59.767] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:39:0)
[18:16:59.805] Build status: STARTED
[18:16:59.805] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:40:0) after 8m38s
[18:25:37.903] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:40:0)
[18:25:37.935] Build status: STARTED
[18:25:37.935] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:41:0) after 8m42s
[18:34:20.240] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:41:0)
[18:34:20.295] Build status: STARTED
[18:34:20.295] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:42:0) after 1m39s
[18:35:59.346] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:42:0)
[18:35:59.372] Build status: STARTED
[18:35:59.372] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:43:0) after 1m59s
[18:37:58.418] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:43:0)
[18:37:58.448] Build status: STARTED
[18:37:58.448] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:44:0) after 4m2s
[18:42:00.798] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:44:0)
[18:42:00.828] Build status: STARTED
[18:42:00.828] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:45:0) after 6m17s
[18:48:17.866] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:45:0)
[18:48:17.905] Build status: STARTED
[18:48:17.905] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:46:0) after 7m2s
[18:55:20.360] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:46:0)
[18:55:20.392] Build status: STARTED
[18:55:20.392] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:47:0) after 8m29s
[19:03:49.422] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:47:0)
[19:03:49.517] Build status: STARTED
[19:03:49.517] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:48:0) after 2m3s
[19:05:52.554] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:48:0)
[19:05:52.584] Build status: STARTED
[19:05:52.584] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:49:0) after 1m14s
[19:07:06.607] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:49:0)
[19:07:06.633] Build status: STARTED
[19:07:06.633] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:50:0) after 5m2s
[19:12:08.666] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:50:0)
[19:12:08.707] Build status: STARTED
[19:12:08.707] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:51:0) after 1m4s
[19:13:12.901] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:51:0)
[19:13:13.072] Build status: STARTED
[19:13:13.072] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:52:0) after 2m56s
[19:16:09.443] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:52:0)
[19:16:09.476] Build status: STARTED
[19:16:09.476] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:53:0) after 6m36s
[19:22:45.614] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:53:0)
[19:22:45.649] Build status: STARTED
[19:22:45.649] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:54:0) after 6m6s
[19:28:51.794] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:54:0)
[19:28:51.827] Build status: STARTED
[19:28:51.827] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:55:0) after 4m35s
[19:33:27.129] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:55:0)
[19:33:27.161] Build status: STARTED
[19:33:27.162] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:56:0) after 3m20s
[19:36:47.182] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:56:0)
[19:36:47.210] Build status: STARTED
[19:36:47.210] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:9007332760927412944:57:0) after 6m17s
[19:42:08.876] Received PubSub notification, asking Buildbucket for the build status
[19:42:08.910] Build:
{
"id": "8841902699018569072",
"builder": {
"project": "art",
"bucket": "ci",
"builder": "angler-armv8-debug"
},
"number": 1884,
"createdBy": "project:art",
"createTime": "2021-07-12T14:51:49.990292Z",
"startTime": "2021-07-12T14:52:11.621982Z",
"endTime": "2021-07-12T19:42:08.358481Z",
"updateTime": "2021-07-12T19:42:08.677892Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "android.googlesource.com",
"project": "platform/libcore",
"id": "fdef4f02eb440abfcb6052c49b1bff8a0b117a97",
"ref": "refs/heads/master"
}
}
}
[19:42:08.910] Invocation finished in 4h50m20.123192034s with status SUCCEEDED