[16:14:50.657] New invocation is queued and will start shortly
[16:14:52.323] Starting the invocation (attempt 1)
[16:14:52.359] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/be235e8cc5c5812e4964bab605d5e066cafe181c"
[16:14:52.359] Popped gitiles commit info from properties and tags
[16:14:52.359] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:14:52.359] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:14:52.359] Buildbucket request:
{
"requestId": "8976705762429652496",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "android-official"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "be235e8cc5c5812e4964bab605d5e066cafe181c",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8976705762429652496"
},
{
"key": "scheduler_job_id",
"value": "chromium/android-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[16:14:53.114] Scheduled build:
{
"id": "8811275699921458449",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "android-official"
},
"number": 10505,
"createdBy": "project:chromium",
"createTime": "2022-06-15T16:14:52.418763116Z",
"updateTime": "2022-06-15T16:14:52.418763116Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "be235e8cc5c5812e4964bab605d5e066cafe181c",
"ref": "refs/heads/main"
}
}
}
[16:14:53.114] Task URL: https://cr-buildbucket.appspot.com/build/8811275699921458449
[16:14:53.114] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:2:0) after 9m58s
[16:15:19.419] Received PubSub notification, asking Buildbucket for the build status
[16:15:19.486] Build status: STARTED
[16:24:51.130] Handling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:2:0)
[16:24:51.154] Build status: STARTED
[16:24:51.154] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:4:0) after 8m43s
[16:33:34.381] Handling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:4:0)
[16:33:34.403] Build status: STARTED
[16:33:34.403] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:5:0) after 1m22s
[16:34:56.545] Handling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:5:0)
[16:34:56.576] Build status: STARTED
[16:34:56.576] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:6:0) after 1m15s
[16:36:11.594] Handling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:6:0)
[16:36:11.626] Build status: STARTED
[16:36:11.626] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:7:0) after 6m1s
[16:42:13.627] Handling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:7:0)
[16:42:13.652] Build status: STARTED
[16:42:13.652] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:8:0) after 9m25s
[16:51:38.772] Handling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:8:0)
[16:51:38.832] Build status: STARTED
[16:51:38.832] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:9:0) after 7m38s
[16:59:17.056] Handling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:9:0)
[16:59:17.156] Build status: STARTED
[16:59:17.156] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:10:0) after 9m11s
[17:08:28.296] Handling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:10:0)
[17:08:28.375] Build status: STARTED
[17:08:28.375] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:11:0) after 9m58s
[17:18:26.396] Handling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:11:0)
[17:18:26.428] Build status: STARTED
[17:18:26.428] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:12:0) after 4m48s
[17:23:14.542] Handling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:12:0)
[17:23:14.577] Build status: STARTED
[17:23:14.577] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:13:0) after 2m27s
[17:25:42.114] Handling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:13:0)
[17:25:42.242] Build status: STARTED
[17:25:42.242] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:14:0) after 4m22s
[17:30:04.692] Handling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:14:0)
[17:30:04.724] Build status: STARTED
[17:30:04.724] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:15:0) after 3m17s
[17:33:21.743] Handling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:15:0)
[17:33:21.799] Build status: STARTED
[17:33:21.799] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:16:0) after 9m6s
[17:42:27.960] Handling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:16:0)
[17:42:27.981] Build status: STARTED
[17:42:27.981] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:17:0) after 9m23s
[17:51:51.245] Handling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:17:0)
[17:51:51.282] Build status: STARTED
[17:51:51.282] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:18:0) after 3m52s
[17:55:43.579] Handling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:18:0)
[17:55:43.604] Build status: STARTED
[17:55:43.604] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:19:0) after 9m43s
[18:05:26.697] Handling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:19:0)
[18:05:26.716] Build status: STARTED
[18:05:26.716] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:20:0) after 9m52s
[18:15:18.717] Handling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:20:0)
[18:15:18.740] Build status: STARTED
[18:15:18.740] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:21:0) after 7m22s
[18:22:40.764] Handling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:21:0)
[18:22:40.789] Build status: STARTED
[18:22:40.789] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:22:0) after 3m41s
[18:26:21.808] Handling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:22:0)
[18:26:21.857] Build status: STARTED
[18:26:21.857] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:23:0) after 6m32s
[18:32:53.975] Handling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:23:0)
[18:32:54.001] Build status: STARTED
[18:32:54.001] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:24:0) after 3m40s
[18:36:34.102] Handling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:24:0)
[18:36:34.129] Build status: STARTED
[18:36:34.129] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:25:0) after 6m23s
[18:42:57.182] Handling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:25:0)
[18:42:57.204] Build status: STARTED
[18:42:57.204] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:8976705762429652496:26:0) after 4m57s
[18:43:46.463] Received PubSub notification, asking Buildbucket for the build status
[18:43:46.483] Build:
{
"id": "8811275699921458449",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "android-official"
},
"number": 10505,
"createdBy": "project:chromium",
"createTime": "2022-06-15T16:14:52.418763116Z",
"startTime": "2022-06-15T16:15:18.366123Z",
"endTime": "2022-06-15T18:43:38.308944261Z",
"updateTime": "2022-06-15T18:43:38.308944261Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "be235e8cc5c5812e4964bab605d5e066cafe181c",
"ref": "refs/heads/main"
}
}
}
[18:43:46.483] Invocation finished in 2h28m55.840862195s with status SUCCEEDED