[18:00:40.635] New invocation is queued and will start shortly
[18:00:41.942] Starting the invocation (attempt 1)
[18:00:41.973] Popped buildset tag "buildset:commit/gitiles/android.googlesource.com/platform/libcore/+/7b9b53e32cccb3359b60e0fc1314e3f3c0eaf262"
[18:00:41.973] Popped gitiles commit info from properties and tags
[18:00:41.973] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:00:41.974] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:00:41.974] Buildbucket request:
{
"requestId": "8952056729127209888",
"builder": {
"project": "art",
"bucket": "ci",
"builder": "walleye-armv8-poison-ndebug"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8952056729127209888",
"job": "art/walleye-armv8-poison-ndebug",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "6bf4fd54d7bde6e3e9d49e6f019cec797903be6e"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@6bf4fd54d7bde6e3e9d49e6f019cec797903be6e",
"title": "6bf4fd54d7bde6e3e9d49e6f019cec797903be6e",
"url": "https://android.googlesource.com/platform/libcore/+/6bf4fd54d7bde6e3e9d49e6f019cec797903be6e"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "ef40921146c23da03d023133720038b989867ef9"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@ef40921146c23da03d023133720038b989867ef9",
"title": "ef40921146c23da03d023133720038b989867ef9",
"url": "https://android.googlesource.com/platform/libcore/+/ef40921146c23da03d023133720038b989867ef9"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "8f6699cbb10a04ea2c146d96492b600d3d278ca0"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@8f6699cbb10a04ea2c146d96492b600d3d278ca0",
"title": "8f6699cbb10a04ea2c146d96492b600d3d278ca0",
"url": "https://android.googlesource.com/platform/libcore/+/8f6699cbb10a04ea2c146d96492b600d3d278ca0"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "95061f0d0c18539d2acd76d6bdfda05b3e283ece"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@95061f0d0c18539d2acd76d6bdfda05b3e283ece",
"title": "95061f0d0c18539d2acd76d6bdfda05b3e283ece",
"url": "https://android.googlesource.com/platform/libcore/+/95061f0d0c18539d2acd76d6bdfda05b3e283ece"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "ce346527e06b302a2a741e62c5bd07aa80ff4186"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@ce346527e06b302a2a741e62c5bd07aa80ff4186",
"title": "ce346527e06b302a2a741e62c5bd07aa80ff4186",
"url": "https://android.googlesource.com/platform/libcore/+/ce346527e06b302a2a741e62c5bd07aa80ff4186"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "755df6ea34faf41f63e8b3ce9e13a0e278c6bb21"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@755df6ea34faf41f63e8b3ce9e13a0e278c6bb21",
"title": "755df6ea34faf41f63e8b3ce9e13a0e278c6bb21",
"url": "https://android.googlesource.com/platform/libcore/+/755df6ea34faf41f63e8b3ce9e13a0e278c6bb21"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "ac5e05a2ec94736ffe94e626ed549c741f6f459f"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@ac5e05a2ec94736ffe94e626ed549c741f6f459f",
"title": "ac5e05a2ec94736ffe94e626ed549c741f6f459f",
"url": "https://android.googlesource.com/platform/libcore/+/ac5e05a2ec94736ffe94e626ed549c741f6f459f"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/libcore",
"revision": "7b9b53e32cccb3359b60e0fc1314e3f3c0eaf262"
},
"id": "https://android.googlesource.com/platform/libcore/+/refs/heads/master@7b9b53e32cccb3359b60e0fc1314e3f3c0eaf262",
"title": "7b9b53e32cccb3359b60e0fc1314e3f3c0eaf262",
"url": "https://android.googlesource.com/platform/libcore/+/7b9b53e32cccb3359b60e0fc1314e3f3c0eaf262"
}
]
}
},
"gitilesCommit": {
"host": "android.googlesource.com",
"project": "platform/libcore",
"id": "7b9b53e32cccb3359b60e0fc1314e3f3c0eaf262",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8952056729127209888"
},
{
"key": "scheduler_job_id",
"value": "art/walleye-armv8-poison-ndebug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:00:42.343] Scheduled build:
{
"id": "8786626666995256433",
"builder": {
"project": "art",
"bucket": "ci",
"builder": "walleye-armv8-poison-ndebug"
},
"number": 3231,
"createdBy": "project:art",
"createTime": "2023-03-14T18:00:42.044975615Z",
"updateTime": "2023-03-14T18:00:42.044975615Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "android.googlesource.com",
"project": "platform/libcore",
"id": "7b9b53e32cccb3359b60e0fc1314e3f3c0eaf262",
"ref": "refs/heads/master"
}
}
}
[18:00:42.343] Task URL: https://cr-buildbucket.appspot.com/build/8786626666995256433
[18:00:42.343] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:2:0) after 2m48s
[18:03:30.373] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:2:0)
[18:03:30.410] Build status: SCHEDULED
[18:03:30.410] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:3:0) after 7m38s
[18:05:18.565] Received PubSub notification, asking Buildbucket for the build status
[18:05:18.589] Build status: STARTED
[18:11:08.484] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:3:0)
[18:11:08.532] Build status: STARTED
[18:11:08.532] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:5:0) after 2m3s
[18:13:11.536] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:5:0)
[18:13:11.558] Build status: STARTED
[18:13:11.558] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:6:0) after 5m14s
[18:18:25.636] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:6:0)
[18:18:25.668] Build status: STARTED
[18:18:25.668] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:7:0) after 7m18s
[18:25:43.784] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:7:0)
[18:25:43.826] Build status: STARTED
[18:25:43.826] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:8:0) after 6m6s
[18:31:49.894] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:8:0)
[18:31:49.933] Build status: STARTED
[18:31:49.933] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:9:0) after 9m45s
[18:41:34.971] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:9:0)
[18:41:34.996] Build status: STARTED
[18:41:34.996] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:10:0) after 5m15s
[18:46:50.031] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:10:0)
[18:46:50.056] Build status: STARTED
[18:46:50.056] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:11:0) after 7m49s
[18:54:39.122] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:11:0)
[18:54:39.153] Build status: STARTED
[18:54:39.153] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:12:0) after 8m58s
[19:03:37.173] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:12:0)
[19:03:37.219] Build status: STARTED
[19:03:37.219] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:13:0) after 6m7s
[19:09:44.336] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:13:0)
[19:09:44.396] Build status: STARTED
[19:09:44.396] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:14:0) after 4m49s
[19:14:33.611] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:14:0)
[19:14:33.639] Build status: STARTED
[19:14:33.639] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:15:0) after 6m36s
[19:21:09.677] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:15:0)
[19:21:09.698] Build status: STARTED
[19:21:09.698] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:16:0) after 3m19s
[19:24:28.730] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:16:0)
[19:24:28.750] Build status: STARTED
[19:24:28.750] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:17:0) after 1m44s
[19:26:13.455] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:17:0)
[19:26:13.487] Build status: STARTED
[19:26:13.487] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:18:0) after 9m15s
[19:35:28.661] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:18:0)
[19:35:28.708] Build status: STARTED
[19:35:28.708] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:19:0) after 7m42s
[19:43:11.444] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:19:0)
[19:43:11.472] Build status: STARTED
[19:43:11.472] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:20:0) after 4m59s
[19:48:10.547] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:20:0)
[19:48:10.584] Build status: STARTED
[19:48:10.584] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:21:0) after 5m58s
[19:54:08.614] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:21:0)
[19:54:08.637] Build status: STARTED
[19:54:08.637] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:22:0) after 5m52s
[20:00:00.665] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:22:0)
[20:00:00.726] Build status: STARTED
[20:00:00.727] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:23:0) after 8m7s
[20:08:07.755] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:23:0)
[20:08:07.790] Build status: STARTED
[20:08:07.790] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:24:0) after 6m7s
[20:14:14.859] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:24:0)
[20:14:14.897] Build status: STARTED
[20:14:14.897] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:25:0) after 5m31s
[20:19:46.028] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:25:0)
[20:19:46.058] Build status: STARTED
[20:19:46.058] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:26:0) after 1m10s
[20:20:56.127] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:26:0)
[20:20:56.150] Build status: STARTED
[20:20:56.150] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:27:0) after 5m36s
[20:26:32.170] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:27:0)
[20:26:32.212] Build status: STARTED
[20:26:32.212] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:28:0) after 6m59s
[20:33:31.201] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:28:0)
[20:33:31.229] Build status: STARTED
[20:33:31.229] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:29:0) after 6m30s
[20:40:01.281] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:29:0)
[20:40:01.316] Build status: STARTED
[20:40:01.316] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:30:0) after 9m9s
[20:49:10.392] Handling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:30:0)
[20:49:10.414] Build status: STARTED
[20:49:10.414] Scheduling timer "check-buildbucket-build-status" (art/walleye-armv8-poison-ndebug:8952056729127209888:31:0) after 7m31s
[20:56:40.136] Received PubSub notification, asking Buildbucket for the build status
[20:56:40.168] Build:
{
"id": "8786626666995256433",
"builder": {
"project": "art",
"bucket": "ci",
"builder": "walleye-armv8-poison-ndebug"
},
"number": 3231,
"createdBy": "project:art",
"createTime": "2023-03-14T18:00:42.044975615Z",
"startTime": "2023-03-14T18:05:17.576054Z",
"endTime": "2023-03-14T20:56:39.888874645Z",
"updateTime": "2023-03-14T20:56:39.888874645Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "android.googlesource.com",
"project": "platform/libcore",
"id": "7b9b53e32cccb3359b60e0fc1314e3f3c0eaf262",
"ref": "refs/heads/master"
}
}
}
[20:56:40.168] Invocation finished in 2h55m59.5415503s with status SUCCEEDED