[04:00:21.281] New invocation is queued and will start shortly
[04:00:22.968] Starting the invocation (attempt 1)
[04:00:22.992] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/edcb3d58438a2e576edc1c701a757d6dc270bf7e"
[04:00:22.992] Popped gitiles commit info from properties and tags
[04:00:22.992] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:00:22.993] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:00:22.993] Buildbucket request:
{
"requestId": "8909438426482006480",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "linux-js-code-coverage"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "edcb3d58438a2e576edc1c701a757d6dc270bf7e",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8909438426482006480"
},
{
"key": "scheduler_job_id",
"value": "chromium/linux-js-code-coverage"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:00:23.623] Scheduled build:
{
"id": "8744008363970054209",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "linux-js-code-coverage"
},
"number": 675,
"createdBy": "project:chromium",
"createTime": "2024-06-27T04:00:23.048984051Z",
"updateTime": "2024-06-27T04:00:23.048984051Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "edcb3d58438a2e576edc1c701a757d6dc270bf7e",
"ref": "refs/heads/main"
}
}
}
[04:00:23.623] Task URL: https://cr-buildbucket.appspot.com/build/8744008363970054209
[04:00:23.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:2:0) after 3m34s
[04:00:24.682] Received PubSub notification, asking Buildbucket for the build status
[04:00:24.700] Build status: SCHEDULED
[04:03:57.693] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:2:0)
[04:03:57.751] Build status: SCHEDULED
[04:03:57.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:4:0) after 8m57s
[04:12:54.766] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:4:0)
[04:12:54.812] Build status: SCHEDULED
[04:12:54.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:5:0) after 3m25s
[04:16:20.195] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:5:0)
[04:16:20.223] Build status: SCHEDULED
[04:16:20.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:6:0) after 2m9s
[04:18:29.405] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:6:0)
[04:18:29.434] Build status: SCHEDULED
[04:18:29.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:7:0) after 6m39s
[04:25:08.485] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:7:0)
[04:25:08.519] Build status: SCHEDULED
[04:25:08.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:8:0) after 2m25s
[04:27:34.331] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:8:0)
[04:27:34.367] Build status: SCHEDULED
[04:27:34.367] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:9:0) after 4m55s
[04:32:29.658] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:9:0)
[04:32:29.677] Build status: SCHEDULED
[04:32:29.677] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:10:0) after 5m51s
[04:38:20.691] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:10:0)
[04:38:20.708] Build status: SCHEDULED
[04:38:20.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:11:0) after 8m52s
[04:47:12.772] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:11:0)
[04:47:12.789] Build status: SCHEDULED
[04:47:12.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:12:0) after 9m53s
[04:57:05.909] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:12:0)
[04:57:06.002] Build status: SCHEDULED
[04:57:06.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:13:0) after 5m33s
[05:02:39.017] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:13:0)
[05:02:39.038] Build status: SCHEDULED
[05:02:39.038] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:14:0) after 3m2s
[05:05:41.344] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:14:0)
[05:05:41.366] Build status: SCHEDULED
[05:05:41.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:15:0) after 6m15s
[05:11:56.391] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:15:0)
[05:11:56.407] Build status: SCHEDULED
[05:11:56.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:16:0) after 7m30s
[05:19:26.720] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:16:0)
[05:19:26.735] Build status: SCHEDULED
[05:19:26.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:17:0) after 8m49s
[05:28:15.820] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:17:0)
[05:28:15.841] Build status: SCHEDULED
[05:28:15.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:18:0) after 7m27s
[05:35:42.872] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:18:0)
[05:35:42.948] Build status: SCHEDULED
[05:35:42.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:19:0) after 1m44s
[05:37:26.990] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:19:0)
[05:37:27.008] Build status: SCHEDULED
[05:37:27.008] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:20:0) after 1m4s
[05:38:31.120] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:20:0)
[05:38:31.135] Build status: SCHEDULED
[05:38:31.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:21:0) after 8m56s
[05:47:27.383] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:21:0)
[05:47:27.400] Build status: SCHEDULED
[05:47:27.400] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:22:0) after 6m59s
[05:54:26.433] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:22:0)
[05:54:26.451] Build status: SCHEDULED
[05:54:26.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:23:0) after 6m43s
[06:01:09.699] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:23:0)
[06:01:09.715] Build status: SCHEDULED
[06:01:09.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:24:0) after 6m56s
[06:08:05.789] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:24:0)
[06:08:05.963] Build status: SCHEDULED
[06:08:05.963] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:25:0) after 1m25s
[06:09:30.989] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:25:0)
[06:09:31.005] Build status: SCHEDULED
[06:09:31.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:26:0) after 4m6s
[06:13:37.120] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:26:0)
[06:13:37.135] Build status: SCHEDULED
[06:13:37.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:27:0) after 7m24s
[06:21:01.155] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:27:0)
[06:21:01.185] Build status: SCHEDULED
[06:21:01.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:28:0) after 6m42s
[06:27:43.318] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:28:0)
[06:27:43.387] Build status: SCHEDULED
[06:27:43.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:29:0) after 5m21s
[06:33:04.407] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:29:0)
[06:33:04.498] Build status: SCHEDULED
[06:33:04.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:30:0) after 1m46s
[06:34:50.623] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:30:0)
[06:34:50.712] Build status: SCHEDULED
[06:34:50.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:31:0) after 1m7s
[06:35:57.828] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:31:0)
[06:35:57.891] Build status: SCHEDULED
[06:35:57.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:32:0) after 1m30s
[06:37:28.047] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:32:0)
[06:37:28.065] Build status: SCHEDULED
[06:37:28.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:33:0) after 6m40s
[06:44:08.603] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:33:0)
[06:44:08.620] Build status: SCHEDULED
[06:44:08.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:34:0) after 8m17s
[06:52:25.646] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:34:0)
[06:52:25.663] Build status: SCHEDULED
[06:52:25.663] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:35:0) after 4m12s
[06:56:37.708] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:35:0)
[06:56:37.747] Build status: SCHEDULED
[06:56:37.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:36:0) after 3m24s
[07:00:01.882] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:36:0)
[07:00:01.966] Build status: SCHEDULED
[07:00:01.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:37:0) after 6m55s
[07:06:56.995] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:37:0)
[07:06:57.013] Build status: SCHEDULED
[07:06:57.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:38:0) after 9m56s
[07:16:53.108] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:38:0)
[07:16:53.142] Build status: SCHEDULED
[07:16:53.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:39:0) after 6m30s
[07:23:23.260] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:39:0)
[07:23:23.279] Build status: SCHEDULED
[07:23:23.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:40:0) after 4m30s
[07:27:53.297] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:40:0)
[07:27:53.318] Build status: SCHEDULED
[07:27:53.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:41:0) after 2m26s
[07:30:19.660] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:41:0)
[07:30:19.677] Build status: SCHEDULED
[07:30:19.677] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:42:0) after 9m35s
[07:39:54.683] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:42:0)
[07:39:54.701] Build status: SCHEDULED
[07:39:54.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:43:0) after 9m31s
[07:49:25.821] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:43:0)
[07:49:25.843] Build status: SCHEDULED
[07:49:25.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:44:0) after 1m27s
[07:50:52.860] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:44:0)
[07:50:52.878] Build status: SCHEDULED
[07:50:52.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:45:0) after 9m43s
[08:00:35.944] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:45:0)
[08:00:35.966] Build status: SCHEDULED
[08:00:35.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:46:0) after 7m47s
[08:08:22.989] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:46:0)
[08:08:23.008] Build status: SCHEDULED
[08:08:23.008] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:47:0) after 4m32s
[08:12:55.110] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:47:0)
[08:12:55.141] Build status: SCHEDULED
[08:12:55.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:48:0) after 3m25s
[08:16:20.237] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:48:0)
[08:16:20.299] Build status: SCHEDULED
[08:16:20.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:49:0) after 5m6s
[08:21:26.321] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:49:0)
[08:21:26.367] Build status: SCHEDULED
[08:21:26.367] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:50:0) after 4m0s
[08:24:31.406] Received PubSub notification, asking Buildbucket for the build status
[08:24:31.424] Build status: STARTED
[08:25:26.415] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:50:0)
[08:25:26.437] Build status: STARTED
[08:25:26.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:52:0) after 7m58s
[08:33:24.456] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:52:0)
[08:33:24.510] Build status: STARTED
[08:33:24.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:53:0) after 5m5s
[08:38:29.697] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:53:0)
[08:38:29.717] Build status: STARTED
[08:38:29.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:54:0) after 1m20s
[08:39:49.815] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:54:0)
[08:39:49.842] Build status: STARTED
[08:39:49.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:55:0) after 3m6s
[08:42:56.018] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:55:0)
[08:42:56.035] Build status: STARTED
[08:42:56.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:56:0) after 8m33s
[08:51:29.147] Handling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:56:0)
[08:51:29.176] Build status: STARTED
[08:51:29.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-js-code-coverage:8909438426482006480:57:0) after 9m28s
[08:55:43.770] Received PubSub notification, asking Buildbucket for the build status
[08:55:43.788] Build:
{
"id": "8744008363970054209",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "linux-js-code-coverage"
},
"number": 675,
"createdBy": "project:chromium",
"createTime": "2024-06-27T04:00:23.048984051Z",
"startTime": "2024-06-27T08:24:31.243896749Z",
"endTime": "2024-06-27T08:55:43.002788043Z",
"updateTime": "2024-06-27T08:55:43.002788043Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "edcb3d58438a2e576edc1c701a757d6dc270bf7e",
"ref": "refs/heads/main"
}
}
}
[08:55:43.788] Invocation finished in 4h55m22.518594129s with status SUCCEEDED