[41.308820] Initializing watchdogs
[41.308968]   /dev/watchdog0
[41.318936] [001/165] (960s left) i915_module_load (load)
[41.422422] Starting subtest: load
[44.124624] Subtest load: SUCCESS (2.697s)
[44.155288] [002/165] (957s left) core_auth (basic-auth)
[44.290760] Starting subtest: basic-auth
[44.292098] Subtest basic-auth: SUCCESS (0.005s)
[44.384972] [003/165] (957s left) debugfs_test (read_all_entries)
[44.520045] Starting subtest: read_all_entries
[44.606353] Subtest read_all_entries: SUCCESS (0.093s)
[44.721133] [004/165] (957s left) debugfs_test (basic-hwmon)
[44.838395] Starting subtest: basic-hwmon
[44.840856] Subtest basic-hwmon: SKIP (0.000s)
[44.966127] [005/165] (956s left) fbdev (eof)
[45.131035] Starting subtest: eof
[45.135595] Subtest eof: SUCCESS (0.004s)
[45.245110] [006/165] (956s left) fbdev (info)
[45.339522] Starting subtest: info
[45.340805] Subtest info: SUCCESS (0.000s)
[45.419335] [007/165] (956s left) fbdev (nullptr)
[45.521747] Starting subtest: nullptr
[45.522949] Subtest nullptr: SUCCESS (0.000s)
[45.589926] [008/165] (956s left) fbdev (read)
[45.688271] Starting subtest: read
[52.784366] Subtest read: SUCCESS (7.060s)
[52.832026] [009/165] (949s left) fbdev (write)
[52.928739] Starting subtest: write
[56.711026] Subtest write: SUCCESS (3.747s)
[56.749119] [010/165] (945s left) gem_basic (bad-close)
[56.839375] Starting subtest: bad-close
[56.841489] Subtest bad-close: SUCCESS (0.000s)
[56.916087] [011/165] (945s left) gem_basic (create-close)
[57.006366] Starting subtest: create-close
[57.008415] Subtest create-close: SUCCESS (0.000s)
[57.104238] [012/165] (945s left) gem_basic (create-fd-close)
[57.194483] Starting subtest: create-fd-close
[57.196674] Subtest create-fd-close: SUCCESS (0.000s)
[57.305057] [013/165] (944s left) gem_busy (busy@all-engines)
[57.415360] Starting subtest: busy
[57.416627] Starting dynamic subtest: all-engines
[57.480460] Dynamic subtest all-engines: SUCCESS (0.067s)
[57.481506] Subtest busy: SUCCESS (0.068s)
[57.877090] [014/165] (944s left) gem_close_race (basic-process)
[57.998678] Starting subtest: basic-process
[58.085256] Subtest basic-process: SUCCESS (0.086s)
[58.284935] [015/165] (943s left) gem_close_race (basic-threads)
[58.394493] Starting subtest: basic-threads
[59.558815] Subtest basic-threads: SUCCESS (1.164s)
[59.805453] [016/165] (942s left) gem_ctx_create (basic)
[59.913871] Starting subtest: basic
[59.915065] Subtest basic: SUCCESS (0.000s)
[60.126363] [017/165] (942s left) gem_ctx_create (basic-files)
[60.231605] Starting subtest: basic-files
[62.257227] Subtest basic-files: SUCCESS (2.026s)
[62.496120] [018/165] (939s left) gem_ctx_exec (basic)
[62.592797] Starting subtest: basic
[62.597835] Subtest basic: SUCCESS (0.005s)
[62.711056] [019/165] (939s left) gem_exec_basic (basic)
[62.815337] Starting subtest: basic
[62.816564] Starting dynamic subtest: rcs0-smem
[62.817865] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[62.828800] Starting dynamic subtest: bcs0-smem
[62.830232] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[62.840715] Starting dynamic subtest: vcs0-smem
[62.842015] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[62.852419] Starting dynamic subtest: vecs0-smem
[62.853720] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[62.854988] Subtest basic: SUCCESS (0.006s)
[63.027192] [020/165] (939s left) gem_exec_create (basic)
[63.133753] Starting subtest: basic
[63.135127] Starting dynamic subtest: smem
[65.196858] Dynamic subtest smem: SUCCESS (2.040s)
[65.198223] Subtest basic: SUCCESS (2.041s)
[65.412357] [021/165] (936s left) gem_exec_fence (basic-busy)
[65.675314] Starting subtest: basic-busy
[65.676518] Starting dynamic subtest: rcs0
[65.702147] Dynamic subtest rcs0: SUCCESS (0.035s)
[65.715778] Starting dynamic subtest: bcs0
[65.721477] Dynamic subtest bcs0: SUCCESS (0.019s)
[65.732773] Starting dynamic subtest: vcs0
[65.745416] Dynamic subtest vcs0: SUCCESS (0.024s)
[65.756936] Starting dynamic subtest: vecs0
[65.766082] Dynamic subtest vecs0: SUCCESS (0.020s)
[65.767471] Subtest basic-busy: SUCCESS (0.099s)
[66.365595] [022/165] (936s left) gem_exec_fence (basic-wait)
[66.617534] Starting subtest: basic-wait
[66.618795] Starting dynamic subtest: rcs0
[66.648787] Dynamic subtest rcs0: SUCCESS (0.036s)
[66.662484] Starting dynamic subtest: bcs0
[66.684790] Dynamic subtest bcs0: SUCCESS (0.036s)
[66.697078] Starting dynamic subtest: vcs0
[66.715558] Dynamic subtest vcs0: SUCCESS (0.031s)
[66.728074] Starting dynamic subtest: vecs0
[66.740368] Dynamic subtest vecs0: SUCCESS (0.025s)
[66.741482] Subtest basic-wait: SUCCESS (0.129s)
[67.288147] [023/165] (935s left) gem_exec_fence (basic-await)
[67.544047] Starting subtest: basic-await
[67.545252] Starting dynamic subtest: rcs0
[67.639045] Dynamic subtest rcs0: SUCCESS (0.102s)
[67.660424] Starting dynamic subtest: bcs0
[67.747125] Dynamic subtest bcs0: SUCCESS (0.107s)
[67.774945] Starting dynamic subtest: vcs0
[67.886598] Dynamic subtest vcs0: SUCCESS (0.130s)
[67.912646] Starting dynamic subtest: vecs0
[68.013094] Dynamic subtest vecs0: SUCCESS (0.133s)
[68.015127] Subtest basic-await: SUCCESS (0.476s)
[68.617462] [024/165] (933s left) gem_exec_fence (nb-await)
[68.870738] Starting subtest: nb-await
[68.871915] Starting dynamic subtest: rcs0
[68.929113] Dynamic subtest rcs0: SUCCESS (0.065s)
[68.947056] Starting dynamic subtest: bcs0
[68.998200] Dynamic subtest bcs0: SUCCESS (0.068s)
[69.018459] Starting dynamic subtest: vcs0
[69.069339] Dynamic subtest vcs0: SUCCESS (0.070s)
[69.097923] Starting dynamic subtest: vecs0
[69.142989] Dynamic subtest vecs0: SUCCESS (0.074s)
[69.145104] Subtest nb-await: SUCCESS (0.280s)
[69.685531] [025/165] (932s left) gem_exec_gttfill (basic)
[69.793173] Starting subtest: basic
[76.353516] Subtest basic: SUCCESS (6.552s)
[76.542658] [026/165] (925s left) gem_exec_parallel (engines)
[76.714409] Starting subtest: engines
[76.715586] Starting dynamic subtest: basic
[79.130472] Dynamic subtest basic: SUCCESS (2.397s)
[79.144741] Starting dynamic subtest: contexts
[83.348081] Dynamic subtest contexts: SUCCESS (4.228s)
[83.367926] Starting dynamic subtest: fds
[93.311713] Dynamic subtest fds: SUCCESS (9.972s)
[93.330931] Starting dynamic subtest: userptr
[95.831609] Dynamic subtest userptr: SUCCESS (2.497s)
[95.833603] Subtest engines: SUCCESS (19.096s)
[96.073423] [027/165] (906s left) gem_exec_store (basic)
[96.183991] Starting subtest: basic
[96.249551] Subtest basic: SUCCESS (0.065s)
[96.468329] [028/165] (906s left) gem_flink_basic (bad-flink)
[96.558401] Starting subtest: bad-flink
[96.559686] Subtest bad-flink: SUCCESS (0.000s)
[96.649398] [029/165] (905s left) gem_flink_basic (bad-open)
[96.739628] Starting subtest: bad-open
[96.740848] Subtest bad-open: SUCCESS (0.000s)
[96.832168] [030/165] (905s left) gem_flink_basic (basic)
[96.921585] Starting subtest: basic
[96.922738] Subtest basic: SUCCESS (0.000s)
[97.033572] [031/165] (905s left) gem_flink_basic (double-flink)
[97.123671] Starting subtest: double-flink
[97.124826] Subtest double-flink: SUCCESS (0.000s)
[97.231097] [032/165] (905s left) gem_flink_basic (flink-lifetime)
[97.320832] Starting subtest: flink-lifetime
[97.323479] Subtest flink-lifetime: SUCCESS (0.002s)
[97.434417] [033/165] (905s left) gem_huc_copy (huc-copy)
[97.532135] Starting subtest: huc-copy
[97.534430] Subtest huc-copy: SKIP (0.000s)
[97.650267] [034/165] (905s left) gem_linear_blits (basic)
[97.907334] Starting subtest: basic
[97.918972] Subtest basic: SUCCESS (0.012s)
[98.052185] [035/165] (904s left) gem_mmap (basic)
[98.208364] Starting subtest: basic
[98.213158] Subtest basic: SUCCESS (0.001s)
[98.320971] [036/165] (904s left) gem_mmap_gtt (basic)
[98.411643] Starting subtest: basic
[98.412865] Subtest basic: SUCCESS (0.001s)
[98.493447] [037/165] (904s left) gem_render_linear_blits (basic)
[98.590589] Starting subtest: basic
[98.640251] Subtest basic: SUCCESS (0.049s)
[98.693437] [038/165] (904s left) gem_render_tiled_blits (basic)
[98.789171] Starting subtest: basic
[98.850151] Subtest basic: SUCCESS (0.061s)
[98.913985] [039/165] (904s left) gem_ringfill (basic-all)
[99.150998] Starting subtest: basic-all
[100.365870] Subtest basic-all: SUCCESS (1.206s)
[100.457838] [040/165] (902s left) gem_softpin (allocator-basic)
[100.554573] Starting subtest: allocator-basic
[100.725937] Subtest allocator-basic: SUCCESS (0.161s)
[100.836641] [041/165] (902s left) gem_softpin (allocator-basic-reserve)
[100.930890] Starting subtest: allocator-basic-reserve
[101.092578] Subtest allocator-basic-reserve: SUCCESS (0.161s)
[101.221917] [042/165] (901s left) gem_softpin (safe-alignment)
[101.321199] Starting subtest: safe-alignment
[101.339554] Subtest safe-alignment: SUCCESS (0.018s)
[101.471385] [043/165] (901s left) gem_sync (basic-all)
[101.579337] Starting subtest: basic-all
[103.860615] Subtest basic-all: SUCCESS (2.281s)
[104.073974] [044/165] (898s left) gem_sync (basic-each)
[104.182153] Starting subtest: basic-each
[106.389391] Subtest basic-each: SUCCESS (2.206s)
[106.643711] [045/165] (896s left) gem_tiled_blits (basic)
[106.880119] Starting subtest: basic
[106.910905] Subtest basic: SUCCESS (0.031s)
[107.060627] [046/165] (896s left) gem_tiled_fence_blits (basic)
[107.376839] Starting subtest: basic
[107.404621] Subtest basic: SUCCESS (0.028s)
[107.543128] [047/165] (895s left) gem_tiled_pread_basic
[108.061517] [048/165] (895s left) gem_wait (busy@all-engines)
[108.180241] Starting subtest: busy
[108.181519] Starting dynamic subtest: all-engines
[108.709048] Dynamic subtest all-engines: SUCCESS (0.529s)
[108.710115] Subtest busy: SUCCESS (0.529s)
[108.962570] [049/165] (894s left) gem_wait (wait@all-engines)
[109.078040] Starting subtest: wait
[109.079245] Starting dynamic subtest: all-engines
[110.129907] Dynamic subtest all-engines: SUCCESS (1.051s)
[110.131793] Subtest wait: SUCCESS (1.051s)
[110.381129] [050/165] (892s left) i915_getparams_basic (basic-eu-total)
[110.468236] Starting subtest: basic-eu-total
[110.470453] Subtest basic-eu-total: SUCCESS (0.000s)
[110.564336] [051/165] (892s left) i915_getparams_basic (basic-subslice-total)
[110.655546] Starting subtest: basic-subslice-total
[110.657734] Subtest basic-subslice-total: SUCCESS (0.000s)
[110.747428] [052/165] (892s left) i915_hangman (error-state-basic)
[110.853076] Starting subtest: error-state-basic
[110.867194] Subtest error-state-basic: SUCCESS (0.011s)
[110.963416] [053/165] (892s left) i915_pciid
[111.148128] [054/165] (892s left) kms_addfb_basic (addfb25-4-tiled)
[111.277989] Starting subtest: addfb25-4-tiled
[111.279136] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[111.382402] [055/165] (892s left) kms_addfb_basic (addfb25-bad-modifier)
[111.473036] Starting subtest: addfb25-bad-modifier
[111.474130] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[111.616368] [056/165] (891s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[111.708143] Starting subtest: addfb25-framebuffer-vs-set-tiling
[111.709176] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[111.831736] [057/165] (891s left) kms_addfb_basic (addfb25-modifier-no-flag)
[111.925256] Starting subtest: addfb25-modifier-no-flag
[111.926313] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[112.051075] [058/165] (891s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[112.144686] Starting subtest: addfb25-x-tiled-legacy
[112.145783] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[112.264885] [059/165] (891s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[112.355029] Starting subtest: addfb25-x-tiled-mismatch-legacy
[112.356181] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[112.481135] [060/165] (891s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[112.602873] Starting subtest: addfb25-yf-tiled-legacy
[112.603997] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[112.699717] [061/165] (890s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[112.819519] Starting subtest: addfb25-y-tiled-legacy
[112.820620] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[112.917755] [062/165] (890s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[113.038168] Starting subtest: addfb25-y-tiled-small-legacy
[113.039320] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[113.150194] [063/165] (890s left) kms_addfb_basic (bad-pitch-0)
[113.241092] Starting subtest: bad-pitch-0
[113.242176] Subtest bad-pitch-0: SUCCESS (0.000s)
[113.366842] [064/165] (890s left) kms_addfb_basic (bad-pitch-1024)
[113.458280] Starting subtest: bad-pitch-1024
[113.459373] Subtest bad-pitch-1024: SUCCESS (0.000s)
[113.601055] [065/165] (890s left) kms_addfb_basic (bad-pitch-128)
[113.693327] Starting subtest: bad-pitch-128
[113.694445] Subtest bad-pitch-128: SUCCESS (0.000s)
[113.834882] [066/165] (889s left) kms_addfb_basic (bad-pitch-256)
[113.925620] Starting subtest: bad-pitch-256
[113.926733] Subtest bad-pitch-256: SUCCESS (0.000s)
[114.049791] [067/165] (889s left) kms_addfb_basic (bad-pitch-32)
[114.139106] Starting subtest: bad-pitch-32
[114.140187] Subtest bad-pitch-32: SUCCESS (0.000s)
[114.268129] [068/165] (889s left) kms_addfb_basic (bad-pitch-63)
[114.359407] Starting subtest: bad-pitch-63
[114.360430] Subtest bad-pitch-63: SUCCESS (0.000s)
[114.484693] [069/165] (889s left) kms_addfb_basic (bad-pitch-65536)
[114.575827] Starting subtest: bad-pitch-65536
[114.576935] Subtest bad-pitch-65536: SUCCESS (0.000s)
[114.701899] [070/165] (889s left) kms_addfb_basic (bad-pitch-999)
[114.792738] Starting subtest: bad-pitch-999
[114.793822] Subtest bad-pitch-999: SUCCESS (0.000s)
[114.936269] [071/165] (888s left) kms_addfb_basic (basic)
[115.027680] Starting subtest: basic
[115.028783] Subtest basic: SUCCESS (0.000s)
[115.150051] [072/165] (888s left) kms_addfb_basic (basic-x-tiled-legacy)
[115.243086] Starting subtest: basic-x-tiled-legacy
[115.244127] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[115.369139] [073/165] (888s left) kms_addfb_basic (basic-y-tiled-legacy)
[115.461694] Starting subtest: basic-y-tiled-legacy
[115.462800] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[115.584821] [074/165] (888s left) kms_addfb_basic (bo-too-small)
[115.703437] Starting subtest: bo-too-small
[115.704557] Subtest bo-too-small: SUCCESS (0.000s)
[115.809318] [075/165] (888s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[115.929766] Starting subtest: bo-too-small-due-to-tiling
[115.930968] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[116.036759] [076/165] (887s left) kms_addfb_basic (clobberred-modifier)
[116.126948] Starting subtest: clobberred-modifier
[116.128318] Subtest clobberred-modifier: SUCCESS (0.000s)
[116.270071] [077/165] (887s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[116.361956] Starting subtest: framebuffer-vs-set-tiling
[116.363109] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[116.506295] [078/165] (887s left) kms_addfb_basic (invalid-get-prop)
[116.596603] Starting subtest: invalid-get-prop
[116.597673] Subtest invalid-get-prop: SUCCESS (0.000s)
[116.719594] [079/165] (887s left) kms_addfb_basic (invalid-get-prop-any)
[116.812652] Starting subtest: invalid-get-prop-any
[116.813710] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[116.936854] [080/165] (887s left) kms_addfb_basic (invalid-set-prop)
[117.030758] Starting subtest: invalid-set-prop
[117.031964] Subtest invalid-set-prop: SUCCESS (0.000s)
[117.170350] [081/165] (886s left) kms_addfb_basic (invalid-set-prop-any)
[117.261414] Starting subtest: invalid-set-prop-any
[117.262574] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[117.407198] [082/165] (886s left) kms_addfb_basic (no-handle)
[117.499369] Starting subtest: no-handle
[117.500416] Subtest no-handle: SUCCESS (0.000s)
[117.615496] [083/165] (886s left) kms_addfb_basic (size-max)
[117.736341] Starting subtest: size-max
[117.737425] Subtest size-max: SUCCESS (0.000s)
[117.840683] [084/165] (886s left) kms_addfb_basic (small-bo)
[117.961301] Starting subtest: small-bo
[117.962481] Subtest small-bo: SUCCESS (0.000s)
[118.054714] [085/165] (886s left) kms_addfb_basic (tile-pitch-mismatch)
[118.144516] Starting subtest: tile-pitch-mismatch
[118.145598] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[118.272659] [086/165] (886s left) kms_addfb_basic (too-high)
[118.393249] Starting subtest: too-high
[118.394387] Subtest too-high: SUCCESS (0.001s)
[118.487407] [087/165] (885s left) kms_addfb_basic (too-wide)
[118.607875] Starting subtest: too-wide
[118.609202] Subtest too-wide: SUCCESS (0.000s)
[118.700044] [088/165] (885s left) kms_addfb_basic (unused-handle)
[118.790239] Starting subtest: unused-handle
[118.791342] Subtest unused-handle: SUCCESS (0.000s)
[118.923511] [089/165] (885s left) kms_addfb_basic (unused-modifier)
[119.014338] Starting subtest: unused-modifier
[119.015563] Subtest unused-modifier: SUCCESS (0.000s)
[119.139407] [090/165] (885s left) kms_addfb_basic (unused-offsets)
[119.231142] Starting subtest: unused-offsets
[119.232328] Subtest unused-offsets: SUCCESS (0.000s)
[119.358605] [091/165] (885s left) kms_addfb_basic (unused-pitches)
[119.449756] Starting subtest: unused-pitches
[119.450979] Subtest unused-pitches: SUCCESS (0.000s)
[119.590579] [092/165] (884s left) kms_busy (basic)
[119.715530] Starting subtest: basic
[119.717792] Starting dynamic subtest: flip
[120.723389] Dynamic subtest flip: SUCCESS (1.006s)
[120.740883] Starting dynamic subtest: modeset
[124.524932] Dynamic subtest modeset: SUCCESS (3.801s)
[124.529023] Subtest basic: SUCCESS (4.809s)
[125.508141] [093/165] (878s left) kms_prop_blob (basic)
[125.600674] Starting subtest: basic
[125.601767] Subtest basic: SUCCESS (0.000s)
[125.682917] [094/165] (878s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[125.803085] Starting subtest: basic-busy-flip-before-cursor-atomic
[125.805087] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[125.877656] [095/165] (878s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[125.995405] Starting subtest: basic-busy-flip-before-cursor-legacy
[125.997515] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[126.082817] [096/165] (878s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[126.201247] Starting subtest: basic-flip-after-cursor-atomic
[127.512418] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.311s)
[128.443577] [097/165] (876s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[128.564084] Starting subtest: basic-flip-after-cursor-legacy
[129.870532] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.306s)
[130.812141] [098/165] (873s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[130.931185] Starting subtest: basic-flip-after-cursor-varying-size
[132.206257] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.275s)
[133.178371] [099/165] (871s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[133.297879] Starting subtest: basic-flip-before-cursor-atomic
[134.607310] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.309s)
[135.546171] [100/165] (869s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[135.665602] Starting subtest: basic-flip-before-cursor-legacy
[136.976928] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.311s)
[137.912912] [101/165] (866s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[138.032239] Starting subtest: basic-flip-before-cursor-varying-size
[139.337751] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.306s)
[140.283295] [102/165] (864s left) kms_dsc (dsc-basic)
[140.404552] Subtest dsc-basic: SKIP (0.000s)
[140.458066] [103/165] (864s left) kms_flip (basic-flip-vs-dpms)
[140.558375] Starting subtest: basic-flip-vs-dpms
[140.560701] Starting dynamic subtest: A-eDP1
[143.426056] Dynamic subtest A-eDP1: SUCCESS (2.863s)
[143.442231] Starting dynamic subtest: B-eDP1
[145.860593] Dynamic subtest B-eDP1: SUCCESS (2.435s)
[145.882373] Starting dynamic subtest: C-eDP1
[148.279090] Dynamic subtest C-eDP1: SUCCESS (2.415s)
[148.283463] Subtest basic-flip-vs-dpms: SUCCESS (7.725s)
[149.188530] [104/165] (855s left) kms_flip (basic-flip-vs-modeset)
[149.289021] Starting subtest: basic-flip-vs-modeset
[149.292074] Starting dynamic subtest: A-eDP1
[152.173166] Dynamic subtest A-eDP1: SUCCESS (2.881s)
[152.191712] Starting dynamic subtest: B-eDP1
[154.544130] Dynamic subtest B-eDP1: SUCCESS (2.369s)
[154.561129] Starting dynamic subtest: C-eDP1
[156.917200] Dynamic subtest C-eDP1: SUCCESS (2.372s)
[156.923144] Subtest basic-flip-vs-modeset: SUCCESS (7.634s)
[157.832569] [105/165] (847s left) kms_flip (basic-flip-vs-wf_vblank)
[157.934765] Starting subtest: basic-flip-vs-wf_vblank
[157.937450] Starting dynamic subtest: A-eDP1
[160.282935] Dynamic subtest A-eDP1: SUCCESS (2.344s)
[160.304868] Starting dynamic subtest: B-eDP1
[162.568447] Dynamic subtest B-eDP1: SUCCESS (2.283s)
[162.587112] Starting dynamic subtest: C-eDP1
[164.808071] Dynamic subtest C-eDP1: SUCCESS (2.237s)
[164.812604] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.879s)
[166.139878] [106/165] (838s left) kms_flip (basic-plain-flip)
[166.236694] Starting subtest: basic-plain-flip
[166.240522] Starting dynamic subtest: A-eDP1
[168.320337] Dynamic subtest A-eDP1: SUCCESS (2.079s)
[168.342396] Starting dynamic subtest: B-eDP1
[170.289160] Dynamic subtest B-eDP1: SUCCESS (1.967s)
[170.308152] Starting dynamic subtest: C-eDP1
[172.267954] Dynamic subtest C-eDP1: SUCCESS (1.977s)
[172.272653] Subtest basic-plain-flip: SUCCESS (6.036s)
[173.574777] [107/165] (831s left) kms_force_connector_basic (force-connector-state)
[173.673159] Starting subtest: force-connector-state
[174.267024] Subtest force-connector-state: SUCCESS (0.594s)
[175.320977] [108/165] (829s left) kms_force_connector_basic (force-edid)
[175.416206] Starting subtest: force-edid
[175.677483] Subtest force-edid: SUCCESS (0.262s)
[175.818953] [109/165] (829s left) kms_force_connector_basic (force-load-detect)
[175.914381] Starting subtest: force-load-detect
[175.916664] Subtest force-load-detect: SKIP (0.000s)
[176.032461] [110/165] (828s left) kms_force_connector_basic (prune-stale-modes)
[176.128043] Starting subtest: prune-stale-modes
[176.446462] Subtest prune-stale-modes: SUCCESS (0.317s)
[176.587071] [111/165] (828s left) kms_frontbuffer_tracking (basic)
[176.713441] Starting subtest: basic
[180.069122] Subtest basic: SUCCESS (3.354s)
[180.209955] [112/165] (824s left) kms_hdmi_inject (inject-audio)
[180.625352] Starting subtest: inject-audio
[180.955544] Subtest inject-audio: SUCCESS (0.327s)
[181.554498] [113/165] (823s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[181.676359] Starting subtest: compare-crc-sanitycheck-xr24
[181.679027] Starting dynamic subtest: pipe-A-eDP-1
[182.349506] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.670s)
[182.370234] Starting dynamic subtest: pipe-B-eDP-1
[183.768175] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.413s)
[183.788184] Starting dynamic subtest: pipe-C-eDP-1
[185.143542] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.374s)
[185.144898] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.468s)
[186.106644] [114/165] (819s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[186.225555] Starting subtest: compare-crc-sanitycheck-nv12
[186.228192] Starting dynamic subtest: pipe-A-eDP-1
[187.171048] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.939s)
[187.189812] Starting dynamic subtest: pipe-B-eDP-1
[188.566278] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.395s)
[188.590084] Starting dynamic subtest: pipe-C-eDP-1
[189.959087] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.389s)
[189.960258] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.735s)
[190.906717] [115/165] (814s left) kms_pipe_crc_basic (hang-read-crc)
[191.027251] Starting subtest: hang-read-crc
[191.030202] Starting dynamic subtest: pipe-A-eDP-1
[193.396253] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.363s)
[193.426994] Starting dynamic subtest: pipe-B-eDP-1
[196.436223] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.032s)
[196.465072] Starting dynamic subtest: pipe-C-eDP-1
[199.424920] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.985s)
[199.426375] Subtest hang-read-crc: SUCCESS (8.398s)
[200.382582] [116/165] (804s left) kms_pipe_crc_basic (nonblocking-crc)
[200.505546] Starting subtest: nonblocking-crc
[200.508388] Starting dynamic subtest: pipe-A-eDP-1
[201.405123] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.897s)
[201.423614] Starting dynamic subtest: pipe-B-eDP-1
[203.010612] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.600s)
[203.027443] Starting dynamic subtest: pipe-C-eDP-1
[204.557218] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.544s)
[204.558416] Subtest nonblocking-crc: SUCCESS (4.052s)
[205.496312] [117/165] (799s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[205.621175] Starting subtest: nonblocking-crc-frame-sequence
[205.623831] Starting dynamic subtest: pipe-A-eDP-1
[206.524518] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.900s)
[206.547440] Starting dynamic subtest: pipe-B-eDP-1
[208.140581] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.610s)
[208.159495] Starting dynamic subtest: pipe-C-eDP-1
[209.704319] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.560s)
[209.705785] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.083s)
[210.626713] [118/165] (794s left) kms_pipe_crc_basic (read-crc)
[210.747143] Starting subtest: read-crc
[210.749912] Starting dynamic subtest: pipe-A-eDP-1
[211.556222] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.806s)
[211.577105] Starting dynamic subtest: pipe-B-eDP-1
[213.067238] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.507s)
[213.088809] Starting dynamic subtest: pipe-C-eDP-1
[214.568448] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.497s)
[214.569521] Subtest read-crc: SUCCESS (3.822s)
[215.481683] [119/165] (789s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[215.603085] Starting subtest: read-crc-frame-sequence
[215.605874] Starting dynamic subtest: pipe-A-eDP-1
[216.412184] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.804s)
[216.452153] Starting dynamic subtest: pipe-B-eDP-1
[217.922550] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.502s)
[217.950392] Starting dynamic subtest: pipe-C-eDP-1
[219.415604] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.488s)
[219.417220] Subtest read-crc-frame-sequence: SUCCESS (3.814s)
[220.346055] [120/165] (784s left) kms_pm_backlight (basic-brightness)
[220.468194] Starting subtest: basic-brightness
[220.582535] Starting dynamic subtest: eDP-1
[221.143516] Dynamic subtest eDP-1: SUCCESS (0.570s)
[221.144827] Subtest basic-brightness: SUCCESS (0.676s)
[222.077648] [121/165] (783s left) kms_pm_rpm (basic-pci-d3-state)
[223.910187] Starting subtest: basic-pci-d3-state
[228.304570] Subtest basic-pci-d3-state: SUCCESS (4.394s)
[228.521248] [122/165] (776s left) kms_pm_rpm (basic-rte)
[228.611355] Starting subtest: basic-rte
[235.026580] Subtest basic-rte: SUCCESS (6.415s)
[236.513075] [123/165] (768s left) kms_psr (primary_page_flip)
[236.635189] Starting subtest: primary_page_flip
[240.488521] Subtest primary_page_flip: SUCCESS (3.853s)
[241.401282] [124/165] (764s left) kms_psr (cursor_plane_move)
[241.524138] Starting subtest: cursor_plane_move
[245.270770] Subtest cursor_plane_move: SUCCESS (3.745s)
[246.201500] [125/165] (759s left) kms_psr (sprite_plane_onoff)
[246.324797] Starting subtest: sprite_plane_onoff
[250.227108] Subtest sprite_plane_onoff: SUCCESS (3.899s)
[251.195136] [126/165] (754s left) kms_psr (primary_mmap_gtt)
[251.318480] Starting subtest: primary_mmap_gtt
[255.146312] Subtest primary_mmap_gtt: SUCCESS (3.824s)
[256.077755] [127/165] (749s left) kms_setmode (basic-clone-single-crtc)
[256.171232] Starting subtest: basic-clone-single-crtc
[256.174549] Subtest basic-clone-single-crtc: SKIP (0.000s)
[256.261302] [128/165] (749s left) i915_pm_rps (basic-api)
[256.362241] Starting subtest: basic-api
[256.364727] Subtest basic-api: SUCCESS (0.004s)
[256.458820] [129/165] (749s left) prime_self_import (basic-llseek-bad)
[256.548266] Starting subtest: basic-llseek-bad
[256.552566] Subtest basic-llseek-bad: SUCCESS (0.003s)
[256.661077] [130/165] (748s left) prime_self_import (basic-llseek-size)
[256.749252] Starting subtest: basic-llseek-size
[256.753679] Subtest basic-llseek-size: SUCCESS (0.004s)
[256.862374] [131/165] (748s left) prime_self_import (basic-with_fd_dup)
[256.949961] Starting subtest: basic-with_fd_dup
[256.954401] Subtest basic-with_fd_dup: SUCCESS (0.005s)
[257.061664] [132/165] (748s left) prime_self_import (basic-with_one_bo)
[257.153033] Starting subtest: basic-with_one_bo
[257.155495] Subtest basic-with_one_bo: SUCCESS (0.005s)
[257.240965] [133/165] (748s left) prime_self_import (basic-with_one_bo_two_files)
[257.332059] Starting subtest: basic-with_one_bo_two_files
[257.334944] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s)
[257.447346] [134/165] (748s left) prime_self_import (basic-with_two_bos)
[257.536397] Starting subtest: basic-with_two_bos
[257.540911] Subtest basic-with_two_bos: SUCCESS (0.005s)
[257.645142] [135/165] (748s left) prime_vgem (basic-fence-flip)
[257.771383] Starting subtest: basic-fence-flip
[258.319409] Subtest basic-fence-flip: SUCCESS (0.548s)
[258.450263] [136/165] (747s left) prime_vgem (basic-fence-mmap)
[258.570544] Starting subtest: basic-fence-mmap
[258.621418] Subtest basic-fence-mmap: SUCCESS (0.051s)
[258.714947] [137/165] (747s left) prime_vgem (basic-fence-read)
[258.840950] Starting subtest: basic-fence-read
[258.918389] Subtest basic-fence-read: SUCCESS (0.077s)
[259.015722] [138/165] (746s left) prime_vgem (basic-gtt)
[259.136673] Starting subtest: basic-gtt
[259.162283] Subtest basic-gtt: SUCCESS (0.025s)
[259.268489] [139/165] (746s left) prime_vgem (basic-read)
[259.385497] Starting subtest: basic-read
[259.424279] Subtest basic-read: SUCCESS (0.039s)
[259.533052] [140/165] (746s left) prime_vgem (basic-write)
[259.659984] Starting subtest: basic-write
[259.704786] Subtest basic-write: SUCCESS (0.045s)
[259.797326] [141/165] (746s left) vgem_basic (setversion)
[259.905809] Starting subtest: setversion
[259.907996] Subtest setversion: SUCCESS (0.000s)
[259.978364] [142/165] (746s left) vgem_basic (create)
[260.072281] Starting subtest: create
[260.073419] Subtest create: SUCCESS (0.000s)
[260.147210] [143/165] (745s left) vgem_basic (debugfs)
[260.256807] Starting subtest: debugfs
[260.258344] Subtest debugfs: SUCCESS (0.001s)
[260.333405] [144/165] (745s left) vgem_basic (dmabuf-export)
[260.440198] Starting subtest: dmabuf-export
[260.454446] Subtest dmabuf-export: SUCCESS (0.014s)
[260.567297] [145/165] (745s left) vgem_basic (dmabuf-fence)
[260.673507] Starting subtest: dmabuf-fence
[260.674775] Subtest dmabuf-fence: SUCCESS (0.001s)
[260.750236] [146/165] (745s left) vgem_basic (dmabuf-fence-before)
[260.857473] Starting subtest: dmabuf-fence-before
[260.858639] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[260.931650] [147/165] (745s left) vgem_basic (dmabuf-mmap)
[261.040564] Starting subtest: dmabuf-mmap
[261.066145] Subtest dmabuf-mmap: SUCCESS (0.026s)
[261.148203] [148/165] (745s left) vgem_basic (mmap)
[261.256912] Starting subtest: mmap
[261.274437] Subtest mmap: SUCCESS (0.017s)
[261.346713] [149/165] (744s left) vgem_basic (second-client)
[261.457747] Starting subtest: second-client
[261.494030] Subtest second-client: SUCCESS (0.034s)
[261.566348] [150/165] (744s left) vgem_basic (sysfs)
[261.674326] Starting subtest: sysfs
[261.675509] Subtest sysfs: SUCCESS (0.001s)
[261.749554] [151/165] (744s left) core_hotunplug (unbind-rebind)
[261.890723] Starting subtest: unbind-rebind
[266.382230] Subtest unbind-rebind: SUCCESS (4.491s)
[266.423703] [152/165] (739s left) vgem_basic (unload)
[266.515645] Starting subtest: unload
[295.578923] Subtest unload: SUCCESS (29.028s)
[295.692051] [153/165] (710s left) i915_module_load (reload)
[295.786265] Starting subtest: reload
[299.193677] Subtest reload: SUCCESS (3.407s)
[299.224180] [154/165] (707s left) gem_lmem_swapping (basic)
[299.336600] Subtest basic: SKIP (0.000s)
[299.378097] [155/165] (707s left) gem_lmem_swapping (parallel-random-engines)
[299.473832] Subtest parallel-random-engines: SKIP (0.000s)
[299.530952] [156/165] (706s left) gem_lmem_swapping (random-engines)
[299.628112] Subtest random-engines: SKIP (0.000s)
[299.678951] [157/165] (706s left) gem_lmem_swapping (verify-random)
[299.777502] Subtest verify-random: SKIP (0.000s)
[299.829194] [158/165] (706s left) i915_pm_rpm (module-reload)
[312.294395] Starting subtest: module-reload
[341.660831] Subtest module-reload: SUCCESS (29.362s)
[341.683020] [159/165] (664s left) i915_selftest (live)
[341.787065] Starting subtest: live
[341.788368] Starting dynamic subtest: sanitycheck
[343.641430] Dynamic subtest sanitycheck: SUCCESS (1.845s)
[343.656689] Starting dynamic subtest: uncore
[345.505872] Dynamic subtest uncore: SUCCESS (1.861s)
[345.520880] Starting dynamic subtest: workarounds
[347.687357] Dynamic subtest workarounds: SUCCESS (2.178s)
[347.702539] Starting dynamic subtest: gt_engines
[349.981592] Dynamic subtest gt_engines: SUCCESS (2.291s)
[349.996414] Starting dynamic subtest: gt_timelines
[362.769787] Dynamic subtest gt_timelines: SUCCESS (12.784s)
[362.784873] Starting dynamic subtest: gt_contexts
[364.686605] Dynamic subtest gt_contexts: SUCCESS (1.913s)
[364.701249] Starting dynamic subtest: gt_lrc
[369.041429] Dynamic subtest gt_lrc: SUCCESS (4.351s)
[369.056594] Starting dynamic subtest: gt_mocs
[371.050487] Dynamic subtest gt_mocs: SUCCESS (2.005s)
[371.065517] Starting dynamic subtest: gt_pm
[376.180627] Dynamic subtest gt_pm: SUCCESS (5.126s)
[376.195722] Starting dynamic subtest: gt_heartbeat
[378.160423] Dynamic subtest gt_heartbeat: SUCCESS (1.976s)
[378.175524] Starting dynamic subtest: gt_tlb
[381.348415] Dynamic subtest gt_tlb: SUCCESS (3.184s)
[381.368822] Starting dynamic subtest: requests
[389.076618] Dynamic subtest requests: SUCCESS (7.724s)
[389.092028] Starting dynamic subtest: migrate
[393.688402] Dynamic subtest migrate: SUCCESS (4.608s)
[393.703831] Starting dynamic subtest: active
[395.529478] Dynamic subtest active: SUCCESS (1.838s)
[395.544746] Starting dynamic subtest: objects
[398.913410] Dynamic subtest objects: SUCCESS (3.380s)
[398.928992] Starting dynamic subtest: mman
[405.865647] Dynamic subtest mman: SUCCESS (6.949s)
[405.880982] Starting dynamic subtest: dmabuf
[407.726472] Dynamic subtest dmabuf: SUCCESS (1.857s)
[407.742059] Starting dynamic subtest: vma
[409.543885] Dynamic subtest vma: SUCCESS (1.813s)
[409.559425] Starting dynamic subtest: coherency
[414.053553] Dynamic subtest coherency: SUCCESS (4.506s)
[414.068994] Starting dynamic subtest: gtt
[423.546739] Dynamic subtest gtt: SUCCESS (9.489s)
[423.561624] Starting dynamic subtest: gem
[425.594388] Dynamic subtest gem: SUCCESS (2.044s)
[425.610330] Starting dynamic subtest: evict
[429.481409] Dynamic subtest evict: SUCCESS (3.884s)
[429.497129] Starting dynamic subtest: hugepages
[437.272924] Dynamic subtest hugepages: SUCCESS (7.788s)
[437.288576] Starting dynamic subtest: gem_contexts
[452.649622] Dynamic subtest gem_contexts: SUCCESS (15.373s)
[452.665282] Starting dynamic subtest: client
[454.584438] Dynamic subtest client: SUCCESS (1.931s)
[454.600078] Starting dynamic subtest: gem_migrate
[456.470464] Dynamic subtest gem_migrate: SUCCESS (1.882s)
[456.486053] Starting dynamic subtest: reset
[461.894798] Dynamic subtest reset: SUCCESS (5.420s)
[461.910434] Starting dynamic subtest: memory_region
[463.773606] Dynamic subtest memory_region: SUCCESS (1.875s)
[463.789511] Starting dynamic subtest: hangcheck
[488.242920] Dynamic subtest hangcheck: SUCCESS (24.465s)
[488.260293] Starting dynamic subtest: execlists
[498.505665] Dynamic subtest execlists: SUCCESS (10.259s)
[498.521213] Starting dynamic subtest: ring_submission
[500.373844] Dynamic subtest ring_submission: SUCCESS (1.864s)
[500.389674] Starting dynamic subtest: perf
[502.387833] Dynamic subtest perf: SUCCESS (2.010s)
[502.403571] Starting dynamic subtest: slpc
[504.279478] Dynamic subtest slpc: SUCCESS (1.888s)
[504.295478] Starting dynamic subtest: guc
[506.147406] Dynamic subtest guc: SUCCESS (1.864s)
[506.163420] Starting dynamic subtest: guc_multi_lrc
[508.015505] Dynamic subtest guc_multi_lrc: SUCCESS (1.864s)
[508.031215] Starting dynamic subtest: guc_hang
[509.847374] Dynamic subtest guc_hang: SUCCESS (1.828s)
[509.862893] Starting dynamic subtest: late_gt_pm
[511.792321] Dynamic subtest late_gt_pm: SUCCESS (1.941s)
[511.793636] Subtest live: SUCCESS (169.998s)
[511.818325] [160/165] (494s left) dmabuf (all-tests)
[511.914852] Starting subtest: all-tests
[511.916196] Starting dynamic subtest: sanitycheck
[511.987718] Dynamic subtest sanitycheck: SUCCESS (0.071s)
[512.009157] Starting dynamic subtest: dma_fence
[512.173821] Dynamic subtest dma_fence: SUCCESS (0.182s)
[512.190979] Starting dynamic subtest: dma_fence_chain
[530.064206] Dynamic subtest dma_fence_chain: SUCCESS (17.878s)
[530.077239] Starting dynamic subtest: dma_fence_unwrap
[530.140743] Dynamic subtest dma_fence_unwrap: SUCCESS (0.081s)
[530.161518] Starting dynamic subtest: dma_resv
[530.218650] Dynamic subtest dma_resv: SUCCESS (0.074s)
[530.220812] Subtest all-tests: SUCCESS (18.305s)
[530.252130] [161/165] (476s left) i915_suspend (basic-s2idle-without-i915)
[530.341854] Starting subtest: basic-s2idle-without-i915
[553.753440] Subtest basic-s2idle-without-i915: SUCCESS (8.166s)
[554.102231] [162/165] (467s left) i915_suspend (basic-s3-without-i915)
[554.205931] Starting subtest: basic-s3-without-i915
[576.839153] Subtest basic-s3-without-i915: SUCCESS (6.856s)
[577.185848] [163/165] (460s left) gem_exec_suspend (basic-s0)
[577.303040] Starting subtest: basic-S0
[577.304153] Starting dynamic subtest: smem
[596.936875] Dynamic subtest smem: SUCCESS (3.755s)
[596.938214] Subtest basic-S0: SUCCESS (3.757s)
[597.149197] [164/165] (456s left) gem_exec_suspend (basic-s3)
[597.256268] Starting subtest: basic-S3
[597.257403] Starting dynamic subtest: smem
[615.947353] Dynamic subtest smem: SUCCESS (3.643s)
[615.948642] Subtest basic-S3: SUCCESS (3.645s)
[616.157503] [165/165] (452s left) kms_pipe_crc_basic (suspend-read-crc)
[616.279705] Starting subtest: suspend-read-crc
[616.282636] Starting dynamic subtest: pipe-A-eDP-1
[633.914648] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.522s)
[633.952327] Starting dynamic subtest: pipe-B-eDP-1
[651.885985] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.140s)
[651.920945] Starting dynamic subtest: pipe-C-eDP-1
[669.910932] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.146s)
[669.912967] Subtest suspend-read-crc: SUCCESS (8.831s)
[670.797246] Closing watchdogs
Done.