[40.225189] Initializing watchdogs
[40.225333]   /dev/watchdog0
[40.234543] [001/160] (960s left) i915_module_load (load)
[40.337110] Starting subtest: load
[44.522973] Subtest load: SUCCESS (4.186s)
[44.547142] [002/160] (956s left) core_auth (basic-auth)
[44.666626] Starting subtest: basic-auth
[44.669063] Subtest basic-auth: SUCCESS (0.002s)
[44.757079] [003/160] (956s left) debugfs_test (read_all_entries)
[44.869027] Starting subtest: read_all_entries
[44.963293] Subtest read_all_entries: SUCCESS (0.092s)
[45.076436] [004/160] (955s left) debugfs_test (basic-hwmon)
[45.180653] Starting subtest: basic-hwmon
[45.182810] Subtest basic-hwmon: SKIP (0.000s)
[45.290046] [005/160] (955s left) fbdev (eof)
[45.393859] Starting subtest: eof
[45.399956] Subtest eof: SUCCESS (0.003s)
[45.481059] [006/160] (955s left) fbdev (info)
[45.575137] Starting subtest: info
[45.576505] Subtest info: SUCCESS (0.000s)
[45.682500] [007/160] (955s left) fbdev (nullptr)
[45.791574] Starting subtest: nullptr
[45.792866] Subtest nullptr: SUCCESS (0.000s)
[45.859093] [008/160] (955s left) fbdev (read)
[45.958846] Starting subtest: read
[53.067121] Subtest read: SUCCESS (7.074s)
[53.118383] [009/160] (947s left) fbdev (write)
[53.218431] Starting subtest: write
[56.991913] Subtest write: SUCCESS (3.740s)
[57.037050] [010/160] (943s left) gem_basic (bad-close)
[57.141873] Starting subtest: bad-close
[57.144241] Subtest bad-close: SUCCESS (0.000s)
[57.245496] [011/160] (943s left) gem_basic (create-close)
[57.345768] Starting subtest: create-close
[57.347995] Subtest create-close: SUCCESS (0.000s)
[57.456542] [012/160] (943s left) gem_basic (create-fd-close)
[57.551346] Starting subtest: create-fd-close
[57.553468] Subtest create-fd-close: SUCCESS (0.000s)
[57.657329] [013/160] (943s left) gem_busy (busy@all-engines)
[57.773478] Starting subtest: busy
[57.774663] Starting dynamic subtest: all-engines
[57.840745] Dynamic subtest all-engines: SUCCESS (0.067s)
[57.842565] Subtest busy: SUCCESS (0.068s)
[58.243235] [014/160] (942s left) gem_close_race (basic-process)
[58.369813] Starting subtest: basic-process
[58.443060] Subtest basic-process: SUCCESS (0.073s)
[58.645040] [015/160] (942s left) gem_close_race (basic-threads)
[58.768932] Starting subtest: basic-threads
[60.032157] Subtest basic-threads: SUCCESS (1.263s)
[60.269816] [016/160] (940s left) gem_ctx_create (basic)
[60.391642] Starting subtest: basic
[60.392756] Subtest basic: SUCCESS (0.000s)
[60.595367] [017/160] (940s left) gem_ctx_create (basic-files)
[60.713287] Starting subtest: basic-files
[62.740313] Subtest basic-files: SUCCESS (2.027s)
[62.952139] [018/160] (938s left) gem_ctx_exec (basic)
[63.053276] Starting subtest: basic
[63.059677] Subtest basic: SUCCESS (0.006s)
[63.185267] [019/160] (938s left) gem_exec_basic (basic)
[63.292917] Starting subtest: basic
[63.294181] Starting dynamic subtest: rcs0-smem
[63.296828] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[63.308369] Starting dynamic subtest: bcs0-smem
[63.309719] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[63.320419] Starting dynamic subtest: vcs0-smem
[63.321498] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[63.332072] Starting dynamic subtest: vecs0-smem
[63.333483] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[63.334856] Subtest basic: SUCCESS (0.007s)
[63.496120] [020/160] (937s left) gem_exec_create (basic)
[63.614454] Starting subtest: basic
[63.615547] Starting dynamic subtest: smem
[65.648474] Dynamic subtest smem: SUCCESS (2.033s)
[65.649499] Subtest basic: SUCCESS (2.033s)
[65.881883] [021/160] (935s left) gem_exec_fence (basic-busy)
[66.153167] Starting subtest: basic-busy
[66.154595] Starting dynamic subtest: rcs0
[66.189542] Dynamic subtest rcs0: SUCCESS (0.044s)
[66.204747] Starting dynamic subtest: bcs0
[66.223305] Dynamic subtest bcs0: SUCCESS (0.033s)
[66.239677] Starting dynamic subtest: vcs0
[66.248685] Dynamic subtest vcs0: SUCCESS (0.025s)
[66.261608] Starting dynamic subtest: vecs0
[66.278947] Dynamic subtest vecs0: SUCCESS (0.030s)
[66.280852] Subtest basic-busy: SUCCESS (0.134s)
[66.888541] [022/160] (934s left) gem_exec_fence (basic-wait)
[67.148458] Starting subtest: basic-wait
[67.149703] Starting dynamic subtest: rcs0
[67.162749] Dynamic subtest rcs0: SUCCESS (0.023s)
[67.174592] Starting dynamic subtest: bcs0
[67.181608] Dynamic subtest bcs0: SUCCESS (0.019s)
[67.193757] Starting dynamic subtest: vcs0
[67.199456] Dynamic subtest vcs0: SUCCESS (0.018s)
[67.211227] Starting dynamic subtest: vecs0
[67.223352] Dynamic subtest vecs0: SUCCESS (0.024s)
[67.224458] Subtest basic-wait: SUCCESS (0.084s)
[67.770382] [023/160] (933s left) gem_exec_fence (basic-await)
[68.026680] Starting subtest: basic-await
[68.027957] Starting dynamic subtest: rcs0
[68.117914] Dynamic subtest rcs0: SUCCESS (0.098s)
[68.138029] Starting dynamic subtest: bcs0
[68.223052] Dynamic subtest bcs0: SUCCESS (0.104s)
[68.250998] Starting dynamic subtest: vcs0
[68.351490] Dynamic subtest vcs0: SUCCESS (0.128s)
[68.379045] Starting dynamic subtest: vecs0
[68.483683] Dynamic subtest vecs0: SUCCESS (0.131s)
[68.486200] Subtest basic-await: SUCCESS (0.464s)
[69.057297] [024/160] (932s left) gem_exec_fence (nb-await)
[69.316174] Starting subtest: nb-await
[69.317373] Starting dynamic subtest: rcs0
[69.373093] Dynamic subtest rcs0: SUCCESS (0.064s)
[69.394052] Starting dynamic subtest: bcs0
[69.446310] Dynamic subtest bcs0: SUCCESS (0.073s)
[69.468846] Starting dynamic subtest: vcs0
[69.518932] Dynamic subtest vcs0: SUCCESS (0.072s)
[69.546602] Starting dynamic subtest: vecs0
[69.595910] Dynamic subtest vecs0: SUCCESS (0.076s)
[69.597997] Subtest nb-await: SUCCESS (0.288s)
[70.158712] [025/160] (931s left) gem_exec_gttfill (basic)
[70.280628] Starting subtest: basic
[76.023381] Subtest basic: SUCCESS (5.734s)
[76.213787] [026/160] (925s left) gem_exec_parallel (engines)
[76.413494] Starting subtest: engines
[76.414905] Starting dynamic subtest: basic
[78.899356] Dynamic subtest basic: SUCCESS (2.485s)
[78.914756] Starting dynamic subtest: contexts
[86.126552] Dynamic subtest contexts: SUCCESS (7.221s)
[86.139812] Starting dynamic subtest: fds
[97.767787] Dynamic subtest fds: SUCCESS (11.650s)
[97.783121] Starting dynamic subtest: userptr
[100.267876] Dynamic subtest userptr: SUCCESS (2.474s)
[100.269939] Subtest engines: SUCCESS (23.831s)
[100.491692] [027/160] (900s left) gem_exec_store (basic)
[100.609914] Starting subtest: basic
[100.678789] Subtest basic: SUCCESS (0.069s)
[100.891381] [028/160] (900s left) gem_flink_basic (bad-flink)
[100.995673] Starting subtest: bad-flink
[100.996764] Subtest bad-flink: SUCCESS (0.000s)
[101.088115] [029/160] (900s left) gem_flink_basic (bad-open)
[101.184523] Starting subtest: bad-open
[101.185796] Subtest bad-open: SUCCESS (0.000s)
[101.289119] [030/160] (900s left) gem_flink_basic (basic)
[101.389672] Starting subtest: basic
[101.390749] Subtest basic: SUCCESS (0.000s)
[101.489665] [031/160] (900s left) gem_flink_basic (double-flink)
[101.586428] Starting subtest: double-flink
[101.587716] Subtest double-flink: SUCCESS (0.000s)
[101.690093] [032/160] (899s left) gem_flink_basic (flink-lifetime)
[101.791525] Starting subtest: flink-lifetime
[101.795361] Subtest flink-lifetime: SUCCESS (0.003s)
[101.907285] [033/160] (899s left) gem_huc_copy (huc-copy)
[102.018618] Starting subtest: huc-copy
[102.020838] Subtest huc-copy: SKIP (0.000s)
[102.140760] [034/160] (899s left) gem_linear_blits (basic)
[102.405766] Starting subtest: basic
[102.423791] Subtest basic: SUCCESS (0.018s)
[102.560467] [035/160] (899s left) gem_mmap (basic)
[102.728786] Starting subtest: basic
[102.734157] Subtest basic: SUCCESS (0.001s)
[102.824846] [036/160] (898s left) gem_mmap_gtt (basic)
[102.924388] Starting subtest: basic
[102.926826] Subtest basic: SUCCESS (0.002s)
[103.033231] [037/160] (898s left) gem_render_linear_blits (basic)
[103.142313] Starting subtest: basic
[103.201711] Subtest basic: SUCCESS (0.058s)
[103.268187] [038/160] (898s left) gem_render_tiled_blits (basic)
[103.376308] Starting subtest: basic
[103.448369] Subtest basic: SUCCESS (0.073s)
[103.521138] [039/160] (898s left) gem_ringfill (basic-all)
[103.766633] Starting subtest: basic-all
[105.021165] Subtest basic-all: SUCCESS (1.254s)
[105.118034] [040/160] (896s left) gem_softpin (allocator-basic)
[105.220287] Starting subtest: allocator-basic
[105.393573] Subtest allocator-basic: SUCCESS (0.165s)
[105.513035] [041/160] (896s left) gem_softpin (allocator-basic-reserve)
[105.620281] Starting subtest: allocator-basic-reserve
[105.794733] Subtest allocator-basic-reserve: SUCCESS (0.166s)
[105.912957] [042/160] (895s left) gem_softpin (safe-alignment)
[106.019514] Starting subtest: safe-alignment
[106.039214] Subtest safe-alignment: SUCCESS (0.020s)
[106.162714] [043/160] (895s left) gem_sync (basic-all)
[106.279602] Starting subtest: basic-all
[108.976509] Subtest basic-all: SUCCESS (2.673s)
[109.166420] [044/160] (892s left) gem_sync (basic-each)
[109.284380] Starting subtest: basic-each
[111.509899] Subtest basic-each: SUCCESS (2.226s)
[111.735998] [045/160] (890s left) gem_tiled_blits (basic)
[111.978108] Starting subtest: basic
[112.011654] Subtest basic: SUCCESS (0.034s)
[112.153976] [046/160] (889s left) gem_tiled_fence_blits (basic)
[112.461292] Starting subtest: basic
[112.491802] Subtest basic: SUCCESS (0.030s)
[112.623280] [047/160] (889s left) gem_tiled_pread_basic
[113.137300] [048/160] (888s left) gem_wait (busy@all-engines)
[113.266304] Starting subtest: busy
[113.267509] Starting dynamic subtest: all-engines
[113.800958] Dynamic subtest all-engines: SUCCESS (0.534s)
[113.802125] Subtest busy: SUCCESS (0.535s)
[114.037203] [049/160] (888s left) gem_wait (wait@all-engines)
[114.160636] Starting subtest: wait
[114.161927] Starting dynamic subtest: all-engines
[115.194412] Dynamic subtest all-engines: SUCCESS (1.031s)
[115.195601] Subtest wait: SUCCESS (1.031s)
[115.439270] [050/160] (886s left) i915_getparams_basic (basic-eu-total)
[115.534458] Starting subtest: basic-eu-total
[115.536439] Subtest basic-eu-total: SUCCESS (0.000s)
[115.638250] [051/160] (886s left) i915_getparams_basic (basic-subslice-total)
[115.732417] Starting subtest: basic-subslice-total
[115.734690] Subtest basic-subslice-total: SUCCESS (0.000s)
[115.838112] [052/160] (886s left) i915_hangman (error-state-basic)
[115.955922] Starting subtest: error-state-basic
[115.969926] Subtest error-state-basic: SUCCESS (0.013s)
[116.050942] [053/160] (886s left) i915_pciid
[116.256433] [054/160] (885s left) kms_addfb_basic (addfb25-4-tiled)
[116.387731] Starting subtest: addfb25-4-tiled
[116.388946] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[116.489824] [055/160] (885s left) kms_addfb_basic (addfb25-bad-modifier)
[116.590656] Starting subtest: addfb25-bad-modifier
[116.592075] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[116.706516] [056/160] (885s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[116.805686] Starting subtest: addfb25-framebuffer-vs-set-tiling
[116.806882] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[116.940420] [057/160] (885s left) kms_addfb_basic (addfb25-modifier-no-flag)
[117.042100] Starting subtest: addfb25-modifier-no-flag
[117.043358] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[117.157967] [058/160] (885s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[117.258064] Starting subtest: addfb25-x-tiled-legacy
[117.259111] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[117.387719] [059/160] (884s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[117.486159] Starting subtest: addfb25-x-tiled-mismatch-legacy
[117.487203] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[117.624390] [060/160] (884s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[117.752785] Starting subtest: addfb25-yf-tiled-legacy
[117.753929] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[117.858357] [061/160] (884s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[117.991606] Starting subtest: addfb25-y-tiled-legacy
[117.992813] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[118.091649] [062/160] (884s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[118.223193] Starting subtest: addfb25-y-tiled-small-legacy
[118.224295] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[118.325359] [063/160] (884s left) kms_addfb_basic (bad-pitch-0)
[118.424620] Starting subtest: bad-pitch-0
[118.425767] Subtest bad-pitch-0: SUCCESS (0.000s)
[118.535538] [064/160] (883s left) kms_addfb_basic (bad-pitch-1024)
[118.639229] Starting subtest: bad-pitch-1024
[118.640425] Subtest bad-pitch-1024: SUCCESS (0.000s)
[118.777398] [065/160] (883s left) kms_addfb_basic (bad-pitch-128)
[118.878113] Starting subtest: bad-pitch-128
[118.879385] Subtest bad-pitch-128: SUCCESS (0.000s)
[119.008707] [066/160] (883s left) kms_addfb_basic (bad-pitch-256)
[119.105607] Starting subtest: bad-pitch-256
[119.106743] Subtest bad-pitch-256: SUCCESS (0.000s)
[119.243401] [067/160] (883s left) kms_addfb_basic (bad-pitch-32)
[119.337733] Starting subtest: bad-pitch-32
[119.338973] Subtest bad-pitch-32: SUCCESS (0.000s)
[119.458713] [068/160] (883s left) kms_addfb_basic (bad-pitch-63)
[119.559958] Starting subtest: bad-pitch-63
[119.561076] Subtest bad-pitch-63: SUCCESS (0.000s)
[119.693762] [069/160] (882s left) kms_addfb_basic (bad-pitch-65536)
[119.797591] Starting subtest: bad-pitch-65536
[119.798709] Subtest bad-pitch-65536: SUCCESS (0.000s)
[119.922497] [070/160] (882s left) kms_addfb_basic (bad-pitch-999)
[120.021535] Starting subtest: bad-pitch-999
[120.022666] Subtest bad-pitch-999: SUCCESS (0.000s)
[120.161405] [071/160] (882s left) kms_addfb_basic (basic)
[120.270376] Starting subtest: basic
[120.271455] Subtest basic: SUCCESS (0.000s)
[120.411962] [072/160] (882s left) kms_addfb_basic (basic-x-tiled-legacy)
[120.509748] Starting subtest: basic-x-tiled-legacy
[120.511070] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[120.656039] [073/160] (882s left) kms_addfb_basic (basic-y-tiled-legacy)
[120.754903] Starting subtest: basic-y-tiled-legacy
[120.756076] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[120.904510] [074/160] (881s left) kms_addfb_basic (bo-too-small)
[121.030497] Starting subtest: bo-too-small
[121.031657] Subtest bo-too-small: SUCCESS (0.000s)
[121.130917] [075/160] (881s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[121.257154] Starting subtest: bo-too-small-due-to-tiling
[121.258367] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[121.363362] [076/160] (881s left) kms_addfb_basic (clobberred-modifier)
[121.465683] Starting subtest: clobberred-modifier
[121.466804] Subtest clobberred-modifier: SUCCESS (0.000s)
[121.595618] [077/160] (881s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[121.694770] Starting subtest: framebuffer-vs-set-tiling
[121.696075] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[121.814274] [078/160] (881s left) kms_addfb_basic (invalid-get-prop)
[121.910484] Starting subtest: invalid-get-prop
[121.911585] Subtest invalid-get-prop: SUCCESS (0.000s)
[122.026763] [079/160] (880s left) kms_addfb_basic (invalid-get-prop-any)
[122.131871] Starting subtest: invalid-get-prop-any
[122.133247] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[122.260991] [080/160] (880s left) kms_addfb_basic (invalid-set-prop)
[122.365048] Starting subtest: invalid-set-prop
[122.366184] Subtest invalid-set-prop: SUCCESS (0.000s)
[122.490968] [081/160] (880s left) kms_addfb_basic (invalid-set-prop-any)
[122.597949] Starting subtest: invalid-set-prop-any
[122.599103] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[122.728616] [082/160] (880s left) kms_addfb_basic (no-handle)
[122.823510] Starting subtest: no-handle
[122.824675] Subtest no-handle: SUCCESS (0.000s)
[122.952411] [083/160] (880s left) kms_addfb_basic (size-max)
[123.080337] Starting subtest: size-max
[123.081482] Subtest size-max: SUCCESS (0.000s)
[123.179843] [084/160] (879s left) kms_addfb_basic (small-bo)
[123.308607] Starting subtest: small-bo
[123.309733] Subtest small-bo: SUCCESS (0.000s)
[123.415350] [085/160] (879s left) kms_addfb_basic (tile-pitch-mismatch)
[123.524740] Starting subtest: tile-pitch-mismatch
[123.525922] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[123.648207] [086/160] (879s left) kms_addfb_basic (too-high)
[123.780858] Starting subtest: too-high
[123.782116] Subtest too-high: SUCCESS (0.001s)
[123.874197] [087/160] (879s left) kms_addfb_basic (too-wide)
[124.003609] Starting subtest: too-wide
[124.004799] Subtest too-wide: SUCCESS (0.000s)
[124.115515] [088/160] (879s left) kms_addfb_basic (unused-handle)
[124.214837] Starting subtest: unused-handle
[124.216042] Subtest unused-handle: SUCCESS (0.000s)
[124.350257] [089/160] (878s left) kms_addfb_basic (unused-modifier)
[124.453918] Starting subtest: unused-modifier
[124.455073] Subtest unused-modifier: SUCCESS (0.000s)
[124.599354] [090/160] (878s left) kms_addfb_basic (unused-offsets)
[124.695542] Starting subtest: unused-offsets
[124.696663] Subtest unused-offsets: SUCCESS (0.000s)
[124.813448] [091/160] (878s left) kms_addfb_basic (unused-pitches)
[124.915402] Starting subtest: unused-pitches
[124.916501] Subtest unused-pitches: SUCCESS (0.000s)
[125.025401] [092/160] (878s left) kms_busy (basic)
[125.160394] Starting subtest: basic
[125.161739] Starting dynamic subtest: flip
[126.169821] Dynamic subtest flip: SUCCESS (1.002s)
[126.184608] Starting dynamic subtest: modeset
[130.069048] Dynamic subtest modeset: SUCCESS (3.904s)
[130.070157] Subtest basic: SUCCESS (4.909s)
[131.048685] [093/160] (872s left) kms_prop_blob (basic)
[131.151796] Starting subtest: basic
[131.152974] Subtest basic: SUCCESS (0.000s)
[131.248824] [094/160] (872s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[131.380553] Starting subtest: basic-busy-flip-before-cursor-atomic
[131.382692] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[131.464617] [095/160] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[131.606533] Starting subtest: basic-busy-flip-before-cursor-legacy
[131.608786] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[131.699483] [096/160] (871s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[131.823834] Starting subtest: basic-flip-after-cursor-atomic
[133.127364] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.303s)
[134.054314] [097/160] (869s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[134.185737] Starting subtest: basic-flip-after-cursor-legacy
[135.486395] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.297s)
[136.421621] [098/160] (867s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[136.551757] Starting subtest: basic-flip-after-cursor-varying-size
[137.818165] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.266s)
[138.778997] [099/160] (864s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[138.921189] Starting subtest: basic-flip-before-cursor-atomic
[140.230173] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.310s)
[141.156314] [100/160] (862s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[141.294136] Starting subtest: basic-flip-before-cursor-legacy
[142.605532] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.311s)
[143.524186] [101/160] (860s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[143.653672] Starting subtest: basic-flip-before-cursor-varying-size
[144.953069] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.300s)
[145.893572] [102/160] (857s left) kms_dsc (dsc-basic)
[146.026376] Starting subtest: dsc-basic
[146.028879] Subtest dsc-basic: SKIP (0.001s)
[146.110255] [103/160] (857s left) kms_flip (basic-flip-vs-dpms)
[146.241435] Starting subtest: basic-flip-vs-dpms
[146.243989] Starting dynamic subtest: A-eDP1
[149.100935] Dynamic subtest A-eDP1: SUCCESS (2.856s)
[149.117084] Starting dynamic subtest: B-eDP1
[151.531463] Dynamic subtest B-eDP1: SUCCESS (2.430s)
[151.549129] Starting dynamic subtest: C-eDP1
[153.966410] Dynamic subtest C-eDP1: SUCCESS (2.435s)
[153.969469] Subtest basic-flip-vs-dpms: SUCCESS (7.729s)
[154.878094] [104/160] (848s left) kms_flip (basic-flip-vs-modeset)
[155.007809] Starting subtest: basic-flip-vs-modeset
[155.010708] Starting dynamic subtest: A-eDP1
[157.847732] Dynamic subtest A-eDP1: SUCCESS (2.837s)
[157.864303] Starting dynamic subtest: B-eDP1
[160.285557] Dynamic subtest B-eDP1: SUCCESS (2.432s)
[160.300797] Starting dynamic subtest: C-eDP1
[162.651148] Dynamic subtest C-eDP1: SUCCESS (2.369s)
[162.656224] Subtest basic-flip-vs-modeset: SUCCESS (7.647s)
[163.623884] [105/160] (840s left) kms_flip (basic-flip-vs-wf_vblank)
[163.752663] Starting subtest: basic-flip-vs-wf_vblank
[163.755523] Starting dynamic subtest: A-eDP1
[166.083445] Dynamic subtest A-eDP1: SUCCESS (2.326s)
[166.102181] Starting dynamic subtest: B-eDP1
[168.369249] Dynamic subtest B-eDP1: SUCCESS (2.284s)
[168.389312] Starting dynamic subtest: C-eDP1
[170.612309] Dynamic subtest C-eDP1: SUCCESS (2.240s)
[170.617039] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.865s)
[171.940582] [106/160] (831s left) kms_flip (basic-plain-flip)
[172.072575] Starting subtest: basic-plain-flip
[172.075823] Starting dynamic subtest: A-eDP1
[174.116938] Dynamic subtest A-eDP1: SUCCESS (2.040s)
[174.140737] Starting dynamic subtest: B-eDP1
[176.087363] Dynamic subtest B-eDP1: SUCCESS (1.967s)
[176.105724] Starting dynamic subtest: C-eDP1
[178.068059] Dynamic subtest C-eDP1: SUCCESS (1.979s)
[178.072972] Subtest basic-plain-flip: SUCCESS (6.001s)
[179.364565] [107/160] (824s left) kms_force_connector_basic (force-connector-state)
[179.471088] Starting subtest: force-connector-state
[180.059469] Subtest force-connector-state: SUCCESS (0.588s)
[181.132518] [108/160] (822s left) kms_force_connector_basic (force-edid)
[181.238061] Starting subtest: force-edid
[181.498621] Subtest force-edid: SUCCESS (0.261s)
[181.626121] [109/160] (822s left) kms_force_connector_basic (force-load-detect)
[181.735622] Starting subtest: force-load-detect
[181.738601] Subtest force-load-detect: SKIP (0.000s)
[181.842445] [110/160] (821s left) kms_force_connector_basic (prune-stale-modes)
[181.949057] Starting subtest: prune-stale-modes
[182.265837] Subtest prune-stale-modes: SUCCESS (0.317s)
[182.414302] [111/160] (821s left) kms_frontbuffer_tracking (basic)
[182.549219] Starting subtest: basic
[186.294855] Subtest basic: SUCCESS (3.744s)
[186.421386] [112/160] (817s left) kms_hdmi_inject (inject-audio)
[186.853107] Starting subtest: inject-audio
[187.101229] Subtest inject-audio: SUCCESS (0.247s)
[187.798915] [113/160] (816s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[187.927672] Starting subtest: compare-crc-sanitycheck-xr24
[187.930531] Starting dynamic subtest: pipe-A-eDP-1
[188.627557] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.697s)
[188.648455] Starting dynamic subtest: pipe-B-eDP-1
[190.031537] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.399s)
[190.051698] Starting dynamic subtest: pipe-C-eDP-1
[191.428466] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.394s)
[191.429557] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.501s)
[192.356895] [114/160] (811s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[192.488175] Starting subtest: compare-crc-sanitycheck-nv12
[192.491171] Starting dynamic subtest: pipe-A-eDP-1
[193.440351] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.946s)
[193.457504] Starting dynamic subtest: pipe-B-eDP-1
[194.835257] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.395s)
[194.854802] Starting dynamic subtest: pipe-C-eDP-1
[196.254148] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.415s)
[196.255380] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.766s)
[197.222093] [115/160] (806s left) kms_pipe_crc_basic (hang-read-crc)
[197.354065] Starting subtest: hang-read-crc
[197.357072] Starting dynamic subtest: pipe-A-eDP-1
[199.786577] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.428s)
[199.804883] Starting dynamic subtest: pipe-B-eDP-1
[202.872270] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.083s)
[202.890870] Starting dynamic subtest: pipe-C-eDP-1
[205.835264] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.960s)
[205.836563] Subtest hang-read-crc: SUCCESS (8.481s)
[206.757640] [116/160] (797s left) kms_pipe_crc_basic (nonblocking-crc)
[206.885796] Starting subtest: nonblocking-crc
[206.888880] Starting dynamic subtest: pipe-A-eDP-1
[207.786020] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.898s)
[207.804515] Starting dynamic subtest: pipe-B-eDP-1
[209.405867] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.615s)
[209.424530] Starting dynamic subtest: pipe-C-eDP-1
[210.952124] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.543s)
[210.953383] Subtest nonblocking-crc: SUCCESS (4.067s)
[211.874443] [117/160] (792s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[212.015364] Starting subtest: nonblocking-crc-frame-sequence
[212.017016] Starting dynamic subtest: pipe-A-eDP-1
[212.920584] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.902s)
[212.938949] Starting dynamic subtest: pipe-B-eDP-1
[214.506565] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.582s)
[214.525242] Starting dynamic subtest: pipe-C-eDP-1
[216.086241] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.576s)
[216.087486] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.071s)
[217.059203] [118/160] (786s left) kms_pipe_crc_basic (read-crc)
[217.185910] Starting subtest: read-crc
[217.189205] Starting dynamic subtest: pipe-A-eDP-1
[218.021586] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.833s)
[218.040533] Starting dynamic subtest: pipe-B-eDP-1
[219.560387] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.534s)
[219.579442] Starting dynamic subtest: pipe-C-eDP-1
[221.080055] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.515s)
[221.081186] Subtest read-crc: SUCCESS (3.893s)
[222.056268] [119/160] (781s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[222.188479] Starting subtest: read-crc-frame-sequence
[222.191462] Starting dynamic subtest: pipe-A-eDP-1
[223.020109] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.828s)
[223.038571] Starting dynamic subtest: pipe-B-eDP-1
[224.550538] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.527s)
[224.569383] Starting dynamic subtest: pipe-C-eDP-1
[226.045997] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.492s)
[226.047183] Subtest read-crc-frame-sequence: SUCCESS (3.859s)
[226.980157] [120/160] (777s left) kms_pm_backlight (basic-brightness)
[227.113162] Starting subtest: basic-brightness
[227.207357] Starting dynamic subtest: eDP-1
[227.744598] Dynamic subtest eDP-1: SUCCESS (0.535s)
[227.745872] Subtest basic-brightness: SUCCESS (0.630s)
[228.709995] [121/160] (775s left) kms_pm_rpm (basic-pci-d3-state)
[230.543437] Starting subtest: basic-pci-d3-state
[234.940777] Subtest basic-pci-d3-state: SUCCESS (4.397s)
[235.146748] [122/160] (768s left) kms_pm_rpm (basic-rte)
[235.235389] Starting subtest: basic-rte
[241.407145] Subtest basic-rte: SUCCESS (6.170s)
[242.916857] [123/160] (761s left) kms_psr (psr-primary-page-flip)
[243.047210] Starting subtest: psr-primary-page-flip
[243.048393] Starting dynamic subtest: eDP-1
[246.941605] Dynamic subtest eDP-1: SUCCESS (3.891s)
[246.942679] Subtest psr-primary-page-flip: SUCCESS (3.894s)
[247.909392] [124/160] (756s left) kms_psr (psr-cursor-plane-move)
[248.042780] Starting subtest: psr-cursor-plane-move
[248.044075] Starting dynamic subtest: eDP-1
[251.846586] Dynamic subtest eDP-1: SUCCESS (3.803s)
[251.847840] Subtest psr-cursor-plane-move: SUCCESS (3.806s)
[252.775285] [125/160] (751s left) kms_psr (psr-sprite-plane-onoff)
[252.906601] Starting subtest: psr-sprite-plane-onoff
[252.907967] Starting dynamic subtest: eDP-1
[256.865548] Dynamic subtest eDP-1: SUCCESS (3.956s)
[256.867180] Subtest psr-sprite-plane-onoff: SUCCESS (3.959s)
[257.782545] [126/160] (746s left) kms_psr (psr-primary-mmap-gtt)
[257.912456] Starting subtest: psr-primary-mmap-gtt
[257.913626] Starting dynamic subtest: eDP-1
[261.721450] Dynamic subtest eDP-1: SUCCESS (3.807s)
[261.725071] Subtest psr-primary-mmap-gtt: SUCCESS (3.810s)
[262.637504] [127/160] (741s left) kms_setmode (basic-clone-single-crtc)
[262.739252] Starting subtest: basic-clone-single-crtc
[262.742619] Subtest basic-clone-single-crtc: SKIP (0.000s)
[262.838468] [128/160] (741s left) i915_pm_rps (basic-api)
[262.943082] Starting subtest: basic-api
[262.947933] Subtest basic-api: SUCCESS (0.005s)
[263.037187] [129/160] (741s left) prime_self_import (basic-llseek-bad)
[263.124609] Starting subtest: basic-llseek-bad
[263.138424] Subtest basic-llseek-bad: SUCCESS (0.013s)
[263.256084] [130/160] (741s left) prime_self_import (basic-llseek-size)
[263.342635] Starting subtest: basic-llseek-size
[263.352686] Subtest basic-llseek-size: SUCCESS (0.011s)
[263.455344] [131/160] (740s left) prime_self_import (basic-with_fd_dup)
[263.542781] Starting subtest: basic-with_fd_dup
[263.558419] Subtest basic-with_fd_dup: SUCCESS (0.015s)
[263.672281] [132/160] (740s left) prime_self_import (basic-with_one_bo)
[263.759939] Starting subtest: basic-with_one_bo
[263.776456] Subtest basic-with_one_bo: SUCCESS (0.018s)
[263.883465] [133/160] (740s left) prime_self_import (basic-with_one_bo_two_files)
[263.970377] Starting subtest: basic-with_one_bo_two_files
[263.988795] Subtest basic-with_one_bo_two_files: SUCCESS (0.018s)
[264.106622] [134/160] (740s left) prime_self_import (basic-with_two_bos)
[264.194082] Starting subtest: basic-with_two_bos
[264.211462] Subtest basic-with_two_bos: SUCCESS (0.019s)
[264.337407] [135/160] (740s left) prime_vgem (basic-fence-flip)
[264.467193] Starting subtest: basic-fence-flip
[264.995819] Subtest basic-fence-flip: SUCCESS (0.528s)
[265.126698] [136/160] (739s left) prime_vgem (basic-fence-mmap)
[265.251705] Starting subtest: basic-fence-mmap
[265.301158] Subtest basic-fence-mmap: SUCCESS (0.049s)
[265.391465] [137/160] (739s left) prime_vgem (basic-fence-read)
[265.518175] Starting subtest: basic-fence-read
[265.614731] Subtest basic-fence-read: SUCCESS (0.098s)
[265.709174] [138/160] (738s left) prime_vgem (basic-gtt)
[265.829114] Starting subtest: basic-gtt
[265.855737] Subtest basic-gtt: SUCCESS (0.025s)
[265.964763] [139/160] (738s left) prime_vgem (basic-read)
[266.082815] Starting subtest: basic-read
[266.131788] Subtest basic-read: SUCCESS (0.048s)
[266.240163] [140/160] (738s left) prime_vgem (basic-write)
[266.349351] Starting subtest: basic-write
[266.415273] Subtest basic-write: SUCCESS (0.066s)
[266.508917] [141/160] (738s left) vgem_basic (setversion)
[266.615561] Starting subtest: setversion
[266.618122] Subtest setversion: SUCCESS (0.000s)
[266.690683] [142/160] (738s left) vgem_basic (create)
[266.800184] Starting subtest: create
[266.801724] Subtest create: SUCCESS (0.000s)
[266.876304] [143/160] (737s left) vgem_basic (debugfs)
[266.982527] Starting subtest: debugfs
[266.983844] Subtest debugfs: SUCCESS (0.001s)
[267.058687] [144/160] (737s left) vgem_basic (dmabuf-export)
[267.166950] Starting subtest: dmabuf-export
[267.197058] Subtest dmabuf-export: SUCCESS (0.021s)
[267.310344] [145/160] (737s left) vgem_basic (dmabuf-fence)
[267.416558] Starting subtest: dmabuf-fence
[267.417799] Subtest dmabuf-fence: SUCCESS (0.001s)
[267.491424] [146/160] (737s left) vgem_basic (dmabuf-fence-before)
[267.586174] Starting subtest: dmabuf-fence-before
[267.587491] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[267.659132] [147/160] (737s left) vgem_basic (dmabuf-mmap)
[267.766920] Starting subtest: dmabuf-mmap
[267.792585] Subtest dmabuf-mmap: SUCCESS (0.026s)
[267.855805] [148/160] (737s left) vgem_basic (mmap)
[267.949755] Starting subtest: mmap
[267.970052] Subtest mmap: SUCCESS (0.017s)
[268.039095] [149/160] (736s left) vgem_basic (second-client)
[268.133300] Starting subtest: second-client
[268.168595] Subtest second-client: SUCCESS (0.034s)
[268.242711] [150/160] (736s left) vgem_basic (sysfs)
[268.351181] Starting subtest: sysfs
[268.352460] Subtest sysfs: SUCCESS (0.001s)
[268.425902] [151/160] (736s left) core_hotunplug (unbind-rebind)
[268.567423] Starting subtest: unbind-rebind
[274.624164] Subtest unbind-rebind: SUCCESS (6.057s)
[274.660115] [152/160] (730s left) vgem_basic (unload)
[274.753361] Starting subtest: unload
[303.803425] Subtest unload: SUCCESS (29.016s)
[303.916766] [153/160] (701s left) i915_module_load (reload)
[304.007303] Starting subtest: reload
[308.994244] Subtest reload: SUCCESS (4.984s)
[309.022670] [154/160] (696s left) gem_lmem_swapping (basic)
[309.132984] Subtest basic: SKIP (0.000s)
[309.176040] [155/160] (695s left) gem_lmem_swapping (parallel-random-engines)
[309.275391] Subtest parallel-random-engines: SKIP (0.000s)
[309.327079] [156/160] (695s left) gem_lmem_swapping (random-engines)
[309.423156] Subtest random-engines: SKIP (0.000s)
[309.477464] [157/160] (695s left) gem_lmem_swapping (verify-random)
[309.575121] Subtest verify-random: SKIP (0.000s)
[309.627460] [158/160] (695s left) i915_pm_rpm (module-reload)
[322.100673] Starting subtest: module-reload
[354.557834] Subtest module-reload: SUCCESS (32.450s)
[354.580666] [159/160] (650s left) i915_selftest (live)
[354.681950] Starting subtest: live
[354.683212] Starting dynamic subtest: sanitycheck
[358.151784] Dynamic subtest sanitycheck: SUCCESS (3.460s)
[358.162529] Starting dynamic subtest: uncore
[361.593680] Dynamic subtest uncore: SUCCESS (3.438s)
[361.604545] Starting dynamic subtest: workarounds
[365.311535] Dynamic subtest workarounds: SUCCESS (3.714s)
[365.322284] Starting dynamic subtest: gt_engines
[369.209610] Dynamic subtest gt_engines: SUCCESS (3.895s)
[369.220370] Starting dynamic subtest: gt_timelines
[384.811579] Dynamic subtest gt_timelines: SUCCESS (15.598s)
[384.822381] Starting dynamic subtest: gt_contexts
[388.339528] Dynamic subtest gt_contexts: SUCCESS (3.525s)
[388.350245] Starting dynamic subtest: gt_lrc
[393.744455] Dynamic subtest gt_lrc: SUCCESS (5.402s)
[393.755314] Starting dynamic subtest: gt_mocs
[397.305529] Dynamic subtest gt_mocs: SUCCESS (3.557s)
[397.316339] Starting dynamic subtest: gt_pm
[404.003327] Dynamic subtest gt_pm: SUCCESS (6.702s)
[404.018201] Starting dynamic subtest: gt_heartbeat
[407.547413] Dynamic subtest gt_heartbeat: SUCCESS (3.533s)
[407.558252] Starting dynamic subtest: gt_tlb
[412.127064] Dynamic subtest gt_tlb: SUCCESS (4.577s)
[412.137947] Starting dynamic subtest: requests
[421.484620] Dynamic subtest requests: SUCCESS (9.361s)
[421.499972] Starting dynamic subtest: migrate
[427.393914] Dynamic subtest migrate: SUCCESS (5.898s)
[427.404812] Starting dynamic subtest: active
[430.862692] Dynamic subtest active: SUCCESS (3.465s)
[430.873529] Starting dynamic subtest: objects
[435.407584] Dynamic subtest objects: SUCCESS (4.541s)
[435.418401] Starting dynamic subtest: mman
[443.906620] Dynamic subtest mman: SUCCESS (8.495s)
[443.917524] Starting dynamic subtest: dmabuf
[447.386447] Dynamic subtest dmabuf: SUCCESS (3.476s)
[447.397369] Starting dynamic subtest: vma
[450.887549] Dynamic subtest vma: SUCCESS (3.498s)
[450.898389] Starting dynamic subtest: coherency
[457.285152] Dynamic subtest coherency: SUCCESS (6.403s)
[457.300156] Starting dynamic subtest: gtt
[468.080646] Dynamic subtest gtt: SUCCESS (10.784s)
[468.091613] Starting dynamic subtest: gem
[471.682417] Dynamic subtest gem: SUCCESS (3.598s)
[471.693262] Starting dynamic subtest: evict
[476.807689] Dynamic subtest evict: SUCCESS (5.122s)
[476.818578] Starting dynamic subtest: hugepages
[486.221694] Dynamic subtest hugepages: SUCCESS (9.410s)
[486.233161] Starting dynamic subtest: gem_contexts
[504.519138] Dynamic subtest gem_contexts: SUCCESS (18.293s)
[504.530341] Starting dynamic subtest: client
[508.031570] Dynamic subtest client: SUCCESS (3.510s)
[508.042778] Starting dynamic subtest: gem_migrate
[511.492884] Dynamic subtest gem_migrate: SUCCESS (3.457s)
[511.504890] Starting dynamic subtest: reset
[518.455234] Dynamic subtest reset: SUCCESS (6.959s)
[518.471517] Starting dynamic subtest: memory_region
[521.911834] Dynamic subtest memory_region: SUCCESS (3.458s)
[521.924634] Starting dynamic subtest: hangcheck
[547.966636] Dynamic subtest hangcheck: SUCCESS (26.046s)
[547.977904] Starting dynamic subtest: execlists
[560.100771] Dynamic subtest execlists: SUCCESS (12.130s)
[560.112111] Starting dynamic subtest: ring_submission
[563.580445] Dynamic subtest ring_submission: SUCCESS (3.476s)
[563.591716] Starting dynamic subtest: perf
[567.099225] Dynamic subtest perf: SUCCESS (3.516s)
[567.110512] Starting dynamic subtest: slpc
[570.560063] Dynamic subtest slpc: SUCCESS (3.457s)
[570.572772] Starting dynamic subtest: guc
[574.009647] Dynamic subtest guc: SUCCESS (3.446s)
[574.021053] Starting dynamic subtest: guc_multi_lrc
[577.486552] Dynamic subtest guc_multi_lrc: SUCCESS (3.473s)
[577.497767] Starting dynamic subtest: guc_hang
[580.923429] Dynamic subtest guc_hang: SUCCESS (3.433s)
[580.934696] Starting dynamic subtest: late_gt_pm
[584.446575] Dynamic subtest late_gt_pm: SUCCESS (3.520s)
[584.447793] Subtest live: SUCCESS (229.758s)
[584.476089] [160/160] (420s left) dmabuf (all-tests)
[584.570284] Starting subtest: all-tests
[584.571827] Starting dynamic subtest: sanitycheck
[584.647862] Dynamic subtest sanitycheck: SUCCESS (0.076s)
[584.668142] Starting dynamic subtest: dma_fence
[584.835092] Dynamic subtest dma_fence: SUCCESS (0.183s)
[584.853633] Starting dynamic subtest: dma_fence_chain
[602.861854] Dynamic subtest dma_fence_chain: SUCCESS (18.015s)
[602.875286] Starting dynamic subtest: dma_fence_unwrap
[602.925935] Dynamic subtest dma_fence_unwrap: SUCCESS (0.068s)
[602.944784] Starting dynamic subtest: dma_resv
[603.011941] Dynamic subtest dma_resv: SUCCESS (0.082s)
[603.014280] Subtest all-tests: SUCCESS (18.443s)
[603.042346] Closing watchdogs
Done.