[45.473994] Initializing watchdogs
[45.474134]   /dev/watchdog0
[45.481283] [001/165] (960s left) i915_module_load (load)
[45.561109] Starting subtest: load
[46.630632] Subtest load: SUCCESS (1.063s)
[46.649622] [002/165] (959s left) core_auth (basic-auth)
[46.743653] Starting subtest: basic-auth
[46.745097] Subtest basic-auth: SUCCESS (0.001s)
[46.829383] [003/165] (959s left) debugfs_test (read_all_entries)
[46.937407] Starting subtest: read_all_entries
[47.029655] Subtest read_all_entries: SUCCESS (0.092s)
[47.131376] [004/165] (958s left) debugfs_test (basic-hwmon)
[47.205652] Starting subtest: basic-hwmon
[47.207726] Subtest basic-hwmon: SKIP (0.000s)
[47.345332] [005/165] (958s left) fbdev (eof)
[47.433187] Starting subtest: eof
[47.434213] Subtest eof: SUCCESS (0.001s)
[47.487554] [006/165] (958s left) fbdev (info)
[47.554427] Starting subtest: info
[47.555334] Subtest info: SUCCESS (0.000s)
[47.621021] [007/165] (958s left) fbdev (nullptr)
[47.698811] Starting subtest: nullptr
[47.699924] Subtest nullptr: SUCCESS (0.000s)
[47.756102] [008/165] (958s left) fbdev (read)
[47.832075] Starting subtest: read
[48.681263] Subtest read: SUCCESS (0.840s)
[48.720578] [009/165] (957s left) fbdev (write)
[48.799082] Starting subtest: write
[49.227045] Subtest write: SUCCESS (0.419s)
[49.293725] [010/165] (956s left) gem_basic (bad-close)
[49.362410] Starting subtest: bad-close
[49.364455] Subtest bad-close: SUCCESS (0.000s)
[49.426551] [011/165] (956s left) gem_basic (create-close)
[49.497523] Starting subtest: create-close
[49.499717] Subtest create-close: SUCCESS (0.000s)
[49.621348] [012/165] (956s left) gem_basic (create-fd-close)
[49.694896] Starting subtest: create-fd-close
[49.696861] Subtest create-fd-close: SUCCESS (0.000s)
[49.824385] [013/165] (956s left) gem_busy (busy@all-engines)
[49.912244] Starting subtest: busy
[49.913200] Starting dynamic subtest: all-engines
[49.973995] Dynamic subtest all-engines: SUCCESS (0.062s)
[49.974963] Subtest busy: SUCCESS (0.062s)
[50.421678] [014/165] (955s left) gem_close_race (basic-process)
[50.515065] Starting subtest: basic-process
[50.581499] Subtest basic-process: SUCCESS (0.069s)
[50.822924] [015/165] (955s left) gem_close_race (basic-threads)
[50.913296] Starting subtest: basic-threads
[52.086589] Subtest basic-threads: SUCCESS (1.173s)
[52.359428] [016/165] (953s left) gem_ctx_create (basic)
[52.453218] Starting subtest: basic
[52.454263] Subtest basic: SUCCESS (0.000s)
[52.679372] [017/165] (953s left) gem_ctx_create (basic-files)
[52.765646] Starting subtest: basic-files
[54.786796] Subtest basic-files: SUCCESS (2.021s)
[55.091690] [018/165] (951s left) gem_ctx_exec (basic)
[55.168500] Starting subtest: basic
[55.173020] Subtest basic: SUCCESS (0.004s)
[55.317592] [019/165] (951s left) gem_exec_basic (basic)
[55.401297] Starting subtest: basic
[55.402299] Starting dynamic subtest: rcs0-smem
[55.403312] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[55.411284] Starting dynamic subtest: bcs0-smem
[55.412273] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[55.419299] Starting dynamic subtest: vcs0-smem
[55.420362] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[55.427280] Starting dynamic subtest: vecs0-smem
[55.428310] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[55.429343] Subtest basic: SUCCESS (0.007s)
[55.664614] [020/165] (950s left) gem_exec_create (basic)
[55.748633] Starting subtest: basic
[55.749784] Starting dynamic subtest: smem
[57.793507] Dynamic subtest smem: SUCCESS (2.045s)
[57.794564] Subtest basic: SUCCESS (2.045s)
[58.046766] [021/165] (948s left) gem_exec_fence (basic-busy)
[58.293814] Starting subtest: basic-busy
[58.295414] Starting dynamic subtest: rcs0
[58.326228] Dynamic subtest rcs0: SUCCESS (0.033s)
[58.333724] Starting dynamic subtest: bcs0
[58.355465] Dynamic subtest bcs0: SUCCESS (0.029s)
[58.362848] Starting dynamic subtest: vcs0
[58.378333] Dynamic subtest vcs0: SUCCESS (0.023s)
[58.385621] Starting dynamic subtest: vecs0
[58.403211] Dynamic subtest vecs0: SUCCESS (0.025s)
[58.404231] Subtest basic-busy: SUCCESS (0.110s)
[59.118572] [022/165] (947s left) gem_exec_fence (basic-wait)
[59.351264] Starting subtest: basic-wait
[59.352563] Starting dynamic subtest: rcs0
[59.384269] Dynamic subtest rcs0: SUCCESS (0.033s)
[59.392064] Starting dynamic subtest: bcs0
[59.415288] Dynamic subtest bcs0: SUCCESS (0.031s)
[59.422982] Starting dynamic subtest: vcs0
[59.433119] Dynamic subtest vcs0: SUCCESS (0.018s)
[59.441115] Starting dynamic subtest: vecs0
[59.453206] Dynamic subtest vecs0: SUCCESS (0.020s)
[59.454288] Subtest basic-wait: SUCCESS (0.102s)
[60.131482] [023/165] (946s left) gem_exec_fence (basic-await)
[60.373998] Starting subtest: basic-await
[60.375663] Starting dynamic subtest: rcs0
[60.477851] Dynamic subtest rcs0: SUCCESS (0.104s)
[60.486495] Starting dynamic subtest: bcs0
[60.575796] Dynamic subtest bcs0: SUCCESS (0.097s)
[60.585454] Starting dynamic subtest: vcs0
[60.680139] Dynamic subtest vcs0: SUCCESS (0.104s)
[60.688137] Starting dynamic subtest: vecs0
[60.774833] Dynamic subtest vecs0: SUCCESS (0.094s)
[60.775929] Subtest basic-await: SUCCESS (0.401s)
[61.540112] [024/165] (944s left) gem_exec_fence (nb-await)
[61.777342] Starting subtest: nb-await
[61.778595] Starting dynamic subtest: rcs0
[61.841853] Dynamic subtest rcs0: SUCCESS (0.065s)
[61.857475] Starting dynamic subtest: bcs0
[61.917216] Dynamic subtest bcs0: SUCCESS (0.073s)
[61.927124] Starting dynamic subtest: vcs0
[61.987419] Dynamic subtest vcs0: SUCCESS (0.068s)
[62.000654] Starting dynamic subtest: vecs0
[62.055524] Dynamic subtest vecs0: SUCCESS (0.071s)
[62.057081] Subtest nb-await: SUCCESS (0.278s)
[62.705488] [025/165] (943s left) gem_exec_gttfill (basic)
[62.796904] Starting subtest: basic
[72.314193] Subtest basic: SUCCESS (9.509s)
[72.508300] [026/165] (933s left) gem_exec_parallel (engines)
[72.697397] Starting subtest: engines
[72.698497] Starting dynamic subtest: basic
[75.054385] Dynamic subtest basic: SUCCESS (2.356s)
[75.063985] Starting dynamic subtest: contexts
[79.350911] Dynamic subtest contexts: SUCCESS (4.287s)
[79.359636] Starting dynamic subtest: fds
[85.588106] Dynamic subtest fds: SUCCESS (6.246s)
[85.597978] Starting dynamic subtest: userptr
[87.866619] Dynamic subtest userptr: SUCCESS (2.277s)
[87.869054] Subtest engines: SUCCESS (15.168s)
[88.110829] [027/165] (918s left) gem_exec_store (basic)
[88.201064] Starting subtest: basic
[88.259900] Subtest basic: SUCCESS (0.058s)
[88.505632] [028/165] (918s left) gem_flink_basic (bad-flink)
[88.580182] Starting subtest: bad-flink
[88.581375] Subtest bad-flink: SUCCESS (0.000s)
[88.644050] [029/165] (917s left) gem_flink_basic (bad-open)
[88.717116] Starting subtest: bad-open
[88.718158] Subtest bad-open: SUCCESS (0.000s)
[88.811119] [030/165] (917s left) gem_flink_basic (basic)
[88.883080] Starting subtest: basic
[88.884065] Subtest basic: SUCCESS (0.000s)
[89.029829] [031/165] (917s left) gem_flink_basic (double-flink)
[89.104898] Starting subtest: double-flink
[89.105980] Subtest double-flink: SUCCESS (0.000s)
[89.229397] [032/165] (917s left) gem_flink_basic (flink-lifetime)
[89.304963] Starting subtest: flink-lifetime
[89.306255] Subtest flink-lifetime: SUCCESS (0.002s)
[89.437585] [033/165] (917s left) gem_huc_copy (huc-copy)
[89.516574] Starting subtest: huc-copy
[89.518992] Subtest huc-copy: SKIP (0.000s)
[89.650471] [034/165] (917s left) gem_linear_blits (basic)
[89.876066] Starting subtest: basic
[89.886431] Subtest basic: SUCCESS (0.010s)
[90.042219] [035/165] (916s left) gem_mmap (basic)
[90.166380] Starting subtest: basic
[90.171656] Subtest basic: SUCCESS (0.001s)
[90.252099] [036/165] (916s left) gem_mmap_gtt (basic)
[90.325273] Starting subtest: basic
[90.326381] Subtest basic: SUCCESS (0.001s)
[90.392990] [037/165] (916s left) gem_render_linear_blits (basic)
[90.470447] Starting subtest: basic
[90.513950] Subtest basic: SUCCESS (0.042s)
[90.565544] [038/165] (916s left) gem_render_tiled_blits (basic)
[90.644780] Starting subtest: basic
[90.689615] Subtest basic: SUCCESS (0.045s)
[90.731588] [039/165] (916s left) gem_ringfill (basic-all)
[91.018213] Starting subtest: basic-all
[92.182293] Subtest basic-all: SUCCESS (1.155s)
[92.308487] [040/165] (914s left) gem_softpin (allocator-basic)
[92.387549] Starting subtest: allocator-basic
[92.532591] Subtest allocator-basic: SUCCESS (0.136s)
[92.665407] [041/165] (914s left) gem_softpin (allocator-basic-reserve)
[92.742428] Starting subtest: allocator-basic-reserve
[92.887882] Subtest allocator-basic-reserve: SUCCESS (0.136s)
[93.029386] [042/165] (913s left) gem_softpin (safe-alignment)
[93.108185] Starting subtest: safe-alignment
[93.123239] Subtest safe-alignment: SUCCESS (0.015s)
[93.263534] [043/165] (913s left) gem_sync (basic-all)
[93.352133] Starting subtest: basic-all
[95.577480] Subtest basic-all: SUCCESS (2.225s)
[95.821932] [044/165] (911s left) gem_sync (basic-each)
[95.928241] Starting subtest: basic-each
[98.160512] Subtest basic-each: SUCCESS (2.232s)
[98.414301] [045/165] (908s left) gem_tiled_blits (basic)
[98.637537] Starting subtest: basic
[98.663556] Subtest basic: SUCCESS (0.026s)
[98.818819] [046/165] (908s left) gem_tiled_fence_blits (basic)
[99.099752] Starting subtest: basic
[99.114191] Subtest basic: SUCCESS (0.015s)
[99.245310] [047/165] (907s left) gem_tiled_pread_basic
[99.606210] [048/165] (907s left) gem_wait (busy@all-engines)
[99.709335] Starting subtest: busy
[99.710632] Starting dynamic subtest: all-engines
[100.244215] Dynamic subtest all-engines: SUCCESS (0.538s)
[100.245132] Subtest busy: SUCCESS (0.538s)
[100.500069] [049/165] (906s left) gem_wait (wait@all-engines)
[100.598084] Starting subtest: wait
[100.599050] Starting dynamic subtest: all-engines
[101.665836] Dynamic subtest all-engines: SUCCESS (1.066s)
[101.668521] Subtest wait: SUCCESS (1.067s)
[101.966995] [050/165] (905s left) i915_getparams_basic (basic-eu-total)
[102.043219] Starting subtest: basic-eu-total
[102.045373] Subtest basic-eu-total: SUCCESS (0.000s)
[102.110180] [051/165] (905s left) i915_getparams_basic (basic-subslice-total)
[102.181019] Starting subtest: basic-subslice-total
[102.183051] Subtest basic-subslice-total: SUCCESS (0.000s)
[102.241889] [052/165] (904s left) i915_hangman (error-state-basic)
[102.327456] Starting subtest: error-state-basic
[102.337199] Subtest error-state-basic: SUCCESS (0.010s)
[102.408779] [053/165] (904s left) i915_pciid
[102.542970] [054/165] (904s left) kms_addfb_basic (addfb25-4-tiled)
[102.661084] Starting subtest: addfb25-4-tiled
[102.662078] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[102.776387] [055/165] (904s left) kms_addfb_basic (addfb25-bad-modifier)
[102.864026] Starting subtest: addfb25-bad-modifier
[102.865068] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[103.019070] [056/165] (904s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[103.108083] Starting subtest: addfb25-framebuffer-vs-set-tiling
[103.109046] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[103.250431] [057/165] (904s left) kms_addfb_basic (addfb25-modifier-no-flag)
[103.329128] Starting subtest: addfb25-modifier-no-flag
[103.330276] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[103.471744] [058/165] (903s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[103.558197] Starting subtest: addfb25-x-tiled-legacy
[103.559084] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[103.720482] [059/165] (903s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[103.805485] Starting subtest: addfb25-x-tiled-mismatch-legacy
[103.806403] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[103.947787] [060/165] (903s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[104.061129] Starting subtest: addfb25-yf-tiled-legacy
[104.062173] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[104.166924] [061/165] (903s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[104.289328] Starting subtest: addfb25-y-tiled-legacy
[104.290403] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[104.392790] [062/165] (903s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[104.504178] Starting subtest: addfb25-y-tiled-small-legacy
[104.505205] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[104.627272] [063/165] (902s left) kms_addfb_basic (bad-pitch-0)
[104.710744] Starting subtest: bad-pitch-0
[104.711839] Subtest bad-pitch-0: SUCCESS (0.000s)
[104.879535] [064/165] (902s left) kms_addfb_basic (bad-pitch-1024)
[104.953420] Starting subtest: bad-pitch-1024
[104.954447] Subtest bad-pitch-1024: SUCCESS (0.000s)
[105.094871] [065/165] (902s left) kms_addfb_basic (bad-pitch-128)
[105.167792] Starting subtest: bad-pitch-128
[105.168818] Subtest bad-pitch-128: SUCCESS (0.000s)
[105.333233] [066/165] (902s left) kms_addfb_basic (bad-pitch-256)
[105.405105] Starting subtest: bad-pitch-256
[105.406115] Subtest bad-pitch-256: SUCCESS (0.000s)
[105.552091] [067/165] (901s left) kms_addfb_basic (bad-pitch-32)
[105.632112] Starting subtest: bad-pitch-32
[105.633236] Subtest bad-pitch-32: SUCCESS (0.000s)
[105.800949] [068/165] (901s left) kms_addfb_basic (bad-pitch-63)
[105.872815] Starting subtest: bad-pitch-63
[105.873942] Subtest bad-pitch-63: SUCCESS (0.000s)
[106.039603] [069/165] (901s left) kms_addfb_basic (bad-pitch-65536)
[106.112433] Starting subtest: bad-pitch-65536
[106.113536] Subtest bad-pitch-65536: SUCCESS (0.000s)
[106.249832] [070/165] (901s left) kms_addfb_basic (bad-pitch-999)
[106.326502] Starting subtest: bad-pitch-999
[106.327401] Subtest bad-pitch-999: SUCCESS (0.000s)
[106.469503] [071/165] (901s left) kms_addfb_basic (basic)
[106.544331] Starting subtest: basic
[106.545386] Subtest basic: SUCCESS (0.000s)
[106.692432] [072/165] (900s left) kms_addfb_basic (basic-x-tiled-legacy)
[106.780163] Starting subtest: basic-x-tiled-legacy
[106.781201] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[106.942943] [073/165] (900s left) kms_addfb_basic (basic-y-tiled-legacy)
[107.027737] Starting subtest: basic-y-tiled-legacy
[107.028882] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[107.162097] [074/165] (900s left) kms_addfb_basic (bo-too-small)
[107.271070] Starting subtest: bo-too-small
[107.272194] Subtest bo-too-small: SUCCESS (0.000s)
[107.377193] [075/165] (900s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[107.488142] Starting subtest: bo-too-small-due-to-tiling
[107.489060] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[107.581846] [076/165] (900s left) kms_addfb_basic (clobberred-modifier)
[107.655264] Starting subtest: clobberred-modifier
[107.656309] Subtest clobberred-modifier: SUCCESS (0.000s)
[107.815916] [077/165] (900s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[107.901214] Starting subtest: framebuffer-vs-set-tiling
[107.902255] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[108.049589] [078/165] (899s left) kms_addfb_basic (invalid-get-prop)
[108.129384] Starting subtest: invalid-get-prop
[108.130491] Subtest invalid-get-prop: SUCCESS (0.000s)
[108.270228] [079/165] (899s left) kms_addfb_basic (invalid-get-prop-any)
[108.346716] Starting subtest: invalid-get-prop-any
[108.347750] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[108.479840] [080/165] (899s left) kms_addfb_basic (invalid-set-prop)
[108.554487] Starting subtest: invalid-set-prop
[108.555515] Subtest invalid-set-prop: SUCCESS (0.000s)
[108.684895] [081/165] (899s left) kms_addfb_basic (invalid-set-prop-any)
[108.761288] Starting subtest: invalid-set-prop-any
[108.762179] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[108.923354] [082/165] (899s left) kms_addfb_basic (no-handle)
[109.006337] Starting subtest: no-handle
[109.007295] Subtest no-handle: SUCCESS (0.000s)
[109.174347] [083/165] (898s left) kms_addfb_basic (size-max)
[109.295509] Starting subtest: size-max
[109.296604] Subtest size-max: SUCCESS (0.000s)
[109.410262] [084/165] (898s left) kms_addfb_basic (small-bo)
[109.517519] Starting subtest: small-bo
[109.518658] Subtest small-bo: SUCCESS (0.000s)
[109.605657] [085/165] (898s left) kms_addfb_basic (tile-pitch-mismatch)
[109.679825] Starting subtest: tile-pitch-mismatch
[109.680996] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[109.823434] [086/165] (898s left) kms_addfb_basic (too-high)
[109.941423] Starting subtest: too-high
[109.942404] Subtest too-high: SUCCESS (0.001s)
[110.040330] [087/165] (898s left) kms_addfb_basic (too-wide)
[110.152126] Starting subtest: too-wide
[110.153257] Subtest too-wide: SUCCESS (0.000s)
[110.268496] [088/165] (897s left) kms_addfb_basic (unused-handle)
[110.357410] Starting subtest: unused-handle
[110.358516] Subtest unused-handle: SUCCESS (0.000s)
[110.490870] [089/165] (897s left) kms_addfb_basic (unused-modifier)
[110.566064] Starting subtest: unused-modifier
[110.567170] Subtest unused-modifier: SUCCESS (0.000s)
[110.706323] [090/165] (897s left) kms_addfb_basic (unused-offsets)
[110.781490] Starting subtest: unused-offsets
[110.782788] Subtest unused-offsets: SUCCESS (0.000s)
[110.923553] [091/165] (897s left) kms_addfb_basic (unused-pitches)
[111.002403] Starting subtest: unused-pitches
[111.003416] Subtest unused-pitches: SUCCESS (0.000s)
[111.150462] [092/165] (897s left) kms_busy (basic)
[111.279380] Starting subtest: basic
[111.281722] Starting dynamic subtest: flip
[112.244769] Dynamic subtest flip: SUCCESS (0.959s)
[112.259141] Starting dynamic subtest: modeset
[116.082136] Dynamic subtest modeset: SUCCESS (3.838s)
[116.084540] Subtest basic: SUCCESS (4.800s)
[117.037400] [093/165] (891s left) kms_prop_blob (basic)
[117.127033] Starting subtest: basic
[117.128138] Subtest basic: SUCCESS (0.000s)
[117.245967] [094/165] (891s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[117.357741] Starting subtest: basic-busy-flip-before-cursor-atomic
[117.359831] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[117.440370] [095/165] (890s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[117.550321] Starting subtest: basic-busy-flip-before-cursor-legacy
[117.552386] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[117.652281] [096/165] (890s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[117.764479] Starting subtest: basic-flip-after-cursor-atomic
[119.069672] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.298s)
[119.964335] [097/165] (888s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[120.077069] Starting subtest: basic-flip-after-cursor-legacy
[121.374614] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.294s)
[122.261421] [098/165] (886s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[122.371043] Starting subtest: basic-flip-after-cursor-varying-size
[123.664086] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.289s)
[124.609404] [099/165] (883s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[124.722092] Starting subtest: basic-flip-before-cursor-atomic
[125.993143] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.266s)
[126.890420] [100/165] (881s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[126.999129] Starting subtest: basic-flip-before-cursor-legacy
[128.284393] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.282s)
[129.213044] [101/165] (879s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[129.327995] Starting subtest: basic-flip-before-cursor-varying-size
[130.676674] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.343s)
[131.604407] [102/165] (876s left) kms_dsc (dsc-basic)
[131.722090] Subtest dsc-basic: SKIP (0.000s)
[131.762403] [103/165] (876s left) kms_flip (basic-flip-vs-dpms)
[131.851814] Starting subtest: basic-flip-vs-dpms
[131.855613] Starting dynamic subtest: A-eDP1
[134.689787] Dynamic subtest A-eDP1: SUCCESS (2.831s)
[134.727510] Starting dynamic subtest: B-eDP1
[137.041144] Dynamic subtest B-eDP1: SUCCESS (2.345s)
[137.076313] Starting dynamic subtest: C-eDP1
[139.421247] Dynamic subtest C-eDP1: SUCCESS (2.367s)
[139.435529] Subtest basic-flip-vs-dpms: SUCCESS (7.581s)
[140.333397] [104/165] (868s left) kms_flip (basic-flip-vs-modeset)
[140.429529] Starting subtest: basic-flip-vs-modeset
[140.432457] Starting dynamic subtest: A-eDP1
[143.314380] Dynamic subtest A-eDP1: SUCCESS (2.878s)
[143.371618] Starting dynamic subtest: B-eDP1
[145.742451] Dynamic subtest B-eDP1: SUCCESS (2.415s)
[145.798131] Starting dynamic subtest: C-eDP1
[148.114358] Dynamic subtest C-eDP1: SUCCESS (2.366s)
[148.133808] Subtest basic-flip-vs-modeset: SUCCESS (7.701s)
[148.992137] [105/165] (859s left) kms_flip (basic-flip-vs-wf_vblank)
[149.089525] Starting subtest: basic-flip-vs-wf_vblank
[149.093857] Starting dynamic subtest: A-eDP1
[151.388404] Dynamic subtest A-eDP1: SUCCESS (2.293s)
[151.401388] Starting dynamic subtest: B-eDP1
[153.694756] Dynamic subtest B-eDP1: SUCCESS (2.307s)
[153.710933] Starting dynamic subtest: C-eDP1
[155.993992] Dynamic subtest C-eDP1: SUCCESS (2.298s)
[155.998223] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.909s)
[157.310581] [106/165] (851s left) kms_flip (basic-plain-flip)
[157.401159] Starting subtest: basic-plain-flip
[157.406304] Starting dynamic subtest: A-eDP1
[159.426166] Dynamic subtest A-eDP1: SUCCESS (2.016s)
[159.503148] Starting dynamic subtest: B-eDP1
[161.496917] Dynamic subtest B-eDP1: SUCCESS (2.062s)
[161.574582] Starting dynamic subtest: C-eDP1
[163.576355] Dynamic subtest C-eDP1: SUCCESS (2.073s)
[163.579577] Subtest basic-plain-flip: SUCCESS (6.179s)
[164.864176] [107/165] (843s left) kms_force_connector_basic (force-connector-state)
[164.965995] Starting subtest: force-connector-state
[165.479058] Subtest force-connector-state: SUCCESS (0.513s)
[166.781229] [108/165] (841s left) kms_force_connector_basic (force-edid)
[166.880057] Starting subtest: force-edid
[166.910313] Subtest force-edid: SUCCESS (0.030s)
[167.066585] [109/165] (841s left) kms_force_connector_basic (force-load-detect)
[167.162989] Starting subtest: force-load-detect
[167.165113] Subtest force-load-detect: SKIP (0.000s)
[167.317439] [110/165] (841s left) kms_force_connector_basic (prune-stale-modes)
[167.416166] Starting subtest: prune-stale-modes
[167.447704] Subtest prune-stale-modes: SUCCESS (0.034s)
[167.615504] [111/165] (841s left) kms_frontbuffer_tracking (basic)
[167.730292] Starting subtest: basic
[170.674909] Subtest basic: SUCCESS (2.945s)
[170.820357] [112/165] (837s left) kms_hdmi_inject (inject-audio)
[171.211801] Starting subtest: inject-audio
[171.351444] Subtest inject-audio: SUCCESS (0.143s)
[172.132585] [113/165] (836s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[172.248507] Starting subtest: compare-crc-sanitycheck-xr24
[172.250104] Starting dynamic subtest: pipe-A-eDP-1
[172.955737] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s)
[172.995138] Starting dynamic subtest: pipe-B-eDP-1
[174.323159] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.346s)
[174.379400] Starting dynamic subtest: pipe-C-eDP-1
[175.685623] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.342s)
[175.689620] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.432s)
[176.556878] [114/165] (832s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[176.672205] Starting subtest: compare-crc-sanitycheck-nv12
[176.675152] Starting dynamic subtest: pipe-A-eDP-1
[176.677165] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[176.688068] Starting dynamic subtest: pipe-B-eDP-1
[176.689949] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[176.698941] Starting dynamic subtest: pipe-C-eDP-1
[176.700933] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[176.702906] Subtest compare-crc-sanitycheck-nv12: SKIP (0.010s)
[176.767054] [115/165] (832s left) kms_pipe_crc_basic (hang-read-crc)
[176.877134] Starting subtest: hang-read-crc
[176.878203] Starting dynamic subtest: pipe-A-eDP-1
[179.344305] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.459s)
[179.414156] Starting dynamic subtest: pipe-B-eDP-1
[182.623701] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.259s)
[182.685465] Starting dynamic subtest: pipe-C-eDP-1
[185.976293] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.334s)
[185.979452] Subtest hang-read-crc: SUCCESS (9.099s)
[186.860814] [116/165] (821s left) kms_pipe_crc_basic (nonblocking-crc)
[186.975128] Starting subtest: nonblocking-crc
[186.976218] Starting dynamic subtest: pipe-A-eDP-1
[187.936665] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.956s)
[188.017351] Starting dynamic subtest: pipe-B-eDP-1
[189.698287] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.736s)
[189.774206] Starting dynamic subtest: pipe-C-eDP-1
[191.482665] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.772s)
[191.486608] Subtest nonblocking-crc: SUCCESS (4.510s)
[192.428151] [117/165] (816s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[192.544226] Starting subtest: nonblocking-crc-frame-sequence
[192.545245] Starting dynamic subtest: pipe-A-eDP-1
[193.592702] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.039s)
[193.662163] Starting dynamic subtest: pipe-B-eDP-1
[195.328655] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.718s)
[195.404158] Starting dynamic subtest: pipe-C-eDP-1
[197.062634] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.711s)
[197.078370] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.522s)
[197.935799] [118/165] (810s left) kms_pipe_crc_basic (read-crc)
[198.052396] Starting subtest: read-crc
[198.055068] Starting dynamic subtest: pipe-A-eDP-1
[198.955327] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.895s)
[199.026064] Starting dynamic subtest: pipe-B-eDP-1
[200.562436] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.580s)
[200.626940] Starting dynamic subtest: pipe-C-eDP-1
[202.172803] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.591s)
[202.176720] Subtest read-crc: SUCCESS (4.116s)
[203.093918] [119/165] (805s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[203.219666] Starting subtest: read-crc-frame-sequence
[203.220700] Starting dynamic subtest: pipe-A-eDP-1
[204.121365] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.886s)
[204.190925] Starting dynamic subtest: pipe-B-eDP-1
[205.747659] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.606s)
[205.821107] Starting dynamic subtest: pipe-C-eDP-1
[207.342713] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.574s)
[207.346679] Subtest read-crc-frame-sequence: SUCCESS (4.123s)
[208.271588] [120/165] (800s left) kms_pm_backlight (basic-brightness)
[208.393930] Starting subtest: basic-brightness
[208.493768] Starting dynamic subtest: eDP-1
[209.129130] Dynamic subtest eDP-1: SUCCESS (0.633s)
[209.137846] Subtest basic-brightness: SUCCESS (0.743s)
[210.044557] [121/165] (798s left) kms_pm_rpm (basic-pci-d3-state)
[211.793738] Starting subtest: basic-pci-d3-state
[216.291059] Subtest basic-pci-d3-state: SUCCESS (4.498s)
[216.451283] [122/165] (792s left) kms_pm_rpm (basic-rte)
[216.520807] Starting subtest: basic-rte
[222.692223] Subtest basic-rte: SUCCESS (6.171s)
[228.198854] [123/165] (780s left) kms_psr (primary_page_flip)
[228.339405] Starting subtest: primary_page_flip
[230.441934] Subtest primary_page_flip: SUCCESS (2.089s)
[231.369540] [124/165] (777s left) kms_psr (cursor_plane_move)
[231.490714] Starting subtest: cursor_plane_move
[233.589626] Subtest cursor_plane_move: SUCCESS (2.088s)
[234.534961] [125/165] (774s left) kms_psr (sprite_plane_onoff)
[234.655319] Starting subtest: sprite_plane_onoff
[236.795433] Subtest sprite_plane_onoff: SUCCESS (2.132s)
[237.731625] [126/165] (771s left) kms_psr (primary_mmap_gtt)
[237.848384] Starting subtest: primary_mmap_gtt
[239.909459] Subtest primary_mmap_gtt: SUCCESS (2.048s)
[240.817319] [127/165] (768s left) kms_setmode (basic-clone-single-crtc)
[240.895216] Starting subtest: basic-clone-single-crtc
[240.897864] Subtest basic-clone-single-crtc: SKIP (0.001s)
[240.985666] [128/165] (768s left) i915_pm_rps (basic-api)
[241.074193] Starting subtest: basic-api
[241.078935] Subtest basic-api: SUCCESS (0.005s)
[241.213664] [129/165] (768s left) prime_self_import (basic-llseek-bad)
[241.285281] Starting subtest: basic-llseek-bad
[241.287360] Subtest basic-llseek-bad: SUCCESS (0.002s)
[241.413492] [130/165] (767s left) prime_self_import (basic-llseek-size)
[241.484205] Starting subtest: basic-llseek-size
[241.486379] Subtest basic-llseek-size: SUCCESS (0.003s)
[241.620039] [131/165] (767s left) prime_self_import (basic-with_fd_dup)
[241.691823] Starting subtest: basic-with_fd_dup
[241.696116] Subtest basic-with_fd_dup: SUCCESS (0.004s)
[241.833157] [132/165] (767s left) prime_self_import (basic-with_one_bo)
[241.907559] Starting subtest: basic-with_one_bo
[241.912444] Subtest basic-with_one_bo: SUCCESS (0.003s)
[242.013542] [133/165] (767s left) prime_self_import (basic-with_one_bo_two_files)
[242.101408] Starting subtest: basic-with_one_bo_two_files
[242.103532] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[242.236756] [134/165] (767s left) prime_self_import (basic-with_two_bos)
[242.312446] Starting subtest: basic-with_two_bos
[242.314465] Subtest basic-with_two_bos: SUCCESS (0.003s)
[242.449929] [135/165] (766s left) prime_vgem (basic-fence-flip)
[242.532969] Starting subtest: basic-fence-flip
[243.025562] Subtest basic-fence-flip: SUCCESS (0.492s)
[243.135674] [136/165] (766s left) prime_vgem (basic-fence-mmap)
[243.218297] Starting subtest: basic-fence-mmap
[243.255309] Subtest basic-fence-mmap: SUCCESS (0.038s)
[243.341440] [137/165] (766s left) prime_vgem (basic-fence-read)
[243.447047] Starting subtest: basic-fence-read
[243.505947] Subtest basic-fence-read: SUCCESS (0.059s)
[243.597983] [138/165] (765s left) prime_vgem (basic-gtt)
[243.699362] Starting subtest: basic-gtt
[243.717082] Subtest basic-gtt: SUCCESS (0.017s)
[243.813147] [139/165] (765s left) prime_vgem (basic-read)
[243.911158] Starting subtest: basic-read
[243.938123] Subtest basic-read: SUCCESS (0.027s)
[244.058058] [140/165] (765s left) prime_vgem (basic-write)
[244.149367] Starting subtest: basic-write
[244.179253] Subtest basic-write: SUCCESS (0.030s)
[244.255839] [141/165] (765s left) vgem_basic (setversion)
[244.343362] Starting subtest: setversion
[244.345365] Subtest setversion: SUCCESS (0.000s)
[244.402499] [142/165] (765s left) vgem_basic (create)
[244.476661] Starting subtest: create
[244.477781] Subtest create: SUCCESS (0.000s)
[244.536638] [143/165] (765s left) vgem_basic (debugfs)
[244.612270] Starting subtest: debugfs
[244.613273] Subtest debugfs: SUCCESS (0.000s)
[244.670220] [144/165] (764s left) vgem_basic (dmabuf-export)
[244.760533] Starting subtest: dmabuf-export
[244.764479] Subtest dmabuf-export: SUCCESS (0.002s)
[244.853960] [145/165] (764s left) vgem_basic (dmabuf-fence)
[244.943241] Starting subtest: dmabuf-fence
[244.944399] Subtest dmabuf-fence: SUCCESS (0.001s)
[245.002413] [146/165] (764s left) vgem_basic (dmabuf-fence-before)
[245.077065] Starting subtest: dmabuf-fence-before
[245.078086] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[245.136084] [147/165] (764s left) vgem_basic (dmabuf-mmap)
[245.210349] Starting subtest: dmabuf-mmap
[245.228664] Subtest dmabuf-mmap: SUCCESS (0.018s)
[245.287122] [148/165] (764s left) vgem_basic (mmap)
[245.377095] Starting subtest: mmap
[245.389459] Subtest mmap: SUCCESS (0.012s)
[245.456089] [149/165] (764s left) vgem_basic (second-client)
[245.543899] Starting subtest: second-client
[245.577123] Subtest second-client: SUCCESS (0.032s)
[245.655512] [150/165] (764s left) vgem_basic (sysfs)
[245.743559] Starting subtest: sysfs
[245.744484] Subtest sysfs: SUCCESS (0.001s)
[245.802401] [151/165] (764s left) core_hotunplug (unbind-rebind)
[245.949517] Starting subtest: unbind-rebind
[250.257087] Subtest unbind-rebind: SUCCESS (4.308s)
[250.285303] [152/165] (759s left) vgem_basic (unload)
[250.363226] Starting subtest: unload
[279.475743] Subtest unload: SUCCESS (29.076s)
[279.578414] [153/165] (730s left) i915_module_load (reload)
[279.651187] Starting subtest: reload
[282.902131] Subtest reload: SUCCESS (3.252s)
[282.928745] [154/165] (726s left) gem_lmem_swapping (basic)
[283.058071] Subtest basic: SKIP (0.000s)
[283.102625] [155/165] (726s left) gem_lmem_swapping (parallel-random-engines)
[283.213697] Subtest parallel-random-engines: SKIP (0.000s)
[283.267177] [156/165] (726s left) gem_lmem_swapping (random-engines)
[283.350789] Subtest random-engines: SKIP (0.000s)
[283.382169] [157/165] (726s left) gem_lmem_swapping (verify-random)
[283.462702] Subtest verify-random: SKIP (0.000s)
[283.498571] [158/165] (726s left) i915_pm_rpm (module-reload)
[286.307787] Starting subtest: module-reload
[298.716237] Subtest module-reload: SUCCESS (12.411s)
[298.732655] [159/165] (711s left) i915_selftest (live)
[298.819732] Starting subtest: live
[298.820839] Starting dynamic subtest: sanitycheck
[300.512621] Dynamic subtest sanitycheck: SUCCESS (1.683s)
[300.519691] Starting dynamic subtest: uncore
[302.306744] Dynamic subtest uncore: SUCCESS (1.792s)
[302.315224] Starting dynamic subtest: workarounds
[304.199461] Dynamic subtest workarounds: SUCCESS (1.895s)
[304.207269] Starting dynamic subtest: gt_engines
[306.352700] Dynamic subtest gt_engines: SUCCESS (2.147s)
[306.360366] Starting dynamic subtest: gt_timelines
[317.033824] Dynamic subtest gt_timelines: SUCCESS (10.679s)
[317.042351] Starting dynamic subtest: gt_contexts
[318.811752] Dynamic subtest gt_contexts: SUCCESS (1.776s)
[318.819468] Starting dynamic subtest: gt_lrc
[322.973717] Dynamic subtest gt_lrc: SUCCESS (4.160s)
[322.982446] Starting dynamic subtest: gt_mocs
[324.764739] Dynamic subtest gt_mocs: SUCCESS (1.789s)
[324.772444] Starting dynamic subtest: gt_pm
[330.734785] Dynamic subtest gt_pm: SUCCESS (5.968s)
[330.742584] Starting dynamic subtest: gt_heartbeat
[332.578677] Dynamic subtest gt_heartbeat: SUCCESS (1.842s)
[332.586478] Starting dynamic subtest: gt_tlb
[335.419722] Dynamic subtest gt_tlb: SUCCESS (2.839s)
[335.427543] Starting dynamic subtest: requests
[342.746741] Dynamic subtest requests: SUCCESS (7.325s)
[342.754559] Starting dynamic subtest: migrate
[347.259704] Dynamic subtest migrate: SUCCESS (4.511s)
[347.268233] Starting dynamic subtest: active
[349.031761] Dynamic subtest active: SUCCESS (1.770s)
[349.041272] Starting dynamic subtest: objects
[351.839638] Dynamic subtest objects: SUCCESS (2.806s)
[351.850138] Starting dynamic subtest: mman
[357.004787] Dynamic subtest mman: SUCCESS (5.163s)
[357.013039] Starting dynamic subtest: dmabuf
[358.774625] Dynamic subtest dmabuf: SUCCESS (1.768s)
[358.785244] Starting dynamic subtest: vma
[360.561250] Dynamic subtest vma: SUCCESS (1.783s)
[360.569845] Starting dynamic subtest: coherency
[364.285804] Dynamic subtest coherency: SUCCESS (3.724s)
[364.294442] Starting dynamic subtest: gtt
[372.862625] Dynamic subtest gtt: SUCCESS (8.575s)
[372.873235] Starting dynamic subtest: gem
[374.838669] Dynamic subtest gem: SUCCESS (1.974s)
[374.849298] Starting dynamic subtest: evict
[378.093674] Dynamic subtest evict: SUCCESS (3.253s)
[378.104371] Starting dynamic subtest: hugepages
[385.067063] Dynamic subtest hugepages: SUCCESS (6.971s)
[385.077494] Starting dynamic subtest: gem_contexts
[399.596637] Dynamic subtest gem_contexts: SUCCESS (14.528s)
[399.604512] Starting dynamic subtest: client
[401.355780] Dynamic subtest client: SUCCESS (1.757s)
[401.364380] Starting dynamic subtest: gem_migrate
[403.097683] Dynamic subtest gem_migrate: SUCCESS (1.740s)
[403.105839] Starting dynamic subtest: reset
[405.497722] Dynamic subtest reset: SUCCESS (2.399s)
[405.507471] Starting dynamic subtest: memory_region
[407.244543] Dynamic subtest memory_region: SUCCESS (1.745s)
[407.252367] Starting dynamic subtest: hangcheck
[431.532683] Dynamic subtest hangcheck: SUCCESS (24.286s)
[431.540479] Starting dynamic subtest: execlists
[441.258616] Dynamic subtest execlists: SUCCESS (9.724s)
[441.266450] Starting dynamic subtest: ring_submission
[443.027792] Dynamic subtest ring_submission: SUCCESS (1.767s)
[443.036481] Starting dynamic subtest: perf
[444.941789] Dynamic subtest perf: SUCCESS (1.912s)
[444.951458] Starting dynamic subtest: slpc
[446.683707] Dynamic subtest slpc: SUCCESS (1.740s)
[446.691653] Starting dynamic subtest: guc
[448.402705] Dynamic subtest guc: SUCCESS (1.717s)
[448.413478] Starting dynamic subtest: guc_multi_lrc
[450.207639] Dynamic subtest guc_multi_lrc: SUCCESS (1.803s)
[450.218371] Starting dynamic subtest: guc_hang
[451.997783] Dynamic subtest guc_hang: SUCCESS (1.789s)
[452.009604] Starting dynamic subtest: late_gt_pm
[453.774660] Dynamic subtest late_gt_pm: SUCCESS (1.775s)
[453.775713] Subtest live: SUCCESS (154.947s)
[453.791878] [160/165] (556s left) dmabuf (all-tests)
[453.868614] Starting subtest: all-tests
[453.870518] Starting dynamic subtest: sanitycheck
[453.946329] Dynamic subtest sanitycheck: SUCCESS (0.074s)
[453.986585] Starting dynamic subtest: dma_fence
[454.143476] Dynamic subtest dma_fence: SUCCESS (0.186s)
[454.156494] Starting dynamic subtest: dma_fence_chain
[470.208349] Dynamic subtest dma_fence_chain: SUCCESS (16.053s)
[470.234766] Starting dynamic subtest: dma_fence_unwrap
[470.295360] Dynamic subtest dma_fence_unwrap: SUCCESS (0.088s)
[470.327319] Starting dynamic subtest: dma_resv
[470.388462] Dynamic subtest dma_resv: SUCCESS (0.086s)
[470.399355] Subtest all-tests: SUCCESS (16.522s)
[470.443305] [161/165] (539s left) i915_suspend (basic-s2idle-without-i915)
[470.518926] Starting subtest: basic-s2idle-without-i915
[489.424941] Subtest basic-s2idle-without-i915: SUCCESS (4.057s)
[492.810392] [162/165] (535s left) i915_suspend (basic-s3-without-i915)
[492.887692] Starting subtest: basic-s3-without-i915
[514.196293] Subtest basic-s3-without-i915: SUCCESS (5.009s)
[516.600725] [163/165] (529s left) gem_exec_suspend (basic-s0)
[516.721619] Starting subtest: basic-S0
[516.722661] Starting dynamic subtest: smem
[535.391207] Dynamic subtest smem: SUCCESS (3.174s)
[535.392564] Subtest basic-S0: SUCCESS (3.177s)
[539.640689] [164/165] (526s left) gem_exec_suspend (basic-s3)
[539.731604] Starting subtest: basic-S3
[539.732685] Starting dynamic subtest: smem
[559.993727] Dynamic subtest smem: SUCCESS (4.745s)
[559.995403] Subtest basic-S3: SUCCESS (4.747s)
[562.176535] [165/165] (521s left) kms_pipe_crc_basic (suspend-read-crc)
[562.303265] Starting subtest: suspend-read-crc
[562.306134] Starting dynamic subtest: pipe-A-eDP-1
[582.821393] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.918s)
[582.854712] Starting dynamic subtest: pipe-B-eDP-1
[603.395418] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.141s)
[603.444228] Starting dynamic subtest: pipe-C-eDP-1
[624.627830] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.314s)
[624.628854] Subtest suspend-read-crc: SUCCESS (12.401s)
[627.494705] Closing watchdogs
Done.