[12:01:39.067] New invocation is queued and will start shortly
[12:01:40.257] Starting the invocation (attempt 1)
[12:01:40.323] Popped buildset tag "buildset:commit/gitiles/android.googlesource.com/platform/art/+/d95a1f2ecf322d21ae98bfb7affe0070ddb9bc08"
[12:01:40.323] Popped gitiles commit info from properties and tags
[12:01:40.323] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:01:40.323] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:01:40.324] Buildbucket request:
{
"requestId": "8999099142671758992",
"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/art",
"revision": "4a4696ad2a1403139828e5e6703479f320f06fee"
},
"id": "https://android.googlesource.com/platform/art/+/refs/heads/master@4a4696ad2a1403139828e5e6703479f320f06fee",
"title": "4a4696ad2a1403139828e5e6703479f320f06fee",
"url": "https://android.googlesource.com/platform/art/+/4a4696ad2a1403139828e5e6703479f320f06fee"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/art",
"revision": "507a729e51588f7fa4eac7579d54ce7c96804349"
},
"id": "https://android.googlesource.com/platform/art/+/refs/heads/master@507a729e51588f7fa4eac7579d54ce7c96804349",
"title": "507a729e51588f7fa4eac7579d54ce7c96804349",
"url": "https://android.googlesource.com/platform/art/+/507a729e51588f7fa4eac7579d54ce7c96804349"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://android.googlesource.com/platform/art",
"revision": "d95a1f2ecf322d21ae98bfb7affe0070ddb9bc08"
},
"id": "https://android.googlesource.com/platform/art/+/refs/heads/master@d95a1f2ecf322d21ae98bfb7affe0070ddb9bc08",
"title": "d95a1f2ecf322d21ae98bfb7affe0070ddb9bc08",
"url": "https://android.googlesource.com/platform/art/+/d95a1f2ecf322d21ae98bfb7affe0070ddb9bc08"
}
]
}
},
"gitilesCommit": {
"host": "android.googlesource.com",
"project": "platform/art",
"id": "d95a1f2ecf322d21ae98bfb7affe0070ddb9bc08",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8999099142671758992"
},
{
"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"
}
}
[12:01:40.876] Scheduled build:
{
"id": "8833669080587758929",
"builder": {
"project": "art",
"bucket": "ci",
"builder": "angler-armv8-debug"
},
"number": 2062,
"createdBy": "project:art",
"createTime": "2021-10-11T12:01:40.419088763Z",
"updateTime": "2021-10-11T12:01:40.678044541Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "android.googlesource.com",
"project": "platform/art",
"id": "d95a1f2ecf322d21ae98bfb7affe0070ddb9bc08",
"ref": "refs/heads/master"
}
}
}
[12:01:40.876] Task URL: https://cr-buildbucket.appspot.com/build/8833669080587758929
[12:01:40.876] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:2:0) after 3m30s
[12:01:55.567] Received PubSub notification, asking Buildbucket for the build status
[12:01:55.610] Build status: STARTED
[12:05:10.891] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:2:0)
[12:05:11.077] Build status: STARTED
[12:05:11.077] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:4:0) after 1m40s
[12:06:51.092] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:4:0)
[12:06:51.119] Build status: STARTED
[12:06:51.119] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:5:0) after 7m58s
[12:14:49.174] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:5:0)
[12:14:49.200] Build status: STARTED
[12:14:49.200] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:6:0) after 3m6s
[12:17:55.216] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:6:0)
[12:17:55.274] Build status: STARTED
[12:17:55.274] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:7:0) after 1m27s
[12:19:22.387] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:7:0)
[12:19:22.414] Build status: STARTED
[12:19:22.414] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:8:0) after 6m9s
[12:25:31.432] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:8:0)
[12:25:31.476] Build status: STARTED
[12:25:31.476] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:9:0) after 1m21s
[12:26:52.490] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:9:0)
[12:26:52.524] Build status: STARTED
[12:26:52.524] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:10:0) after 5m41s
[12:32:33.765] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:10:0)
[12:32:33.808] Build status: STARTED
[12:32:33.808] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:11:0) after 8m33s
[12:41:06.872] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:11:0)
[12:41:06.949] Build status: STARTED
[12:41:06.949] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:12:0) after 8m18s
[12:49:24.967] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:12:0)
[12:49:24.998] Build status: STARTED
[12:49:24.998] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:13:0) after 6m55s
[12:56:20.083] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:13:0)
[12:56:20.160] Build status: STARTED
[12:56:20.160] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:14:0) after 3m31s
[12:59:51.291] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:14:0)
[12:59:51.326] Build status: STARTED
[12:59:51.326] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:15:0) after 9m28s
[13:09:19.385] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:15:0)
[13:09:19.417] Build status: STARTED
[13:09:19.417] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:16:0) after 4m5s
[13:13:24.452] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:16:0)
[13:13:24.502] Build status: STARTED
[13:13:24.502] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:17:0) after 8m37s
[13:22:01.517] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:17:0)
[13:22:01.560] Build status: STARTED
[13:22:01.560] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:18:0) after 3m17s
[13:25:18.576] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:18:0)
[13:25:18.606] Build status: STARTED
[13:25:18.606] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:19:0) after 4m4s
[13:29:22.788] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:19:0)
[13:29:22.831] Build status: STARTED
[13:29:22.831] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:20:0) after 3m42s
[13:33:04.852] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:20:0)
[13:33:04.882] Build status: STARTED
[13:33:04.882] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:21:0) after 4m28s
[13:37:32.899] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:21:0)
[13:37:33.051] Build status: STARTED
[13:37:33.051] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:22:0) after 8m32s
[13:46:05.271] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:22:0)
[13:46:05.369] Build status: STARTED
[13:46:05.369] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:23:0) after 5m33s
[13:51:38.394] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:23:0)
[13:51:38.435] Build status: STARTED
[13:51:38.435] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:24:0) after 2m57s
[13:54:35.744] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:24:0)
[13:54:35.776] Build status: STARTED
[13:54:35.776] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:25:0) after 7m23s
[14:01:58.796] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:25:0)
[14:01:58.831] Build status: STARTED
[14:01:58.831] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:26:0) after 6m46s
[14:08:44.863] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:26:0)
[14:08:44.970] Build status: STARTED
[14:08:44.970] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:27:0) after 1m52s
[14:10:36.988] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:27:0)
[14:10:37.025] Build status: STARTED
[14:10:37.025] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:28:0) after 3m27s
[14:14:03.997] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:28:0)
[14:14:04.035] Build status: STARTED
[14:14:04.035] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:29:0) after 5m43s
[14:19:47.127] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:29:0)
[14:19:47.179] Build status: STARTED
[14:19:47.179] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:30:0) after 9m51s
[14:29:38.283] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:30:0)
[14:29:38.316] Build status: STARTED
[14:29:38.316] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:31:0) after 9m50s
[14:39:28.393] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:31:0)
[14:39:28.423] Build status: STARTED
[14:39:28.423] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:32:0) after 4m42s
[14:44:10.909] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:32:0)
[14:44:10.944] Build status: STARTED
[14:44:10.944] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:33:0) after 9m30s
[14:53:41.223] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:33:0)
[14:53:41.294] Build status: STARTED
[14:53:41.295] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:34:0) after 4m22s
[14:58:03.321] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:34:0)
[14:58:03.348] Build status: STARTED
[14:58:03.348] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:35:0) after 2m41s
[15:00:44.388] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:35:0)
[15:00:44.462] Build status: STARTED
[15:00:44.462] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:36:0) after 3m18s
[15:04:02.691] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:36:0)
[15:04:02.870] Build status: STARTED
[15:04:02.870] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:37:0) after 5m5s
[15:09:07.891] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:37:0)
[15:09:07.916] Build status: STARTED
[15:09:07.916] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:38:0) after 6m59s
[15:16:06.939] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:38:0)
[15:16:06.970] Build status: STARTED
[15:16:06.970] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:39:0) after 1m3s
[15:17:09.990] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:39:0)
[15:17:10.031] Build status: STARTED
[15:17:10.031] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:40:0) after 9m37s
[15:26:47.248] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:40:0)
[15:26:47.322] Build status: STARTED
[15:26:47.322] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:41:0) after 9m21s
[15:36:08.341] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:41:0)
[15:36:08.410] Build status: STARTED
[15:36:08.410] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:42:0) after 5m55s
[15:42:03.651] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:42:0)
[15:42:03.694] Build status: STARTED
[15:42:03.694] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:43:0) after 6m12s
[15:48:15.714] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:43:0)
[15:48:15.761] Build status: STARTED
[15:48:15.761] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:44:0) after 1m59s
[15:50:14.759] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:44:0)
[15:50:14.787] Build status: STARTED
[15:50:14.787] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:45:0) after 4m9s
[15:54:23.812] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:45:0)
[15:54:23.841] Build status: STARTED
[15:54:23.841] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:46:0) after 4m0s
[15:58:23.859] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:46:0)
[15:58:23.888] Build status: STARTED
[15:58:23.888] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:47:0) after 1m28s
[15:59:51.868] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:47:0)
[15:59:51.904] Build status: STARTED
[15:59:51.904] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:48:0) after 4m36s
[16:04:28.023] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:48:0)
[16:04:28.151] Build status: STARTED
[16:04:28.151] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:49:0) after 6m44s
[16:11:12.195] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:49:0)
[16:11:12.223] Build status: STARTED
[16:11:12.223] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:50:0) after 2m22s
[16:13:34.245] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:50:0)
[16:13:34.280] Build status: STARTED
[16:13:34.280] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:51:0) after 9m48s
[16:23:22.465] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:51:0)
[16:23:22.560] Build status: STARTED
[16:23:22.560] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:52:0) after 5m3s
[16:28:25.580] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:52:0)
[16:28:25.614] Build status: STARTED
[16:28:25.614] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:53:0) after 1m8s
[16:29:33.836] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:53:0)
[16:29:33.873] Build status: STARTED
[16:29:33.873] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:54:0) after 5m55s
[16:35:28.894] Handling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:54:0)
[16:35:28.924] Build status: STARTED
[16:35:28.924] Scheduling timer "check-buildbucket-build-status" (art/angler-armv8-debug:8999099142671758992:55:0) after 6m2s
[16:37:43.968] Received PubSub notification, asking Buildbucket for the build status
[16:37:44.081] Build:
{
"id": "8833669080587758929",
"builder": {
"project": "art",
"bucket": "ci",
"builder": "angler-armv8-debug"
},
"number": 2062,
"createdBy": "project:art",
"createTime": "2021-10-11T12:01:40.419088763Z",
"startTime": "2021-10-11T12:01:54.856640Z",
"endTime": "2021-10-11T16:37:42.677313Z",
"updateTime": "2021-10-11T16:37:43.079759Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "android.googlesource.com",
"project": "platform/art",
"id": "d95a1f2ecf322d21ae98bfb7affe0070ddb9bc08",
"ref": "refs/heads/master"
}
}
}
[16:37:44.081] Invocation finished in 4h36m5.033616141s with status SUCCEEDED