[15:22:06.089] New invocation is queued and will start shortly
[15:22:07.180] Starting the invocation (attempt 1)
[15:22:07.222] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1608baafa3c4b09c621c69c5fab0a6f130b64cd8"
[15:22:07.222] Popped gitiles commit info from properties and tags
[15:22:07.222] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:22:07.222] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:22:07.224] Buildbucket request:
{
"requestId": "8901694792539077360",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8901694792539077360",
"job": "openscreen/chromium_linux_x64",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "427a4dc42e6e9d127cc0151ab25dd5f3b4d4cd95"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@427a4dc42e6e9d127cc0151ab25dd5f3b4d4cd95",
"title": "427a4dc42e6e9d127cc0151ab25dd5f3b4d4cd95",
"url": "https://chromium.googlesource.com/chromium/src/+/427a4dc42e6e9d127cc0151ab25dd5f3b4d4cd95"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "853ad8bbd0f86ec9612c7a75e7fbc64badd88e0e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@853ad8bbd0f86ec9612c7a75e7fbc64badd88e0e",
"title": "853ad8bbd0f86ec9612c7a75e7fbc64badd88e0e",
"url": "https://chromium.googlesource.com/chromium/src/+/853ad8bbd0f86ec9612c7a75e7fbc64badd88e0e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "69052f7b13dbac03332d836cf45e80e9aabb1073"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@69052f7b13dbac03332d836cf45e80e9aabb1073",
"title": "69052f7b13dbac03332d836cf45e80e9aabb1073",
"url": "https://chromium.googlesource.com/chromium/src/+/69052f7b13dbac03332d836cf45e80e9aabb1073"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6a8efb6385b765f01cf68098c5d3635ba8b80652"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@6a8efb6385b765f01cf68098c5d3635ba8b80652",
"title": "6a8efb6385b765f01cf68098c5d3635ba8b80652",
"url": "https://chromium.googlesource.com/chromium/src/+/6a8efb6385b765f01cf68098c5d3635ba8b80652"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "75a06c00e3d88e90bb99a388df490427a37e03f4"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@75a06c00e3d88e90bb99a388df490427a37e03f4",
"title": "75a06c00e3d88e90bb99a388df490427a37e03f4",
"url": "https://chromium.googlesource.com/chromium/src/+/75a06c00e3d88e90bb99a388df490427a37e03f4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7fb4d355eb154e29870371cb1289f95eab012915"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@7fb4d355eb154e29870371cb1289f95eab012915",
"title": "7fb4d355eb154e29870371cb1289f95eab012915",
"url": "https://chromium.googlesource.com/chromium/src/+/7fb4d355eb154e29870371cb1289f95eab012915"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b95d2af647af13658c222284dbe80462400575b9"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@b95d2af647af13658c222284dbe80462400575b9",
"title": "b95d2af647af13658c222284dbe80462400575b9",
"url": "https://chromium.googlesource.com/chromium/src/+/b95d2af647af13658c222284dbe80462400575b9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c769a4b4b70e9a09d915e615c86c768e3a79784f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@c769a4b4b70e9a09d915e615c86c768e3a79784f",
"title": "c769a4b4b70e9a09d915e615c86c768e3a79784f",
"url": "https://chromium.googlesource.com/chromium/src/+/c769a4b4b70e9a09d915e615c86c768e3a79784f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "686d118696f459d31fd28bbd003da9acfee92248"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@686d118696f459d31fd28bbd003da9acfee92248",
"title": "686d118696f459d31fd28bbd003da9acfee92248",
"url": "https://chromium.googlesource.com/chromium/src/+/686d118696f459d31fd28bbd003da9acfee92248"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5ff49be0c5a60b35eaa29dbf20b17e12632d95d3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@5ff49be0c5a60b35eaa29dbf20b17e12632d95d3",
"title": "5ff49be0c5a60b35eaa29dbf20b17e12632d95d3",
"url": "https://chromium.googlesource.com/chromium/src/+/5ff49be0c5a60b35eaa29dbf20b17e12632d95d3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9399729ad10e9d076096223bef9ff8367c4fee6b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@9399729ad10e9d076096223bef9ff8367c4fee6b",
"title": "9399729ad10e9d076096223bef9ff8367c4fee6b",
"url": "https://chromium.googlesource.com/chromium/src/+/9399729ad10e9d076096223bef9ff8367c4fee6b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a2b291c6ead9720cc8717accd4163af4914ea626"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@a2b291c6ead9720cc8717accd4163af4914ea626",
"title": "a2b291c6ead9720cc8717accd4163af4914ea626",
"url": "https://chromium.googlesource.com/chromium/src/+/a2b291c6ead9720cc8717accd4163af4914ea626"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1608baafa3c4b09c621c69c5fab0a6f130b64cd8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@1608baafa3c4b09c621c69c5fab0a6f130b64cd8",
"title": "1608baafa3c4b09c621c69c5fab0a6f130b64cd8",
"url": "https://chromium.googlesource.com/chromium/src/+/1608baafa3c4b09c621c69c5fab0a6f130b64cd8"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "1608baafa3c4b09c621c69c5fab0a6f130b64cd8",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8901694792539077360"
},
{
"key": "scheduler_job_id",
"value": "openscreen/chromium_linux_x64"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:22:07.702] Scheduled build:
{
"id": "8736264730604726177",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"createdBy": "project:openscreen",
"createTime": "2024-09-20T15:22:07.304937836Z",
"updateTime": "2024-09-20T15:22:07.304937836Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "1608baafa3c4b09c621c69c5fab0a6f130b64cd8",
"ref": "refs/heads/main"
}
}
}
[15:22:07.702] Task URL: https://cr-buildbucket.appspot.com/build/8736264730604726177
[15:22:07.702] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:2:0) after 1m18s
[15:22:08.615] Received PubSub notification, asking Buildbucket for the build status
[15:22:08.648] Build status: SCHEDULED
[15:22:15.437] Received PubSub notification, asking Buildbucket for the build status
[15:22:15.532] Build status: STARTED
[15:23:25.719] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:2:0)
[15:23:25.756] Build status: STARTED
[15:23:25.756] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:5:0) after 3m48s
[15:27:13.825] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:5:0)
[15:27:13.866] Build status: STARTED
[15:27:13.866] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:6:0) after 4m13s
[15:31:27.004] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:6:0)
[15:31:27.041] Build status: STARTED
[15:31:27.041] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:7:0) after 8m55s
[15:40:22.167] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:7:0)
[15:40:22.187] Build status: STARTED
[15:40:22.187] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:8:0) after 9m56s
[15:50:18.231] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:8:0)
[15:50:18.250] Build status: STARTED
[15:50:18.250] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:9:0) after 3m16s
[15:53:34.334] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:9:0)
[15:53:34.418] Build status: STARTED
[15:53:34.418] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:10:0) after 6m50s
[16:00:24.526] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:10:0)
[16:00:24.556] Build status: STARTED
[16:00:24.556] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:11:0) after 4m22s
[16:04:46.667] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:11:0)
[16:04:46.689] Build status: STARTED
[16:04:46.689] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:12:0) after 2m26s
[16:07:12.772] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:12:0)
[16:07:12.790] Build status: STARTED
[16:07:12.790] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:13:0) after 4m16s
[16:11:28.864] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:13:0)
[16:11:28.905] Build status: STARTED
[16:11:28.905] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:14:0) after 2m9s
[16:13:37.875] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:14:0)
[16:13:37.909] Build status: STARTED
[16:13:37.909] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:15:0) after 3m8s
[16:16:45.926] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:15:0)
[16:16:45.957] Build status: STARTED
[16:16:45.957] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:16:0) after 2m36s
[16:19:21.981] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:16:0)
[16:19:22.012] Build status: STARTED
[16:19:22.012] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:17:0) after 7m18s
[16:26:40.272] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:17:0)
[16:26:40.313] Build status: STARTED
[16:26:40.313] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:18:0) after 6m58s
[16:33:38.385] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:18:0)
[16:33:38.411] Build status: STARTED
[16:33:38.411] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8901694792539077360:19:0) after 6m39s
[16:33:47.398] Received PubSub notification, asking Buildbucket for the build status
[16:33:47.417] Build:
{
"id": "8736264730604726177",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"createdBy": "project:openscreen",
"createTime": "2024-09-20T15:22:07.304937836Z",
"startTime": "2024-09-20T15:22:15.136438472Z",
"endTime": "2024-09-20T16:33:47.189515032Z",
"updateTime": "2024-09-20T16:33:47.189515032Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "1608baafa3c4b09c621c69c5fab0a6f130b64cd8",
"ref": "refs/heads/main"
}
}
}
[16:33:47.417] Invocation finished in 1h11m41.341653842s with status SUCCEEDED