[01:16:07.346] New invocation is queued and will start shortly
[01:16:08.724] Starting the invocation (attempt 1)
[01:16:08.762] Popped buildset tag "buildset:commit/gitiles/android.googlesource.com/platform/art/+/298dc96f06058b86944023be94a7f8ab1e6ff3c5"
[01:16:08.762] Popped gitiles commit info from properties and tags
[01:16:08.762] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:16:08.762] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:16:08.762] Buildbucket request:
{
"requestId": "8896946377716446880",
"builder": {
"project": "art",
"bucket": "ci",
"builder": "target.arm.gsctress.32"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8896946377716446880",
"job": "art/target.arm.gsctress.32",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/art",
"revision": "2aaea4a0da6943f69cd16b8a9970f90413c40376"
},
"id": "https://android.googlesource.com/platform/art/+/refs/heads/master@2aaea4a0da6943f69cd16b8a9970f90413c40376",
"title": "2aaea4a0da6943f69cd16b8a9970f90413c40376",
"url": "https://android.googlesource.com/platform/art/+/2aaea4a0da6943f69cd16b8a9970f90413c40376"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/art",
"revision": "298dc96f06058b86944023be94a7f8ab1e6ff3c5"
},
"id": "https://android.googlesource.com/platform/art/+/refs/heads/master@298dc96f06058b86944023be94a7f8ab1e6ff3c5",
"title": "298dc96f06058b86944023be94a7f8ab1e6ff3c5",
"url": "https://android.googlesource.com/platform/art/+/298dc96f06058b86944023be94a7f8ab1e6ff3c5"
}
]
}
},
"gitilesCommit": {
"host": "android.googlesource.com",
"project": "platform/art",
"id": "298dc96f06058b86944023be94a7f8ab1e6ff3c5",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8896946377716446880"
},
{
"key": "scheduler_job_id",
"value": "art/target.arm.gsctress.32"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[01:16:09.204] Scheduled build:
{
"id": "8731516315509338401",
"builder": {
"project": "art",
"bucket": "ci",
"builder": "target.arm.gsctress.32"
},
"number": 5,
"createdBy": "project:art",
"createTime": "2024-11-12T01:16:08.824034276Z",
"updateTime": "2024-11-12T01:16:08.824034276Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "android.googlesource.com",
"project": "platform/art",
"id": "298dc96f06058b86944023be94a7f8ab1e6ff3c5",
"ref": "refs/heads/master"
}
}
}
[01:16:09.204] Task URL: https://cr-buildbucket.appspot.com/build/8731516315509338401
[01:16:09.204] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:2:0) after 6m50s
[01:16:09.307] Received PubSub notification, asking Buildbucket for the build status
[01:16:09.335] Build status: SCHEDULED
[01:16:14.585] Received PubSub notification, asking Buildbucket for the build status
[01:16:14.608] Build status: STARTED
[01:22:59.412] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:2:0)
[01:22:59.449] Build status: STARTED
[01:22:59.449] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:5:0) after 5m8s
[01:28:07.471] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:5:0)
[01:28:07.493] Build status: STARTED
[01:28:07.493] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:6:0) after 4m27s
[01:32:34.521] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:6:0)
[01:32:34.550] Build status: STARTED
[01:32:34.550] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:7:0) after 7m55s
[01:40:29.616] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:7:0)
[01:40:29.635] Build status: STARTED
[01:40:29.635] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:8:0) after 1m25s
[01:41:54.657] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:8:0)
[01:41:54.708] Build status: STARTED
[01:41:54.708] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:9:0) after 5m44s
[01:47:38.761] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:9:0)
[01:47:38.782] Build status: STARTED
[01:47:38.782] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:10:0) after 9m29s
[01:57:07.802] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:10:0)
[01:57:07.823] Build status: STARTED
[01:57:07.823] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:11:0) after 9m8s
[02:06:15.841] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:11:0)
[02:06:15.862] Build status: STARTED
[02:06:15.862] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:12:0) after 6m46s
[02:13:01.843] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:12:0)
[02:13:01.863] Build status: STARTED
[02:13:01.863] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:13:0) after 5m20s
[02:18:22.013] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:13:0)
[02:18:22.042] Build status: STARTED
[02:18:22.043] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:14:0) after 8m50s
[02:27:12.123] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:14:0)
[02:27:12.150] Build status: STARTED
[02:27:12.150] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:15:0) after 3m4s
[02:30:16.198] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:15:0)
[02:30:16.238] Build status: STARTED
[02:30:16.238] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:16:0) after 2m29s
[02:32:45.253] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:16:0)
[02:32:45.273] Build status: STARTED
[02:32:45.273] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:17:0) after 8m13s
[02:40:58.303] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:17:0)
[02:40:58.319] Build status: STARTED
[02:40:58.319] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:18:0) after 2m56s
[02:43:54.417] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:18:0)
[02:43:54.434] Build status: STARTED
[02:43:54.434] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:19:0) after 6m18s
[02:50:12.578] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:19:0)
[02:50:12.610] Build status: STARTED
[02:50:12.610] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:20:0) after 7m56s
[02:58:08.628] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:20:0)
[02:58:08.658] Build status: STARTED
[02:58:08.658] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:21:0) after 6m50s
[03:04:58.675] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:21:0)
[03:04:58.800] Build status: STARTED
[03:04:58.800] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:22:0) after 8m34s
[03:13:33.082] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:22:0)
[03:13:33.106] Build status: STARTED
[03:13:33.106] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:23:0) after 9m38s
[03:23:11.171] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:23:0)
[03:23:11.194] Build status: STARTED
[03:23:11.194] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:24:0) after 9m22s
[03:32:33.272] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:24:0)
[03:32:33.304] Build status: STARTED
[03:32:33.304] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:25:0) after 5m37s
[03:38:10.366] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:25:0)
[03:38:10.417] Build status: STARTED
[03:38:10.417] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:26:0) after 9m10s
[03:47:20.792] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:26:0)
[03:47:20.875] Build status: STARTED
[03:47:20.875] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:27:0) after 9m53s
[03:57:14.366] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:27:0)
[03:57:14.393] Build status: STARTED
[03:57:14.393] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:28:0) after 6m33s
[04:03:47.436] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:28:0)
[04:03:47.455] Build status: STARTED
[04:03:47.455] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:29:0) after 2m9s
[04:05:56.645] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:29:0)
[04:05:56.663] Build status: STARTED
[04:05:56.663] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:30:0) after 4m50s
[04:10:47.080] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:30:0)
[04:10:47.105] Build status: STARTED
[04:10:47.105] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:31:0) after 9m15s
[04:20:02.152] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:31:0)
[04:20:02.175] Build status: STARTED
[04:20:02.175] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:32:0) after 1m43s
[04:21:45.483] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:32:0)
[04:21:45.512] Build status: STARTED
[04:21:45.512] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:33:0) after 6m38s
[04:28:23.640] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:33:0)
[04:28:23.662] Build status: STARTED
[04:28:23.662] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:34:0) after 7m2s
[04:35:25.721] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:34:0)
[04:35:25.860] Build status: STARTED
[04:35:25.861] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:35:0) after 9m38s
[04:45:04.032] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:35:0)
[04:45:04.063] Build status: STARTED
[04:45:04.063] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:36:0) after 8m5s
[04:53:09.137] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:36:0)
[04:53:09.233] Build status: STARTED
[04:53:09.234] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:37:0) after 2m1s
[04:55:10.249] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:37:0)
[04:55:10.271] Build status: STARTED
[04:55:10.271] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:38:0) after 3m46s
[04:58:56.507] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:38:0)
[04:58:56.553] Build status: STARTED
[04:58:56.553] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:39:0) after 3m41s
[05:02:37.568] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:39:0)
[05:02:37.593] Build status: STARTED
[05:02:37.593] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:40:0) after 8m59s
[05:11:36.629] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:40:0)
[05:11:36.656] Build status: STARTED
[05:11:36.656] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:41:0) after 8m6s
[05:19:42.672] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:41:0)
[05:19:42.689] Build status: STARTED
[05:19:42.689] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:42:0) after 2m34s
[05:22:17.286] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:42:0)
[05:22:17.304] Build status: STARTED
[05:22:17.304] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:43:0) after 7m39s
[05:29:56.320] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:43:0)
[05:29:56.348] Build status: STARTED
[05:29:56.348] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:44:0) after 8m46s
[05:38:42.559] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:44:0)
[05:38:42.573] Build status: STARTED
[05:38:42.573] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:45:0) after 3m37s
[05:42:19.590] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:45:0)
[05:42:19.607] Build status: STARTED
[05:42:19.607] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:46:0) after 3m31s
[05:45:50.627] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:46:0)
[05:45:50.692] Build status: STARTED
[05:45:50.692] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:47:0) after 5m6s
[05:50:56.759] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:47:0)
[05:50:56.781] Build status: STARTED
[05:50:56.781] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:48:0) after 3m23s
[05:54:19.884] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:48:0)
[05:54:19.920] Build status: STARTED
[05:54:19.920] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:49:0) after 3m33s
[05:57:53.051] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:49:0)
[05:57:53.067] Build status: STARTED
[05:57:53.068] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:50:0) after 8m26s
[06:06:19.160] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:50:0)
[06:06:19.229] Build status: STARTED
[06:06:19.229] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:51:0) after 1m1s
[06:07:20.301] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:51:0)
[06:07:20.339] Build status: STARTED
[06:07:20.340] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:52:0) after 8m21s
[06:15:41.403] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:52:0)
[06:15:41.420] Build status: STARTED
[06:15:41.420] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:53:0) after 3m36s
[06:19:17.436] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:53:0)
[06:19:17.469] Build status: STARTED
[06:19:17.469] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:54:0) after 2m36s
[06:21:53.626] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:54:0)
[06:21:53.650] Build status: STARTED
[06:21:53.650] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:55:0) after 7m16s
[06:29:09.725] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:55:0)
[06:29:09.756] Build status: STARTED
[06:29:09.756] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:56:0) after 7m4s
[06:36:13.847] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:56:0)
[06:36:13.879] Build status: STARTED
[06:36:13.879] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:57:0) after 1m15s
[06:37:29.252] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:57:0)
[06:37:29.281] Build status: STARTED
[06:37:29.281] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:58:0) after 1m49s
[06:39:18.300] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:58:0)
[06:39:18.333] Build status: STARTED
[06:39:18.333] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:59:0) after 1m35s
[06:40:53.596] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:59:0)
[06:40:53.624] Build status: STARTED
[06:40:53.624] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:60:0) after 8m52s
[06:49:45.743] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:60:0)
[06:49:45.816] Build status: STARTED
[06:49:45.816] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:61:0) after 4m22s
[06:54:08.115] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:61:0)
[06:54:08.194] Build status: STARTED
[06:54:08.194] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:62:0) after 1m44s
[06:55:52.170] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:62:0)
[06:55:52.189] Build status: STARTED
[06:55:52.189] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:63:0) after 6m55s
[07:02:47.208] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:63:0)
[07:02:47.227] Build status: STARTED
[07:02:47.227] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:64:0) after 5m58s
[07:08:45.432] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:64:0)
[07:08:45.465] Build status: STARTED
[07:08:45.465] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:65:0) after 1m24s
[07:10:09.485] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:65:0)
[07:10:09.526] Build status: STARTED
[07:10:09.526] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:66:0) after 8m21s
[07:18:30.664] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:66:0)
[07:18:30.693] Build status: STARTED
[07:18:30.693] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:67:0) after 9m51s
[07:28:21.680] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:67:0)
[07:28:21.717] Build status: STARTED
[07:28:21.717] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:68:0) after 8m51s
[07:37:12.931] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:68:0)
[07:37:12.951] Build status: STARTED
[07:37:12.951] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:69:0) after 1m11s
[07:38:23.967] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:69:0)
[07:38:24.008] Build status: STARTED
[07:38:24.008] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:70:0) after 1m54s
[07:40:18.281] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:70:0)
[07:40:18.341] Build status: STARTED
[07:40:18.341] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:71:0) after 5m48s
[07:46:06.392] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:71:0)
[07:46:06.428] Build status: STARTED
[07:46:06.428] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:72:0) after 9m17s
[07:55:23.445] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:72:0)
[07:55:23.463] Build status: STARTED
[07:55:23.463] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:73:0) after 7m12s
[08:02:35.683] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:73:0)
[08:02:35.704] Build status: STARTED
[08:02:35.704] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:74:0) after 2m50s
[08:05:25.819] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:74:0)
[08:05:25.844] Build status: STARTED
[08:05:25.844] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:75:0) after 3m25s
[08:08:50.891] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:75:0)
[08:08:50.941] Build status: STARTED
[08:08:50.941] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:76:0) after 1m51s
[08:10:42.126] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:76:0)
[08:10:42.141] Build status: STARTED
[08:10:42.141] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:77:0) after 2m47s
[08:13:29.159] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:77:0)
[08:13:29.192] Build status: STARTED
[08:13:29.192] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:78:0) after 5m40s
[08:19:09.427] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:78:0)
[08:19:09.453] Build status: STARTED
[08:19:09.453] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:79:0) after 6m56s
[08:26:05.477] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:79:0)
[08:26:05.497] Build status: STARTED
[08:26:05.497] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:80:0) after 7m26s
[08:33:31.648] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:80:0)
[08:33:31.732] Build status: STARTED
[08:33:31.732] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:81:0) after 7m49s
[08:41:20.753] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:81:0)
[08:41:20.773] Build status: STARTED
[08:41:20.773] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:82:0) after 5m8s
[08:46:28.991] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:82:0)
[08:46:29.014] Build status: STARTED
[08:46:29.014] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:83:0) after 9m7s
[08:55:36.084] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:83:0)
[08:55:36.104] Build status: STARTED
[08:55:36.104] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:84:0) after 6m19s
[09:01:55.351] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:84:0)
[09:01:55.371] Build status: STARTED
[09:01:55.371] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:85:0) after 1m37s
[09:03:32.444] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:85:0)
[09:03:32.467] Build status: STARTED
[09:03:32.467] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:86:0) after 6m17s
[09:09:49.808] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:86:0)
[09:09:49.838] Build status: STARTED
[09:09:49.838] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:87:0) after 1m22s
[09:11:11.961] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:87:0)
[09:11:11.979] Build status: STARTED
[09:11:11.979] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:88:0) after 1m32s
[09:12:44.231] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:88:0)
[09:12:44.261] Build status: STARTED
[09:12:44.261] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:89:0) after 4m49s
[09:17:33.280] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:89:0)
[09:17:33.457] Build status: STARTED
[09:17:33.457] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:90:0) after 3m29s
[09:21:02.477] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:90:0)
[09:21:02.496] Build status: STARTED
[09:21:02.496] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:91:0) after 7m26s
[09:28:28.512] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:91:0)
[09:28:28.531] Build status: STARTED
[09:28:28.531] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:92:0) after 5m39s
[09:34:07.666] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:92:0)
[09:34:07.688] Build status: STARTED
[09:34:07.688] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:93:0) after 1m8s
[09:35:15.706] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:93:0)
[09:35:15.727] Build status: STARTED
[09:35:15.727] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:94:0) after 3m48s
[09:39:03.763] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:94:0)
[09:39:03.781] Build status: STARTED
[09:39:03.781] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:95:0) after 8m29s
[09:47:32.794] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:95:0)
[09:47:32.815] Build status: STARTED
[09:47:32.815] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:96:0) after 7m42s
[09:55:15.153] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:96:0)
[09:55:15.253] Build status: STARTED
[09:55:15.253] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:97:0) after 5m5s
[10:00:20.297] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:97:0)
[10:00:20.319] Build status: STARTED
[10:00:20.319] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:98:0) after 3m59s
[10:04:20.207] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:98:0)
[10:04:20.244] Build status: STARTED
[10:04:20.244] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:99:0) after 4m51s
[10:09:11.269] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:99:0)
[10:09:11.297] Build status: STARTED
[10:09:11.297] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:100:0) after 1m32s
[10:10:43.328] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:100:0)
[10:10:43.346] Build status: STARTED
[10:10:43.347] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:101:0) after 1m8s
[10:11:51.456] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:101:0)
[10:11:51.489] Build status: STARTED
[10:11:51.489] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:102:0) after 6m50s
[10:18:41.533] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:102:0)
[10:18:41.552] Build status: STARTED
[10:18:41.552] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:103:0) after 3m32s
[10:22:13.570] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:103:0)
[10:22:13.590] Build status: STARTED
[10:22:13.590] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:104:0) after 6m57s
[10:29:10.780] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:104:0)
[10:29:10.837] Build status: STARTED
[10:29:10.837] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:105:0) after 1m59s
[10:31:09.855] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:105:0)
[10:31:09.889] Build status: STARTED
[10:31:09.889] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:106:0) after 3m18s
[10:34:27.952] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:106:0)
[10:34:27.979] Build status: STARTED
[10:34:27.979] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:107:0) after 1m23s
[10:35:51.001] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:107:0)
[10:35:51.025] Build status: STARTED
[10:35:51.025] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:108:0) after 1m27s
[10:37:18.166] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:108:0)
[10:37:18.188] Build status: STARTED
[10:37:18.188] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:109:0) after 1m7s
[10:38:25.183] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:109:0)
[10:38:25.225] Build status: STARTED
[10:38:25.225] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:110:0) after 3m33s
[10:41:58.243] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:110:0)
[10:41:58.264] Build status: STARTED
[10:41:58.264] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:111:0) after 1m13s
[10:43:11.280] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:111:0)
[10:43:11.309] Build status: STARTED
[10:43:11.309] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:112:0) after 9m3s
[10:52:14.336] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:112:0)
[10:52:14.354] Build status: STARTED
[10:52:14.354] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:113:0) after 9m59s
[11:02:13.388] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:113:0)
[11:02:13.409] Build status: STARTED
[11:02:13.409] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:114:0) after 1m8s
[11:03:21.881] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:114:0)
[11:03:21.917] Build status: STARTED
[11:03:21.918] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:115:0) after 4m12s
[11:07:33.938] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:115:0)
[11:07:33.988] Build status: STARTED
[11:07:33.988] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:116:0) after 3m6s
[11:10:40.009] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:116:0)
[11:10:40.025] Build status: STARTED
[11:10:40.025] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:117:0) after 7m9s
[11:17:49.340] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:117:0)
[11:17:49.374] Build status: STARTED
[11:17:49.374] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:118:0) after 7m14s
[11:25:03.403] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:118:0)
[11:25:03.467] Build status: STARTED
[11:25:03.467] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:119:0) after 8m45s
[11:33:48.657] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:119:0)
[11:33:48.703] Build status: STARTED
[11:33:48.703] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:120:0) after 5m43s
[11:39:32.006] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:120:0)
[11:39:32.038] Build status: STARTED
[11:39:32.038] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:121:0) after 1m25s
[11:40:57.141] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:121:0)
[11:40:57.165] Build status: STARTED
[11:40:57.165] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:122:0) after 9m32s
[11:50:29.664] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:122:0)
[11:50:29.816] Build status: STARTED
[11:50:29.816] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:123:0) after 4m39s
[11:55:08.834] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:123:0)
[11:55:09.024] Build status: STARTED
[11:55:09.024] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:124:0) after 3m52s
[11:59:01.045] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:124:0)
[11:59:01.102] Build status: STARTED
[11:59:01.102] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:125:0) after 8m4s
[12:07:05.511] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:125:0)
[12:07:05.529] Build status: STARTED
[12:07:05.529] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:126:0) after 4m50s
[12:11:55.549] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:126:0)
[12:11:55.594] Build status: STARTED
[12:11:55.594] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:127:0) after 3m52s
[12:15:47.650] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:127:0)
[12:15:47.671] Build status: STARTED
[12:15:47.671] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:128:0) after 8m23s
[12:24:10.745] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:128:0)
[12:24:10.765] Build status: STARTED
[12:24:10.765] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:129:0) after 7m50s
[12:32:00.816] Handling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:129:0)
[12:32:00.840] Build status: STARTED
[12:32:00.840] Scheduling timer "check-buildbucket-build-status" (art/target.arm.gsctress.32:8896946377716446880:130:0) after 9m0s
[12:37:49.884] Received PubSub notification, asking Buildbucket for the build status
[12:37:49.918] Build:
{
"id": "8731516315509338401",
"builder": {
"project": "art",
"bucket": "ci",
"builder": "target.arm.gsctress.32"
},
"number": 5,
"createdBy": "project:art",
"createTime": "2024-11-12T01:16:08.824034276Z",
"startTime": "2024-11-12T01:16:14.369275761Z",
"endTime": "2024-11-12T12:37:48.650132655Z",
"updateTime": "2024-11-12T12:37:48.650132655Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "android.googlesource.com",
"project": "platform/art",
"id": "298dc96f06058b86944023be94a7f8ab1e6ff3c5",
"ref": "refs/heads/master"
}
}
}
[12:37:49.918] Invocation finished in 11h21m42.582521956s with status FAILED