[31.845822] Initializing watchdogs
[31.846062]   /dev/watchdog0
[31.872420] [001/162] (960s left) i915_module_load (load)
[32.011916] Starting subtest: load
[33.445123] Subtest load: SUCCESS (1.422s)
[33.581758] [002/162] (958s left) core_auth (basic-auth)
[33.743623] Starting subtest: basic-auth
[33.762941] Subtest basic-auth: SUCCESS (0.000s)
[33.840788] [003/162] (958s left) debugfs_test (read_all_entries)
[34.009763] Starting subtest: read_all_entries
[34.030884] Subtest read_all_entries: SUCCESS (0.043s)
[34.128591] [004/162] (958s left) debugfs_test (basic-hwmon)
[34.297419] Starting subtest: basic-hwmon
[34.337307] Subtest basic-hwmon: SKIP (0.000s)
[34.410989] [005/162] (958s left) fbdev (eof)
[34.568189] Starting subtest: eof
[34.586908] Subtest eof: SUCCESS (0.000s)
[34.675397] [006/162] (958s left) fbdev (info)
[34.814843] Starting subtest: info
[34.835408] Subtest info: SUCCESS (0.000s)
[34.934625] [007/162] (957s left) fbdev (nullptr)
[35.086350] Starting subtest: nullptr
[35.110474] Subtest nullptr: SUCCESS (0.000s)
[35.213856] [008/162] (957s left) fbdev (read)
[35.370420] Starting subtest: read
[35.493529] Subtest read: SUCCESS (0.130s)
[35.591814] [009/162] (957s left) fbdev (write)
[35.726563] Starting subtest: write
[35.780917] Subtest write: SUCCESS (0.068s)
[35.883406] [010/162] (957s left) gem_basic (bad-close)
[36.039442] Starting subtest: bad-close
[36.085488] Subtest bad-close: SUCCESS (0.000s)
[36.168638] [011/162] (956s left) gem_basic (create-close)
[36.323394] Starting subtest: create-close
[36.372505] Subtest create-close: SUCCESS (0.000s)
[36.449825] [012/162] (956s left) gem_basic (create-fd-close)
[36.631518] Starting subtest: create-fd-close
[36.673071] Subtest create-fd-close: SUCCESS (0.000s)
[36.756430] [013/162] (956s left) gem_busy (busy@all-engines)
[36.939692] Starting subtest: busy
[36.964731] Starting dynamic subtest: all-engines
[36.988815] Dynamic subtest all-engines: SUCCESS (0.023s)
[37.012458] Subtest busy: SUCCESS (0.023s)
[37.263912] [014/162] (955s left) gem_close_race (basic-process)
[37.524145] Starting subtest: basic-process
[37.551486] Subtest basic-process: SUCCESS (0.038s)
[37.670834] [015/162] (955s left) gem_close_race (basic-threads)
[37.849111] Starting subtest: basic-threads
[39.016588] Subtest basic-threads: SUCCESS (1.201s)
[39.212505] [016/162] (954s left) gem_ctx_create (basic)
[39.388581] Starting subtest: basic
[39.412701] Subtest basic: SUCCESS (0.000s)
[39.554099] [017/162] (953s left) gem_ctx_create (basic-files)
[39.749907] Starting subtest: basic-files
[41.754466] Subtest basic-files: SUCCESS (2.016s)
[42.039652] [018/162] (951s left) gem_ctx_exec (basic)
[42.219831] Starting subtest: basic
[42.239032] Subtest basic: SUCCESS (0.003s)
[42.317162] [019/162] (951s left) gem_exec_basic (basic)
[42.476886] Starting subtest: basic
[42.499057] Starting dynamic subtest: rcs0-smem
[42.520555] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[42.545564] Starting dynamic subtest: bcs0-smem
[42.565829] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[42.589103] Starting dynamic subtest: vcs0-smem
[42.608428] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[42.628157] Subtest basic: SUCCESS (0.002s)
[42.711576] [020/162] (950s left) gem_exec_create (basic)
[42.881030] Starting subtest: basic
[42.902217] Starting dynamic subtest: smem
[44.898453] Dynamic subtest smem: SUCCESS (2.042s)
[44.917669] Subtest basic: SUCCESS (2.042s)
[45.099192] [021/162] (948s left) gem_exec_fence (basic-busy)
[45.355467] Starting subtest: basic-busy
[45.374827] Starting dynamic subtest: rcs0
[45.413365] Dynamic subtest rcs0: SUCCESS (0.028s)
[45.441911] Starting dynamic subtest: bcs0
[45.485375] Dynamic subtest bcs0: SUCCESS (0.022s)
[45.510545] Starting dynamic subtest: vcs0
[45.549295] Dynamic subtest vcs0: SUCCESS (0.024s)
[45.569838] Subtest basic-busy: SUCCESS (0.074s)
[45.984471] [022/162] (947s left) gem_exec_fence (basic-wait)
[46.240503] Starting subtest: basic-wait
[46.261865] Starting dynamic subtest: rcs0
[46.282853] Dynamic subtest rcs0: SUCCESS (0.027s)
[46.309375] Starting dynamic subtest: bcs0
[46.328766] Dynamic subtest bcs0: SUCCESS (0.024s)
[46.352060] Starting dynamic subtest: vcs0
[46.371302] Dynamic subtest vcs0: SUCCESS (0.021s)
[46.392896] Subtest basic-wait: SUCCESS (0.072s)
[46.771993] [023/162] (947s left) gem_exec_fence (basic-await)
[47.026199] Starting subtest: basic-await
[47.045282] Starting dynamic subtest: rcs0
[47.092348] Dynamic subtest rcs0: SUCCESS (0.067s)
[47.115742] Starting dynamic subtest: bcs0
[47.161513] Dynamic subtest bcs0: SUCCESS (0.067s)
[47.245075] Starting dynamic subtest: vcs0
[47.265805] Dynamic subtest vcs0: SUCCESS (0.097s)
[47.284553] Subtest basic-await: SUCCESS (0.232s)
[47.704310] [024/162] (946s left) gem_exec_fence (nb-await)
[47.958701] Starting subtest: nb-await
[47.980263] Starting dynamic subtest: rcs0
[48.023332] Dynamic subtest rcs0: SUCCESS (0.053s)
[48.048551] Starting dynamic subtest: bcs0
[48.105581] Dynamic subtest bcs0: SUCCESS (0.052s)
[48.128853] Starting dynamic subtest: vcs0
[48.147473] Dynamic subtest vcs0: SUCCESS (0.053s)
[48.166163] Subtest nb-await: SUCCESS (0.159s)
[48.577920] [025/162] (945s left) gem_exec_gttfill (basic)
[48.731603] Starting subtest: basic
[50.813491] Subtest basic: SUCCESS (2.104s)
[51.002237] [026/162] (943s left) gem_exec_parallel (engines)
[51.257156] Starting subtest: engines
[51.278215] Starting dynamic subtest: basic
[52.648719] Dynamic subtest basic: SUCCESS (1.413s)
[52.673051] Starting dynamic subtest: contexts
[54.252168] Dynamic subtest contexts: SUCCESS (1.612s)
[54.278145] Starting dynamic subtest: fds
[56.016626] Dynamic subtest fds: SUCCESS (1.764s)
[56.044267] Starting dynamic subtest: userptr
[57.518785] Dynamic subtest userptr: SUCCESS (1.492s)
[57.538529] Subtest engines: SUCCESS (6.281s)
[57.718255] [027/162] (936s left) gem_exec_store (basic)
[57.952261] Starting subtest: basic
[57.971265] Subtest basic: SUCCESS (0.031s)
[58.088421] [028/162] (936s left) gem_flink_basic (bad-flink)
[58.254175] Starting subtest: bad-flink
[58.276107] Subtest bad-flink: SUCCESS (0.000s)
[58.352095] [029/162] (935s left) gem_flink_basic (bad-open)
[58.520490] Starting subtest: bad-open
[58.541625] Subtest bad-open: SUCCESS (0.000s)
[58.614365] [030/162] (935s left) gem_flink_basic (basic)
[58.787187] Starting subtest: basic
[58.809406] Subtest basic: SUCCESS (0.000s)
[58.897140] [031/162] (935s left) gem_flink_basic (double-flink)
[59.076411] Starting subtest: double-flink
[59.102488] Subtest double-flink: SUCCESS (0.000s)
[59.204146] [032/162] (935s left) gem_flink_basic (flink-lifetime)
[59.394686] Starting subtest: flink-lifetime
[59.422300] Subtest flink-lifetime: SUCCESS (0.001s)
[59.513443] [033/162] (934s left) gem_huc_copy (huc-copy)
[59.730771] Subtest huc-copy: SKIP (0.000s)
[59.822354] [034/162] (934s left) gem_linear_blits (basic)
[60.074211] Starting subtest: basic
[60.101160] Subtest basic: SUCCESS (0.005s)
[60.264339] [035/162] (934s left) gem_mmap (basic)
[60.541791] Starting subtest: basic
[60.641066] Subtest basic: SUCCESS (0.000s)
[60.721419] [036/162] (934s left) gem_mmap_gtt (basic)
[60.893184] Starting subtest: basic
[60.914947] Subtest basic: SUCCESS (0.000s)
[60.990894] [037/162] (933s left) gem_render_linear_blits (basic)
[61.162219] Starting subtest: basic
[61.261276] Subtest basic: SUCCESS (0.016s)
[61.340868] [038/162] (933s left) gem_render_tiled_blits (basic)
[61.510755] Starting subtest: basic
[61.632028] Subtest basic: SUCCESS (0.022s)
[61.710583] [039/162] (933s left) gem_ringfill (basic-all)
[61.963858] Starting subtest: basic-all
[63.042240] Subtest basic-all: SUCCESS (1.107s)
[63.155062] [040/162] (931s left) gem_softpin (allocator-basic)
[63.346042] Subtest allocator-basic: SKIP (0.000s)
[63.442912] [041/162] (931s left) gem_softpin (allocator-basic-reserve)
[63.619696] Subtest allocator-basic-reserve: SKIP (0.000s)
[63.719206] [042/162] (931s left) gem_softpin (safe-alignment)
[63.925342] Starting subtest: safe-alignment
[63.946202] Subtest safe-alignment: SUCCESS (0.005s)
[64.025179] [043/162] (931s left) gem_sync (basic-all)
[64.235737] Starting subtest: basic-all
[66.286816] Subtest basic-all: SUCCESS (2.121s)
[66.497046] [044/162] (928s left) gem_sync (basic-each)
[66.701471] Starting subtest: basic-each
[68.737905] Subtest basic-each: SUCCESS (2.087s)
[68.920214] [045/162] (926s left) gem_tiled_blits (basic)
[69.149630] Starting subtest: basic
[69.173180] Subtest basic: SUCCESS (0.012s)
[69.300699] [046/162] (926s left) gem_tiled_fence_blits (basic)
[69.607930] Starting subtest: basic
[69.627633] Subtest basic: SUCCESS (0.006s)
[69.755747] [047/162] (925s left) gem_tiled_pread_basic
[70.172974] [048/162] (925s left) gem_wait (busy@all-engines)
[70.346532] Starting subtest: busy
[70.366259] Starting dynamic subtest: all-engines
[70.840305] Dynamic subtest all-engines: SUCCESS (0.519s)
[70.860953] Subtest busy: SUCCESS (0.519s)
[71.042263] [049/162] (924s left) gem_wait (wait@all-engines)
[71.209560] Starting subtest: wait
[71.228970] Starting dynamic subtest: all-engines
[72.205768] Dynamic subtest all-engines: SUCCESS (1.015s)
[72.226575] Subtest wait: SUCCESS (1.015s)
[72.421266] [050/162] (923s left) i915_getparams_basic (basic-eu-total)
[72.591502] Starting subtest: basic-eu-total
[72.630426] Subtest basic-eu-total: SUCCESS (0.000s)
[72.708047] [051/162] (923s left) i915_getparams_basic (basic-subslice-total)
[72.853753] Starting subtest: basic-subslice-total
[72.895026] Subtest basic-subslice-total: SUCCESS (0.000s)
[72.974557] [052/162] (922s left) i915_hangman (error-state-basic)
[73.147311] Starting subtest: error-state-basic
[73.168229] Subtest error-state-basic: SUCCESS (0.004s)
[73.243580] [053/162] (922s left) i915_pciid
[73.507242] [054/162] (922s left) kms_addfb_basic (addfb25-bad-modifier)
[73.683119] Starting subtest: addfb25-bad-modifier
[73.702864] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[73.838309] [055/162] (922s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[74.004027] Starting subtest: addfb25-framebuffer-vs-set-tiling
[74.024956] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[74.099905] [056/162] (921s left) kms_addfb_basic (addfb25-modifier-no-flag)
[74.247308] Starting subtest: addfb25-modifier-no-flag
[74.267931] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[74.342579] [057/162] (921s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[74.511607] Starting subtest: addfb25-x-tiled-legacy
[74.530839] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[74.609987] [058/162] (921s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[74.769865] Starting subtest: addfb25-x-tiled-mismatch-legacy
[74.790191] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[74.870641] [059/162] (921s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[75.013761] Starting subtest: addfb25-yf-tiled-legacy
[75.035248] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[75.116532] [060/162] (921s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[75.279459] Starting subtest: addfb25-y-tiled-legacy
[75.300815] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[75.375215] [061/162] (921s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[75.544033] Starting subtest: addfb25-y-tiled-small-legacy
[75.581988] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[75.666196] [062/162] (920s left) kms_addfb_basic (bad-pitch-0)
[75.827465] Starting subtest: bad-pitch-0
[75.847911] Subtest bad-pitch-0: SUCCESS (0.000s)
[75.928559] [063/162] (920s left) kms_addfb_basic (bad-pitch-1024)
[76.093178] Starting subtest: bad-pitch-1024
[76.114718] Subtest bad-pitch-1024: SUCCESS (0.000s)
[76.190636] [064/162] (920s left) kms_addfb_basic (bad-pitch-128)
[76.358248] Starting subtest: bad-pitch-128
[76.378460] Subtest bad-pitch-128: SUCCESS (0.000s)
[76.451684] [065/162] (920s left) kms_addfb_basic (bad-pitch-256)
[76.618963] Starting subtest: bad-pitch-256
[76.638501] Subtest bad-pitch-256: SUCCESS (0.000s)
[76.720350] [066/162] (920s left) kms_addfb_basic (bad-pitch-32)
[76.881888] Starting subtest: bad-pitch-32
[76.903526] Subtest bad-pitch-32: SUCCESS (0.000s)
[76.987658] [067/162] (919s left) kms_addfb_basic (bad-pitch-63)
[77.151799] Starting subtest: bad-pitch-63
[77.173231] Subtest bad-pitch-63: SUCCESS (0.000s)
[77.249227] [068/162] (919s left) kms_addfb_basic (bad-pitch-65536)
[77.418066] Starting subtest: bad-pitch-65536
[77.437376] Subtest bad-pitch-65536: SUCCESS (0.000s)
[77.511744] [069/162] (919s left) kms_addfb_basic (bad-pitch-999)
[77.676973] Starting subtest: bad-pitch-999
[77.696204] Subtest bad-pitch-999: SUCCESS (0.000s)
[77.776857] [070/162] (919s left) kms_addfb_basic (basic)
[77.937657] Starting subtest: basic
[77.959691] Subtest basic: SUCCESS (0.000s)
[78.038510] [071/162] (919s left) kms_addfb_basic (basic-x-tiled-legacy)
[78.203612] Starting subtest: basic-x-tiled-legacy
[78.224815] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[78.298686] [072/162] (918s left) kms_addfb_basic (basic-y-tiled-legacy)
[78.465591] Starting subtest: basic-y-tiled-legacy
[78.484256] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[78.559472] [073/162] (918s left) kms_addfb_basic (bo-too-small)
[78.722865] Starting subtest: bo-too-small
[78.741651] Subtest bo-too-small: SUCCESS (0.000s)
[78.821170] [074/162] (918s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[78.981746] Starting subtest: bo-too-small-due-to-tiling
[79.000796] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[79.094330] [075/162] (918s left) kms_addfb_basic (clobberred-modifier)
[79.267634] Starting subtest: clobberred-modifier
[79.290958] Subtest clobberred-modifier: SUCCESS (0.000s)
[79.370233] [076/162] (917s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[79.545808] Starting subtest: framebuffer-vs-set-tiling
[79.568325] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[79.657752] [077/162] (917s left) kms_addfb_basic (invalid-get-prop)
[79.831099] Starting subtest: invalid-get-prop
[79.855067] Subtest invalid-get-prop: SUCCESS (0.000s)
[79.941476] [078/162] (917s left) kms_addfb_basic (invalid-get-prop-any)
[80.120032] Starting subtest: invalid-get-prop-any
[80.143076] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[80.221772] [079/162] (917s left) kms_addfb_basic (invalid-set-prop)
[80.405949] Starting subtest: invalid-set-prop
[80.429603] Subtest invalid-set-prop: SUCCESS (0.000s)
[80.517972] [080/162] (917s left) kms_addfb_basic (invalid-set-prop-any)
[80.691668] Starting subtest: invalid-set-prop-any
[80.715181] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[80.805869] [081/162] (916s left) kms_addfb_basic (no-handle)
[80.982606] Starting subtest: no-handle
[81.006806] Subtest no-handle: SUCCESS (0.000s)
[81.093341] [082/162] (916s left) kms_addfb_basic (size-max)
[81.272945] Starting subtest: size-max
[81.295102] Subtest size-max: SUCCESS (0.000s)
[81.378587] [083/162] (916s left) kms_addfb_basic (small-bo)
[81.555133] Starting subtest: small-bo
[81.577355] Subtest small-bo: SUCCESS (0.000s)
[81.662696] [084/162] (916s left) kms_addfb_basic (tile-pitch-mismatch)
[81.837239] Starting subtest: tile-pitch-mismatch
[81.861726] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[81.952420] [085/162] (916s left) kms_addfb_basic (too-high)
[82.118490] Starting subtest: too-high
[82.139052] Subtest too-high: SUCCESS (0.001s)
[82.215103] [086/162] (915s left) kms_addfb_basic (too-wide)
[82.382160] Starting subtest: too-wide
[82.401506] Subtest too-wide: SUCCESS (0.000s)
[82.475695] [087/162] (915s left) kms_addfb_basic (unused-handle)
[82.641882] Starting subtest: unused-handle
[82.661303] Subtest unused-handle: SUCCESS (0.000s)
[82.740998] [088/162] (915s left) kms_addfb_basic (unused-modifier)
[82.902176] Starting subtest: unused-modifier
[82.923947] Subtest unused-modifier: SUCCESS (0.000s)
[83.004591] [089/162] (915s left) kms_addfb_basic (unused-offsets)
[83.146532] Starting subtest: unused-offsets
[83.168379] Subtest unused-offsets: SUCCESS (0.000s)
[83.245560] [090/162] (915s left) kms_addfb_basic (unused-pitches)
[83.411795] Starting subtest: unused-pitches
[83.433823] Subtest unused-pitches: SUCCESS (0.000s)
[83.507898] [091/162] (914s left) kms_busy (basic)
[83.684041] Starting subtest: basic
[83.704119] Starting dynamic subtest: flip
[84.297976] Dynamic subtest flip: SUCCESS (0.633s)
[84.322756] Starting dynamic subtest: modeset
[84.809934] Dynamic subtest modeset: SUCCESS (0.507s)
[84.830189] Subtest basic: SUCCESS (1.141s)
[84.984362] [092/162] (913s left) kms_prop_blob (basic)
[85.165781] Starting subtest: basic
[85.185829] Subtest basic: SUCCESS (0.000s)
[85.283809] [093/162] (913s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[85.450134] Starting subtest: basic-busy-flip-before-cursor-atomic
[86.366987] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.938s)
[86.545537] [094/162] (912s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[86.721044] Starting subtest: basic-busy-flip-before-cursor-legacy
[87.628159] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.925s)
[87.791056] [095/162] (910s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[87.960450] Starting subtest: basic-flip-after-cursor-atomic
[88.882575] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.935s)
[89.042945] [096/162] (909s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[89.187070] Starting subtest: basic-flip-after-cursor-legacy
[90.117416] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.941s)
[90.285141] [097/162] (908s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[90.445119] Starting subtest: basic-flip-after-cursor-varying-size
[91.374073] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.939s)
[91.540341] [098/162] (907s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[91.700477] Starting subtest: basic-flip-before-cursor-atomic
[92.622783] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.935s)
[92.799261] [099/162] (906s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[92.965136] Starting subtest: basic-flip-before-cursor-legacy
[93.876884] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.935s)
[94.050717] [100/162] (905s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[94.221341] Starting subtest: basic-flip-before-cursor-varying-size
[95.136032] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.929s)
[95.297368] [101/162] (903s left) kms_flip (basic-flip-vs-dpms)
[95.493941] Starting subtest: basic-flip-vs-dpms
[95.512671] Starting dynamic subtest: A-VGA1
[96.403972] Dynamic subtest A-VGA1: SUCCESS (0.954s)
[96.429218] Starting dynamic subtest: B-VGA1
[97.294044] Dynamic subtest B-VGA1: SUCCESS (0.893s)
[97.322813] Starting dynamic subtest: C-VGA1
[98.186420] Dynamic subtest C-VGA1: SUCCESS (0.891s)
[98.205052] Subtest basic-flip-vs-dpms: SUCCESS (2.740s)
[98.364532] [102/162] (900s left) kms_flip (basic-flip-vs-modeset)
[98.553800] Starting subtest: basic-flip-vs-modeset
[98.578482] Starting dynamic subtest: A-VGA1
[99.382392] Dynamic subtest A-VGA1: SUCCESS (0.862s)
[99.410429] Starting dynamic subtest: B-VGA1
[100.174626] Dynamic subtest B-VGA1: SUCCESS (0.791s)
[100.201184] Starting dynamic subtest: C-VGA1
[100.965183] Dynamic subtest C-VGA1: SUCCESS (0.796s)
[100.985637] Subtest basic-flip-vs-modeset: SUCCESS (2.452s)
[101.139736] [103/162] (898s left) kms_flip (basic-flip-vs-wf_vblank)
[101.342635] Starting subtest: basic-flip-vs-wf_vblank
[101.363110] Starting dynamic subtest: A-VGA1
[102.435411] Dynamic subtest A-VGA1: SUCCESS (1.145s)
[102.461538] Starting dynamic subtest: B-VGA1
[103.582336] Dynamic subtest B-VGA1: SUCCESS (1.133s)
[103.615022] Starting dynamic subtest: C-VGA1
[104.697119] Dynamic subtest C-VGA1: SUCCESS (1.125s)
[104.719207] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.407s)
[104.918457] [104/162] (894s left) kms_flip (basic-plain-flip)
[105.120107] Starting subtest: basic-plain-flip
[105.140856] Starting dynamic subtest: A-VGA1
[105.948463] Dynamic subtest A-VGA1: SUCCESS (0.870s)
[105.979808] Starting dynamic subtest: B-VGA1
[106.798572] Dynamic subtest B-VGA1: SUCCESS (0.842s)
[106.829522] Starting dynamic subtest: C-VGA1
[107.630179] Dynamic subtest C-VGA1: SUCCESS (0.841s)
[107.650735] Subtest basic-plain-flip: SUCCESS (2.559s)
[107.844879] [105/162] (891s left) kms_force_connector_basic (force-connector-state)
[108.015601] Starting subtest: force-connector-state
[108.147816] Subtest force-connector-state: SUCCESS (0.138s)
[108.347822] [106/162] (891s left) kms_force_connector_basic (force-edid)
[108.515929] Starting subtest: force-edid
[108.553366] Subtest force-edid: SUCCESS (0.061s)
[108.693506] [107/162] (890s left) kms_force_connector_basic (force-load-detect)
[108.858605] Starting subtest: force-load-detect
[108.992835] Subtest force-load-detect: SUCCESS (0.150s)
[109.198479] [108/162] (890s left) kms_force_connector_basic (prune-stale-modes)
[109.360728] Starting subtest: prune-stale-modes
[109.379329] Subtest prune-stale-modes: SUCCESS (0.016s)
[109.501777] [109/162] (890s left) kms_frontbuffer_tracking (basic)
[109.736440] Starting subtest: basic
[111.504274] Subtest basic: SUCCESS (1.844s)
[111.601349] [110/162] (888s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[111.776961] Starting subtest: compare-crc-sanitycheck-xr24
[111.796522] Starting dynamic subtest: pipe-A-VGA-1
[112.020717] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.258s)
[112.045689] Starting dynamic subtest: pipe-B-VGA-1
[112.284878] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.266s)
[112.309536] Starting dynamic subtest: pipe-C-VGA-1
[112.556619] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.271s)
[112.576692] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.798s)
[112.729765] [111/162] (887s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[112.898998] Starting subtest: compare-crc-sanitycheck-nv12
[112.918371] Starting dynamic subtest: pipe-A-VGA-1
[112.957104] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s)
[112.983481] Starting dynamic subtest: pipe-B-VGA-1
[113.026906] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[113.053631] Starting dynamic subtest: pipe-C-VGA-1
[113.093964] Dynamic subtest pipe-C-VGA-1: SKIP (0.000s)
[113.133056] Subtest compare-crc-sanitycheck-nv12: SKIP (0.003s)
[113.216144] [112/162] (886s left) kms_pipe_crc_basic (hang-read-crc)
[113.378673] Starting subtest: hang-read-crc
[113.400564] Starting dynamic subtest: pipe-A-VGA-1
[114.133974] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.760s)
[114.158476] Starting dynamic subtest: pipe-B-VGA-1
[114.896714] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.766s)
[114.923392] Starting dynamic subtest: pipe-C-VGA-1
[115.671310] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.777s)
[115.692633] Subtest hang-read-crc: SUCCESS (2.306s)
[115.827159] [113/162] (884s left) kms_pipe_crc_basic (nonblocking-crc)
[115.995450] Starting subtest: nonblocking-crc
[116.014819] Starting dynamic subtest: pipe-A-VGA-1
[116.432485] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.444s)
[116.459961] Starting dynamic subtest: pipe-B-VGA-1
[116.886859] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.449s)
[116.911582] Starting dynamic subtest: pipe-C-VGA-1
[117.334918] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.456s)
[117.354956] Subtest nonblocking-crc: SUCCESS (1.352s)
[117.495867] [114/162] (882s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[117.666811] Starting subtest: nonblocking-crc-frame-sequence
[117.686192] Starting dynamic subtest: pipe-A-VGA-1
[118.094624] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.445s)
[118.120702] Starting dynamic subtest: pipe-B-VGA-1
[118.556220] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.449s)
[118.583753] Starting dynamic subtest: pipe-C-VGA-1
[119.001844] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.455s)
[119.020672] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.352s)
[119.163196] [115/162] (881s left) kms_pipe_crc_basic (read-crc)
[119.324781] Starting subtest: read-crc
[119.365893] Starting dynamic subtest: pipe-A-VGA-1
[119.713880] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.380s)
[119.750526] Starting dynamic subtest: pipe-B-VGA-1
[120.076445] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.380s)
[120.109972] Starting dynamic subtest: pipe-C-VGA-1
[120.477956] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.388s)
[120.504957] Subtest read-crc: SUCCESS (1.152s)
[120.642382] [116/162] (879s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[120.835488] Starting subtest: read-crc-frame-sequence
[120.859667] Starting dynamic subtest: pipe-A-VGA-1
[121.200506] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.379s)
[121.233332] Starting dynamic subtest: pipe-B-VGA-1
[121.568178] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.380s)
[121.604459] Starting dynamic subtest: pipe-C-VGA-1
[121.979438] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.386s)
[122.001758] Subtest read-crc-frame-sequence: SUCCESS (1.149s)
[122.138612] [117/162] (878s left) kms_psr (primary_page_flip)
[122.351538] Subtest primary_page_flip: SKIP (0.000s)
[122.448736] [118/162] (878s left) kms_psr (cursor_plane_move)
[122.665380] Subtest cursor_plane_move: SKIP (0.000s)
[122.752164] [119/162] (877s left) kms_psr (sprite_plane_onoff)
[122.973074] Subtest sprite_plane_onoff: SKIP (0.000s)
[123.065251] [120/162] (877s left) kms_psr (primary_mmap_gtt)
[123.280256] Subtest primary_mmap_gtt: SKIP (0.000s)
[123.373560] [121/162] (877s left) kms_setmode (basic-clone-single-crtc)
[123.541889] Starting subtest: basic-clone-single-crtc
[123.611101] Subtest basic-clone-single-crtc: SKIP (0.000s)
[123.689927] [122/162] (877s left) i915_pm_backlight (basic-brightness)
[123.872233] Subtest basic-brightness: SKIP (0.000s)
[123.950387] [123/162] (877s left) i915_pm_rpm (basic-pci-d3-state)
[135.458497] Subtest basic-pci-d3-state: SKIP (0.000s)
[135.535530] [124/162] (865s left) i915_pm_rpm (basic-rte)
[135.682943] Starting subtest: basic-rte
[146.848801] Subtest basic-rte: SKIP (11.103s)
[146.964122] [125/162] (854s left) i915_pm_rps (basic-api)
[147.121267] Starting subtest: basic-api
[147.140840] Subtest basic-api: SUCCESS (0.003s)
[147.240900] [126/162] (853s left) prime_self_import (basic-llseek-bad)
[147.392447] Starting subtest: basic-llseek-bad
[147.433313] Subtest basic-llseek-bad: SUCCESS (0.001s)
[147.515366] [127/162] (853s left) prime_self_import (basic-llseek-size)
[147.660814] Starting subtest: basic-llseek-size
[147.704537] Subtest basic-llseek-size: SUCCESS (0.002s)
[147.781570] [128/162] (853s left) prime_self_import (basic-with_fd_dup)
[147.931485] Starting subtest: basic-with_fd_dup
[147.972512] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[148.046993] [129/162] (853s left) prime_self_import (basic-with_one_bo)
[148.196121] Starting subtest: basic-with_one_bo
[148.234577] Subtest basic-with_one_bo: SUCCESS (0.002s)
[148.315084] [130/162] (853s left) prime_self_import (basic-with_one_bo_two_files)
[148.457204] Starting subtest: basic-with_one_bo_two_files
[148.498368] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[148.579304] [131/162] (853s left) prime_self_import (basic-with_two_bos)
[148.723604] Starting subtest: basic-with_two_bos
[148.767141] Subtest basic-with_two_bos: SUCCESS (0.002s)
[148.844407] [132/162] (852s left) prime_vgem (basic-fence-flip)
[149.037319] Starting subtest: basic-fence-flip
[149.321408] Subtest basic-fence-flip: SUCCESS (0.331s)
[149.446555] [133/162] (852s left) prime_vgem (basic-fence-mmap)
[149.635531] Starting subtest: basic-fence-mmap
[149.655200] Subtest basic-fence-mmap: SUCCESS (0.028s)
[149.756732] [134/162] (852s left) prime_vgem (basic-fence-read)
[149.945142] Starting subtest: basic-fence-read
[149.967523] Subtest basic-fence-read: SUCCESS (0.039s)
[150.065337] [135/162] (851s left) prime_vgem (basic-gtt)
[150.254609] Starting subtest: basic-gtt
[150.274358] Subtest basic-gtt: SUCCESS (0.011s)
[150.374287] [136/162] (851s left) prime_vgem (basic-read)
[150.559802] Starting subtest: basic-read
[150.581849] Subtest basic-read: SUCCESS (0.018s)
[150.681084] [137/162] (851s left) prime_vgem (basic-write)
[150.869614] Starting subtest: basic-write
[150.889649] Subtest basic-write: SUCCESS (0.018s)
[150.989174] [138/162] (851s left) vgem_basic (setversion)
[151.181545] Starting subtest: setversion
[151.224656] Subtest setversion: SUCCESS (0.000s)
[151.300866] [139/162] (850s left) vgem_basic (create)
[151.472061] Starting subtest: create
[151.491634] Subtest create: SUCCESS (0.000s)
[151.577501] [140/162] (850s left) vgem_basic (debugfs)
[151.742089] Starting subtest: debugfs
[151.761615] Subtest debugfs: SUCCESS (0.000s)
[151.846269] [141/162] (850s left) vgem_basic (dmabuf-export)
[152.012264] Starting subtest: dmabuf-export
[152.055104] Subtest dmabuf-export: SUCCESS (0.002s)
[152.131064] [142/162] (850s left) vgem_basic (dmabuf-fence)
[152.302645] Starting subtest: dmabuf-fence
[152.322300] Subtest dmabuf-fence: SUCCESS (0.001s)
[152.398184] [143/162] (850s left) vgem_basic (dmabuf-fence-before)
[152.584279] Starting subtest: dmabuf-fence-before
[152.605172] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[152.687317] [144/162] (849s left) vgem_basic (dmabuf-mmap)
[152.853508] Starting subtest: dmabuf-mmap
[152.874945] Subtest dmabuf-mmap: SUCCESS (0.016s)
[152.952795] [145/162] (849s left) vgem_basic (mmap)
[153.122377] Starting subtest: mmap
[153.142825] Subtest mmap: SUCCESS (0.010s)
[153.218686] [146/162] (849s left) vgem_basic (second-client)
[153.388145] Starting subtest: second-client
[153.427737] Subtest second-client: SUCCESS (0.033s)
[153.508804] [147/162] (849s left) vgem_basic (sysfs)
[153.652146] Starting subtest: sysfs
[153.672874] Subtest sysfs: SUCCESS (0.001s)
[153.755175] [148/162] (849s left) core_hotunplug (unbind-rebind)
[153.972262] Starting subtest: unbind-rebind
[156.702717] Subtest unbind-rebind: SUCCESS (2.716s)
[156.784041] [149/162] (846s left) vgem_basic (unload)
[156.928334] Starting subtest: unload
[186.021891] Subtest unload: SUCCESS (28.916s)
[186.100851] [150/162] (816s left) i915_module_load (reload)
[186.250404] Starting subtest: reload
[188.405640] Subtest reload: SUCCESS (2.146s)
[188.521270] [151/162] (814s left) gem_lmem_swapping (basic)
[188.764424] Subtest basic: SKIP (0.000s)
[188.864211] [152/162] (814s left) gem_lmem_swapping (parallel-random-engines)
[189.079714] Subtest parallel-random-engines: SKIP (0.000s)
[189.172764] [153/162] (814s left) gem_lmem_swapping (random-engines)
[189.389187] Subtest random-engines: SKIP (0.000s)
[189.487617] [154/162] (813s left) gem_lmem_swapping (verify-random)
[189.707420] Subtest verify-random: SKIP (0.000s)
[189.805070] [155/162] (813s left) i915_pm_rpm (module-reload)
[201.304518] Subtest module-reload: SKIP (0.000s)
[201.394812] [156/162] (802s left) i915_selftest (live)
[202.300343] Starting subtest: live
[202.319571] Starting dynamic subtest: sanitycheck
[202.953555] Dynamic subtest sanitycheck: SUCCESS (0.654s)
[202.985630] Starting dynamic subtest: uncore
[203.555465] Dynamic subtest uncore: SUCCESS (0.598s)
[203.581309] Starting dynamic subtest: workarounds
[204.241847] Dynamic subtest workarounds: SUCCESS (0.685s)
[204.269374] Starting dynamic subtest: gt_engines
[204.867260] Dynamic subtest gt_engines: SUCCESS (0.626s)
[204.895539] Starting dynamic subtest: gt_timelines
[210.249408] Dynamic subtest gt_timelines: SUCCESS (5.378s)
[210.277212] Starting dynamic subtest: gt_contexts
[210.921795] Dynamic subtest gt_contexts: SUCCESS (0.674s)
[210.947598] Starting dynamic subtest: gt_lrc
[211.551347] Dynamic subtest gt_lrc: SUCCESS (0.626s)
[211.578999] Starting dynamic subtest: gt_mocs
[212.170316] Dynamic subtest gt_mocs: SUCCESS (0.620s)
[212.195623] Starting dynamic subtest: gt_pm
[220.786548] Dynamic subtest gt_pm: SUCCESS (8.614s)
[220.812489] Starting dynamic subtest: gt_heartbeat
[221.497614] Dynamic subtest gt_heartbeat: SUCCESS (0.709s)
[221.523082] Starting dynamic subtest: gt_tlb
[222.132768] Dynamic subtest gt_tlb: SUCCESS (0.630s)
[222.161405] Starting dynamic subtest: requests
[227.406759] Dynamic subtest requests: SUCCESS (5.273s)
[227.434475] Starting dynamic subtest: migrate
[228.033711] Dynamic subtest migrate: SUCCESS (0.628s)
[228.059457] Starting dynamic subtest: active
[228.666045] Dynamic subtest active: SUCCESS (0.628s)
[228.693383] Starting dynamic subtest: objects
[229.724541] Dynamic subtest objects: SUCCESS (1.059s)
[229.753093] Starting dynamic subtest: mman
[233.718594] Dynamic subtest mman: SUCCESS (3.989s)
[233.746192] Starting dynamic subtest: dmabuf
[234.385185] Dynamic subtest dmabuf: SUCCESS (0.668s)
[234.410727] Starting dynamic subtest: vma
[235.040425] Dynamic subtest vma: SUCCESS (0.652s)
[235.066237] Starting dynamic subtest: coherency
[236.787604] Dynamic subtest coherency: SUCCESS (1.747s)
[236.816084] Starting dynamic subtest: gtt
[240.718540] Dynamic subtest gtt: SUCCESS (3.928s)
[240.746804] Starting dynamic subtest: gem
[241.403268] Dynamic subtest gem: SUCCESS (0.685s)
[241.433936] Starting dynamic subtest: evict
[242.023580] Dynamic subtest evict: SUCCESS (0.616s)
[242.050140] Starting dynamic subtest: hugepages
[243.719355] Dynamic subtest hugepages: SUCCESS (1.696s)
[243.745068] Starting dynamic subtest: gem_contexts
[248.088229] Dynamic subtest gem_contexts: SUCCESS (4.368s)
[248.120184] Starting dynamic subtest: client
[248.746612] Dynamic subtest client: SUCCESS (0.653s)
[248.774335] Starting dynamic subtest: gem_migrate
[249.372428] Dynamic subtest gem_migrate: SUCCESS (0.627s)
[249.398270] Starting dynamic subtest: reset
[250.020405] Dynamic subtest reset: SUCCESS (0.644s)
[250.048791] Starting dynamic subtest: memory_region
[250.655642] Dynamic subtest memory_region: SUCCESS (0.630s)
[250.687215] Starting dynamic subtest: hangcheck
[264.036966] Dynamic subtest hangcheck: SUCCESS (13.383s)
[264.062745] Starting dynamic subtest: execlists
[264.672382] Dynamic subtest execlists: SUCCESS (0.636s)
[264.700942] Starting dynamic subtest: ring_submission
[265.338051] Dynamic subtest ring_submission: SUCCESS (0.663s)
[265.363680] Starting dynamic subtest: perf
[266.007290] Dynamic subtest perf: SUCCESS (0.666s)
[266.036106] Starting dynamic subtest: slpc
[266.639500] Dynamic subtest slpc: SUCCESS (0.633s)
[266.665580] Starting dynamic subtest: guc
[267.274198] Dynamic subtest guc: SUCCESS (0.630s)
[267.302840] Starting dynamic subtest: guc_multi_lrc
[267.883141] Dynamic subtest guc_multi_lrc: SUCCESS (0.610s)
[267.912593] Starting dynamic subtest: guc_hang
[268.516779] Dynamic subtest guc_hang: SUCCESS (0.629s)
[268.544718] Starting dynamic subtest: late_gt_pm
[269.133395] Dynamic subtest late_gt_pm: SUCCESS (0.618s)
[269.152467] Subtest live: SUCCESS (66.836s)
[269.367295] [157/162] (734s left) dmabuf (all-tests)
[269.504764] Starting subtest: all-tests
[269.527290] Starting dynamic subtest: sanitycheck
[269.584834] Dynamic subtest sanitycheck: SUCCESS (0.081s)
[269.610117] Starting dynamic subtest: dma_fence
[269.762733] Dynamic subtest dma_fence: SUCCESS (0.177s)
[269.789296] Starting dynamic subtest: dma_fence_chain
[281.748989] Dynamic subtest dma_fence_chain: SUCCESS (11.984s)
[281.780387] Starting dynamic subtest: dma_fence_unwrap
[281.839073] Dynamic subtest dma_fence_unwrap: SUCCESS (0.086s)
[281.866279] Starting dynamic subtest: dma_resv
[281.918774] Dynamic subtest dma_resv: SUCCESS (0.080s)
[281.938334] Subtest all-tests: SUCCESS (12.417s)
[282.016744] [158/162] (721s left) i915_suspend (basic-s2idle-without-i915)
[282.169779] Starting subtest: basic-s2idle-without-i915
[300.270710] Subtest basic-s2idle-without-i915: SUCCESS (2.305s)
[303.396291] [159/162] (719s left) i915_suspend (basic-s3-without-i915)
[303.558593] Starting subtest: basic-s3-without-i915
[322.282577] Subtest basic-s3-without-i915: SUCCESS (2.042s)
[325.338608] [160/162] (717s left) gem_exec_suspend (basic-s0)
[325.537022] Starting subtest: basic-S0
[325.555360] Starting dynamic subtest: smem
[342.145873] Dynamic subtest smem: SUCCESS (1.495s)
[342.165330] Subtest basic-S0: SUCCESS (1.496s)
[345.506978] [161/162] (715s left) gem_exec_suspend (basic-s3)
[345.670120] Starting subtest: basic-S3
[345.691311] Starting dynamic subtest: smem
[363.051252] Dynamic subtest smem: SUCCESS (1.539s)
[363.069964] Subtest basic-S3: SUCCESS (1.540s)
[368.428226] [162/162] (713s left) kms_pipe_crc_basic (suspend-read-crc)
[368.587829] Starting subtest: suspend-read-crc
[368.609915] Starting dynamic subtest: pipe-A-VGA-1
[386.211248] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.657s)
[386.239770] Starting dynamic subtest: pipe-B-VGA-1
[404.229648] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.643s)
[404.256793] Starting dynamic subtest: pipe-C-VGA-1
[422.244736] Dynamic subtest pipe-C-VGA-1: SUCCESS (1.693s)
[422.263414] Subtest suspend-read-crc: SUCCESS (4.997s)
[425.369612] Closing watchdogs
Done.