[40.437557] Initializing watchdogs
[40.437643]   /dev/watchdog0
[40.442528] [001/165] (960s left) i915_module_load (load)
[40.502879] Starting subtest: load
[42.673613] Subtest load: SUCCESS (2.166s)
[42.686594] [002/165] (958s left) core_auth (basic-auth)
[42.756338] Starting subtest: basic-auth
[42.757678] Subtest basic-auth: SUCCESS (0.001s)
[42.817430] [003/165] (958s left) debugfs_test (read_all_entries)
[42.891397] Starting subtest: read_all_entries
[42.952552] Subtest read_all_entries: SUCCESS (0.061s)
[43.440304] [004/165] (957s left) debugfs_test (basic-hwmon)
[43.521513] Starting subtest: basic-hwmon
[43.522493] Subtest basic-hwmon: SKIP (0.000s)
[43.965118] [005/165] (957s left) fbdev (eof)
[44.051265] Starting subtest: eof
[44.051886] Subtest eof: SUCCESS (0.001s)
[44.097823] [006/165] (956s left) fbdev (info)
[44.147515] Starting subtest: info
[44.148195] Subtest info: SUCCESS (0.000s)
[44.199055] [007/165] (956s left) fbdev (nullptr)
[44.267849] Starting subtest: nullptr
[44.268471] Subtest nullptr: SUCCESS (0.000s)
[44.315284] [008/165] (956s left) fbdev (read)
[44.386298] Starting subtest: read
[44.609206] Subtest read: SUCCESS (0.225s)
[44.647081] [009/165] (956s left) fbdev (write)
[44.702329] Starting subtest: write
[44.819174] Subtest write: SUCCESS (0.118s)
[44.867148] [010/165] (956s left) gem_basic (bad-close)
[44.921849] Starting subtest: bad-close
[44.922969] Subtest bad-close: SUCCESS (0.000s)
[44.981862] [011/165] (956s left) gem_basic (create-close)
[45.039870] Starting subtest: create-close
[45.041070] Subtest create-close: SUCCESS (0.000s)
[45.099154] [012/165] (956s left) gem_basic (create-fd-close)
[45.156790] Starting subtest: create-fd-close
[45.158038] Subtest create-fd-close: SUCCESS (0.000s)
[45.215450] [013/165] (955s left) gem_busy (busy@all-engines)
[45.286367] Starting subtest: busy
[45.286910] Starting dynamic subtest: all-engines
[45.340928] Dynamic subtest all-engines: SUCCESS (0.054s)
[45.341682] Subtest busy: SUCCESS (0.055s)
[45.727272] [014/165] (955s left) gem_close_race (basic-process)
[45.805749] Starting subtest: basic-process
[45.873905] Subtest basic-process: SUCCESS (0.068s)
[46.058434] [015/165] (955s left) gem_close_race (basic-threads)
[46.124748] Starting subtest: basic-threads
[47.259541] Subtest basic-threads: SUCCESS (1.135s)
[47.465534] [016/165] (953s left) gem_ctx_create (basic)
[47.535760] Starting subtest: basic
[47.536464] Subtest basic: SUCCESS (0.000s)
[47.731022] [017/165] (953s left) gem_ctx_create (basic-files)
[47.796587] Starting subtest: basic-files
[49.812451] Subtest basic-files: SUCCESS (2.016s)
[50.068543] [018/165] (951s left) gem_ctx_exec (basic)
[50.153126] Starting subtest: basic
[50.156706] Subtest basic: SUCCESS (0.003s)
[50.270963] [019/165] (951s left) gem_exec_basic (basic)
[50.347909] Starting subtest: basic
[50.348615] Starting dynamic subtest: rcs0-smem
[50.349938] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[50.355958] Starting dynamic subtest: bcs0-smem
[50.356578] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[50.362355] Starting dynamic subtest: vcs0-smem
[50.363369] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[50.368375] Starting dynamic subtest: vcs1-smem
[50.369176] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[50.373844] Starting dynamic subtest: vecs0-smem
[50.374687] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[50.375330] Subtest basic: SUCCESS (0.004s)
[50.578030] [020/165] (950s left) gem_exec_create (basic)
[50.644133] Starting subtest: basic
[50.645096] Starting dynamic subtest: smem
[52.688811] Dynamic subtest smem: SUCCESS (2.044s)
[52.689684] Subtest basic: SUCCESS (2.044s)
[52.878996] [021/165] (948s left) gem_exec_fence (basic-busy)
[53.071450] Starting subtest: basic-busy
[53.072793] Starting dynamic subtest: rcs0
[53.093602] Dynamic subtest rcs0: SUCCESS (0.022s)
[53.105406] Starting dynamic subtest: bcs0
[53.123348] Dynamic subtest bcs0: SUCCESS (0.030s)
[53.132935] Starting dynamic subtest: vcs0
[53.143346] Dynamic subtest vcs0: SUCCESS (0.020s)
[53.152781] Starting dynamic subtest: vcs1
[53.167239] Dynamic subtest vcs1: SUCCESS (0.024s)
[53.176854] Starting dynamic subtest: vecs0
[53.194191] Dynamic subtest vecs0: SUCCESS (0.027s)
[53.195129] Subtest basic-busy: SUCCESS (0.123s)
[53.861989] [022/165] (947s left) gem_exec_fence (basic-wait)
[54.071398] Starting subtest: basic-wait
[54.073259] Starting dynamic subtest: rcs0
[54.099314] Dynamic subtest rcs0: SUCCESS (0.028s)
[54.113517] Starting dynamic subtest: bcs0
[54.129019] Dynamic subtest bcs0: SUCCESS (0.033s)
[54.137031] Starting dynamic subtest: vcs0
[54.148109] Dynamic subtest vcs0: SUCCESS (0.019s)
[54.156295] Starting dynamic subtest: vcs1
[54.171418] Dynamic subtest vcs1: SUCCESS (0.023s)
[54.178935] Starting dynamic subtest: vecs0
[54.194155] Dynamic subtest vecs0: SUCCESS (0.023s)
[54.194949] Subtest basic-wait: SUCCESS (0.126s)
[54.867926] [023/165] (946s left) gem_exec_fence (basic-await)
[55.058215] Starting subtest: basic-await
[55.059133] Starting dynamic subtest: rcs0
[55.163465] Dynamic subtest rcs0: SUCCESS (0.107s)
[55.172633] Starting dynamic subtest: bcs0
[55.266457] Dynamic subtest bcs0: SUCCESS (0.103s)
[55.272494] Starting dynamic subtest: vcs0
[55.363610] Dynamic subtest vcs0: SUCCESS (0.097s)
[55.370324] Starting dynamic subtest: vcs1
[55.465359] Dynamic subtest vcs1: SUCCESS (0.101s)
[55.476878] Starting dynamic subtest: vecs0
[55.598913] Dynamic subtest vecs0: SUCCESS (0.133s)
[55.599634] Subtest basic-await: SUCCESS (0.543s)
[56.250436] [024/165] (945s left) gem_exec_fence (nb-await)
[56.470790] Starting subtest: nb-await
[56.472511] Starting dynamic subtest: rcs0
[56.542626] Dynamic subtest rcs0: SUCCESS (0.073s)
[56.562910] Starting dynamic subtest: bcs0
[56.625567] Dynamic subtest bcs0: SUCCESS (0.078s)
[56.654580] Starting dynamic subtest: vcs0
[56.711227] Dynamic subtest vcs0: SUCCESS (0.088s)
[56.735544] Starting dynamic subtest: vcs1
[56.800390] Dynamic subtest vcs1: SUCCESS (0.089s)
[56.822190] Starting dynamic subtest: vecs0
[56.880815] Dynamic subtest vecs0: SUCCESS (0.079s)
[56.883096] Subtest nb-await: SUCCESS (0.412s)
[57.563713] [025/165] (943s left) gem_exec_gttfill (basic)
[57.630931] Starting subtest: basic
[65.651104] Subtest basic: SUCCESS (8.020s)
[65.815776] [026/165] (935s left) gem_exec_parallel (engines)
[65.945544] Starting subtest: engines
[65.946164] Starting dynamic subtest: basic
[67.990241] Dynamic subtest basic: SUCCESS (2.046s)
[67.996058] Starting dynamic subtest: contexts
[70.736819] Dynamic subtest contexts: SUCCESS (2.746s)
[70.742925] Starting dynamic subtest: fds
[76.621104] Dynamic subtest fds: SUCCESS (5.884s)
[76.627306] Starting dynamic subtest: userptr
[78.609180] Dynamic subtest userptr: SUCCESS (1.988s)
[78.609921] Subtest engines: SUCCESS (12.665s)
[78.818479] [027/165] (922s left) gem_exec_store (basic)
[78.889803] Starting subtest: basic
[78.940772] Subtest basic: SUCCESS (0.050s)
[79.145620] [028/165] (922s left) gem_flink_basic (bad-flink)
[79.219175] Starting subtest: bad-flink
[79.219779] Subtest bad-flink: SUCCESS (0.000s)
[79.281897] [029/165] (922s left) gem_flink_basic (bad-open)
[79.333922] Starting subtest: bad-open
[79.334622] Subtest bad-open: SUCCESS (0.000s)
[79.402566] [030/165] (922s left) gem_flink_basic (basic)
[79.470744] Starting subtest: basic
[79.471302] Subtest basic: SUCCESS (0.000s)
[79.533320] [031/165] (922s left) gem_flink_basic (double-flink)
[79.589690] Starting subtest: double-flink
[79.590250] Subtest double-flink: SUCCESS (0.000s)
[79.669632] [032/165] (921s left) gem_flink_basic (flink-lifetime)
[79.730610] Starting subtest: flink-lifetime
[79.732066] Subtest flink-lifetime: SUCCESS (0.001s)
[79.800898] [033/165] (921s left) gem_huc_copy (huc-copy)
[79.862804] Starting subtest: huc-copy
[79.863958] Subtest huc-copy: SKIP (0.000s)
[79.974337] [034/165] (921s left) gem_linear_blits (basic)
[80.165681] Starting subtest: basic
[80.172141] Subtest basic: SUCCESS (0.007s)
[80.330892] [035/165] (921s left) gem_mmap (basic)
[80.456060] Starting subtest: basic
[80.458589] Subtest basic: SUCCESS (0.000s)
[80.518267] [036/165] (921s left) gem_mmap_gtt (basic)
[80.581256] Starting subtest: basic
[80.581858] Subtest basic: SUCCESS (0.001s)
[80.624951] [037/165] (921s left) gem_render_linear_blits (basic)
[80.682169] Starting subtest: basic
[80.710863] Subtest basic: SUCCESS (0.031s)
[80.758438] [038/165] (920s left) gem_render_tiled_blits (basic)
[80.815511] Starting subtest: basic
[80.851899] Subtest basic: SUCCESS (0.035s)
[80.891135] [039/165] (920s left) gem_ringfill (basic-all)
[81.130115] Starting subtest: basic-all
[82.289179] Subtest basic-all: SUCCESS (1.162s)
[82.400732] [040/165] (919s left) gem_softpin (allocator-basic)
[82.470996] Starting subtest: allocator-basic
[82.574140] Subtest allocator-basic: SUCCESS (0.102s)
[82.680651] [041/165] (919s left) gem_softpin (allocator-basic-reserve)
[82.753114] Starting subtest: allocator-basic-reserve
[82.857734] Subtest allocator-basic-reserve: SUCCESS (0.104s)
[82.953313] [042/165] (918s left) gem_softpin (safe-alignment)
[83.025262] Starting subtest: safe-alignment
[83.039202] Subtest safe-alignment: SUCCESS (0.014s)
[83.146262] [043/165] (918s left) gem_sync (basic-all)
[83.223240] Starting subtest: basic-all
[85.306834] Subtest basic-all: SUCCESS (2.084s)
[85.511872] [044/165] (916s left) gem_sync (basic-each)
[85.579504] Starting subtest: basic-each
[87.801993] Subtest basic-each: SUCCESS (2.222s)
[88.030140] [045/165] (913s left) gem_tiled_blits (basic)
[88.233837] Starting subtest: basic
[88.251765] Subtest basic: SUCCESS (0.018s)
[88.382395] [046/165] (913s left) gem_tiled_fence_blits (basic)
[88.654170] Starting subtest: basic
[88.661614] Subtest basic: SUCCESS (0.010s)
[88.800281] [047/165] (913s left) gem_tiled_pread_basic
[89.104951] [048/165] (912s left) gem_wait (busy@all-engines)
[89.182828] Starting subtest: busy
[89.183420] Starting dynamic subtest: all-engines
[89.705124] Dynamic subtest all-engines: SUCCESS (0.520s)
[89.705746] Subtest busy: SUCCESS (0.520s)
[89.926830] [049/165] (912s left) gem_wait (wait@all-engines)
[90.001123] Starting subtest: wait
[90.001709] Starting dynamic subtest: all-engines
[91.036099] Dynamic subtest all-engines: SUCCESS (1.036s)
[91.038279] Subtest wait: SUCCESS (1.036s)
[91.317656] [050/165] (910s left) i915_getparams_basic (basic-eu-total)
[91.391065] Starting subtest: basic-eu-total
[91.392297] Subtest basic-eu-total: SUCCESS (0.000s)
[91.449674] [051/165] (910s left) i915_getparams_basic (basic-subslice-total)
[91.505313] Starting subtest: basic-subslice-total
[91.506268] Subtest basic-subslice-total: SUCCESS (0.000s)
[91.568690] [052/165] (910s left) i915_hangman (error-state-basic)
[91.642649] Starting subtest: error-state-basic
[91.649043] Subtest error-state-basic: SUCCESS (0.006s)
[91.716604] [053/165] (910s left) i915_pciid
[91.834774] [054/165] (910s left) kms_addfb_basic (addfb25-4-tiled)
[92.274699] Starting subtest: addfb25-4-tiled
[92.275447] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[92.381650] [055/165] (909s left) kms_addfb_basic (addfb25-bad-modifier)
[92.440731] Starting subtest: addfb25-bad-modifier
[92.441336] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[92.928874] [056/165] (909s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[92.988872] Starting subtest: addfb25-framebuffer-vs-set-tiling
[92.989523] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[93.469838] [057/165] (908s left) kms_addfb_basic (addfb25-modifier-no-flag)
[93.547806] Starting subtest: addfb25-modifier-no-flag
[93.548397] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[94.011657] [058/165] (908s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[94.104690] Starting subtest: addfb25-x-tiled-legacy
[94.105212] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[94.620452] [059/165] (907s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[94.695625] Starting subtest: addfb25-x-tiled-mismatch-legacy
[94.696154] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[95.199683] [060/165] (907s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[95.649591] Starting subtest: addfb25-yf-tiled-legacy
[95.650229] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[95.757648] [061/165] (906s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[96.206643] Starting subtest: addfb25-y-tiled-legacy
[96.207358] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[96.285695] [062/165] (906s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[96.747625] Starting subtest: addfb25-y-tiled-small-legacy
[96.748364] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[96.841087] [063/165] (905s left) kms_addfb_basic (bad-pitch-0)
[96.920824] Starting subtest: bad-pitch-0
[96.921501] Subtest bad-pitch-0: SUCCESS (0.000s)
[97.380320] [064/165] (905s left) kms_addfb_basic (bad-pitch-1024)
[97.465278] Starting subtest: bad-pitch-1024
[97.465891] Subtest bad-pitch-1024: SUCCESS (0.000s)
[97.916848] [065/165] (904s left) kms_addfb_basic (bad-pitch-128)
[98.002600] Starting subtest: bad-pitch-128
[98.003130] Subtest bad-pitch-128: SUCCESS (0.000s)
[98.485282] [066/165] (904s left) kms_addfb_basic (bad-pitch-256)
[98.561017] Starting subtest: bad-pitch-256
[98.561704] Subtest bad-pitch-256: SUCCESS (0.000s)
[99.066452] [067/165] (903s left) kms_addfb_basic (bad-pitch-32)
[99.142013] Starting subtest: bad-pitch-32
[99.142557] Subtest bad-pitch-32: SUCCESS (0.000s)
[99.596641] [068/165] (903s left) kms_addfb_basic (bad-pitch-63)
[99.675066] Starting subtest: bad-pitch-63
[99.675645] Subtest bad-pitch-63: SUCCESS (0.000s)
[100.157818] [069/165] (902s left) kms_addfb_basic (bad-pitch-65536)
[100.218837] Starting subtest: bad-pitch-65536
[100.219423] Subtest bad-pitch-65536: SUCCESS (0.000s)
[100.694286] [070/165] (902s left) kms_addfb_basic (bad-pitch-999)
[100.770547] Starting subtest: bad-pitch-999
[100.771090] Subtest bad-pitch-999: SUCCESS (0.000s)
[101.264556] [071/165] (901s left) kms_addfb_basic (basic)
[101.341121] Starting subtest: basic
[101.341695] Subtest basic: SUCCESS (0.000s)
[101.811392] [072/165] (900s left) kms_addfb_basic (basic-x-tiled-legacy)
[101.888868] Starting subtest: basic-x-tiled-legacy
[101.889527] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[102.366319] [073/165] (900s left) kms_addfb_basic (basic-y-tiled-legacy)
[102.429780] Starting subtest: basic-y-tiled-legacy
[102.430422] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[102.934829] [074/165] (899s left) kms_addfb_basic (bo-too-small)
[103.383857] Starting subtest: bo-too-small
[103.384639] Subtest bo-too-small: SUCCESS (0.000s)
[103.486596] [075/165] (899s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[103.918393] Starting subtest: bo-too-small-due-to-tiling
[103.918908] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[103.994075] [076/165] (898s left) kms_addfb_basic (clobberred-modifier)
[104.078307] Starting subtest: clobberred-modifier
[104.078876] Subtest clobberred-modifier: SUCCESS (0.000s)
[104.535543] [077/165] (898s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[104.619376] Starting subtest: framebuffer-vs-set-tiling
[104.619935] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[105.118367] [078/165] (897s left) kms_addfb_basic (invalid-get-prop)
[105.185933] Starting subtest: invalid-get-prop
[105.186523] Subtest invalid-get-prop: SUCCESS (0.000s)
[105.686599] [079/165] (897s left) kms_addfb_basic (invalid-get-prop-any)
[105.759836] Starting subtest: invalid-get-prop-any
[105.760404] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[106.268074] [080/165] (896s left) kms_addfb_basic (invalid-set-prop)
[106.339714] Starting subtest: invalid-set-prop
[106.340320] Subtest invalid-set-prop: SUCCESS (0.000s)
[106.825476] [081/165] (896s left) kms_addfb_basic (invalid-set-prop-any)
[106.884876] Starting subtest: invalid-set-prop-any
[106.885350] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[107.393997] [082/165] (895s left) kms_addfb_basic (no-handle)
[107.453501] Starting subtest: no-handle
[107.453933] Subtest no-handle: SUCCESS (0.000s)
[107.936406] [083/165] (895s left) kms_addfb_basic (size-max)
[108.373938] Starting subtest: size-max
[108.374962] Subtest size-max: SUCCESS (0.000s)
[108.493216] [084/165] (894s left) kms_addfb_basic (small-bo)
[108.923926] Starting subtest: small-bo
[108.924759] Subtest small-bo: SUCCESS (0.000s)
[109.040449] [085/165] (894s left) kms_addfb_basic (tile-pitch-mismatch)
[109.101196] Starting subtest: tile-pitch-mismatch
[109.101688] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[109.601489] [086/165] (893s left) kms_addfb_basic (too-high)
[110.045568] Starting subtest: too-high
[110.047307] Subtest too-high: SUCCESS (0.001s)
[110.131951] [087/165] (893s left) kms_addfb_basic (too-wide)
[110.591937] Starting subtest: too-wide
[110.592795] Subtest too-wide: SUCCESS (0.000s)
[110.713725] [088/165] (892s left) kms_addfb_basic (unused-handle)
[110.788382] Starting subtest: unused-handle
[110.789513] Subtest unused-handle: SUCCESS (0.000s)
[111.301668] [089/165] (892s left) kms_addfb_basic (unused-modifier)
[111.371668] Starting subtest: unused-modifier
[111.372238] Subtest unused-modifier: SUCCESS (0.000s)
[111.858726] [090/165] (891s left) kms_addfb_basic (unused-offsets)
[111.919845] Starting subtest: unused-offsets
[111.920460] Subtest unused-offsets: SUCCESS (0.000s)
[112.411091] [091/165] (891s left) kms_addfb_basic (unused-pitches)
[112.471347] Starting subtest: unused-pitches
[112.472104] Subtest unused-pitches: SUCCESS (0.000s)
[112.979534] [092/165] (890s left) kms_busy (basic)
[113.420817] Starting subtest: basic
[113.422161] Starting dynamic subtest: flip
[114.075027] Dynamic subtest flip: SUCCESS (0.652s)
[114.082368] Starting dynamic subtest: modeset
[115.130376] Dynamic subtest modeset: SUCCESS (1.053s)
[115.131107] Subtest basic: SUCCESS (1.709s)
[115.408051] [093/165] (888s left) kms_prop_blob (basic)
[115.489698] Starting subtest: basic
[115.490313] Subtest basic: SUCCESS (0.000s)
[115.550526] [094/165] (888s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[115.982756] Starting subtest: basic-busy-flip-before-cursor-atomic
[115.983992] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[116.068941] [095/165] (887s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[116.516905] Starting subtest: basic-busy-flip-before-cursor-legacy
[116.518360] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[116.613176] [096/165] (887s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[117.050058] Starting subtest: basic-flip-after-cursor-atomic
[118.025022] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.976s)
[118.270152] [097/165] (885s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[118.726123] Starting subtest: basic-flip-after-cursor-legacy
[119.706622] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.979s)
[119.957036] [098/165] (883s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[120.386155] Starting subtest: basic-flip-after-cursor-varying-size
[121.380019] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.993s)
[121.617336] [099/165] (882s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[122.074791] Starting subtest: basic-flip-before-cursor-atomic
[123.058893] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.983s)
[123.338211] [100/165] (880s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[123.792620] Starting subtest: basic-flip-before-cursor-legacy
[124.766106] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.973s)
[125.052839] [101/165] (878s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[125.497963] Starting subtest: basic-flip-before-cursor-varying-size
[126.478501] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.979s)
[126.742690] [102/165] (877s left) kms_dsc (dsc-basic)
[127.193764] Subtest dsc-basic: SKIP (0.000s)
[127.218807] [103/165] (876s left) kms_flip (basic-flip-vs-dpms)
[127.410995] Starting subtest: basic-flip-vs-dpms
[127.413567] Starting dynamic subtest: A-DP1
[128.679058] Dynamic subtest A-DP1: SUCCESS (1.264s)
[128.687521] Starting dynamic subtest: B-DP1
[129.614068] Dynamic subtest B-DP1: SUCCESS (0.927s)
[129.631866] Starting dynamic subtest: C-DP1
[130.832681] Dynamic subtest C-DP1: SUCCESS (1.221s)
[130.837955] Subtest basic-flip-vs-dpms: SUCCESS (3.425s)
[131.105819] [104/165] (872s left) kms_flip (basic-flip-vs-modeset)
[131.310714] Starting subtest: basic-flip-vs-modeset
[131.313205] Starting dynamic subtest: A-DP1
[132.530957] Dynamic subtest A-DP1: SUCCESS (1.217s)
[132.543070] Starting dynamic subtest: B-DP1
[133.739122] Dynamic subtest B-DP1: SUCCESS (1.201s)
[133.748558] Starting dynamic subtest: C-DP1
[134.869458] Dynamic subtest C-DP1: SUCCESS (1.128s)
[134.870146] Subtest basic-flip-vs-modeset: SUCCESS (3.558s)
[135.173823] [105/165] (868s left) kms_flip (basic-flip-vs-wf_vblank)
[135.378414] Starting subtest: basic-flip-vs-wf_vblank
[135.380301] Starting dynamic subtest: A-DP1
[136.660270] Dynamic subtest A-DP1: SUCCESS (1.276s)
[136.709472] Starting dynamic subtest: B-DP1
[138.018267] Dynamic subtest B-DP1: SUCCESS (1.350s)
[138.031528] Starting dynamic subtest: C-DP1
[139.308135] Dynamic subtest C-DP1: SUCCESS (1.286s)
[139.308965] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.931s)
[139.720787] [106/165] (864s left) kms_flip (basic-plain-flip)
[139.918702] Starting subtest: basic-plain-flip
[139.921559] Starting dynamic subtest: A-DP1
[140.916771] Dynamic subtest A-DP1: SUCCESS (0.995s)
[140.925082] Starting dynamic subtest: B-DP1
[141.906960] Dynamic subtest B-DP1: SUCCESS (0.988s)
[141.915838] Starting dynamic subtest: C-DP1
[142.899535] Dynamic subtest C-DP1: SUCCESS (0.990s)
[142.901783] Subtest basic-plain-flip: SUCCESS (2.983s)
[143.261339] [107/165] (860s left) kms_force_connector_basic (force-connector-state)
[143.505857] Starting subtest: force-connector-state
[144.420475] Subtest force-connector-state: SUCCESS (0.913s)
[145.248359] [108/165] (858s left) kms_force_connector_basic (force-edid)
[145.516187] Starting subtest: force-edid
[145.937476] Subtest force-edid: SUCCESS (0.419s)
[146.517897] [109/165] (857s left) kms_force_connector_basic (force-load-detect)
[146.770919] Starting subtest: force-load-detect
[146.776868] Subtest force-load-detect: SKIP (0.000s)
[147.245312] [110/165] (856s left) kms_force_connector_basic (prune-stale-modes)
[147.490332] Starting subtest: prune-stale-modes
[147.950143] Subtest prune-stale-modes: SUCCESS (0.457s)
[148.570777] [111/165] (855s left) kms_frontbuffer_tracking (basic)
[149.038965] Starting subtest: basic
[151.720795] Subtest basic: SUCCESS (2.679s)
[151.823721] [112/165] (852s left) kms_hdmi_inject (inject-audio)
[151.941964] Starting subtest: inject-audio
[152.416543] Subtest inject-audio: SUCCESS (0.470s)
[153.007803] [113/165] (851s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[153.470613] Starting subtest: compare-crc-sanitycheck-xr24
[153.473032] Starting dynamic subtest: pipe-A-DP-1
[153.962264] Dynamic subtest pipe-A-DP-1: SUCCESS (0.489s)
[153.974168] Starting dynamic subtest: pipe-B-DP-1
[154.517043] Dynamic subtest pipe-B-DP-1: SUCCESS (0.551s)
[154.539274] Starting dynamic subtest: pipe-C-DP-1
[155.105301] Dynamic subtest pipe-C-DP-1: SUCCESS (0.579s)
[155.106335] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.634s)
[155.397789] [114/165] (848s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[155.849515] Starting subtest: compare-crc-sanitycheck-nv12
[155.850922] Starting dynamic subtest: pipe-A-DP-1
[156.336153] Dynamic subtest pipe-A-DP-1: SUCCESS (0.482s)
[156.345416] Starting dynamic subtest: pipe-B-DP-1
[156.926365] Dynamic subtest pipe-B-DP-1: SUCCESS (0.587s)
[156.942856] Starting dynamic subtest: pipe-C-DP-1
[156.946393] Dynamic subtest pipe-C-DP-1: SKIP (0.001s)
[156.947925] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.084s)
[157.169168] [115/165] (847s left) kms_pipe_crc_basic (hang-read-crc)
[157.623393] Starting subtest: hang-read-crc
[157.624340] Starting dynamic subtest: pipe-A-DP-1
[158.982770] Dynamic subtest pipe-A-DP-1: SUCCESS (1.355s)
[158.995668] Starting dynamic subtest: pipe-B-DP-1
[160.377688] Dynamic subtest pipe-B-DP-1: SUCCESS (1.392s)
[160.392405] Starting dynamic subtest: pipe-C-DP-1
[161.786676] Dynamic subtest pipe-C-DP-1: SUCCESS (1.402s)
[161.787765] Subtest hang-read-crc: SUCCESS (4.163s)
[162.042434] [116/165] (842s left) kms_pipe_crc_basic (nonblocking-crc)
[162.512436] Starting subtest: nonblocking-crc
[162.513035] Starting dynamic subtest: pipe-A-DP-1
[163.180183] Dynamic subtest pipe-A-DP-1: SUCCESS (0.664s)
[163.194258] Starting dynamic subtest: pipe-B-DP-1
[163.939097] Dynamic subtest pipe-B-DP-1: SUCCESS (0.752s)
[163.954855] Starting dynamic subtest: pipe-C-DP-1
[164.710796] Dynamic subtest pipe-C-DP-1: SUCCESS (0.770s)
[164.715357] Subtest nonblocking-crc: SUCCESS (2.201s)
[164.975931] [117/165] (839s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[165.451723] Starting subtest: nonblocking-crc-frame-sequence
[165.453666] Starting dynamic subtest: pipe-A-DP-1
[166.144919] Dynamic subtest pipe-A-DP-1: SUCCESS (0.690s)
[166.162814] Starting dynamic subtest: pipe-B-DP-1
[166.898441] Dynamic subtest pipe-B-DP-1: SUCCESS (0.747s)
[166.911925] Starting dynamic subtest: pipe-C-DP-1
[167.692636] Dynamic subtest pipe-C-DP-1: SUCCESS (0.788s)
[167.693419] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.242s)
[167.955173] [118/165] (836s left) kms_pipe_crc_basic (read-crc)
[168.405736] Starting subtest: read-crc
[168.407742] Starting dynamic subtest: pipe-A-DP-1
[169.028374] Dynamic subtest pipe-A-DP-1: SUCCESS (0.618s)
[169.042490] Starting dynamic subtest: pipe-B-DP-1
[169.737144] Dynamic subtest pipe-B-DP-1: SUCCESS (0.702s)
[169.753643] Starting dynamic subtest: pipe-C-DP-1
[170.471240] Dynamic subtest pipe-C-DP-1: SUCCESS (0.727s)
[170.472229] Subtest read-crc: SUCCESS (2.065s)
[170.718412] [119/165] (833s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[171.189510] Starting subtest: read-crc-frame-sequence
[171.190220] Starting dynamic subtest: pipe-A-DP-1
[171.805240] Dynamic subtest pipe-A-DP-1: SUCCESS (0.615s)
[171.822576] Starting dynamic subtest: pipe-B-DP-1
[172.539518] Dynamic subtest pipe-B-DP-1: SUCCESS (0.725s)
[172.552669] Starting dynamic subtest: pipe-C-DP-1
[173.238270] Dynamic subtest pipe-C-DP-1: SUCCESS (0.694s)
[173.239257] Subtest read-crc-frame-sequence: SUCCESS (2.049s)
[173.510910] [120/165] (831s left) kms_pm_backlight (basic-brightness)
[173.966462] Subtest basic-brightness: SKIP (0.000s)
[173.993146] [121/165] (830s left) kms_pm_rpm (basic-pci-d3-state)
[175.973487] Starting subtest: basic-pci-d3-state
[176.599310] Subtest basic-pci-d3-state: SUCCESS (0.634s)
[176.874483] [122/165] (827s left) kms_pm_rpm (basic-rte)
[176.963912] Starting subtest: basic-rte
[179.477761] Subtest basic-rte: SUCCESS (2.512s)
[180.432342] [123/165] (824s left) kms_psr (psr_primary_page_flip)
[180.890439] Subtest psr_primary_page_flip: SKIP (0.000s)
[180.917813] [124/165] (823s left) kms_psr (psr_cursor_plane_move)
[181.358570] Subtest psr_cursor_plane_move: SKIP (0.000s)
[181.385237] [125/165] (823s left) kms_psr (psr_sprite_plane_onoff)
[181.831330] Subtest psr_sprite_plane_onoff: SKIP (0.000s)
[181.870211] [126/165] (822s left) kms_psr (psr_primary_mmap_gtt)
[182.321220] Subtest psr_primary_mmap_gtt: SKIP (0.000s)
[182.352086] [127/165] (822s left) kms_setmode (basic-clone-single-crtc)
[182.415492] Starting subtest: basic-clone-single-crtc
[182.417320] Subtest basic-clone-single-crtc: SKIP (0.000s)
[182.475214] [128/165] (822s left) i915_pm_rps (basic-api)
[182.534819] Starting subtest: basic-api
[182.539116] Subtest basic-api: SUCCESS (0.004s)
[182.611492] [129/165] (822s left) prime_self_import (basic-llseek-bad)
[182.671483] Starting subtest: basic-llseek-bad
[182.674334] Subtest basic-llseek-bad: SUCCESS (0.002s)
[182.742553] [130/165] (822s left) prime_self_import (basic-llseek-size)
[182.798071] Starting subtest: basic-llseek-size
[182.800924] Subtest basic-llseek-size: SUCCESS (0.003s)
[182.878682] [131/165] (821s left) prime_self_import (basic-with_fd_dup)
[182.941428] Starting subtest: basic-with_fd_dup
[182.943777] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[183.028161] [132/165] (821s left) prime_self_import (basic-with_one_bo)
[183.090408] Starting subtest: basic-with_one_bo
[183.092733] Subtest basic-with_one_bo: SUCCESS (0.003s)
[183.149415] [133/165] (821s left) prime_self_import (basic-with_one_bo_two_files)
[183.201555] Starting subtest: basic-with_one_bo_two_files
[183.202688] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[183.284749] [134/165] (821s left) prime_self_import (basic-with_two_bos)
[183.347416] Starting subtest: basic-with_two_bos
[183.350396] Subtest basic-with_two_bos: SUCCESS (0.003s)
[183.428301] [135/165] (821s left) prime_vgem (basic-fence-flip)
[183.496917] Starting subtest: basic-fence-flip
[184.326889] Subtest basic-fence-flip: SUCCESS (0.827s)
[184.424731] [136/165] (820s left) prime_vgem (basic-fence-mmap)
[184.503697] Starting subtest: basic-fence-mmap
[184.530213] Subtest basic-fence-mmap: SUCCESS (0.027s)
[184.616214] [137/165] (820s left) prime_vgem (basic-fence-read)
[184.701960] Starting subtest: basic-fence-read
[184.744275] Subtest basic-fence-read: SUCCESS (0.042s)
[184.810145] [138/165] (820s left) prime_vgem (basic-gtt)
[184.889862] Starting subtest: basic-gtt
[184.903171] Subtest basic-gtt: SUCCESS (0.012s)
[185.011103] [139/165] (820s left) prime_vgem (basic-read)
[185.094300] Starting subtest: basic-read
[185.113641] Subtest basic-read: SUCCESS (0.019s)
[185.237230] [140/165] (819s left) prime_vgem (basic-write)
[185.321346] Starting subtest: basic-write
[185.342720] Subtest basic-write: SUCCESS (0.021s)
[185.408936] [141/165] (819s left) vgem_basic (setversion)
[185.476817] Starting subtest: setversion
[185.477836] Subtest setversion: SUCCESS (0.000s)
[185.525245] [142/165] (819s left) vgem_basic (create)
[185.593911] Starting subtest: create
[185.594473] Subtest create: SUCCESS (0.000s)
[185.642963] [143/165] (819s left) vgem_basic (debugfs)
[185.708050] Starting subtest: debugfs
[185.708707] Subtest debugfs: SUCCESS (0.000s)
[185.757236] [144/165] (819s left) vgem_basic (dmabuf-export)
[185.826595] Starting subtest: dmabuf-export
[185.827805] Subtest dmabuf-export: SUCCESS (0.002s)
[185.928255] [145/165] (819s left) vgem_basic (dmabuf-fence)
[185.991311] Starting subtest: dmabuf-fence
[185.993604] Subtest dmabuf-fence: SUCCESS (0.001s)
[186.040824] [146/165] (819s left) vgem_basic (dmabuf-fence-before)
[186.108110] Starting subtest: dmabuf-fence-before
[186.108625] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[186.159623] [147/165] (819s left) vgem_basic (dmabuf-mmap)
[186.224829] Starting subtest: dmabuf-mmap
[186.237495] Subtest dmabuf-mmap: SUCCESS (0.013s)
[186.290664] [148/165] (818s left) vgem_basic (mmap)
[186.358811] Starting subtest: mmap
[186.366870] Subtest mmap: SUCCESS (0.009s)
[186.408368] [149/165] (818s left) vgem_basic (second-client)
[186.476464] Starting subtest: second-client
[186.508972] Subtest second-client: SUCCESS (0.033s)
[186.562925] [150/165] (818s left) vgem_basic (sysfs)
[186.641578] Starting subtest: sysfs
[186.642166] Subtest sysfs: SUCCESS (0.001s)
[186.689407] [151/165] (818s left) core_hotunplug (unbind-rebind)
[186.791177] Starting subtest: unbind-rebind
[190.463881] Subtest unbind-rebind: SUCCESS (3.673s)
[190.492790] [152/165] (814s left) vgem_basic (unload)
[190.576580] Starting subtest: unload
[219.627758] Subtest unload: SUCCESS (29.050s)
[219.739554] [153/165] (785s left) i915_module_load (reload)
[219.799580] Starting subtest: reload
[222.704907] Subtest reload: SUCCESS (2.905s)
[222.721720] [154/165] (782s left) gem_lmem_swapping (basic)
[222.785899] Subtest basic: SKIP (0.000s)
[222.813461] [155/165] (782s left) gem_lmem_swapping (parallel-random-engines)
[222.868194] Subtest parallel-random-engines: SKIP (0.000s)
[222.896766] [156/165] (782s left) gem_lmem_swapping (random-engines)
[222.952585] Subtest random-engines: SKIP (0.000s)
[222.980125] [157/165] (782s left) gem_lmem_swapping (verify-random)
[223.036256] Subtest verify-random: SKIP (0.000s)
[223.063724] [158/165] (782s left) i915_pm_rpm (module-reload)
[225.491784] Starting subtest: module-reload
[236.109029] Subtest module-reload: SUCCESS (10.620s)
[236.125902] [159/165] (769s left) i915_selftest (live)
[236.194146] Starting subtest: live
[236.194876] Starting dynamic subtest: sanitycheck
[237.454479] Dynamic subtest sanitycheck: SUCCESS (1.262s)
[237.461794] Starting dynamic subtest: uncore
[238.715486] Dynamic subtest uncore: SUCCESS (1.259s)
[238.723477] Starting dynamic subtest: workarounds
[240.237767] Dynamic subtest workarounds: SUCCESS (1.520s)
[240.246305] Starting dynamic subtest: gt_engines
[242.004425] Dynamic subtest gt_engines: SUCCESS (1.765s)
[242.014058] Starting dynamic subtest: gt_timelines
[252.851189] Dynamic subtest gt_timelines: SUCCESS (10.843s)
[252.856401] Starting dynamic subtest: gt_contexts
[254.264195] Dynamic subtest gt_contexts: SUCCESS (1.411s)
[254.269629] Starting dynamic subtest: gt_lrc
[258.498588] Dynamic subtest gt_lrc: SUCCESS (4.234s)
[258.505453] Starting dynamic subtest: gt_mocs
[259.930569] Dynamic subtest gt_mocs: SUCCESS (1.430s)
[259.937258] Starting dynamic subtest: gt_pm
[267.024722] Dynamic subtest gt_pm: SUCCESS (7.092s)
[267.032107] Starting dynamic subtest: gt_heartbeat
[268.360871] Dynamic subtest gt_heartbeat: SUCCESS (1.334s)
[268.371963] Starting dynamic subtest: gt_tlb
[270.784379] Dynamic subtest gt_tlb: SUCCESS (2.421s)
[270.792465] Starting dynamic subtest: requests
[279.540459] Dynamic subtest requests: SUCCESS (8.755s)
[279.547913] Starting dynamic subtest: migrate
[283.725165] Dynamic subtest migrate: SUCCESS (4.181s)
[283.730260] Starting dynamic subtest: active
[284.996147] Dynamic subtest active: SUCCESS (1.270s)
[285.001707] Starting dynamic subtest: objects
[287.135525] Dynamic subtest objects: SUCCESS (2.139s)
[287.143554] Starting dynamic subtest: mman
[292.161168] Dynamic subtest mman: SUCCESS (5.022s)
[292.167431] Starting dynamic subtest: dmabuf
[293.541438] Dynamic subtest dmabuf: SUCCESS (1.380s)
[293.548309] Starting dynamic subtest: vma
[294.803716] Dynamic subtest vma: SUCCESS (1.260s)
[294.810964] Starting dynamic subtest: coherency
[296.869509] Dynamic subtest coherency: SUCCESS (2.064s)
[296.877781] Starting dynamic subtest: gtt
[305.569821] Dynamic subtest gtt: SUCCESS (8.698s)
[305.578085] Starting dynamic subtest: gem
[306.991783] Dynamic subtest gem: SUCCESS (1.420s)
[307.001484] Starting dynamic subtest: evict
[309.710182] Dynamic subtest evict: SUCCESS (2.715s)
[309.715363] Starting dynamic subtest: hugepages
[316.847443] Dynamic subtest hugepages: SUCCESS (7.137s)
[316.853912] Starting dynamic subtest: gem_contexts
[333.586494] Dynamic subtest gem_contexts: SUCCESS (16.738s)
[333.596836] Starting dynamic subtest: client
[334.870130] Dynamic subtest client: SUCCESS (1.280s)
[334.877312] Starting dynamic subtest: gem_migrate
[336.160655] Dynamic subtest gem_migrate: SUCCESS (1.290s)
[336.168165] Starting dynamic subtest: reset
[338.060514] Dynamic subtest reset: SUCCESS (1.898s)
[338.068595] Starting dynamic subtest: memory_region
[339.313595] Dynamic subtest memory_region: SUCCESS (1.251s)
[339.322958] Starting dynamic subtest: hangcheck
[369.140469] Dynamic subtest hangcheck: SUCCESS (29.825s)
[369.147854] Starting dynamic subtest: execlists
[382.801446] Dynamic subtest execlists: SUCCESS (13.659s)
[382.808955] Starting dynamic subtest: ring_submission
[384.035787] Dynamic subtest ring_submission: SUCCESS (1.232s)
[384.045492] Starting dynamic subtest: perf
[385.481195] Dynamic subtest perf: SUCCESS (1.442s)
[385.486824] Starting dynamic subtest: slpc
[386.744127] Dynamic subtest slpc: SUCCESS (1.262s)
[386.750277] Starting dynamic subtest: guc
[388.002529] Dynamic subtest guc: SUCCESS (1.258s)
[388.010274] Starting dynamic subtest: guc_multi_lrc
[389.252505] Dynamic subtest guc_multi_lrc: SUCCESS (1.248s)
[389.259313] Starting dynamic subtest: guc_hang
[390.489201] Dynamic subtest guc_hang: SUCCESS (1.234s)
[390.494852] Starting dynamic subtest: late_gt_pm
[391.781237] Dynamic subtest late_gt_pm: SUCCESS (1.291s)
[391.781956] Subtest live: SUCCESS (155.588s)
[391.799080] [160/165] (613s left) dmabuf (all-tests)
[391.860736] Starting subtest: all-tests
[391.861766] Starting dynamic subtest: sanitycheck
[391.923254] Dynamic subtest sanitycheck: SUCCESS (0.062s)
[391.939552] Starting dynamic subtest: dma_fence
[392.111143] Dynamic subtest dma_fence: SUCCESS (0.185s)
[392.120428] Starting dynamic subtest: dma_fence_chain
[406.448161] Dynamic subtest dma_fence_chain: SUCCESS (14.335s)
[406.460730] Starting dynamic subtest: dma_fence_unwrap
[406.517063] Dynamic subtest dma_fence_unwrap: SUCCESS (0.066s)
[406.547196] Starting dynamic subtest: dma_resv
[406.601942] Dynamic subtest dma_resv: SUCCESS (0.080s)
[406.605144] Subtest all-tests: SUCCESS (14.743s)
[406.644841] [161/165] (598s left) i915_suspend (basic-s2idle-without-i915)
[406.699898] Starting subtest: basic-s2idle-without-i915
[425.997167] Subtest basic-s2idle-without-i915: SUCCESS (5.033s)
[429.364690] [162/165] (593s left) i915_suspend (basic-s3-without-i915)
[429.423226] Starting subtest: basic-s3-without-i915
[447.262068] Subtest basic-s3-without-i915: SUCCESS (3.829s)
[449.679354] [163/165] (589s left) gem_exec_suspend (basic-s0)
[449.755537] Starting subtest: basic-S0
[449.756027] Starting dynamic subtest: smem
[468.359351] Dynamic subtest smem: SUCCESS (3.233s)
[468.360226] Subtest basic-S0: SUCCESS (3.235s)
[472.536151] [164/165] (585s left) gem_exec_suspend (basic-s3)
[472.603482] Starting subtest: basic-S3
[472.605187] Starting dynamic subtest: smem
[491.078597] Dynamic subtest smem: SUCCESS (3.663s)
[491.080282] Subtest basic-S3: SUCCESS (3.665s)
[496.134841] [165/165] (581s left) kms_pipe_crc_basic (suspend-read-crc)
[496.619507] Starting subtest: suspend-read-crc
[496.621018] Starting dynamic subtest: pipe-A-DP-1
[515.089612] Dynamic subtest pipe-A-DP-1: SUCCESS (3.131s)
[517.702464] Closing watchdogs
Done.