[21:14:08.957] New invocation is queued and will start shortly
[21:14:10.743] Starting the invocation (attempt 1)
[21:14:10.770] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49d2adb648eaa18f26ee3916ee7c8d42eed7474d"
[21:14:10.770] Popped gitiles commit info from properties and tags
[21:14:10.770] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:14:10.770] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:14:10.770] Buildbucket request:
{
"requestId": "8895059065057504144",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8895059065057504144",
"job": "openscreen/chromium_linux_x64",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a35131209da76b34e9cd33f3922382f35d27c38b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@a35131209da76b34e9cd33f3922382f35d27c38b",
"title": "a35131209da76b34e9cd33f3922382f35d27c38b",
"url": "https://chromium.googlesource.com/chromium/src/+/a35131209da76b34e9cd33f3922382f35d27c38b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0482bcfc7cc5aa1d7b102f6015b8f88ed87d6405"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@0482bcfc7cc5aa1d7b102f6015b8f88ed87d6405",
"title": "0482bcfc7cc5aa1d7b102f6015b8f88ed87d6405",
"url": "https://chromium.googlesource.com/chromium/src/+/0482bcfc7cc5aa1d7b102f6015b8f88ed87d6405"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e477d4cd32bd903d7d187c1a0f8f64576fab4510"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@e477d4cd32bd903d7d187c1a0f8f64576fab4510",
"title": "e477d4cd32bd903d7d187c1a0f8f64576fab4510",
"url": "https://chromium.googlesource.com/chromium/src/+/e477d4cd32bd903d7d187c1a0f8f64576fab4510"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5e3cae6b3808de6a95cf9b1d74fb6559b4d81380"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@5e3cae6b3808de6a95cf9b1d74fb6559b4d81380",
"title": "5e3cae6b3808de6a95cf9b1d74fb6559b4d81380",
"url": "https://chromium.googlesource.com/chromium/src/+/5e3cae6b3808de6a95cf9b1d74fb6559b4d81380"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "cb0567a62b42f04b8e098839ea17c5033413699d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@cb0567a62b42f04b8e098839ea17c5033413699d",
"title": "cb0567a62b42f04b8e098839ea17c5033413699d",
"url": "https://chromium.googlesource.com/chromium/src/+/cb0567a62b42f04b8e098839ea17c5033413699d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0e44771e48c390ebdcf43cdf183b6ab35d268988"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@0e44771e48c390ebdcf43cdf183b6ab35d268988",
"title": "0e44771e48c390ebdcf43cdf183b6ab35d268988",
"url": "https://chromium.googlesource.com/chromium/src/+/0e44771e48c390ebdcf43cdf183b6ab35d268988"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "608e1fa8365d32f78372bc141686c2c633ca31bb"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@608e1fa8365d32f78372bc141686c2c633ca31bb",
"title": "608e1fa8365d32f78372bc141686c2c633ca31bb",
"url": "https://chromium.googlesource.com/chromium/src/+/608e1fa8365d32f78372bc141686c2c633ca31bb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4cc73ae7f0b46bda114c9c124b073aba1cc3c9fa"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@4cc73ae7f0b46bda114c9c124b073aba1cc3c9fa",
"title": "4cc73ae7f0b46bda114c9c124b073aba1cc3c9fa",
"url": "https://chromium.googlesource.com/chromium/src/+/4cc73ae7f0b46bda114c9c124b073aba1cc3c9fa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "023b180d52f7147b93be17c0cf3ca42c70c0d912"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@023b180d52f7147b93be17c0cf3ca42c70c0d912",
"title": "023b180d52f7147b93be17c0cf3ca42c70c0d912",
"url": "https://chromium.googlesource.com/chromium/src/+/023b180d52f7147b93be17c0cf3ca42c70c0d912"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f2ae46de5ec6934cb6bfece7e495fa03e0f1477e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@f2ae46de5ec6934cb6bfece7e495fa03e0f1477e",
"title": "f2ae46de5ec6934cb6bfece7e495fa03e0f1477e",
"url": "https://chromium.googlesource.com/chromium/src/+/f2ae46de5ec6934cb6bfece7e495fa03e0f1477e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "bc27db0df1701d352c1b91f07b83fb8f13862909"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@bc27db0df1701d352c1b91f07b83fb8f13862909",
"title": "bc27db0df1701d352c1b91f07b83fb8f13862909",
"url": "https://chromium.googlesource.com/chromium/src/+/bc27db0df1701d352c1b91f07b83fb8f13862909"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0d3fa8ae35bd40ef6541651ae1b6a706d4f901cd"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@0d3fa8ae35bd40ef6541651ae1b6a706d4f901cd",
"title": "0d3fa8ae35bd40ef6541651ae1b6a706d4f901cd",
"url": "https://chromium.googlesource.com/chromium/src/+/0d3fa8ae35bd40ef6541651ae1b6a706d4f901cd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "49d2adb648eaa18f26ee3916ee7c8d42eed7474d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@49d2adb648eaa18f26ee3916ee7c8d42eed7474d",
"title": "49d2adb648eaa18f26ee3916ee7c8d42eed7474d",
"url": "https://chromium.googlesource.com/chromium/src/+/49d2adb648eaa18f26ee3916ee7c8d42eed7474d"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "49d2adb648eaa18f26ee3916ee7c8d42eed7474d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8895059065057504144"
},
{
"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"
}
}
[21:14:11.186] Scheduled build:
{
"id": "8729629002420421905",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"createdBy": "project:openscreen",
"createTime": "2024-12-02T21:14:10.844160692Z",
"updateTime": "2024-12-02T21:14:10.844160692Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "49d2adb648eaa18f26ee3916ee7c8d42eed7474d",
"ref": "refs/heads/main"
}
}
}
[21:14:11.186] Task URL: https://cr-buildbucket.appspot.com/build/8729629002420421905
[21:14:11.186] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:2:0) after 6m1s
[21:14:12.199] Received PubSub notification, asking Buildbucket for the build status
[21:14:12.214] Build status: SCHEDULED
[21:14:17.412] Received PubSub notification, asking Buildbucket for the build status
[21:14:17.432] Build status: STARTED
[21:20:12.354] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:2:0)
[21:20:12.375] Build status: STARTED
[21:20:12.375] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:5:0) after 3m4s
[21:23:16.451] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:5:0)
[21:23:16.520] Build status: STARTED
[21:23:16.520] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:6:0) after 8m40s
[21:31:56.615] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:6:0)
[21:31:56.652] Build status: STARTED
[21:31:56.652] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:7:0) after 1m47s
[21:33:43.717] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:7:0)
[21:33:43.749] Build status: STARTED
[21:33:43.749] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:8:0) after 8m52s
[21:42:35.807] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:8:0)
[21:42:35.826] Build status: STARTED
[21:42:35.826] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:9:0) after 3m18s
[21:45:53.827] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:9:0)
[21:45:53.845] Build status: STARTED
[21:45:53.845] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:10:0) after 8m59s
[21:54:52.818] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:10:0)
[21:54:52.838] Build status: STARTED
[21:54:52.838] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:11:0) after 6m23s
[22:01:15.883] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:11:0)
[22:01:15.909] Build status: STARTED
[22:01:15.909] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:12:0) after 9m20s
[22:10:35.925] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:12:0)
[22:10:35.992] Build status: STARTED
[22:10:35.992] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:13:0) after 4m30s
[22:15:06.113] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:13:0)
[22:15:06.145] Build status: STARTED
[22:15:06.145] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:14:0) after 5m35s
[22:20:41.165] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:14:0)
[22:20:41.186] Build status: STARTED
[22:20:41.187] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:15:0) after 6m30s
[22:27:11.188] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:15:0)
[22:27:11.215] Build status: STARTED
[22:27:11.216] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:16:0) after 9m6s
[22:36:17.396] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:16:0)
[22:36:17.435] Build status: STARTED
[22:36:17.435] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:17:0) after 2m49s
[22:39:06.534] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:17:0)
[22:39:06.553] Build status: STARTED
[22:39:06.553] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:18:0) after 3m26s
[22:42:32.620] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:18:0)
[22:42:32.637] Build status: STARTED
[22:42:32.637] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:19:0) after 8m56s
[22:51:28.673] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:19:0)
[22:51:30.733] Build status: STARTED
[22:51:30.733] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8895059065057504144:20:0) after 8m6s
[22:56:43.473] Received PubSub notification, asking Buildbucket for the build status
[22:56:43.494] Build:
{
"id": "8729629002420421905",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"createdBy": "project:openscreen",
"createTime": "2024-12-02T21:14:10.844160692Z",
"startTime": "2024-12-02T21:14:17.219770053Z",
"endTime": "2024-12-02T22:56:42.893745844Z",
"updateTime": "2024-12-02T22:56:42.893745844Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "49d2adb648eaa18f26ee3916ee7c8d42eed7474d",
"ref": "refs/heads/main"
}
}
}
[22:56:43.494] Invocation finished in 1h42m34.547640082s with status SUCCEEDED