[06:05:14.872] New invocation is queued and will start shortly
[06:05:16.088] Starting the invocation (attempt 1)
[06:05:16.115] Popped buildset tag "buildset:commit/gitiles/pdfium.googlesource.com/pdfium/+/202ebe6ad7ffbb8df19d55a8813872a0b2838d59"
[06:05:16.115] Popped gitiles commit info from properties and tags
[06:05:16.115] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:05:16.116] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:05:16.116] Buildbucket request:
{
"requestId": "8923020113841545040",
"builder": {
"project": "pdfium",
"bucket": "ci",
"builder": "win_xfa_skia"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8923020113841545040",
"job": "pdfium/win_xfa_skia",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pdfium.googlesource.com/pdfium",
"revision": "dfd1ec916e14880f91c86042e4041a09e3e750df"
},
"id": "https://pdfium.googlesource.com/pdfium/+/refs/heads/main@dfd1ec916e14880f91c86042e4041a09e3e750df",
"title": "dfd1ec916e14880f91c86042e4041a09e3e750df",
"url": "https://pdfium.googlesource.com/pdfium/+/dfd1ec916e14880f91c86042e4041a09e3e750df"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pdfium.googlesource.com/pdfium",
"revision": "202ebe6ad7ffbb8df19d55a8813872a0b2838d59"
},
"id": "https://pdfium.googlesource.com/pdfium/+/refs/heads/main@202ebe6ad7ffbb8df19d55a8813872a0b2838d59",
"title": "202ebe6ad7ffbb8df19d55a8813872a0b2838d59",
"url": "https://pdfium.googlesource.com/pdfium/+/202ebe6ad7ffbb8df19d55a8813872a0b2838d59"
}
]
}
},
"gitilesCommit": {
"host": "pdfium.googlesource.com",
"project": "pdfium",
"id": "202ebe6ad7ffbb8df19d55a8813872a0b2838d59",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8923020113841545040"
},
{
"key": "scheduler_job_id",
"value": "pdfium/win_xfa_skia"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[06:05:16.696] Scheduled build:
{
"id": "8757590051764795665",
"builder": {
"project": "pdfium",
"bucket": "ci",
"builder": "win_xfa_skia"
},
"number": 1836,
"createdBy": "project:pdfium",
"createTime": "2024-01-29T06:05:16.225246424Z",
"updateTime": "2024-01-29T06:05:16.225246424Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pdfium.googlesource.com",
"project": "pdfium",
"id": "202ebe6ad7ffbb8df19d55a8813872a0b2838d59",
"ref": "refs/heads/main"
}
}
}
[06:05:16.696] Task URL: https://cr-buildbucket.appspot.com/build/8757590051764795665
[06:05:16.696] Scheduling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:2:0) after 2m31s
[06:05:18.030] Received PubSub notification, asking Buildbucket for the build status
[06:05:18.077] Build status: SCHEDULED
[06:07:47.711] Handling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:2:0)
[06:07:47.747] Build status: SCHEDULED
[06:07:47.747] Scheduling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:4:0) after 9m9s
[06:16:56.862] Handling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:4:0)
[06:16:56.939] Build status: SCHEDULED
[06:16:56.939] Scheduling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:5:0) after 2m5s
[06:19:01.959] Handling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:5:0)
[06:19:01.979] Build status: SCHEDULED
[06:19:01.979] Scheduling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:6:0) after 1m4s
[06:20:05.992] Handling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:6:0)
[06:20:06.022] Build status: SCHEDULED
[06:20:06.022] Scheduling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:7:0) after 4m12s
[06:24:18.204] Handling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:7:0)
[06:24:18.232] Build status: SCHEDULED
[06:24:18.232] Scheduling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:8:0) after 3m59s
[06:28:17.250] Handling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:8:0)
[06:28:17.267] Build status: SCHEDULED
[06:28:17.267] Scheduling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:9:0) after 2m51s
[06:31:08.283] Handling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:9:0)
[06:31:08.311] Build status: SCHEDULED
[06:31:08.311] Scheduling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:10:0) after 4m31s
[06:35:39.324] Handling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:10:0)
[06:35:39.360] Build status: SCHEDULED
[06:35:39.360] Scheduling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:11:0) after 7m33s
[06:38:23.945] Received PubSub notification, asking Buildbucket for the build status
[06:38:23.966] Build status: STARTED
[06:43:12.375] Handling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:11:0)
[06:43:12.482] Build status: STARTED
[06:43:12.482] Scheduling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:13:0) after 5m3s
[06:48:15.520] Handling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:13:0)
[06:48:15.559] Build status: STARTED
[06:48:15.559] Scheduling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:14:0) after 5m21s
[06:53:36.573] Handling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:14:0)
[06:53:36.601] Build status: STARTED
[06:53:36.601] Scheduling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:15:0) after 6m2s
[06:59:38.746] Handling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:15:0)
[06:59:38.766] Build status: STARTED
[06:59:38.766] Scheduling timer "check-buildbucket-build-status" (pdfium/win_xfa_skia:8923020113841545040:16:0) after 8m4s
[07:03:12.872] Received PubSub notification, asking Buildbucket for the build status
[07:03:12.894] Build:
{
"id": "8757590051764795665",
"builder": {
"project": "pdfium",
"bucket": "ci",
"builder": "win_xfa_skia"
},
"number": 1836,
"createdBy": "project:pdfium",
"createTime": "2024-01-29T06:05:16.225246424Z",
"startTime": "2024-01-29T06:38:19.563996Z",
"endTime": "2024-01-29T07:03:12.045614Z",
"updateTime": "2024-01-29T07:03:12.045614Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "pdfium.googlesource.com",
"project": "pdfium",
"id": "202ebe6ad7ffbb8df19d55a8813872a0b2838d59",
"ref": "refs/heads/main"
}
}
}
[07:03:12.894] Invocation finished in 57m58.033650013s with status SUCCEEDED