[42.453210] Initializing watchdogs
[42.453287]   /dev/watchdog0
[42.458414] [001/165] (960s left) i915_module_load (load)
[42.518324] Starting subtest: load
[44.961143] Subtest load: SUCCESS (2.442s)
[44.974151] [002/165] (957s left) core_auth (basic-auth)
[45.049931] Starting subtest: basic-auth
[45.051098] Subtest basic-auth: SUCCESS (0.001s)
[45.108346] [003/165] (957s left) debugfs_test (read_all_entries)
[45.186039] Starting subtest: read_all_entries
[45.242616] Subtest read_all_entries: SUCCESS (0.056s)
[45.766866] [004/165] (957s left) debugfs_test (basic-hwmon)
[45.873289] Starting subtest: basic-hwmon
[45.874201] Subtest basic-hwmon: SKIP (0.000s)
[46.312033] [005/165] (956s left) fbdev (eof)
[46.393301] Starting subtest: eof
[46.393842] Subtest eof: SUCCESS (0.001s)
[46.463748] [006/165] (956s left) fbdev (info)
[46.533328] Starting subtest: info
[46.533935] Subtest info: SUCCESS (0.000s)
[46.591209] [007/165] (956s left) fbdev (nullptr)
[46.658179] Starting subtest: nullptr
[46.658808] Subtest nullptr: SUCCESS (0.000s)
[46.705748] [008/165] (956s left) fbdev (read)
[46.774795] Starting subtest: read
[46.993942] Subtest read: SUCCESS (0.219s)
[47.037559] [009/165] (956s left) fbdev (write)
[47.091063] Starting subtest: write
[47.209930] Subtest write: SUCCESS (0.118s)
[47.254809] [010/165] (955s left) gem_basic (bad-close)
[47.306958] Starting subtest: bad-close
[47.307845] Subtest bad-close: SUCCESS (0.000s)
[47.378743] [011/165] (955s left) gem_basic (create-close)
[47.444218] Starting subtest: create-close
[47.445262] Subtest create-close: SUCCESS (0.000s)
[47.525815] [012/165] (955s left) gem_basic (create-fd-close)
[47.593722] Starting subtest: create-fd-close
[47.595198] Subtest create-fd-close: SUCCESS (0.000s)
[47.654846] [013/165] (955s left) gem_busy (busy@all-engines)
[47.722896] Starting subtest: busy
[47.723649] Starting dynamic subtest: all-engines
[47.774455] Dynamic subtest all-engines: SUCCESS (0.051s)
[47.775213] Subtest busy: SUCCESS (0.052s)
[48.169842] [014/165] (955s left) gem_close_race (basic-process)
[48.250672] Starting subtest: basic-process
[48.305420] Subtest basic-process: SUCCESS (0.054s)
[48.520758] [015/165] (954s left) gem_close_race (basic-threads)
[48.600695] Starting subtest: basic-threads
[49.863413] Subtest basic-threads: SUCCESS (1.263s)
[50.077773] [016/165] (953s left) gem_ctx_create (basic)
[50.147283] Starting subtest: basic
[50.147880] Subtest basic: SUCCESS (0.000s)
[50.352450] [017/165] (952s left) gem_ctx_create (basic-files)
[50.436488] Starting subtest: basic-files
[52.452911] Subtest basic-files: SUCCESS (2.017s)
[52.669950] [018/165] (950s left) gem_ctx_exec (basic)
[52.749011] Starting subtest: basic
[52.752151] Subtest basic: SUCCESS (0.003s)
[52.873129] [019/165] (950s left) gem_exec_basic (basic)
[52.961594] Starting subtest: basic
[52.962166] Starting dynamic subtest: rcs0-smem
[52.963215] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[52.968466] Starting dynamic subtest: bcs0-smem
[52.969188] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[52.973960] Starting dynamic subtest: vcs0-smem
[52.974890] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[52.980456] Starting dynamic subtest: vcs1-smem
[52.981107] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[52.985858] Starting dynamic subtest: vecs0-smem
[52.986810] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[52.987488] Subtest basic: SUCCESS (0.005s)
[53.194503] [020/165] (950s left) gem_exec_create (basic)
[53.262786] Starting subtest: basic
[53.266123] Starting dynamic subtest: smem
[55.302913] Dynamic subtest smem: SUCCESS (2.040s)
[55.303514] Subtest basic: SUCCESS (2.040s)
[55.503187] [021/165] (947s left) gem_exec_fence (basic-busy)
[55.693777] Starting subtest: basic-busy
[55.694963] Starting dynamic subtest: rcs0
[55.722267] Dynamic subtest rcs0: SUCCESS (0.028s)
[55.733261] Starting dynamic subtest: bcs0
[55.752191] Dynamic subtest bcs0: SUCCESS (0.028s)
[55.763419] Starting dynamic subtest: vcs0
[55.776431] Dynamic subtest vcs0: SUCCESS (0.024s)
[55.787368] Starting dynamic subtest: vcs1
[55.797134] Dynamic subtest vcs1: SUCCESS (0.023s)
[55.806609] Starting dynamic subtest: vecs0
[55.815155] Dynamic subtest vecs0: SUCCESS (0.018s)
[55.815844] Subtest basic-busy: SUCCESS (0.122s)
[56.470108] [022/165] (946s left) gem_exec_fence (basic-wait)
[56.674505] Starting subtest: basic-wait
[56.675611] Starting dynamic subtest: rcs0
[56.702415] Dynamic subtest rcs0: SUCCESS (0.028s)
[56.714612] Starting dynamic subtest: bcs0
[56.727462] Dynamic subtest bcs0: SUCCESS (0.025s)
[56.738179] Starting dynamic subtest: vcs0
[56.759637] Dynamic subtest vcs0: SUCCESS (0.032s)
[56.770610] Starting dynamic subtest: vcs1
[56.785172] Dynamic subtest vcs1: SUCCESS (0.023s)
[56.796444] Starting dynamic subtest: vecs0
[56.807633] Dynamic subtest vecs0: SUCCESS (0.025s)
[56.808736] Subtest basic-wait: SUCCESS (0.133s)
[57.437810] [023/165] (946s left) gem_exec_fence (basic-await)
[57.649987] Starting subtest: basic-await
[57.651356] Starting dynamic subtest: rcs0
[57.759863] Dynamic subtest rcs0: SUCCESS (0.110s)
[57.767072] Starting dynamic subtest: bcs0
[57.861412] Dynamic subtest bcs0: SUCCESS (0.101s)
[57.869689] Starting dynamic subtest: vcs0
[57.968520] Dynamic subtest vcs0: SUCCESS (0.107s)
[57.975655] Starting dynamic subtest: vcs1
[58.078593] Dynamic subtest vcs1: SUCCESS (0.110s)
[58.088771] Starting dynamic subtest: vecs0
[58.192421] Dynamic subtest vecs0: SUCCESS (0.114s)
[58.193330] Subtest basic-await: SUCCESS (0.543s)
[58.838875] [024/165] (944s left) gem_exec_fence (nb-await)
[59.059723] Starting subtest: nb-await
[59.061188] Starting dynamic subtest: rcs0
[59.131108] Dynamic subtest rcs0: SUCCESS (0.069s)
[59.141766] Starting dynamic subtest: bcs0
[59.203857] Dynamic subtest bcs0: SUCCESS (0.070s)
[59.228234] Starting dynamic subtest: vcs0
[59.288649] Dynamic subtest vcs0: SUCCESS (0.086s)
[59.312843] Starting dynamic subtest: vcs1
[59.375858] Dynamic subtest vcs1: SUCCESS (0.088s)
[59.402539] Starting dynamic subtest: vecs0
[59.470198] Dynamic subtest vecs0: SUCCESS (0.092s)
[59.472741] Subtest nb-await: SUCCESS (0.410s)
[60.136767] [025/165] (943s left) gem_exec_gttfill (basic)
[60.204276] Starting subtest: basic
[68.180930] Subtest basic: SUCCESS (7.977s)
[68.340140] [026/165] (935s left) gem_exec_parallel (engines)
[68.470287] Starting subtest: engines
[68.470938] Starting dynamic subtest: basic
[70.539693] Dynamic subtest basic: SUCCESS (2.070s)
[70.545841] Starting dynamic subtest: contexts
[75.359886] Dynamic subtest contexts: SUCCESS (4.820s)
[75.366249] Starting dynamic subtest: fds
[80.107313] Dynamic subtest fds: SUCCESS (4.747s)
[80.113982] Starting dynamic subtest: userptr
[82.059705] Dynamic subtest userptr: SUCCESS (1.952s)
[82.060378] Subtest engines: SUCCESS (13.589s)
[82.257317] [027/165] (921s left) gem_exec_store (basic)
[82.320714] Starting subtest: basic
[82.366857] Subtest basic: SUCCESS (0.046s)
[82.572578] [028/165] (920s left) gem_flink_basic (bad-flink)
[82.646965] Starting subtest: bad-flink
[82.647582] Subtest bad-flink: SUCCESS (0.000s)
[82.706210] [029/165] (920s left) gem_flink_basic (bad-open)
[82.762191] Starting subtest: bad-open
[82.762781] Subtest bad-open: SUCCESS (0.000s)
[82.823566] [030/165] (920s left) gem_flink_basic (basic)
[82.877575] Starting subtest: basic
[82.878303] Subtest basic: SUCCESS (0.000s)
[82.969163] [031/165] (920s left) gem_flink_basic (double-flink)
[83.037238] Starting subtest: double-flink
[83.037864] Subtest double-flink: SUCCESS (0.000s)
[83.108368] [032/165] (920s left) gem_flink_basic (flink-lifetime)
[83.168592] Starting subtest: flink-lifetime
[83.169932] Subtest flink-lifetime: SUCCESS (0.001s)
[83.243953] [033/165] (920s left) gem_huc_copy (huc-copy)
[83.316636] Starting subtest: huc-copy
[83.318979] Subtest huc-copy: SKIP (0.000s)
[83.395361] [034/165] (920s left) gem_linear_blits (basic)
[83.562943] Starting subtest: basic
[83.573468] Subtest basic: SUCCESS (0.011s)
[83.729600] [035/165] (919s left) gem_mmap (basic)
[83.858226] Starting subtest: basic
[83.860656] Subtest basic: SUCCESS (0.000s)
[83.924645] [036/165] (919s left) gem_mmap_gtt (basic)
[83.986199] Starting subtest: basic
[83.986813] Subtest basic: SUCCESS (0.000s)
[84.032743] [037/165] (919s left) gem_render_linear_blits (basic)
[84.090380] Starting subtest: basic
[84.121669] Subtest basic: SUCCESS (0.031s)
[84.165603] [038/165] (919s left) gem_render_tiled_blits (basic)
[84.223016] Starting subtest: basic
[84.257303] Subtest basic: SUCCESS (0.035s)
[84.298618] [039/165] (919s left) gem_ringfill (basic-all)
[84.571999] Starting subtest: basic-all
[85.746309] Subtest basic-all: SUCCESS (1.175s)
[85.846853] [040/165] (917s left) gem_softpin (allocator-basic)
[85.921256] Starting subtest: allocator-basic
[86.023152] Subtest allocator-basic: SUCCESS (0.102s)
[86.113300] [041/165] (917s left) gem_softpin (allocator-basic-reserve)
[86.182301] Starting subtest: allocator-basic-reserve
[86.290042] Subtest allocator-basic-reserve: SUCCESS (0.107s)
[86.394689] [042/165] (917s left) gem_softpin (safe-alignment)
[86.464880] Starting subtest: safe-alignment
[86.477822] Subtest safe-alignment: SUCCESS (0.013s)
[86.578899] [043/165] (917s left) gem_sync (basic-all)
[86.650144] Starting subtest: basic-all
[88.758041] Subtest basic-all: SUCCESS (2.108s)
[88.958252] [044/165] (914s left) gem_sync (basic-each)
[89.043844] Starting subtest: basic-each
[91.195982] Subtest basic-each: SUCCESS (2.152s)
[91.425691] [045/165] (912s left) gem_tiled_blits (basic)
[91.640545] Starting subtest: basic
[91.663734] Subtest basic: SUCCESS (0.022s)
[91.809549] [046/165] (912s left) gem_tiled_fence_blits (basic)
[92.093903] Starting subtest: basic
[92.103095] Subtest basic: SUCCESS (0.009s)
[92.247884] [047/165] (911s left) gem_tiled_pread_basic
[92.591892] [048/165] (911s left) gem_wait (busy@all-engines)
[92.669241] Starting subtest: busy
[92.669942] Starting dynamic subtest: all-engines
[93.190929] Dynamic subtest all-engines: SUCCESS (0.522s)
[93.191494] Subtest busy: SUCCESS (0.522s)
[93.388028] [049/165] (910s left) gem_wait (wait@all-engines)
[93.465337] Starting subtest: wait
[93.465996] Starting dynamic subtest: all-engines
[94.497864] Dynamic subtest all-engines: SUCCESS (1.032s)
[94.500572] Subtest wait: SUCCESS (1.033s)
[94.788708] [050/165] (909s left) i915_getparams_basic (basic-eu-total)
[94.867877] Starting subtest: basic-eu-total
[94.868936] Subtest basic-eu-total: SUCCESS (0.000s)
[94.924348] [051/165] (909s left) i915_getparams_basic (basic-subslice-total)
[94.980187] Starting subtest: basic-subslice-total
[94.981330] Subtest basic-subslice-total: SUCCESS (0.000s)
[95.039757] [052/165] (909s left) i915_hangman (error-state-basic)
[95.105448] Starting subtest: error-state-basic
[95.113054] Subtest error-state-basic: SUCCESS (0.007s)
[95.172709] [053/165] (908s left) i915_pciid
[95.291278] [054/165] (908s left) kms_addfb_basic (addfb25-4-tiled)
[95.743826] Starting subtest: addfb25-4-tiled
[95.744381] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[95.827523] [055/165] (908s left) kms_addfb_basic (addfb25-bad-modifier)
[95.892742] Starting subtest: addfb25-bad-modifier
[95.893377] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[96.359331] [056/165] (907s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[96.444833] Starting subtest: addfb25-framebuffer-vs-set-tiling
[96.445342] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[96.938142] [057/165] (907s left) kms_addfb_basic (addfb25-modifier-no-flag)
[97.006335] Starting subtest: addfb25-modifier-no-flag
[97.006998] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[97.500908] [058/165] (906s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[97.561653] Starting subtest: addfb25-x-tiled-legacy
[97.562278] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[98.058527] [059/165] (906s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[98.133195] Starting subtest: addfb25-x-tiled-mismatch-legacy
[98.133826] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[98.635082] [060/165] (905s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[99.082580] Starting subtest: addfb25-yf-tiled-legacy
[99.083298] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[99.201571] [061/165] (905s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[99.644826] Starting subtest: addfb25-y-tiled-legacy
[99.645736] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[99.773814] [062/165] (904s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[100.250575] Starting subtest: addfb25-y-tiled-small-legacy
[100.251660] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[100.347433] [063/165] (904s left) kms_addfb_basic (bad-pitch-0)
[100.427308] Starting subtest: bad-pitch-0
[100.427882] Subtest bad-pitch-0: SUCCESS (0.000s)
[100.927214] [064/165] (903s left) kms_addfb_basic (bad-pitch-1024)
[100.997734] Starting subtest: bad-pitch-1024
[100.998287] Subtest bad-pitch-1024: SUCCESS (0.000s)
[101.469270] [065/165] (903s left) kms_addfb_basic (bad-pitch-128)
[101.533997] Starting subtest: bad-pitch-128
[101.534513] Subtest bad-pitch-128: SUCCESS (0.000s)
[102.026306] [066/165] (902s left) kms_addfb_basic (bad-pitch-256)
[102.103902] Starting subtest: bad-pitch-256
[102.104551] Subtest bad-pitch-256: SUCCESS (0.000s)
[102.600154] [067/165] (902s left) kms_addfb_basic (bad-pitch-32)
[102.665345] Starting subtest: bad-pitch-32
[102.666041] Subtest bad-pitch-32: SUCCESS (0.000s)
[103.168696] [068/165] (901s left) kms_addfb_basic (bad-pitch-63)
[103.230758] Starting subtest: bad-pitch-63
[103.231436] Subtest bad-pitch-63: SUCCESS (0.000s)
[103.743801] [069/165] (900s left) kms_addfb_basic (bad-pitch-65536)
[103.835614] Starting subtest: bad-pitch-65536
[103.836195] Subtest bad-pitch-65536: SUCCESS (0.000s)
[104.327895] [070/165] (900s left) kms_addfb_basic (bad-pitch-999)
[104.402509] Starting subtest: bad-pitch-999
[104.403009] Subtest bad-pitch-999: SUCCESS (0.000s)
[104.909381] [071/165] (899s left) kms_addfb_basic (basic)
[104.985856] Starting subtest: basic
[104.986444] Subtest basic: SUCCESS (0.000s)
[105.482750] [072/165] (899s left) kms_addfb_basic (basic-x-tiled-legacy)
[105.544749] Starting subtest: basic-x-tiled-legacy
[105.545349] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[106.055100] [073/165] (898s left) kms_addfb_basic (basic-y-tiled-legacy)
[106.121463] Starting subtest: basic-y-tiled-legacy
[106.122184] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[106.614844] [074/165] (898s left) kms_addfb_basic (bo-too-small)
[107.096669] Starting subtest: bo-too-small
[107.097341] Subtest bo-too-small: SUCCESS (0.000s)
[107.186068] [075/165] (897s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[107.643535] Starting subtest: bo-too-small-due-to-tiling
[107.644232] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[107.722990] [076/165] (897s left) kms_addfb_basic (clobberred-modifier)
[107.811870] Starting subtest: clobberred-modifier
[107.812364] Subtest clobberred-modifier: SUCCESS (0.000s)
[108.299444] [077/165] (896s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[108.383347] Starting subtest: framebuffer-vs-set-tiling
[108.383931] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[108.892244] [078/165] (896s left) kms_addfb_basic (invalid-get-prop)
[108.964242] Starting subtest: invalid-get-prop
[108.964812] Subtest invalid-get-prop: SUCCESS (0.000s)
[109.468755] [079/165] (895s left) kms_addfb_basic (invalid-get-prop-any)
[109.531171] Starting subtest: invalid-get-prop-any
[109.531762] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[110.025879] [080/165] (895s left) kms_addfb_basic (invalid-set-prop)
[110.094261] Starting subtest: invalid-set-prop
[110.094857] Subtest invalid-set-prop: SUCCESS (0.000s)
[110.609238] [081/165] (894s left) kms_addfb_basic (invalid-set-prop-any)
[110.685455] Starting subtest: invalid-set-prop-any
[110.686035] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[111.137974] [082/165] (894s left) kms_addfb_basic (no-handle)
[111.207796] Starting subtest: no-handle
[111.208524] Subtest no-handle: SUCCESS (0.000s)
[111.726967] [083/165] (893s left) kms_addfb_basic (size-max)
[112.179662] Starting subtest: size-max
[112.180355] Subtest size-max: SUCCESS (0.000s)
[112.290798] [084/165] (893s left) kms_addfb_basic (small-bo)
[112.730329] Starting subtest: small-bo
[112.731186] Subtest small-bo: SUCCESS (0.000s)
[112.832140] [085/165] (892s left) kms_addfb_basic (tile-pitch-mismatch)
[112.894758] Starting subtest: tile-pitch-mismatch
[112.895315] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[113.400807] [086/165] (892s left) kms_addfb_basic (too-high)
[113.842897] Starting subtest: too-high
[113.843768] Subtest too-high: SUCCESS (0.001s)
[113.964148] [087/165] (891s left) kms_addfb_basic (too-wide)
[114.426820] Starting subtest: too-wide
[114.427638] Subtest too-wide: SUCCESS (0.000s)
[114.555066] [088/165] (890s left) kms_addfb_basic (unused-handle)
[114.628788] Starting subtest: unused-handle
[114.629516] Subtest unused-handle: SUCCESS (0.000s)
[115.130103] [089/165] (890s left) kms_addfb_basic (unused-modifier)
[115.206237] Starting subtest: unused-modifier
[115.206881] Subtest unused-modifier: SUCCESS (0.000s)
[115.683496] [090/165] (889s left) kms_addfb_basic (unused-offsets)
[115.763371] Starting subtest: unused-offsets
[115.763959] Subtest unused-offsets: SUCCESS (0.000s)
[116.256470] [091/165] (889s left) kms_addfb_basic (unused-pitches)
[116.328249] Starting subtest: unused-pitches
[116.328806] Subtest unused-pitches: SUCCESS (0.000s)
[116.812618] [092/165] (888s left) kms_busy (basic)
[117.268790] Starting subtest: basic
[117.271121] Starting dynamic subtest: flip
[117.982798] Dynamic subtest flip: SUCCESS (0.711s)
[117.990319] Starting dynamic subtest: modeset
[119.137308] Dynamic subtest modeset: SUCCESS (1.155s)
[119.138022] Subtest basic: SUCCESS (1.869s)
[119.442406] [093/165] (886s left) kms_prop_blob (basic)
[119.525323] Starting subtest: basic
[119.525917] Subtest basic: SUCCESS (0.000s)
[119.573775] [094/165] (886s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[119.998912] Starting subtest: basic-busy-flip-before-cursor-atomic
[120.000429] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[120.088838] [095/165] (885s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[120.539096] Starting subtest: basic-busy-flip-before-cursor-legacy
[120.540771] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[120.619290] [096/165] (885s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[121.073579] Starting subtest: basic-flip-after-cursor-atomic
[122.048849] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.975s)
[122.324541] [097/165] (883s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[122.751745] Starting subtest: basic-flip-after-cursor-legacy
[123.731727] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.979s)
[124.005544] [098/165] (881s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[124.440947] Starting subtest: basic-flip-after-cursor-varying-size
[125.420468] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.980s)
[125.681318] [099/165] (880s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[126.121752] Starting subtest: basic-flip-before-cursor-atomic
[127.114409] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.992s)
[127.384661] [100/165] (878s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[127.838757] Starting subtest: basic-flip-before-cursor-legacy
[128.824731] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.985s)
[129.079168] [101/165] (876s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[129.509815] Starting subtest: basic-flip-before-cursor-varying-size
[130.486810] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.978s)
[130.761162] [102/165] (875s left) kms_dsc (dsc-basic)
[131.202107] Subtest dsc-basic: SKIP (0.000s)
[131.232166] [103/165] (874s left) kms_flip (basic-flip-vs-dpms)
[131.693112] Starting subtest: basic-flip-vs-dpms
[131.695588] Starting dynamic subtest: A-DP1
[132.910604] Dynamic subtest A-DP1: SUCCESS (1.212s)
[132.928511] Starting dynamic subtest: B-DP1
[133.944343] Dynamic subtest B-DP1: SUCCESS (1.032s)
[133.966454] Starting dynamic subtest: C-DP1
[134.962825] Dynamic subtest C-DP1: SUCCESS (1.009s)
[134.964426] Subtest basic-flip-vs-dpms: SUCCESS (3.268s)
[135.286938] [104/165] (870s left) kms_flip (basic-flip-vs-modeset)
[135.732522] Starting subtest: basic-flip-vs-modeset
[135.735695] Starting dynamic subtest: A-DP1
[136.974418] Dynamic subtest A-DP1: SUCCESS (1.236s)
[136.989456] Starting dynamic subtest: B-DP1
[138.152461] Dynamic subtest B-DP1: SUCCESS (1.173s)
[138.169944] Starting dynamic subtest: C-DP1
[139.316539] Dynamic subtest C-DP1: SUCCESS (1.165s)
[139.320819] Subtest basic-flip-vs-modeset: SUCCESS (3.588s)
[139.648111] [105/165] (866s left) kms_flip (basic-flip-vs-wf_vblank)
[140.150560] Starting subtest: basic-flip-vs-wf_vblank
[140.152863] Starting dynamic subtest: A-DP1
[141.445292] Dynamic subtest A-DP1: SUCCESS (1.290s)
[141.454480] Starting dynamic subtest: B-DP1
[142.726181] Dynamic subtest B-DP1: SUCCESS (1.280s)
[142.734666] Starting dynamic subtest: C-DP1
[143.998581] Dynamic subtest C-DP1: SUCCESS (1.273s)
[144.000993] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.851s)
[144.333765] [106/165] (861s left) kms_flip (basic-plain-flip)
[144.800949] Starting subtest: basic-plain-flip
[144.805841] Starting dynamic subtest: A-DP1
[145.847984] Dynamic subtest A-DP1: SUCCESS (1.037s)
[145.873936] Starting dynamic subtest: B-DP1
[146.850743] Dynamic subtest B-DP1: SUCCESS (0.997s)
[146.859507] Starting dynamic subtest: C-DP1
[147.843746] Dynamic subtest C-DP1: SUCCESS (0.994s)
[147.845920] Subtest basic-plain-flip: SUCCESS (3.046s)
[148.193719] [107/165] (857s left) kms_force_connector_basic (force-connector-state)
[148.464150] Starting subtest: force-connector-state
[149.364992] Subtest force-connector-state: SUCCESS (0.902s)
[150.256180] [108/165] (855s left) kms_force_connector_basic (force-edid)
[150.532346] Starting subtest: force-edid
[150.944167] Subtest force-edid: SUCCESS (0.412s)
[151.562432] [109/165] (854s left) kms_force_connector_basic (force-load-detect)
[151.847654] Starting subtest: force-load-detect
[151.854230] Subtest force-load-detect: SKIP (0.000s)
[152.325248] [110/165] (853s left) kms_force_connector_basic (prune-stale-modes)
[152.578694] Starting subtest: prune-stale-modes
[153.040874] Subtest prune-stale-modes: SUCCESS (0.459s)
[153.681693] [111/165] (852s left) kms_frontbuffer_tracking (basic)
[154.166899] Starting subtest: basic
[156.903537] Subtest basic: SUCCESS (2.733s)
[157.009805] [112/165] (849s left) kms_hdmi_inject (inject-audio)
[157.139159] Starting subtest: inject-audio
[157.627349] Subtest inject-audio: SUCCESS (0.484s)
[158.198439] [113/165] (848s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[158.654520] Starting subtest: compare-crc-sanitycheck-xr24
[158.656184] Starting dynamic subtest: pipe-A-DP-1
[159.153925] Dynamic subtest pipe-A-DP-1: SUCCESS (0.496s)
[159.168091] Starting dynamic subtest: pipe-B-DP-1
[159.722300] Dynamic subtest pipe-B-DP-1: SUCCESS (0.562s)
[159.742437] Starting dynamic subtest: pipe-C-DP-1
[160.320997] Dynamic subtest pipe-C-DP-1: SUCCESS (0.590s)
[160.322214] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.665s)
[160.621216] [114/165] (845s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[161.075024] Starting subtest: compare-crc-sanitycheck-nv12
[161.077926] Starting dynamic subtest: pipe-A-DP-1
[161.570520] Dynamic subtest pipe-A-DP-1: SUCCESS (0.493s)
[161.582206] Starting dynamic subtest: pipe-B-DP-1
[162.166256] Dynamic subtest pipe-B-DP-1: SUCCESS (0.592s)
[162.178817] Starting dynamic subtest: pipe-C-DP-1
[162.180058] Dynamic subtest pipe-C-DP-1: SKIP (0.001s)
[162.180642] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.098s)
[162.467594] [115/165] (844s left) kms_pipe_crc_basic (hang-read-crc)
[162.903257] Starting subtest: hang-read-crc
[162.905763] Starting dynamic subtest: pipe-A-DP-1
[164.207111] Dynamic subtest pipe-A-DP-1: SUCCESS (1.298s)
[164.219955] Starting dynamic subtest: pipe-B-DP-1
[165.622188] Dynamic subtest pipe-B-DP-1: SUCCESS (1.413s)
[165.635284] Starting dynamic subtest: pipe-C-DP-1
[167.015638] Dynamic subtest pipe-C-DP-1: SUCCESS (1.389s)
[167.019745] Subtest hang-read-crc: SUCCESS (4.113s)
[167.264478] [116/165] (839s left) kms_pipe_crc_basic (nonblocking-crc)
[167.764263] Starting subtest: nonblocking-crc
[167.765895] Starting dynamic subtest: pipe-A-DP-1
[168.444565] Dynamic subtest pipe-A-DP-1: SUCCESS (0.677s)
[168.457879] Starting dynamic subtest: pipe-B-DP-1
[169.231969] Dynamic subtest pipe-B-DP-1: SUCCESS (0.781s)
[169.254255] Starting dynamic subtest: pipe-C-DP-1
[170.015662] Dynamic subtest pipe-C-DP-1: SUCCESS (0.777s)
[170.018410] Subtest nonblocking-crc: SUCCESS (2.253s)
[170.275523] [117/165] (836s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[170.763707] Starting subtest: nonblocking-crc-frame-sequence
[170.766855] Starting dynamic subtest: pipe-A-DP-1
[171.439071] Dynamic subtest pipe-A-DP-1: SUCCESS (0.670s)
[171.454942] Starting dynamic subtest: pipe-B-DP-1
[172.208203] Dynamic subtest pipe-B-DP-1: SUCCESS (0.766s)
[172.223830] Starting dynamic subtest: pipe-C-DP-1
[172.997274] Dynamic subtest pipe-C-DP-1: SUCCESS (0.777s)
[172.998161] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.229s)
[173.238952] [118/165] (833s left) kms_pipe_crc_basic (read-crc)
[173.713097] Starting subtest: read-crc
[173.715038] Starting dynamic subtest: pipe-A-DP-1
[174.320897] Dynamic subtest pipe-A-DP-1: SUCCESS (0.604s)
[174.334842] Starting dynamic subtest: pipe-B-DP-1
[175.023032] Dynamic subtest pipe-B-DP-1: SUCCESS (0.694s)
[175.039522] Starting dynamic subtest: pipe-C-DP-1
[175.732499] Dynamic subtest pipe-C-DP-1: SUCCESS (0.706s)
[175.733422] Subtest read-crc: SUCCESS (2.020s)
[175.980749] [119/165] (830s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[176.462203] Starting subtest: read-crc-frame-sequence
[176.464283] Starting dynamic subtest: pipe-A-DP-1
[177.070196] Dynamic subtest pipe-A-DP-1: SUCCESS (0.603s)
[177.086510] Starting dynamic subtest: pipe-B-DP-1
[177.764776] Dynamic subtest pipe-B-DP-1: SUCCESS (0.693s)
[177.780746] Starting dynamic subtest: pipe-C-DP-1
[178.477212] Dynamic subtest pipe-C-DP-1: SUCCESS (0.702s)
[178.478402] Subtest read-crc-frame-sequence: SUCCESS (2.011s)
[178.757460] [120/165] (827s left) kms_pm_backlight (basic-brightness)
[179.214928] Subtest basic-brightness: SKIP (0.000s)
[179.251928] [121/165] (827s left) kms_pm_rpm (basic-pci-d3-state)
[181.251910] Starting subtest: basic-pci-d3-state
[181.816348] Subtest basic-pci-d3-state: SUCCESS (0.562s)
[182.120219] [122/165] (824s left) kms_pm_rpm (basic-rte)
[182.203015] Starting subtest: basic-rte
[184.866188] Subtest basic-rte: SUCCESS (2.661s)
[185.864606] [123/165] (820s left) kms_psr (psr_primary_page_flip)
[186.351157] [124/165] (820s left) kms_psr (psr_cursor_plane_move)
[186.831157] [125/165] (820s left) kms_psr (psr_sprite_plane_onoff)
[187.318725] [126/165] (819s left) kms_psr (psr_primary_mmap_gtt)
[187.816272] [127/165] (819s left) kms_setmode (basic-clone-single-crtc)
[187.885143] Starting subtest: basic-clone-single-crtc
[187.886987] Subtest basic-clone-single-crtc: SKIP (0.000s)
[187.963640] [128/165] (818s left) i915_pm_rps (basic-api)
[188.025641] Starting subtest: basic-api
[188.029261] Subtest basic-api: SUCCESS (0.004s)
[188.116953] [129/165] (818s left) prime_self_import (basic-llseek-bad)
[188.177949] Starting subtest: basic-llseek-bad
[188.181015] Subtest basic-llseek-bad: SUCCESS (0.002s)
[188.259877] [130/165] (818s left) prime_self_import (basic-llseek-size)
[188.325088] Starting subtest: basic-llseek-size
[188.326215] Subtest basic-llseek-size: SUCCESS (0.002s)
[188.390971] [131/165] (818s left) prime_self_import (basic-with_fd_dup)
[188.449639] Starting subtest: basic-with_fd_dup
[188.452811] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[188.529724] [132/165] (818s left) prime_self_import (basic-with_one_bo)
[188.596114] Starting subtest: basic-with_one_bo
[188.599209] Subtest basic-with_one_bo: SUCCESS (0.003s)
[188.647841] [133/165] (818s left) prime_self_import (basic-with_one_bo_two_files)
[188.700397] Starting subtest: basic-with_one_bo_two_files
[188.703319] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[188.802959] [134/165] (818s left) prime_self_import (basic-with_two_bos)
[188.878916] Starting subtest: basic-with_two_bos
[188.881487] Subtest basic-with_two_bos: SUCCESS (0.003s)
[188.957854] [135/165] (818s left) prime_vgem (basic-fence-flip)
[189.027849] Starting subtest: basic-fence-flip
[189.838911] Subtest basic-fence-flip: SUCCESS (0.810s)
[189.932140] [136/165] (817s left) prime_vgem (basic-fence-mmap)
[190.018604] Starting subtest: basic-fence-mmap
[190.046032] Subtest basic-fence-mmap: SUCCESS (0.027s)
[190.138443] [137/165] (817s left) prime_vgem (basic-fence-read)
[190.223691] Starting subtest: basic-fence-read
[190.265755] Subtest basic-fence-read: SUCCESS (0.042s)
[190.349050] [138/165] (816s left) prime_vgem (basic-gtt)
[190.439943] Starting subtest: basic-gtt
[190.456237] Subtest basic-gtt: SUCCESS (0.016s)
[190.522698] [139/165] (816s left) prime_vgem (basic-read)
[190.603757] Starting subtest: basic-read
[190.623178] Subtest basic-read: SUCCESS (0.019s)
[190.714743] [140/165] (816s left) prime_vgem (basic-write)
[190.793981] Starting subtest: basic-write
[190.815717] Subtest basic-write: SUCCESS (0.022s)
[190.890608] [141/165] (816s left) vgem_basic (setversion)
[190.955753] Starting subtest: setversion
[190.957158] Subtest setversion: SUCCESS (0.000s)
[191.009651] [142/165] (816s left) vgem_basic (create)
[191.072981] Starting subtest: create
[191.073655] Subtest create: SUCCESS (0.000s)
[191.123089] [143/165] (816s left) vgem_basic (debugfs)
[191.189097] Starting subtest: debugfs
[191.189755] Subtest debugfs: SUCCESS (0.000s)
[191.237631] [144/165] (816s left) vgem_basic (dmabuf-export)
[191.307075] Starting subtest: dmabuf-export
[191.308244] Subtest dmabuf-export: SUCCESS (0.002s)
[191.396515] [145/165] (815s left) vgem_basic (dmabuf-fence)
[191.472584] Starting subtest: dmabuf-fence
[191.473198] Subtest dmabuf-fence: SUCCESS (0.001s)
[191.522877] [146/165] (815s left) vgem_basic (dmabuf-fence-before)
[191.588796] Starting subtest: dmabuf-fence-before
[191.589295] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[191.665269] [147/165] (815s left) vgem_basic (dmabuf-mmap)
[191.739270] Starting subtest: dmabuf-mmap
[191.751832] Subtest dmabuf-mmap: SUCCESS (0.012s)
[191.804503] [148/165] (815s left) vgem_basic (mmap)
[191.874913] Starting subtest: mmap
[191.881854] Subtest mmap: SUCCESS (0.009s)
[191.923817] [149/165] (815s left) vgem_basic (second-client)
[191.990318] Starting subtest: second-client
[192.025199] Subtest second-client: SUCCESS (0.033s)
[192.112727] [150/165] (815s left) vgem_basic (sysfs)
[192.188982] Starting subtest: sysfs
[192.189675] Subtest sysfs: SUCCESS (0.001s)
[192.238730] [151/165] (815s left) core_hotunplug (unbind-rebind)
[192.355601] Starting subtest: unbind-rebind
[196.038041] Subtest unbind-rebind: SUCCESS (3.682s)
[196.057023] [152/165] (811s left) vgem_basic (unload)
[196.114516] Starting subtest: unload
[225.186251] Subtest unload: SUCCESS (29.070s)
[225.305990] [153/165] (782s left) i915_module_load (reload)
[225.358969] Starting subtest: reload
[228.309107] Subtest reload: SUCCESS (2.950s)
[228.345092] [154/165] (779s left) gem_lmem_swapping (basic)
[228.461207] Subtest basic: SKIP (0.000s)
[228.484481] [155/165] (779s left) gem_lmem_swapping (parallel-random-engines)
[228.542873] Subtest parallel-random-engines: SKIP (0.000s)
[228.567837] [156/165] (778s left) gem_lmem_swapping (random-engines)
[228.623238] Subtest random-engines: SKIP (0.000s)
[228.650595] [157/165] (778s left) gem_lmem_swapping (verify-random)
[228.707573] Subtest verify-random: SKIP (0.000s)
[228.734330] [158/165] (778s left) i915_pm_rpm (module-reload)
[231.145585] Starting subtest: module-reload
[241.864903] Subtest module-reload: SUCCESS (10.721s)
[241.884427] [159/165] (765s left) i915_selftest (live)
[241.964047] Starting subtest: live
[241.964843] Starting dynamic subtest: sanitycheck
[243.206657] Dynamic subtest sanitycheck: SUCCESS (1.242s)
[243.213845] Starting dynamic subtest: uncore
[244.467116] Dynamic subtest uncore: SUCCESS (1.257s)
[244.475028] Starting dynamic subtest: workarounds
[246.004611] Dynamic subtest workarounds: SUCCESS (1.537s)
[246.014179] Starting dynamic subtest: gt_engines
[247.774134] Dynamic subtest gt_engines: SUCCESS (1.766s)
[247.779825] Starting dynamic subtest: gt_timelines
[258.666579] Dynamic subtest gt_timelines: SUCCESS (10.892s)
[258.673229] Starting dynamic subtest: gt_contexts
[260.156181] Dynamic subtest gt_contexts: SUCCESS (1.487s)
[260.162392] Starting dynamic subtest: gt_lrc
[264.347579] Dynamic subtest gt_lrc: SUCCESS (4.191s)
[264.355643] Starting dynamic subtest: gt_mocs
[265.721207] Dynamic subtest gt_mocs: SUCCESS (1.370s)
[265.726808] Starting dynamic subtest: gt_pm
[272.858834] Dynamic subtest gt_pm: SUCCESS (7.137s)
[272.867981] Starting dynamic subtest: gt_heartbeat
[274.229698] Dynamic subtest gt_heartbeat: SUCCESS (1.369s)
[274.239934] Starting dynamic subtest: gt_tlb
[276.758154] Dynamic subtest gt_tlb: SUCCESS (2.525s)
[276.764951] Starting dynamic subtest: requests
[285.480880] Dynamic subtest requests: SUCCESS (8.722s)
[285.490352] Starting dynamic subtest: migrate
[289.656091] Dynamic subtest migrate: SUCCESS (4.172s)
[289.662350] Starting dynamic subtest: active
[290.914781] Dynamic subtest active: SUCCESS (1.259s)
[290.922519] Starting dynamic subtest: objects
[293.055810] Dynamic subtest objects: SUCCESS (2.139s)
[293.062926] Starting dynamic subtest: mman
[298.090458] Dynamic subtest mman: SUCCESS (5.033s)
[298.097131] Starting dynamic subtest: dmabuf
[299.443480] Dynamic subtest dmabuf: SUCCESS (1.351s)
[299.450336] Starting dynamic subtest: vma
[300.704454] Dynamic subtest vma: SUCCESS (1.260s)
[300.711073] Starting dynamic subtest: coherency
[302.921703] Dynamic subtest coherency: SUCCESS (2.216s)
[302.931929] Starting dynamic subtest: gtt
[311.622622] Dynamic subtest gtt: SUCCESS (8.699s)
[311.629823] Starting dynamic subtest: gem
[313.042555] Dynamic subtest gem: SUCCESS (1.418s)
[313.051269] Starting dynamic subtest: evict
[315.782718] Dynamic subtest evict: SUCCESS (2.738s)
[315.790922] Starting dynamic subtest: hugepages
[322.907490] Dynamic subtest hugepages: SUCCESS (7.123s)
[322.916893] Starting dynamic subtest: gem_contexts
[339.625178] Dynamic subtest gem_contexts: SUCCESS (16.714s)
[339.631392] Starting dynamic subtest: client
[340.899510] Dynamic subtest client: SUCCESS (1.274s)
[340.906376] Starting dynamic subtest: gem_migrate
[342.138131] Dynamic subtest gem_migrate: SUCCESS (1.235s)
[342.145578] Starting dynamic subtest: reset
[344.042510] Dynamic subtest reset: SUCCESS (1.904s)
[344.049581] Starting dynamic subtest: memory_region
[345.330203] Dynamic subtest memory_region: SUCCESS (1.285s)
[345.336470] Starting dynamic subtest: hangcheck
[375.101572] Dynamic subtest hangcheck: SUCCESS (29.771s)
[375.111214] Starting dynamic subtest: execlists
[388.726225] Dynamic subtest execlists: SUCCESS (13.621s)
[388.731567] Starting dynamic subtest: ring_submission
[389.982118] Dynamic subtest ring_submission: SUCCESS (1.255s)
[389.987881] Starting dynamic subtest: perf
[391.413542] Dynamic subtest perf: SUCCESS (1.431s)
[391.420846] Starting dynamic subtest: slpc
[392.676493] Dynamic subtest slpc: SUCCESS (1.261s)
[392.683940] Starting dynamic subtest: guc
[393.979660] Dynamic subtest guc: SUCCESS (1.301s)
[393.986631] Starting dynamic subtest: guc_multi_lrc
[395.199749] Dynamic subtest guc_multi_lrc: SUCCESS (1.218s)
[395.208134] Starting dynamic subtest: guc_hang
[396.471682] Dynamic subtest guc_hang: SUCCESS (1.270s)
[396.479852] Starting dynamic subtest: late_gt_pm
[397.820184] Dynamic subtest late_gt_pm: SUCCESS (1.345s)
[397.820891] Subtest live: SUCCESS (155.856s)
[397.839317] [160/165] (609s left) dmabuf (all-tests)
[397.901918] Starting subtest: all-tests
[397.903474] Starting dynamic subtest: sanitycheck
[397.980388] Dynamic subtest sanitycheck: SUCCESS (0.077s)
[398.012055] Starting dynamic subtest: dma_fence
[398.170079] Dynamic subtest dma_fence: SUCCESS (0.185s)
[398.179034] Starting dynamic subtest: dma_fence_chain
[412.264403] Dynamic subtest dma_fence_chain: SUCCESS (14.092s)
[412.282294] Starting dynamic subtest: dma_fence_unwrap
[412.340507] Dynamic subtest dma_fence_unwrap: SUCCESS (0.073s)
[412.375292] Starting dynamic subtest: dma_resv
[412.418365] Dynamic subtest dma_resv: SUCCESS (0.072s)
[412.420319] Subtest all-tests: SUCCESS (14.518s)
[412.453327] [161/165] (595s left) i915_suspend (basic-s2idle-without-i915)
[412.513014] Starting subtest: basic-s2idle-without-i915
[432.015578] Subtest basic-s2idle-without-i915: SUCCESS (4.917s)
[435.393220] [162/165] (589s left) i915_suspend (basic-s3-without-i915)
[435.451949] Starting subtest: basic-s3-without-i915
[454.558431] Subtest basic-s3-without-i915: SUCCESS (3.922s)
[456.710655] [163/165] (585s left) gem_exec_suspend (basic-s0)
[456.935636] Starting subtest: basic-S0
[456.936483] Starting dynamic subtest: smem
[474.466610] Dynamic subtest smem: SUCCESS (3.366s)
[474.468364] Subtest basic-S0: SUCCESS (3.368s)
[479.623546] [164/165] (581s left) gem_exec_suspend (basic-s3)
[479.702264] Starting subtest: basic-S3
[479.702950] Starting dynamic subtest: smem
[499.463993] Dynamic subtest smem: SUCCESS (3.594s)
[499.466461] Subtest basic-S3: SUCCESS (3.595s)
[501.515289] [165/165] (577s left) kms_pipe_crc_basic (suspend-read-crc)
[502.033440] Starting subtest: suspend-read-crc
[502.034735] Starting dynamic subtest: pipe-A-DP-1
[521.507543] Dynamic subtest pipe-A-DP-1: SUCCESS (2.960s)
[525.013075] Closing watchdogs
Done.