[38.818230] Initializing watchdogs
[38.818312]   /dev/watchdog0
[38.823156] [001/160] (960s left) i915_module_load (load)
[38.884935] Starting subtest: load
[42.420860] Subtest load: SUCCESS (3.534s)
[42.439070] [002/160] (956s left) core_auth (basic-auth)
[42.527213] Starting subtest: basic-auth
[42.532142] Subtest basic-auth: SUCCESS (0.002s)
[42.615634] [003/160] (956s left) debugfs_test (read_all_entries)
[42.686561] Starting subtest: read_all_entries
[43.367957] Subtest read_all_entries: SUCCESS (0.681s)
[43.971131] [004/160] (955s left) debugfs_test (basic-hwmon)
[44.046594] Starting subtest: basic-hwmon
[44.047864] Subtest basic-hwmon: SKIP (0.000s)
[44.599354] [005/160] (954s left) fbdev (eof)
[44.683185] Starting subtest: eof
[44.683847] Subtest eof: SUCCESS (0.001s)
[44.734602] [006/160] (954s left) fbdev (info)
[44.796165] Starting subtest: info
[44.796726] Subtest info: SUCCESS (0.000s)
[44.849483] [007/160] (954s left) fbdev (nullptr)
[44.919060] Starting subtest: nullptr
[44.919667] Subtest nullptr: SUCCESS (0.000s)
[44.994699] [008/160] (954s left) fbdev (read)
[45.068941] Starting subtest: read
[45.310839] Subtest read: SUCCESS (0.242s)
[45.349119] [009/160] (954s left) fbdev (write)
[45.416166] Starting subtest: write
[45.541882] Subtest write: SUCCESS (0.125s)
[45.583129] [010/160] (953s left) gem_basic (bad-close)
[45.642634] Starting subtest: bad-close
[45.643848] Subtest bad-close: SUCCESS (0.000s)
[45.729428] [011/160] (953s left) gem_basic (create-close)
[45.813605] Starting subtest: create-close
[45.814874] Subtest create-close: SUCCESS (0.000s)
[45.885780] [012/160] (953s left) gem_basic (create-fd-close)
[45.960800] Starting subtest: create-fd-close
[45.961870] Subtest create-fd-close: SUCCESS (0.000s)
[46.036815] [013/160] (953s left) gem_busy (busy@all-engines)
[46.127081] Starting subtest: busy
[46.129877] Starting dynamic subtest: all-engines
[46.180984] Dynamic subtest all-engines: SUCCESS (0.054s)
[46.182825] Subtest busy: SUCCESS (0.054s)
[46.614565] [014/160] (952s left) gem_close_race (basic-process)
[46.706908] Starting subtest: basic-process
[46.764038] Subtest basic-process: SUCCESS (0.057s)
[46.980312] [015/160] (952s left) gem_close_race (basic-threads)
[47.075526] Starting subtest: basic-threads
[48.252595] Subtest basic-threads: SUCCESS (1.177s)
[48.465912] [016/160] (951s left) gem_ctx_create (basic)
[48.542884] Starting subtest: basic
[48.543550] Subtest basic: SUCCESS (0.000s)
[48.748352] [017/160] (950s left) gem_ctx_create (basic-files)
[48.836343] Starting subtest: basic-files
[50.854711] Subtest basic-files: SUCCESS (2.019s)
[51.092167] [018/160] (948s left) gem_ctx_exec (basic)
[51.173539] Starting subtest: basic
[51.177580] Subtest basic: SUCCESS (0.004s)
[51.282446] [019/160] (948s left) gem_exec_basic (basic)
[51.396168] Starting subtest: basic
[51.397086] Starting dynamic subtest: rcs0-smem
[51.398881] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[51.406293] Starting dynamic subtest: bcs0-smem
[51.407013] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[51.412047] Starting dynamic subtest: vcs0-smem
[51.412776] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[51.417742] Starting dynamic subtest: vcs1-smem
[51.418730] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[51.423691] Starting dynamic subtest: vecs0-smem
[51.424559] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[51.425591] Subtest basic: SUCCESS (0.009s)
[51.629689] [020/160] (948s left) gem_exec_create (basic)
[51.728071] Starting subtest: basic
[51.729095] Starting dynamic subtest: smem
[53.779999] Dynamic subtest smem: SUCCESS (2.052s)
[53.780612] Subtest basic: SUCCESS (2.053s)
[53.978586] [021/160] (945s left) gem_exec_fence (basic-busy)
[54.206871] Starting subtest: basic-busy
[54.208463] Starting dynamic subtest: rcs0
[54.237111] Dynamic subtest rcs0: SUCCESS (0.031s)
[54.245302] Starting dynamic subtest: bcs0
[54.257915] Dynamic subtest bcs0: SUCCESS (0.021s)
[54.266059] Starting dynamic subtest: vcs0
[54.288198] Dynamic subtest vcs0: SUCCESS (0.027s)
[54.294927] Starting dynamic subtest: vcs1
[54.313263] Dynamic subtest vcs1: SUCCESS (0.026s)
[54.338893] Starting dynamic subtest: vecs0
[54.344325] Dynamic subtest vecs0: SUCCESS (0.032s)
[54.345385] Subtest basic-busy: SUCCESS (0.138s)
[55.017679] [022/160] (944s left) gem_exec_fence (basic-wait)
[55.240048] Starting subtest: basic-wait
[55.241535] Starting dynamic subtest: rcs0
[55.265561] Dynamic subtest rcs0: SUCCESS (0.025s)
[55.279784] Starting dynamic subtest: bcs0
[55.297429] Dynamic subtest bcs0: SUCCESS (0.032s)
[55.311587] Starting dynamic subtest: vcs0
[55.318133] Dynamic subtest vcs0: SUCCESS (0.021s)
[55.326177] Starting dynamic subtest: vcs1
[55.348316] Dynamic subtest vcs1: SUCCESS (0.028s)
[55.365387] Starting dynamic subtest: vecs0
[55.377045] Dynamic subtest vecs0: SUCCESS (0.030s)
[55.377847] Subtest basic-wait: SUCCESS (0.138s)
[56.033799] [023/160] (943s left) gem_exec_fence (basic-await)
[56.233836] Starting subtest: basic-await
[56.235082] Starting dynamic subtest: rcs0
[56.344881] Dynamic subtest rcs0: SUCCESS (0.111s)
[56.351557] Starting dynamic subtest: bcs0
[56.445814] Dynamic subtest bcs0: SUCCESS (0.100s)
[56.453484] Starting dynamic subtest: vcs0
[56.551457] Dynamic subtest vcs0: SUCCESS (0.105s)
[56.558799] Starting dynamic subtest: vcs1
[56.659414] Dynamic subtest vcs1: SUCCESS (0.108s)
[56.668273] Starting dynamic subtest: vecs0
[56.772202] Dynamic subtest vecs0: SUCCESS (0.109s)
[56.773213] Subtest basic-await: SUCCESS (0.536s)
[57.449106] [024/160] (942s left) gem_exec_fence (nb-await)
[57.684688] Starting subtest: nb-await
[57.686775] Starting dynamic subtest: rcs0
[57.761112] Dynamic subtest rcs0: SUCCESS (0.077s)
[57.774569] Starting dynamic subtest: bcs0
[57.840566] Dynamic subtest bcs0: SUCCESS (0.076s)
[57.866883] Starting dynamic subtest: vcs0
[57.931802] Dynamic subtest vcs0: SUCCESS (0.091s)
[57.962367] Starting dynamic subtest: vcs1
[58.035732] Dynamic subtest vcs1: SUCCESS (0.102s)
[58.064806] Starting dynamic subtest: vecs0
[58.133802] Dynamic subtest vecs0: SUCCESS (0.098s)
[58.136563] Subtest nb-await: SUCCESS (0.447s)
[58.793712] [025/160] (941s left) gem_exec_gttfill (basic)
[58.889956] Starting subtest: basic
[66.992555] Subtest basic: SUCCESS (8.102s)
[67.172316] [026/160] (932s left) gem_exec_parallel (engines)
[67.338691] Starting subtest: engines
[67.340060] Starting dynamic subtest: basic
[69.703310] Dynamic subtest basic: SUCCESS (2.364s)
[69.709749] Starting dynamic subtest: contexts
[74.429394] Dynamic subtest contexts: SUCCESS (4.726s)
[74.435871] Starting dynamic subtest: fds
[82.240192] Dynamic subtest fds: SUCCESS (7.809s)
[82.246515] Starting dynamic subtest: userptr
[84.604181] Dynamic subtest userptr: SUCCESS (2.366s)
[84.604850] Subtest engines: SUCCESS (17.266s)
[84.804590] [027/160] (915s left) gem_exec_store (basic)
[84.880254] Starting subtest: basic
[84.926027] Subtest basic: SUCCESS (0.046s)
[85.129340] [028/160] (914s left) gem_flink_basic (bad-flink)
[85.203322] Starting subtest: bad-flink
[85.203976] Subtest bad-flink: SUCCESS (0.000s)
[85.269385] [029/160] (914s left) gem_flink_basic (bad-open)
[85.343554] Starting subtest: bad-open
[85.344115] Subtest bad-open: SUCCESS (0.000s)
[85.448695] [030/160] (914s left) gem_flink_basic (basic)
[85.544403] Starting subtest: basic
[85.544938] Subtest basic: SUCCESS (0.000s)
[85.648767] [031/160] (914s left) gem_flink_basic (double-flink)
[85.731835] Starting subtest: double-flink
[85.732492] Subtest double-flink: SUCCESS (0.000s)
[85.808052] [032/160] (914s left) gem_flink_basic (flink-lifetime)
[85.881331] Starting subtest: flink-lifetime
[85.883536] Subtest flink-lifetime: SUCCESS (0.002s)
[85.977540] [033/160] (914s left) gem_huc_copy (huc-copy)
[86.056805] Starting subtest: huc-copy
[86.058193] Subtest huc-copy: SKIP (0.000s)
[86.168831] [034/160] (913s left) gem_linear_blits (basic)
[86.380836] Starting subtest: basic
[86.391492] Subtest basic: SUCCESS (0.009s)
[86.549574] [035/160] (913s left) gem_mmap (basic)
[86.741671] Starting subtest: basic
[86.744206] Subtest basic: SUCCESS (0.000s)
[86.803897] [036/160] (913s left) gem_mmap_gtt (basic)
[86.880643] Starting subtest: basic
[86.881800] Subtest basic: SUCCESS (0.001s)
[86.962183] [037/160] (913s left) gem_render_linear_blits (basic)
[87.046771] Starting subtest: basic
[87.079745] Subtest basic: SUCCESS (0.032s)
[87.109157] [038/160] (913s left) gem_render_tiled_blits (basic)
[87.175844] Starting subtest: basic
[87.213560] Subtest basic: SUCCESS (0.037s)
[87.259212] [039/160] (912s left) gem_ringfill (basic-all)
[87.558158] Starting subtest: basic-all
[88.716802] Subtest basic-all: SUCCESS (1.161s)
[88.804447] [040/160] (911s left) gem_softpin (allocator-basic)
[88.884264] Starting subtest: allocator-basic
[88.999962] Subtest allocator-basic: SUCCESS (0.113s)
[89.086612] [041/160] (911s left) gem_softpin (allocator-basic-reserve)
[89.165097] Starting subtest: allocator-basic-reserve
[89.278802] Subtest allocator-basic-reserve: SUCCESS (0.113s)
[89.369365] [042/160] (910s left) gem_softpin (safe-alignment)
[89.446981] Starting subtest: safe-alignment
[89.461919] Subtest safe-alignment: SUCCESS (0.015s)
[89.594259] [043/160] (910s left) gem_sync (basic-all)
[89.676873] Starting subtest: basic-all
[91.828011] Subtest basic-all: SUCCESS (2.151s)
[92.035775] [044/160] (908s left) gem_sync (basic-each)
[92.129877] Starting subtest: basic-each
[94.321014] Subtest basic-each: SUCCESS (2.191s)
[94.549671] [045/160] (905s left) gem_tiled_blits (basic)
[94.788665] Starting subtest: basic
[94.811348] Subtest basic: SUCCESS (0.021s)
[94.969794] [046/160] (905s left) gem_tiled_fence_blits (basic)
[95.294526] Starting subtest: basic
[95.306411] Subtest basic: SUCCESS (0.011s)
[95.460952] [047/160] (904s left) gem_tiled_pread_basic
[95.816443] [048/160] (904s left) gem_wait (busy@all-engines)
[95.902990] Starting subtest: busy
[95.903642] Starting dynamic subtest: all-engines
[96.427757] Dynamic subtest all-engines: SUCCESS (0.525s)
[96.430512] Subtest busy: SUCCESS (0.525s)
[96.694087] [049/160] (903s left) gem_wait (wait@all-engines)
[96.793651] Starting subtest: wait
[96.794330] Starting dynamic subtest: all-engines
[97.842103] Dynamic subtest all-engines: SUCCESS (1.047s)
[97.844358] Subtest wait: SUCCESS (1.047s)
[98.095720] [050/160] (902s left) i915_getparams_basic (basic-eu-total)
[98.180227] Starting subtest: basic-eu-total
[98.181390] Subtest basic-eu-total: SUCCESS (0.000s)
[98.257085] [051/160] (902s left) i915_getparams_basic (basic-subslice-total)
[98.329727] Starting subtest: basic-subslice-total
[98.330834] Subtest basic-subslice-total: SUCCESS (0.000s)
[98.412048] [052/160] (902s left) i915_hangman (error-state-basic)
[98.500564] Starting subtest: error-state-basic
[98.507872] Subtest error-state-basic: SUCCESS (0.008s)
[98.566323] [053/160] (901s left) i915_pciid
[98.710683] [054/160] (901s left) kms_addfb_basic (addfb25-4-tiled)
[99.235389] Starting subtest: addfb25-4-tiled
[99.236124] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[99.316848] [055/160] (901s left) kms_addfb_basic (addfb25-bad-modifier)
[99.378176] Starting subtest: addfb25-bad-modifier
[99.378699] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[99.905364] [056/160] (900s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[99.969333] Starting subtest: addfb25-framebuffer-vs-set-tiling
[99.970013] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[100.484271] [057/160] (900s left) kms_addfb_basic (addfb25-modifier-no-flag)
[100.550191] Starting subtest: addfb25-modifier-no-flag
[100.550813] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[101.089804] [058/160] (899s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[101.165525] Starting subtest: addfb25-x-tiled-legacy
[101.166131] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[101.703141] [059/160] (898s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[101.768258] Starting subtest: addfb25-x-tiled-mismatch-legacy
[101.768758] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[102.307263] [060/160] (898s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[102.829409] Starting subtest: addfb25-yf-tiled-legacy
[102.830339] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[102.911124] [061/160] (897s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[103.459664] Starting subtest: addfb25-y-tiled-legacy
[103.460269] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[103.533725] [062/160] (897s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[104.093068] Starting subtest: addfb25-y-tiled-small-legacy
[104.093969] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[104.167169] [063/160] (896s left) kms_addfb_basic (bad-pitch-0)
[104.236365] Starting subtest: bad-pitch-0
[104.236998] Subtest bad-pitch-0: SUCCESS (0.000s)
[104.763847] [064/160] (895s left) kms_addfb_basic (bad-pitch-1024)
[104.834399] Starting subtest: bad-pitch-1024
[104.835113] Subtest bad-pitch-1024: SUCCESS (0.000s)
[105.390173] [065/160] (895s left) kms_addfb_basic (bad-pitch-128)
[105.468708] Starting subtest: bad-pitch-128
[105.469194] Subtest bad-pitch-128: SUCCESS (0.000s)
[106.001478] [066/160] (894s left) kms_addfb_basic (bad-pitch-256)
[106.072388] Starting subtest: bad-pitch-256
[106.073079] Subtest bad-pitch-256: SUCCESS (0.000s)
[106.649124] [067/160] (894s left) kms_addfb_basic (bad-pitch-32)
[106.717133] Starting subtest: bad-pitch-32
[106.717796] Subtest bad-pitch-32: SUCCESS (0.000s)
[107.263833] [068/160] (893s left) kms_addfb_basic (bad-pitch-63)
[107.325496] Starting subtest: bad-pitch-63
[107.326283] Subtest bad-pitch-63: SUCCESS (0.000s)
[107.867042] [069/160] (892s left) kms_addfb_basic (bad-pitch-65536)
[107.934600] Starting subtest: bad-pitch-65536
[107.935190] Subtest bad-pitch-65536: SUCCESS (0.000s)
[108.459241] [070/160] (892s left) kms_addfb_basic (bad-pitch-999)
[108.533584] Starting subtest: bad-pitch-999
[108.534190] Subtest bad-pitch-999: SUCCESS (0.000s)
[109.104779] [071/160] (891s left) kms_addfb_basic (basic)
[109.179665] Starting subtest: basic
[109.180140] Subtest basic: SUCCESS (0.000s)
[109.701927] [072/160] (891s left) kms_addfb_basic (basic-x-tiled-legacy)
[109.770813] Starting subtest: basic-x-tiled-legacy
[109.771336] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[110.285756] [073/160] (890s left) kms_addfb_basic (basic-y-tiled-legacy)
[110.355687] Starting subtest: basic-y-tiled-legacy
[110.356223] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[110.900797] [074/160] (890s left) kms_addfb_basic (bo-too-small)
[111.469115] Starting subtest: bo-too-small
[111.469675] Subtest bo-too-small: SUCCESS (0.000s)
[111.551840] [075/160] (889s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[112.043971] Starting subtest: bo-too-small-due-to-tiling
[112.044798] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[112.117908] [076/160] (888s left) kms_addfb_basic (clobberred-modifier)
[112.182728] Starting subtest: clobberred-modifier
[112.183264] Subtest clobberred-modifier: SUCCESS (0.000s)
[112.707722] [077/160] (888s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[112.774737] Starting subtest: framebuffer-vs-set-tiling
[112.775254] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[113.285612] [078/160] (887s left) kms_addfb_basic (invalid-get-prop)
[113.349679] Starting subtest: invalid-get-prop
[113.350265] Subtest invalid-get-prop: SUCCESS (0.000s)
[113.883711] [079/160] (887s left) kms_addfb_basic (invalid-get-prop-any)
[113.950795] Starting subtest: invalid-get-prop-any
[113.951390] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[114.470544] [080/160] (886s left) kms_addfb_basic (invalid-set-prop)
[114.539441] Starting subtest: invalid-set-prop
[114.539991] Subtest invalid-set-prop: SUCCESS (0.000s)
[115.073978] [081/160] (885s left) kms_addfb_basic (invalid-set-prop-any)
[115.138697] Starting subtest: invalid-set-prop-any
[115.139289] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[115.678080] [082/160] (885s left) kms_addfb_basic (no-handle)
[115.740843] Starting subtest: no-handle
[115.741440] Subtest no-handle: SUCCESS (0.000s)
[116.267100] [083/160] (884s left) kms_addfb_basic (size-max)
[116.790386] Starting subtest: size-max
[116.791299] Subtest size-max: SUCCESS (0.000s)
[116.874771] [084/160] (884s left) kms_addfb_basic (small-bo)
[117.401236] Starting subtest: small-bo
[117.402651] Subtest small-bo: SUCCESS (0.000s)
[117.492565] [085/160] (883s left) kms_addfb_basic (tile-pitch-mismatch)
[117.554748] Starting subtest: tile-pitch-mismatch
[117.555316] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[118.094263] [086/160] (883s left) kms_addfb_basic (too-high)
[118.614167] Starting subtest: too-high
[118.614936] Subtest too-high: SUCCESS (0.001s)
[118.694509] [087/160] (882s left) kms_addfb_basic (too-wide)
[119.222934] Starting subtest: too-wide
[119.223785] Subtest too-wide: SUCCESS (0.000s)
[119.306626] [088/160] (881s left) kms_addfb_basic (unused-handle)
[119.372743] Starting subtest: unused-handle
[119.373346] Subtest unused-handle: SUCCESS (0.000s)
[119.920059] [089/160] (881s left) kms_addfb_basic (unused-modifier)
[119.995828] Starting subtest: unused-modifier
[119.996399] Subtest unused-modifier: SUCCESS (0.000s)
[120.531500] [090/160] (880s left) kms_addfb_basic (unused-offsets)
[120.599807] Starting subtest: unused-offsets
[120.600365] Subtest unused-offsets: SUCCESS (0.000s)
[121.170905] [091/160] (880s left) kms_addfb_basic (unused-pitches)
[121.235937] Starting subtest: unused-pitches
[121.236630] Subtest unused-pitches: SUCCESS (0.000s)
[121.784755] [092/160] (879s left) kms_busy (basic)
[122.286550] Starting subtest: basic
[122.289298] Starting dynamic subtest: flip
[123.816346] Dynamic subtest flip: SUCCESS (1.525s)
[123.824059] Starting dynamic subtest: modeset
[124.961415] Dynamic subtest modeset: SUCCESS (1.145s)
[124.962538] Subtest basic: SUCCESS (2.676s)
[125.533722] [093/160] (875s left) kms_prop_blob (basic)
[125.622613] Starting subtest: basic
[125.623152] Subtest basic: SUCCESS (0.000s)
[125.688539] [094/160] (875s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[126.183521] Starting subtest: basic-busy-flip-before-cursor-atomic
[126.185496] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[126.250721] [095/160] (875s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[126.814095] Starting subtest: basic-busy-flip-before-cursor-legacy
[126.816374] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[126.893988] [096/160] (874s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[127.430139] Starting subtest: basic-flip-after-cursor-atomic
[129.059756] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.629s)
[129.590360] [097/160] (871s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[130.166405] Starting subtest: basic-flip-after-cursor-legacy
[131.624213] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.453s)
[132.287210] [098/160] (869s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[132.826865] Starting subtest: basic-flip-after-cursor-varying-size
[134.296483] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.470s)
[134.864982] [099/160] (866s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[135.440164] Starting subtest: basic-flip-before-cursor-atomic
[136.869844] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.429s)
[137.336453] [100/160] (864s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[137.851725] Starting subtest: basic-flip-before-cursor-legacy
[139.410542] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.560s)
[139.953665] [101/160] (861s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[140.468779] Starting subtest: basic-flip-before-cursor-varying-size
[141.984128] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.511s)
[142.557261] [102/160] (859s left) kms_dsc (dsc-basic)
[143.062553] Subtest dsc-basic: SKIP (0.000s)
[143.109525] [103/160] (858s left) kms_flip (basic-flip-vs-dpms)
[143.668750] Starting subtest: basic-flip-vs-dpms
[143.671811] Starting dynamic subtest: A-DP1
[145.178688] Dynamic subtest A-DP1: SUCCESS (1.503s)
[145.193601] Starting dynamic subtest: B-DP1
[146.113263] Dynamic subtest B-DP1: SUCCESS (0.932s)
[146.126212] Starting dynamic subtest: C-DP1
[147.096362] Dynamic subtest C-DP1: SUCCESS (0.978s)
[147.119590] Starting dynamic subtest: A-DP3
[148.476234] Dynamic subtest A-DP3: SUCCESS (1.367s)
[148.511615] Starting dynamic subtest: B-DP3
[150.023941] Dynamic subtest B-DP3: SUCCESS (1.541s)
[150.070652] Starting dynamic subtest: C-DP3
[152.124469] Dynamic subtest C-DP3: SUCCESS (2.091s)
[152.129376] Subtest basic-flip-vs-dpms: SUCCESS (8.461s)
[152.789400] [104/160] (848s left) kms_flip (basic-flip-vs-modeset)
[153.333317] Starting subtest: basic-flip-vs-modeset
[153.340235] Starting dynamic subtest: A-DP1
[154.719578] Dynamic subtest A-DP1: SUCCESS (1.376s)
[154.735635] Starting dynamic subtest: B-DP1
[155.752330] Dynamic subtest B-DP1: SUCCESS (1.025s)
[155.768673] Starting dynamic subtest: C-DP1
[156.732648] Dynamic subtest C-DP1: SUCCESS (0.982s)
[156.754255] Starting dynamic subtest: A-DP3
[157.942615] Dynamic subtest A-DP3: SUCCESS (1.199s)
[157.959690] Starting dynamic subtest: B-DP3
[159.315686] Dynamic subtest B-DP3: SUCCESS (1.371s)
[159.337460] Starting dynamic subtest: C-DP3
[160.686796] Dynamic subtest C-DP3: SUCCESS (1.365s)
[160.693039] Subtest basic-flip-vs-modeset: SUCCESS (7.353s)
[161.367195] [105/160] (840s left) kms_flip (basic-flip-vs-wf_vblank)
[161.916866] Starting subtest: basic-flip-vs-wf_vblank
[161.920546] Starting dynamic subtest: A-DP1
[163.562499] Dynamic subtest A-DP1: SUCCESS (1.645s)
[163.575859] Starting dynamic subtest: B-DP1
[164.712704] Dynamic subtest B-DP1: SUCCESS (1.147s)
[164.722822] Starting dynamic subtest: C-DP1
[165.820876] Dynamic subtest C-DP1: SUCCESS (1.106s)
[165.834670] Starting dynamic subtest: A-DP3
[167.028184] Dynamic subtest A-DP3: SUCCESS (1.203s)
[167.035142] Starting dynamic subtest: B-DP3
[169.048081] Dynamic subtest B-DP3: SUCCESS (2.018s)
[169.058420] Starting dynamic subtest: C-DP3
[170.479370] Dynamic subtest C-DP3: SUCCESS (1.430s)
[170.482592] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.569s)
[171.917069] [106/160] (829s left) kms_flip (basic-plain-flip)
[172.445718] Starting subtest: basic-plain-flip
[172.453061] Starting dynamic subtest: A-DP1
[173.776333] Dynamic subtest A-DP1: SUCCESS (1.319s)
[173.833839] Starting dynamic subtest: B-DP1
[174.718334] Dynamic subtest B-DP1: SUCCESS (0.927s)
[174.771801] Starting dynamic subtest: C-DP1
[175.768342] Dynamic subtest C-DP1: SUCCESS (1.043s)
[175.779297] Starting dynamic subtest: A-DP3
[176.675869] Dynamic subtest A-DP3: SUCCESS (0.902s)
[176.684532] Starting dynamic subtest: B-DP3
[177.925670] Dynamic subtest B-DP3: SUCCESS (1.248s)
[177.975174] Starting dynamic subtest: C-DP3
[179.251377] Dynamic subtest C-DP3: SUCCESS (1.310s)
[179.264844] Subtest basic-plain-flip: SUCCESS (6.811s)
[180.136633] [107/160] (821s left) kms_force_connector_basic (force-connector-state)
[180.415528] Starting subtest: force-connector-state
[182.251102] Subtest force-connector-state: SUCCESS (1.836s)
[183.373528] [108/160] (818s left) kms_force_connector_basic (force-edid)
[183.645177] Starting subtest: force-edid
[184.069571] Subtest force-edid: SUCCESS (0.425s)
[184.752834] [109/160] (817s left) kms_force_connector_basic (force-load-detect)
[185.021950] Starting subtest: force-load-detect
[185.028936] Subtest force-load-detect: SKIP (0.000s)
[185.516922] [110/160] (816s left) kms_force_connector_basic (prune-stale-modes)
[185.772324] Starting subtest: prune-stale-modes
[186.238499] Subtest prune-stale-modes: SUCCESS (0.459s)
[186.887783] [111/160] (815s left) kms_frontbuffer_tracking (basic)
[187.451541] Starting subtest: basic
[191.075309] Subtest basic: SUCCESS (3.619s)
[191.683696] [112/160] (810s left) kms_hdmi_inject (inject-audio)
[192.006814] Starting subtest: inject-audio
[192.557093] Subtest inject-audio: SUCCESS (0.542s)
[193.474749] [113/160] (808s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[194.022285] Starting subtest: compare-crc-sanitycheck-xr24
[194.025310] Starting dynamic subtest: pipe-A-DP-1
[195.229154] Dynamic subtest pipe-A-DP-1: SUCCESS (1.200s)
[195.245650] Starting dynamic subtest: pipe-B-DP-3
[196.040224] Dynamic subtest pipe-B-DP-3: SUCCESS (0.800s)
[196.068140] Starting dynamic subtest: pipe-C-DP-1
[196.687347] Dynamic subtest pipe-C-DP-1: SUCCESS (0.640s)
[196.688632] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.665s)
[197.262146] [114/160] (804s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[197.826940] Starting subtest: compare-crc-sanitycheck-nv12
[197.829640] Starting dynamic subtest: pipe-A-DP-1
[199.039548] Dynamic subtest pipe-A-DP-1: SUCCESS (1.205s)
[199.055763] Starting dynamic subtest: pipe-B-DP-3
[199.950561] Dynamic subtest pipe-B-DP-3: SUCCESS (0.899s)
[200.000393] Starting dynamic subtest: pipe-C-DP-1
[200.004223] Dynamic subtest pipe-C-DP-1: SKIP (0.004s)
[200.006341] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.143s)
[200.597732] [115/160] (801s left) kms_pipe_crc_basic (hang-read-crc)
[201.171069] Starting subtest: hang-read-crc
[201.171830] Starting dynamic subtest: pipe-A-DP-1
[202.936182] Dynamic subtest pipe-A-DP-1: SUCCESS (1.764s)
[202.950641] Starting dynamic subtest: pipe-B-DP-3
[205.180496] Dynamic subtest pipe-B-DP-3: SUCCESS (2.236s)
[205.223406] Starting dynamic subtest: pipe-C-DP-1
[206.660885] Dynamic subtest pipe-C-DP-1: SUCCESS (1.470s)
[206.662106] Subtest hang-read-crc: SUCCESS (5.493s)
[207.220994] [116/160] (794s left) kms_pipe_crc_basic (nonblocking-crc)
[207.755072] Starting subtest: nonblocking-crc
[207.758935] Starting dynamic subtest: pipe-A-DP-1
[208.885830] Dynamic subtest pipe-A-DP-1: SUCCESS (1.123s)
[208.902834] Starting dynamic subtest: pipe-B-DP-3
[209.968590] Dynamic subtest pipe-B-DP-3: SUCCESS (1.072s)
[210.010160] Starting dynamic subtest: pipe-C-DP-1
[210.828523] Dynamic subtest pipe-C-DP-1: SUCCESS (0.847s)
[210.829583] Subtest nonblocking-crc: SUCCESS (3.073s)
[211.378951] [117/160] (790s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[211.900544] Starting subtest: nonblocking-crc-frame-sequence
[211.901783] Starting dynamic subtest: pipe-A-DP-1
[213.134316] Dynamic subtest pipe-A-DP-1: SUCCESS (1.231s)
[213.150816] Starting dynamic subtest: pipe-B-DP-3
[214.145283] Dynamic subtest pipe-B-DP-3: SUCCESS (0.999s)
[214.173125] Starting dynamic subtest: pipe-C-DP-1
[214.982387] Dynamic subtest pipe-C-DP-1: SUCCESS (0.833s)
[214.983754] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.086s)
[215.535385] [118/160] (786s left) kms_pipe_crc_basic (read-crc)
[216.055479] Starting subtest: read-crc
[216.057879] Starting dynamic subtest: pipe-A-DP-1
[217.346314] Dynamic subtest pipe-A-DP-1: SUCCESS (1.288s)
[217.361396] Starting dynamic subtest: pipe-B-DP-3
[218.412935] Dynamic subtest pipe-B-DP-3: SUCCESS (1.054s)
[218.460616] Starting dynamic subtest: pipe-C-DP-1
[219.183928] Dynamic subtest pipe-C-DP-1: SUCCESS (0.761s)
[219.185121] Subtest read-crc: SUCCESS (3.130s)
[219.740497] [119/160] (782s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[220.256767] Starting subtest: read-crc-frame-sequence
[220.257695] Starting dynamic subtest: pipe-A-DP-1
[222.064350] Dynamic subtest pipe-A-DP-1: SUCCESS (1.807s)
[222.079254] Starting dynamic subtest: pipe-B-DP-3
[223.130722] Dynamic subtest pipe-B-DP-3: SUCCESS (1.058s)
[223.176494] Starting dynamic subtest: pipe-C-DP-1
[223.932056] Dynamic subtest pipe-C-DP-1: SUCCESS (0.786s)
[223.936282] Subtest read-crc-frame-sequence: SUCCESS (3.679s)
[224.469793] [120/160] (777s left) kms_pm_backlight (basic-brightness)
[224.993828] Subtest basic-brightness: SKIP (0.000s)
[225.043476] [121/160] (777s left) kms_pm_rpm (basic-pci-d3-state)
[227.600127] Starting subtest: basic-pci-d3-state
[228.401931] Subtest basic-pci-d3-state: SUCCESS (0.804s)
[229.243349] [122/160] (773s left) kms_pm_rpm (basic-rte)
[229.317228] Starting subtest: basic-rte
[232.651886] Subtest basic-rte: SUCCESS (3.336s)
[234.108294] [123/160] (768s left) kms_psr (psr-primary-page-flip)
[234.649818] Subtest psr-primary-page-flip: SKIP (0.000s)
[234.699261] [124/160] (767s left) kms_psr (psr-cursor-plane-move)
[235.253730] Subtest psr-cursor-plane-move: SKIP (0.000s)
[235.290338] [125/160] (767s left) kms_psr (psr-sprite-plane-onoff)
[235.839935] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[235.876086] [126/160] (766s left) kms_psr (psr-primary-mmap-gtt)
[236.440369] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[236.475120] [127/160] (766s left) kms_setmode (basic-clone-single-crtc)
[236.567864] Starting subtest: basic-clone-single-crtc
[237.621126] Subtest basic-clone-single-crtc: SKIP (1.052s)
[238.162689] [128/160] (764s left) i915_pm_rps (basic-api)
[238.238631] Starting subtest: basic-api
[238.242730] Subtest basic-api: SUCCESS (0.004s)
[238.337670] [129/160] (764s left) prime_self_import (basic-llseek-bad)
[238.396123] Starting subtest: basic-llseek-bad
[238.410729] Subtest basic-llseek-bad: SUCCESS (0.013s)
[238.534291] [130/160] (764s left) prime_self_import (basic-llseek-size)
[238.607604] Starting subtest: basic-llseek-size
[238.616833] Subtest basic-llseek-size: SUCCESS (0.009s)
[238.714354] [131/160] (764s left) prime_self_import (basic-with_fd_dup)
[238.784940] Starting subtest: basic-with_fd_dup
[238.795321] Subtest basic-with_fd_dup: SUCCESS (0.010s)
[238.897550] [132/160] (763s left) prime_self_import (basic-with_one_bo)
[238.975789] Starting subtest: basic-with_one_bo
[238.985811] Subtest basic-with_one_bo: SUCCESS (0.012s)
[239.059937] [133/160] (763s left) prime_self_import (basic-with_one_bo_two_files)
[239.121675] Starting subtest: basic-with_one_bo_two_files
[239.132873] Subtest basic-with_one_bo_two_files: SUCCESS (0.012s)
[239.226124] [134/160] (763s left) prime_self_import (basic-with_two_bos)
[239.302180] Starting subtest: basic-with_two_bos
[239.308445] Subtest basic-with_two_bos: SUCCESS (0.010s)
[239.405291] [135/160] (763s left) prime_vgem (basic-fence-flip)
[239.497239] Starting subtest: basic-fence-flip
[240.446939] Subtest basic-fence-flip: SUCCESS (0.947s)
[240.556319] [136/160] (762s left) prime_vgem (basic-fence-mmap)
[240.656803] Starting subtest: basic-fence-mmap
[240.684465] Subtest basic-fence-mmap: SUCCESS (0.028s)
[240.804042] [137/160] (762s left) prime_vgem (basic-fence-read)
[240.908543] Starting subtest: basic-fence-read
[240.968441] Subtest basic-fence-read: SUCCESS (0.060s)
[241.038125] [138/160] (761s left) prime_vgem (basic-gtt)
[241.128909] Starting subtest: basic-gtt
[241.140767] Subtest basic-gtt: SUCCESS (0.012s)
[241.264885] [139/160] (761s left) prime_vgem (basic-read)
[241.347918] Starting subtest: basic-read
[241.377618] Subtest basic-read: SUCCESS (0.028s)
[241.450708] [140/160] (761s left) prime_vgem (basic-write)
[241.542169] Starting subtest: basic-write
[241.572290] Subtest basic-write: SUCCESS (0.030s)
[241.646604] [141/160] (761s left) vgem_basic (setversion)
[241.717992] Starting subtest: setversion
[241.719263] Subtest setversion: SUCCESS (0.000s)
[241.767083] [142/160] (761s left) vgem_basic (create)
[241.832075] Starting subtest: create
[241.832742] Subtest create: SUCCESS (0.000s)
[241.881640] [143/160] (761s left) vgem_basic (debugfs)
[241.949176] Starting subtest: debugfs
[241.949898] Subtest debugfs: SUCCESS (0.000s)
[242.003444] [144/160] (761s left) vgem_basic (dmabuf-export)
[242.082811] Starting subtest: dmabuf-export
[242.094241] Subtest dmabuf-export: SUCCESS (0.010s)
[242.211754] [145/160] (760s left) vgem_basic (dmabuf-fence)
[242.282987] Starting subtest: dmabuf-fence
[242.283585] Subtest dmabuf-fence: SUCCESS (0.001s)
[242.334263] [146/160] (760s left) vgem_basic (dmabuf-fence-before)
[242.398832] Starting subtest: dmabuf-fence-before
[242.399500] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[242.448532] [147/160] (760s left) vgem_basic (dmabuf-mmap)
[242.515667] Starting subtest: dmabuf-mmap
[242.528164] Subtest dmabuf-mmap: SUCCESS (0.012s)
[242.582035] [148/160] (760s left) vgem_basic (mmap)
[242.648754] Starting subtest: mmap
[242.657528] Subtest mmap: SUCCESS (0.009s)
[242.717783] [149/160] (760s left) vgem_basic (second-client)
[242.795244] Starting subtest: second-client
[242.828342] Subtest second-client: SUCCESS (0.033s)
[242.920411] [150/160] (760s left) vgem_basic (sysfs)
[243.011712] Starting subtest: sysfs
[243.012321] Subtest sysfs: SUCCESS (0.001s)
[243.068658] [151/160] (760s left) core_hotunplug (unbind-rebind)
[243.234348] Starting subtest: unbind-rebind
[247.690192] Subtest unbind-rebind: SUCCESS (4.455s)
[247.725185] [152/160] (755s left) vgem_basic (unload)
[247.805237] Starting subtest: unload
[276.873802] Subtest unload: SUCCESS (29.068s)
[277.017843] [153/160] (726s left) i915_module_load (reload)
[277.078533] Starting subtest: reload
[287.671161] Subtest reload: SUCCESS (10.592s)
[287.692543] [154/160] (715s left) gem_lmem_swapping (basic)
[287.798201] Subtest basic: SKIP (0.000s)
[287.838150] [155/160] (715s left) gem_lmem_swapping (parallel-random-engines)
[287.900864] Subtest parallel-random-engines: SKIP (0.000s)
[287.929734] [156/160] (715s left) gem_lmem_swapping (random-engines)
[287.990617] Subtest random-engines: SKIP (0.000s)
[288.020704] [157/160] (715s left) gem_lmem_swapping (verify-random)
[288.081960] Subtest verify-random: SKIP (0.000s)
[288.112755] [158/160] (715s left) i915_pm_rpm (module-reload)
[293.330404] Starting subtest: module-reload
[308.490946] Subtest module-reload: SUCCESS (15.162s)
[308.510546] [159/160] (694s left) i915_selftest (live)
[308.596182] Starting subtest: live
[308.596966] Starting dynamic subtest: sanitycheck
[309.983664] Dynamic subtest sanitycheck: SUCCESS (1.387s)
[309.992976] Starting dynamic subtest: uncore
[311.373605] Dynamic subtest uncore: SUCCESS (1.388s)
[311.381024] Starting dynamic subtest: workarounds
[313.035770] Dynamic subtest workarounds: SUCCESS (1.660s)
[313.042598] Starting dynamic subtest: gt_engines
[314.887554] Dynamic subtest gt_engines: SUCCESS (1.850s)
[314.895018] Starting dynamic subtest: gt_timelines
[327.437485] Dynamic subtest gt_timelines: SUCCESS (12.548s)
[327.445357] Starting dynamic subtest: gt_contexts
[328.940462] Dynamic subtest gt_contexts: SUCCESS (1.501s)
[328.947211] Starting dynamic subtest: gt_lrc
[333.364090] Dynamic subtest gt_lrc: SUCCESS (4.420s)
[333.369654] Starting dynamic subtest: gt_mocs
[334.845517] Dynamic subtest gt_mocs: SUCCESS (1.481s)
[334.852767] Starting dynamic subtest: gt_pm
[342.148806] Dynamic subtest gt_pm: SUCCESS (7.301s)
[342.156281] Starting dynamic subtest: gt_heartbeat
[343.777859] Dynamic subtest gt_heartbeat: SUCCESS (1.627s)
[343.785643] Starting dynamic subtest: gt_tlb
[346.380167] Dynamic subtest gt_tlb: SUCCESS (2.599s)
[346.386029] Starting dynamic subtest: requests
[355.340780] Dynamic subtest requests: SUCCESS (8.960s)
[355.347992] Starting dynamic subtest: migrate
[359.651113] Dynamic subtest migrate: SUCCESS (4.307s)
[359.660206] Starting dynamic subtest: active
[361.069697] Dynamic subtest active: SUCCESS (1.418s)
[361.077024] Starting dynamic subtest: objects
[363.364449] Dynamic subtest objects: SUCCESS (2.293s)
[363.371162] Starting dynamic subtest: mman
[368.597525] Dynamic subtest mman: SUCCESS (5.231s)
[368.605135] Starting dynamic subtest: dmabuf
[370.059969] Dynamic subtest dmabuf: SUCCESS (1.460s)
[370.067025] Starting dynamic subtest: vma
[371.474879] Dynamic subtest vma: SUCCESS (1.413s)
[371.483535] Starting dynamic subtest: coherency
[374.056094] Dynamic subtest coherency: SUCCESS (2.578s)
[374.061647] Starting dynamic subtest: gtt
[382.779613] Dynamic subtest gtt: SUCCESS (8.723s)
[382.787762] Starting dynamic subtest: gem
[384.311646] Dynamic subtest gem: SUCCESS (1.530s)
[384.320974] Starting dynamic subtest: evict
[387.560118] Dynamic subtest evict: SUCCESS (3.245s)
[387.565861] Starting dynamic subtest: hugepages
[394.897106] Dynamic subtest hugepages: SUCCESS (7.335s)
[394.904510] Starting dynamic subtest: gem_contexts
[412.996488] Dynamic subtest gem_contexts: SUCCESS (18.099s)
[413.003678] Starting dynamic subtest: client
[414.421602] Dynamic subtest client: SUCCESS (1.423s)
[414.428659] Starting dynamic subtest: gem_migrate
[415.803693] Dynamic subtest gem_migrate: SUCCESS (1.380s)
[415.811748] Starting dynamic subtest: reset
[417.860763] Dynamic subtest reset: SUCCESS (2.055s)
[417.869759] Starting dynamic subtest: memory_region
[419.228516] Dynamic subtest memory_region: SUCCESS (1.366s)
[419.235310] Starting dynamic subtest: hangcheck
[449.167584] Dynamic subtest hangcheck: SUCCESS (29.937s)
[449.176146] Starting dynamic subtest: execlists
[463.454195] Dynamic subtest execlists: SUCCESS (14.283s)
[463.460459] Starting dynamic subtest: ring_submission
[464.860658] Dynamic subtest ring_submission: SUCCESS (1.407s)
[464.867729] Starting dynamic subtest: perf
[466.399715] Dynamic subtest perf: SUCCESS (1.537s)
[466.407225] Starting dynamic subtest: slpc
[467.802584] Dynamic subtest slpc: SUCCESS (1.401s)
[467.809955] Starting dynamic subtest: guc
[469.209109] Dynamic subtest guc: SUCCESS (1.403s)
[469.214398] Starting dynamic subtest: guc_multi_lrc
[470.619125] Dynamic subtest guc_multi_lrc: SUCCESS (1.408s)
[470.625041] Starting dynamic subtest: guc_hang
[472.014155] Dynamic subtest guc_hang: SUCCESS (1.393s)
[472.020296] Starting dynamic subtest: late_gt_pm
[473.442606] Dynamic subtest late_gt_pm: SUCCESS (1.428s)
[473.443271] Subtest live: SUCCESS (164.848s)
[473.462894] [160/160] (529s left) dmabuf (all-tests)
[473.531171] Starting subtest: all-tests
[473.531840] Starting dynamic subtest: sanitycheck
[473.601403] Dynamic subtest sanitycheck: SUCCESS (0.069s)
[473.620440] Starting dynamic subtest: dma_fence
[473.788041] Dynamic subtest dma_fence: SUCCESS (0.184s)
[473.797965] Starting dynamic subtest: dma_fence_chain
[488.097233] Dynamic subtest dma_fence_chain: SUCCESS (14.305s)
[488.110641] Starting dynamic subtest: dma_fence_unwrap
[488.174755] Dynamic subtest dma_fence_unwrap: SUCCESS (0.076s)
[488.205382] Starting dynamic subtest: dma_resv
[488.263466] Dynamic subtest dma_resv: SUCCESS (0.083s)
[488.266659] Subtest all-tests: SUCCESS (14.734s)
[488.309205] Closing watchdogs
Done.