[20:23:25.055] New invocation is queued and will start shortly
[20:23:26.173] Starting the invocation (attempt 1)
[20:23:26.202] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/306b966b00585f5503f1c31e4a9b425fe19c7cba"
[20:23:26.202] Popped gitiles commit info from properties and tags
[20:23:26.202] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:23:26.202] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:23:26.202] Buildbucket request:
{
"requestId": "8908923592681313888",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-android-4.4_release"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8908923592681313888",
"job": "r8/linux-android-4.4_release",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/8.6",
"repo": "https://r8.googlesource.com/r8",
"revision": "306b966b00585f5503f1c31e4a9b425fe19c7cba"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/8.6@306b966b00585f5503f1c31e4a9b425fe19c7cba",
"title": "306b966b00585f5503f1c31e4a9b425fe19c7cba",
"url": "https://r8.googlesource.com/r8/+/306b966b00585f5503f1c31e4a9b425fe19c7cba"
}
]
}
},
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "306b966b00585f5503f1c31e4a9b425fe19c7cba",
"ref": "refs/heads/8.6"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8908923592681313888"
},
{
"key": "scheduler_job_id",
"value": "r8/linux-android-4.4_release"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:23:26.896] Scheduled build:
{
"id": "8743493530613918161",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-android-4.4_release"
},
"number": 42,
"createdBy": "project:r8",
"createTime": "2024-07-02T20:23:26.397613055Z",
"updateTime": "2024-07-02T20:23:26.397613055Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "306b966b00585f5503f1c31e4a9b425fe19c7cba",
"ref": "refs/heads/8.6"
}
}
}
[20:23:26.896] Task URL: https://cr-buildbucket.appspot.com/build/8743493530613918161
[20:23:26.897] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:2:0) after 5m47s
[20:23:27.834] Received PubSub notification, asking Buildbucket for the build status
[20:23:27.863] Build status: SCHEDULED
[20:29:13.915] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:2:0)
[20:29:13.941] Build status: SCHEDULED
[20:29:13.941] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:4:0) after 7m40s
[20:36:54.054] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:4:0)
[20:36:54.080] Build status: SCHEDULED
[20:36:54.080] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:5:0) after 7m3s
[20:43:57.090] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:5:0)
[20:43:57.139] Build status: SCHEDULED
[20:43:57.139] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:6:0) after 3m54s
[20:47:51.157] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:6:0)
[20:47:51.177] Build status: SCHEDULED
[20:47:51.177] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:7:0) after 7m37s
[20:55:28.199] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:7:0)
[20:55:28.219] Build status: SCHEDULED
[20:55:28.219] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:8:0) after 9m22s
[21:04:50.267] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:8:0)
[21:04:50.299] Build status: SCHEDULED
[21:04:50.299] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:9:0) after 4m56s
[21:09:46.286] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:9:0)
[21:09:46.309] Build status: SCHEDULED
[21:09:46.309] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:10:0) after 8m20s
[21:18:06.333] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:10:0)
[21:18:06.386] Build status: SCHEDULED
[21:18:06.386] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:11:0) after 1m54s
[21:20:00.411] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:11:0)
[21:20:00.461] Build status: SCHEDULED
[21:20:00.461] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:12:0) after 5m16s
[21:25:16.536] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:12:0)
[21:25:16.578] Build status: SCHEDULED
[21:25:16.578] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:13:0) after 5m6s
[21:30:22.594] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:13:0)
[21:30:22.626] Build status: SCHEDULED
[21:30:22.626] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:14:0) after 4m40s
[21:35:02.667] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:14:0)
[21:35:02.825] Build status: SCHEDULED
[21:35:02.825] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:15:0) after 4m20s
[21:39:22.852] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:15:0)
[21:39:22.872] Build status: SCHEDULED
[21:39:22.873] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:16:0) after 4m1s
[21:43:23.939] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:16:0)
[21:43:23.957] Build status: SCHEDULED
[21:43:23.957] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:17:0) after 9m48s
[21:53:12.019] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:17:0)
[21:53:12.042] Build status: SCHEDULED
[21:53:12.042] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:18:0) after 3m36s
[21:56:48.162] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:18:0)
[21:56:48.190] Build status: SCHEDULED
[21:56:48.190] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:19:0) after 1m7s
[21:57:55.208] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:19:0)
[21:57:55.266] Build status: SCHEDULED
[21:57:55.266] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:20:0) after 2m17s
[22:00:12.267] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:20:0)
[22:00:12.308] Build status: SCHEDULED
[22:00:12.308] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:21:0) after 2m57s
[22:03:09.505] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:21:0)
[22:03:09.534] Build status: SCHEDULED
[22:03:09.534] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:22:0) after 1m5s
[22:04:14.551] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:22:0)
[22:04:14.569] Build status: SCHEDULED
[22:04:14.569] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:23:0) after 9m24s
[22:13:38.659] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:23:0)
[22:13:38.680] Build status: SCHEDULED
[22:13:38.680] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:24:0) after 6m24s
[22:20:02.723] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:24:0)
[22:20:02.766] Build status: SCHEDULED
[22:20:02.766] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:25:0) after 5m42s
[22:25:44.784] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:25:0)
[22:25:44.805] Build status: SCHEDULED
[22:25:44.805] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:26:0) after 4m6s
[22:29:50.825] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:26:0)
[22:29:50.851] Build status: SCHEDULED
[22:29:50.851] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:27:0) after 9m26s
[22:30:16.076] Received PubSub notification, asking Buildbucket for the build status
[22:30:16.118] Build status: STARTED
[22:39:16.873] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:27:0)
[22:39:16.971] Build status: STARTED
[22:39:16.971] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:29:0) after 1m43s
[22:41:00.244] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:29:0)
[22:41:00.308] Build status: STARTED
[22:41:00.308] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:30:0) after 7m43s
[22:48:43.323] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:30:0)
[22:48:43.348] Build status: STARTED
[22:48:43.348] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:31:0) after 6m48s
[22:55:31.371] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:31:0)
[22:55:31.423] Build status: STARTED
[22:55:31.423] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:32:0) after 6m21s
[23:01:52.439] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:32:0)
[23:01:52.471] Build status: STARTED
[23:01:52.471] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:33:0) after 7m13s
[23:09:05.485] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:33:0)
[23:09:05.505] Build status: STARTED
[23:09:05.505] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:34:0) after 4m2s
[23:13:07.521] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:34:0)
[23:13:07.541] Build status: STARTED
[23:13:07.541] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:35:0) after 7m42s
[23:20:49.600] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:35:0)
[23:20:49.626] Build status: STARTED
[23:20:49.626] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:36:0) after 2m15s
[23:23:05.065] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:36:0)
[23:23:05.096] Build status: STARTED
[23:23:05.096] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:37:0) after 4m45s
[23:27:50.080] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:37:0)
[23:27:50.099] Build status: STARTED
[23:27:50.099] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:38:0) after 3m57s
[23:31:47.125] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:38:0)
[23:31:47.163] Build status: STARTED
[23:31:47.163] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:39:0) after 3m18s
[23:35:05.205] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:39:0)
[23:35:05.246] Build status: STARTED
[23:35:05.246] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:40:0) after 4m22s
[23:39:27.398] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:40:0)
[23:39:27.414] Build status: STARTED
[23:39:27.414] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:41:0) after 3m51s
[23:43:18.578] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:41:0)
[23:43:18.597] Build status: STARTED
[23:43:18.597] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:42:0) after 1m7s
[23:44:25.672] Handling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:42:0)
[23:44:25.710] Build status: STARTED
[23:44:25.710] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-4.4_release:8908923592681313888:43:0) after 8m6s
[23:49:59.585] Received PubSub notification, asking Buildbucket for the build status
[23:49:59.626] Build:
{
"id": "8743493530613918161",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-android-4.4_release"
},
"number": 42,
"createdBy": "project:r8",
"createTime": "2024-07-02T20:23:26.397613055Z",
"startTime": "2024-07-02T22:30:14.851988108Z",
"endTime": "2024-07-02T23:49:59.317922423Z",
"updateTime": "2024-07-02T23:49:59.317922423Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "306b966b00585f5503f1c31e4a9b425fe19c7cba",
"ref": "refs/heads/8.6"
}
}
}
[23:49:59.626] Invocation finished in 3h26m34.583746437s with status SUCCEEDED