[14:53:45.796] New invocation is queued and will start shortly
[14:53:46.893] Starting the invocation (attempt 1)
[14:53:46.922] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e4d18583c20d253e19cffec4d5bde4fe6c78ca7a"
[14:53:46.922] Popped gitiles commit info from properties and tags
[14:53:46.922] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:53:46.923] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:53:46.923] Buildbucket request:
{
"requestId": "8897438517997230816",
"builder": {
"project": "chromium-m130",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8897438517997230816",
"job": "chromium-m130/Android x64 Builder All Targets (dbg)",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/6723",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8b889a01d559f09c3e840ae1573ac2e2890a187d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6723@8b889a01d559f09c3e840ae1573ac2e2890a187d",
"title": "8b889a01d559f09c3e840ae1573ac2e2890a187d",
"url": "https://chromium.googlesource.com/chromium/src/+/8b889a01d559f09c3e840ae1573ac2e2890a187d"
},
{
"gitiles": {
"ref": "refs/branch-heads/6723",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9e02119a6e0d514708b4a2f5f86e3dc8b3841daf"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6723@9e02119a6e0d514708b4a2f5f86e3dc8b3841daf",
"title": "9e02119a6e0d514708b4a2f5f86e3dc8b3841daf",
"url": "https://chromium.googlesource.com/chromium/src/+/9e02119a6e0d514708b4a2f5f86e3dc8b3841daf"
},
{
"gitiles": {
"ref": "refs/branch-heads/6723",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "67c084538bd423087f94dee77db259a757b0cec4"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6723@67c084538bd423087f94dee77db259a757b0cec4",
"title": "67c084538bd423087f94dee77db259a757b0cec4",
"url": "https://chromium.googlesource.com/chromium/src/+/67c084538bd423087f94dee77db259a757b0cec4"
},
{
"gitiles": {
"ref": "refs/branch-heads/6723",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b4238d119172102cbaa99d19859e5dc606b99c74"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6723@b4238d119172102cbaa99d19859e5dc606b99c74",
"title": "b4238d119172102cbaa99d19859e5dc606b99c74",
"url": "https://chromium.googlesource.com/chromium/src/+/b4238d119172102cbaa99d19859e5dc606b99c74"
},
{
"gitiles": {
"ref": "refs/branch-heads/6723",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e4d18583c20d253e19cffec4d5bde4fe6c78ca7a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6723@e4d18583c20d253e19cffec4d5bde4fe6c78ca7a",
"title": "e4d18583c20d253e19cffec4d5bde4fe6c78ca7a",
"url": "https://chromium.googlesource.com/chromium/src/+/e4d18583c20d253e19cffec4d5bde4fe6c78ca7a"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e4d18583c20d253e19cffec4d5bde4fe6c78ca7a",
"ref": "refs/branch-heads/6723"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8897438517997230816"
},
{
"key": "scheduler_job_id",
"value": "chromium-m130/Android x64 Builder All Targets (dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[14:53:47.457] Scheduled build:
{
"id": "8732008456097359041",
"builder": {
"project": "chromium-m130",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"number": 283,
"createdBy": "project:chromium-m130",
"createTime": "2024-11-06T14:53:46.985186055Z",
"updateTime": "2024-11-06T14:53:46.985186055Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e4d18583c20d253e19cffec4d5bde4fe6c78ca7a",
"ref": "refs/branch-heads/6723"
}
}
}
[14:53:47.457] Task URL: https://cr-buildbucket.appspot.com/build/8732008456097359041
[14:53:47.457] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:2:0) after 6m41s
[14:53:48.431] Received PubSub notification, asking Buildbucket for the build status
[14:53:48.458] Build status: SCHEDULED
[15:00:28.538] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:2:0)
[15:00:28.564] Build status: SCHEDULED
[15:00:28.564] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:4:0) after 1m21s
[15:01:49.610] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:4:0)
[15:01:49.668] Build status: SCHEDULED
[15:01:49.668] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:5:0) after 4m56s
[15:06:45.747] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:5:0)
[15:06:45.804] Build status: SCHEDULED
[15:06:45.804] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:6:0) after 4m10s
[15:10:55.820] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:6:0)
[15:10:55.841] Build status: SCHEDULED
[15:10:55.841] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:7:0) after 9m18s
[15:20:13.858] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:7:0)
[15:20:13.889] Build status: SCHEDULED
[15:20:13.889] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:8:0) after 2m6s
[15:22:19.953] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:8:0)
[15:22:19.972] Build status: SCHEDULED
[15:22:19.972] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:9:0) after 3m5s
[15:25:25.029] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:9:0)
[15:25:25.055] Build status: SCHEDULED
[15:25:25.055] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:10:0) after 8m9s
[15:31:09.583] Received PubSub notification, asking Buildbucket for the build status
[15:31:09.604] Build status: STARTED
[15:33:34.470] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:10:0)
[15:33:34.499] Build status: STARTED
[15:33:34.499] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:12:0) after 1m10s
[15:34:44.566] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:12:0)
[15:34:44.586] Build status: STARTED
[15:34:44.586] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:13:0) after 3m42s
[15:38:26.602] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:13:0)
[15:38:26.620] Build status: STARTED
[15:38:26.620] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:14:0) after 3m0s
[15:41:26.636] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:14:0)
[15:41:26.678] Build status: STARTED
[15:41:26.678] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:15:0) after 8m47s
[15:50:13.746] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:15:0)
[15:50:13.763] Build status: STARTED
[15:50:13.763] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:16:0) after 9m16s
[15:59:29.780] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:16:0)
[15:59:29.819] Build status: STARTED
[15:59:29.819] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:17:0) after 5m24s
[16:04:53.887] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:17:0)
[16:04:53.912] Build status: STARTED
[16:04:53.912] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:18:0) after 6m5s
[16:10:59.263] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:18:0)
[16:10:59.289] Build status: STARTED
[16:10:59.289] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:19:0) after 1m12s
[16:12:11.658] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:19:0)
[16:12:11.731] Build status: STARTED
[16:12:11.731] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:20:0) after 2m36s
[16:14:47.750] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:20:0)
[16:14:47.822] Build status: STARTED
[16:14:47.822] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:21:0) after 7m46s
[16:22:33.889] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:21:0)
[16:22:33.910] Build status: STARTED
[16:22:33.910] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:22:0) after 9m25s
[16:31:58.990] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:22:0)
[16:31:59.065] Build status: STARTED
[16:31:59.065] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:23:0) after 4m7s
[16:36:06.034] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:23:0)
[16:36:06.063] Build status: STARTED
[16:36:06.063] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:24:0) after 7m51s
[16:43:57.062] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:24:0)
[16:43:57.097] Build status: STARTED
[16:43:57.097] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:25:0) after 4m15s
[16:48:12.165] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:25:0)
[16:48:12.189] Build status: STARTED
[16:48:12.189] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:26:0) after 2m28s
[16:50:40.260] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:26:0)
[16:50:40.279] Build status: STARTED
[16:50:40.279] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:27:0) after 6m37s
[16:57:17.408] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:27:0)
[16:57:17.431] Build status: STARTED
[16:57:17.431] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:28:0) after 5m26s
[17:02:43.407] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:28:0)
[17:02:43.441] Build status: STARTED
[17:02:43.441] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:29:0) after 6m17s
[17:09:00.549] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:29:0)
[17:09:00.595] Build status: STARTED
[17:09:00.595] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:30:0) after 4m57s
[17:13:57.631] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:30:0)
[17:13:57.649] Build status: STARTED
[17:13:57.649] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:31:0) after 4m16s
[17:18:13.622] Handling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:31:0)
[17:18:13.655] Build status: STARTED
[17:18:13.655] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android x64 Builder All Targets (dbg):8897438517997230816:32:0) after 7m13s
[17:22:02.127] Received PubSub notification, asking Buildbucket for the build status
[17:22:02.165] Build:
{
"id": "8732008456097359041",
"builder": {
"project": "chromium-m130",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"number": 283,
"createdBy": "project:chromium-m130",
"createTime": "2024-11-06T14:53:46.985186055Z",
"startTime": "2024-11-06T15:31:09.200452010Z",
"endTime": "2024-11-06T17:22:01.576963364Z",
"updateTime": "2024-11-06T17:22:01.576963364Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e4d18583c20d253e19cffec4d5bde4fe6c78ca7a",
"ref": "refs/branch-heads/6723"
}
}
}
[17:22:02.165] Invocation finished in 2h28m16.375383702s with status SUCCEEDED