[18:31:58.206] New invocation is queued and will start shortly
[18:31:59.694] Starting the invocation (attempt 1)
[18:31:59.727] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ec89d463d3901ff14afd0a4a87de7e62c31e7c4f"
[18:31:59.727] Popped gitiles commit info from properties and tags
[18:31:59.727] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:31:59.727] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:31:59.728] Buildbucket request:
{
"requestId": "8906212695353240128",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_win_x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8906212695353240128",
"job": "openscreen/chromium_win_x64",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2c0ebcec007fa003d4218bf0d10bf25b947c64a2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@2c0ebcec007fa003d4218bf0d10bf25b947c64a2",
"title": "2c0ebcec007fa003d4218bf0d10bf25b947c64a2",
"url": "https://chromium.googlesource.com/chromium/src/+/2c0ebcec007fa003d4218bf0d10bf25b947c64a2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7fd6eb86e01a351d188ebfca56902a8d1f92777b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@7fd6eb86e01a351d188ebfca56902a8d1f92777b",
"title": "7fd6eb86e01a351d188ebfca56902a8d1f92777b",
"url": "https://chromium.googlesource.com/chromium/src/+/7fd6eb86e01a351d188ebfca56902a8d1f92777b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2fcf246982eaf391bad24d982def2442dcde7ebc"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@2fcf246982eaf391bad24d982def2442dcde7ebc",
"title": "2fcf246982eaf391bad24d982def2442dcde7ebc",
"url": "https://chromium.googlesource.com/chromium/src/+/2fcf246982eaf391bad24d982def2442dcde7ebc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f975243b723ad8e00e434ad065a8ae08624a606b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@f975243b723ad8e00e434ad065a8ae08624a606b",
"title": "f975243b723ad8e00e434ad065a8ae08624a606b",
"url": "https://chromium.googlesource.com/chromium/src/+/f975243b723ad8e00e434ad065a8ae08624a606b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0d804360d89e7d28e68a73db2868104b286ba485"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@0d804360d89e7d28e68a73db2868104b286ba485",
"title": "0d804360d89e7d28e68a73db2868104b286ba485",
"url": "https://chromium.googlesource.com/chromium/src/+/0d804360d89e7d28e68a73db2868104b286ba485"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2a1823734a047d7e30146c44990bc343e9749036"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@2a1823734a047d7e30146c44990bc343e9749036",
"title": "2a1823734a047d7e30146c44990bc343e9749036",
"url": "https://chromium.googlesource.com/chromium/src/+/2a1823734a047d7e30146c44990bc343e9749036"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d4778ec4b2ad22e7000e1d96a1a0c9573c72749f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@d4778ec4b2ad22e7000e1d96a1a0c9573c72749f",
"title": "d4778ec4b2ad22e7000e1d96a1a0c9573c72749f",
"url": "https://chromium.googlesource.com/chromium/src/+/d4778ec4b2ad22e7000e1d96a1a0c9573c72749f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "76c3731d3692b9e4c9f6aec2991df92e9ecf4182"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@76c3731d3692b9e4c9f6aec2991df92e9ecf4182",
"title": "76c3731d3692b9e4c9f6aec2991df92e9ecf4182",
"url": "https://chromium.googlesource.com/chromium/src/+/76c3731d3692b9e4c9f6aec2991df92e9ecf4182"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "53282bc960863618bf874b379f080c3de47cb59b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@53282bc960863618bf874b379f080c3de47cb59b",
"title": "53282bc960863618bf874b379f080c3de47cb59b",
"url": "https://chromium.googlesource.com/chromium/src/+/53282bc960863618bf874b379f080c3de47cb59b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4413fbb2baa6f6a67c100b92953b752c08e17c1e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@4413fbb2baa6f6a67c100b92953b752c08e17c1e",
"title": "4413fbb2baa6f6a67c100b92953b752c08e17c1e",
"url": "https://chromium.googlesource.com/chromium/src/+/4413fbb2baa6f6a67c100b92953b752c08e17c1e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3c07c4b68f23c8bbb3f4d9c9234a529e89218184"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@3c07c4b68f23c8bbb3f4d9c9234a529e89218184",
"title": "3c07c4b68f23c8bbb3f4d9c9234a529e89218184",
"url": "https://chromium.googlesource.com/chromium/src/+/3c07c4b68f23c8bbb3f4d9c9234a529e89218184"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ec89d463d3901ff14afd0a4a87de7e62c31e7c4f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@ec89d463d3901ff14afd0a4a87de7e62c31e7c4f",
"title": "ec89d463d3901ff14afd0a4a87de7e62c31e7c4f",
"url": "https://chromium.googlesource.com/chromium/src/+/ec89d463d3901ff14afd0a4a87de7e62c31e7c4f"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ec89d463d3901ff14afd0a4a87de7e62c31e7c4f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8906212695353240128"
},
{
"key": "scheduler_job_id",
"value": "openscreen/chromium_win_x64"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:32:00.254] Scheduled build:
{
"id": "8740782633019230449",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_win_x64"
},
"createdBy": "project:openscreen",
"createTime": "2024-08-01T18:31:59.807598770Z",
"updateTime": "2024-08-01T18:31:59.807598770Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ec89d463d3901ff14afd0a4a87de7e62c31e7c4f",
"ref": "refs/heads/main"
}
},
"canary": true
}
[18:32:00.254] Task URL: https://cr-buildbucket.appspot.com/build/8740782633019230449
[18:32:00.254] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:2:0) after 8m58s
[18:32:01.183] Received PubSub notification, asking Buildbucket for the build status
[18:32:01.212] Build status: SCHEDULED
[18:40:58.273] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:2:0)
[18:40:58.293] Build status: SCHEDULED
[18:40:58.294] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:4:0) after 1m21s
[18:42:19.372] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:4:0)
[18:42:19.392] Build status: SCHEDULED
[18:42:19.392] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:5:0) after 8m55s
[18:51:14.411] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:5:0)
[18:51:14.438] Build status: SCHEDULED
[18:51:14.438] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:6:0) after 4m53s
[18:56:07.506] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:6:0)
[18:56:07.598] Build status: SCHEDULED
[18:56:07.598] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:7:0) after 1m46s
[18:57:43.669] Received PubSub notification, asking Buildbucket for the build status
[18:57:43.689] Build status: STARTED
[18:57:53.625] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:7:0)
[18:57:53.651] Build status: STARTED
[18:57:53.651] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:9:0) after 5m58s
[19:03:51.718] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:9:0)
[19:03:51.743] Build status: STARTED
[19:03:51.743] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:10:0) after 9m50s
[19:13:41.760] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:10:0)
[19:13:41.787] Build status: STARTED
[19:13:41.787] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:11:0) after 3m47s
[19:17:28.831] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:11:0)
[19:17:28.868] Build status: STARTED
[19:17:28.868] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:12:0) after 8m9s
[19:25:37.888] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:12:0)
[19:25:37.931] Build status: STARTED
[19:25:37.931] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:13:0) after 1m26s
[19:27:03.962] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:13:0)
[19:27:04.008] Build status: STARTED
[19:27:04.008] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:14:0) after 7m27s
[19:34:31.034] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:14:0)
[19:34:31.319] Build status: STARTED
[19:34:31.319] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:15:0) after 3m12s
[19:37:43.424] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:15:0)
[19:37:43.465] Build status: STARTED
[19:37:43.465] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8906212695353240128:16:0) after 6m10s
[19:39:55.740] Received PubSub notification, asking Buildbucket for the build status
[19:39:55.796] Build:
{
"id": "8740782633019230449",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_win_x64"
},
"createdBy": "project:openscreen",
"createTime": "2024-08-01T18:31:59.807598770Z",
"startTime": "2024-08-01T18:57:43.147597369Z",
"endTime": "2024-08-01T19:39:55.438773977Z",
"updateTime": "2024-08-01T19:39:55.438773977Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ec89d463d3901ff14afd0a4a87de7e62c31e7c4f",
"ref": "refs/heads/main"
}
},
"canary": true
}
[19:39:55.796] Invocation finished in 1h7m57.597953859s with status FAILED