[53.777222] Initializing watchdogs
[53.777362]   /dev/watchdog0
[53.786854] [001/164] (960s left) i915_module_load (load)
[53.886663] Starting subtest: load
[55.996063] Subtest load: SUCCESS (2.102s)
[56.049211] [002/164] (958s left) core_auth (basic-auth)
[56.314059] Starting subtest: basic-auth
[56.318920] Subtest basic-auth: SUCCESS (0.001s)
[56.380260] [003/164] (958s left) debugfs_test (read_all_entries)
[56.473292] Starting subtest: read_all_entries
[56.538602] Subtest read_all_entries: SUCCESS (0.065s)
[57.593376] [004/164] (956s left) debugfs_test (basic-hwmon)
[57.785151] Starting subtest: basic-hwmon
[57.834071] Subtest basic-hwmon: SKIP (0.000s)
[58.707843] [005/164] (955s left) fbdev (eof)
[58.800100] Starting subtest: eof
[58.801861] Subtest eof: SUCCESS (0.001s)
[58.859110] [006/164] (955s left) fbdev (info)
[58.942442] Starting subtest: info
[58.944428] Subtest info: SUCCESS (0.000s)
[59.008822] [007/164] (955s left) fbdev (nullptr)
[59.099697] Starting subtest: nullptr
[59.101576] Subtest nullptr: SUCCESS (0.000s)
[59.158436] [008/164] (955s left) fbdev (read)
[59.248776] Starting subtest: read
[59.456765] Subtest read: SUCCESS (0.207s)
[59.508381] [009/164] (955s left) fbdev (write)
[59.597877] Starting subtest: write
[59.700812] Subtest write: SUCCESS (0.102s)
[59.757969] [010/164] (954s left) gem_basic (bad-close)
[59.850093] Starting subtest: bad-close
[59.853905] Subtest bad-close: SUCCESS (0.000s)
[59.906964] [011/164] (954s left) gem_basic (create-close)
[59.992625] Starting subtest: create-close
[59.995941] Subtest create-close: SUCCESS (0.000s)
[60.071721] [012/164] (954s left) gem_basic (create-fd-close)
[60.163050] Starting subtest: create-fd-close
[60.166201] Subtest create-fd-close: SUCCESS (0.000s)
[60.239434] [013/164] (954s left) gem_busy (busy@all-engines)
[60.342680] Starting subtest: busy
[60.344454] Starting dynamic subtest: all-engines
[60.376297] Dynamic subtest all-engines: SUCCESS (0.036s)
[60.378229] Subtest busy: SUCCESS (0.037s)
[60.706348] [014/164] (953s left) gem_close_race (basic-process)
[60.812774] Starting subtest: basic-process
[60.863714] Subtest basic-process: SUCCESS (0.052s)
[61.039360] [015/164] (953s left) gem_close_race (basic-threads)
[61.205106] Starting subtest: basic-threads
[62.346777] Subtest basic-threads: SUCCESS (1.145s)
[62.534202] [016/164] (952s left) gem_ctx_create (basic)
[62.633814] Starting subtest: basic
[62.636045] Subtest basic: SUCCESS (0.000s)
[62.819169] [017/164] (951s left) gem_ctx_create (basic-files)
[62.915796] Starting subtest: basic-files
[64.939265] Subtest basic-files: SUCCESS (2.023s)
[65.168783] [018/164] (949s left) gem_ctx_exec (basic)
[65.296151] Starting subtest: basic
[65.298699] Subtest basic: SUCCESS (0.001s)
[65.380103] [019/164] (949s left) gem_exec_basic (basic)
[65.477655] Starting subtest: basic
[65.479433] Starting dynamic subtest: rcs0-smem
[65.481065] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[65.489050] Starting dynamic subtest: vcs0-smem
[65.490957] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[65.492900] Subtest basic: SUCCESS (0.001s)
[65.663082] [020/164] (949s left) gem_exec_create (basic)
[65.765072] Starting subtest: basic
[65.766907] Starting dynamic subtest: smem
[67.798426] Dynamic subtest smem: SUCCESS (2.035s)
[67.800148] Subtest basic: SUCCESS (2.035s)
[67.975238] [021/164] (946s left) gem_exec_fence (basic-busy)
[68.205423] Starting subtest: basic-busy
[68.207429] Starting dynamic subtest: rcs0
[68.228862] Dynamic subtest rcs0: SUCCESS (0.025s)
[68.237448] Starting dynamic subtest: vcs0
[68.242990] Dynamic subtest vcs0: SUCCESS (0.014s)
[68.244925] Subtest basic-busy: SUCCESS (0.039s)
[68.740640] [022/164] (946s left) gem_exec_fence (basic-wait)
[69.001025] Starting subtest: basic-wait
[69.004735] Starting dynamic subtest: rcs0
[69.011741] Dynamic subtest rcs0: SUCCESS (0.045s)
[69.021140] Starting dynamic subtest: vcs0
[69.022803] Dynamic subtest vcs0: SUCCESS (0.011s)
[69.024416] Subtest basic-wait: SUCCESS (0.057s)
[69.487426] [023/164] (945s left) gem_exec_fence (basic-await)
[69.713371] Starting subtest: basic-await
[69.715066] Starting dynamic subtest: rcs0
[69.787098] Dynamic subtest rcs0: SUCCESS (0.073s)
[69.799083] Starting dynamic subtest: vcs0
[69.858919] Dynamic subtest vcs0: SUCCESS (0.072s)
[69.860927] Subtest basic-await: SUCCESS (0.146s)
[70.320932] [024/164] (944s left) gem_exec_fence (nb-await)
[70.546521] Starting subtest: nb-await
[70.548578] Starting dynamic subtest: rcs0
[70.597891] Dynamic subtest rcs0: SUCCESS (0.053s)
[70.607237] Starting dynamic subtest: vcs0
[70.651289] Dynamic subtest vcs0: SUCCESS (0.053s)
[70.653190] Subtest nb-await: SUCCESS (0.107s)
[71.120192] [025/164] (943s left) gem_exec_gttfill (basic)
[71.219737] Starting subtest: basic
[78.826899] Subtest basic: SUCCESS (7.606s)
[79.001062] [026/164] (935s left) gem_exec_parallel (engines)
[79.199839] Starting subtest: engines
[79.201976] Starting dynamic subtest: basic
[80.857409] Dynamic subtest basic: SUCCESS (1.659s)
[80.867168] Starting dynamic subtest: contexts
[83.537761] Dynamic subtest contexts: SUCCESS (2.677s)
[83.548546] Starting dynamic subtest: fds
[83.551812] Dynamic subtest fds: SKIP (0.001s)
[83.561744] Starting dynamic subtest: userptr
[85.211761] Dynamic subtest userptr: SUCCESS (1.677s)
[85.213871] Subtest engines: SUCCESS (6.014s)
[85.391103] [027/164] (929s left) gem_exec_store (basic)
[85.492115] Starting subtest: basic
[85.518686] Subtest basic: SUCCESS (0.026s)
[85.705266] [028/164] (929s left) gem_flink_basic (bad-flink)
[85.793381] Starting subtest: bad-flink
[85.795157] Subtest bad-flink: SUCCESS (0.000s)
[85.857334] [029/164] (929s left) gem_flink_basic (bad-open)
[85.948813] Starting subtest: bad-open
[85.950491] Subtest bad-open: SUCCESS (0.000s)
[86.023356] [030/164] (929s left) gem_flink_basic (basic)
[86.110322] Starting subtest: basic
[86.111962] Subtest basic: SUCCESS (0.000s)
[86.186771] [031/164] (928s left) gem_flink_basic (double-flink)
[86.275846] Starting subtest: double-flink
[86.278090] Subtest double-flink: SUCCESS (0.000s)
[86.354726] [032/164] (928s left) gem_flink_basic (flink-lifetime)
[86.440846] Starting subtest: flink-lifetime
[86.443113] Subtest flink-lifetime: SUCCESS (0.001s)
[86.520909] [033/164] (928s left) gem_huc_copy (huc-copy)
[86.611897] Subtest huc-copy: SKIP (0.000s)
[86.641227] [034/164] (928s left) gem_linear_blits (basic)
[86.853862] Starting subtest: basic
[86.869099] Subtest basic: SUCCESS (0.014s)
[86.990701] [035/164] (928s left) gem_mmap (basic)
[87.180056] Starting subtest: basic
[87.189440] Subtest basic: SUCCESS (0.000s)
[87.254779] [036/164] (927s left) gem_mmap_gtt (basic)
[87.343864] Starting subtest: basic
[87.345516] Subtest basic: SUCCESS (0.001s)
[87.421927] [037/164] (927s left) gem_render_linear_blits (basic)
[87.515890] Starting subtest: basic
[87.551484] Subtest basic: SUCCESS (0.036s)
[87.586786] [038/164] (927s left) gem_render_tiled_blits (basic)
[87.678103] Starting subtest: basic
[87.712605] Subtest basic: SUCCESS (0.034s)
[87.754802] [039/164] (927s left) gem_ringfill (basic-all)
[87.893606] Starting subtest: basic-all
[89.003942] Subtest basic-all: SUCCESS (1.110s)
[89.084700] [040/164] (926s left) gem_softpin (allocator-basic)
[89.174284] Subtest allocator-basic: SKIP (0.000s)
[89.248095] [041/164] (926s left) gem_softpin (allocator-basic-reserve)
[89.338950] Subtest allocator-basic-reserve: SKIP (0.000s)
[89.416231] [042/164] (925s left) gem_softpin (safe-alignment)
[89.507029] Starting subtest: safe-alignment
[89.511389] Subtest safe-alignment: SUCCESS (0.007s)
[89.597982] [043/164] (925s left) gem_sync (basic-all)
[89.703679] Starting subtest: basic-all
[91.857500] Subtest basic-all: SUCCESS (2.156s)
[92.044646] [044/164] (923s left) gem_sync (basic-each)
[92.149914] Starting subtest: basic-each
[94.265425] Subtest basic-each: SUCCESS (2.119s)
[94.458017] [045/164] (920s left) gem_tiled_blits (basic)
[94.653351] Starting subtest: basic
[94.676267] Subtest basic: SUCCESS (0.021s)
[94.805414] [046/164] (920s left) gem_tiled_fence_blits (basic)
[95.112477] Starting subtest: basic
[95.125586] Subtest basic: SUCCESS (0.011s)
[95.237344] [047/164] (920s left) gem_tiled_pread_basic
[95.671187] [048/164] (919s left) gem_wait (busy@all-engines)
[95.783275] Starting subtest: busy
[95.785221] Starting dynamic subtest: all-engines
[96.302686] Dynamic subtest all-engines: SUCCESS (0.513s)
[96.304803] Subtest busy: SUCCESS (0.513s)
[96.517362] [049/164] (918s left) gem_wait (wait@all-engines)
[96.624730] Starting subtest: wait
[96.626772] Starting dynamic subtest: all-engines
[97.638464] Dynamic subtest all-engines: SUCCESS (1.015s)
[97.640136] Subtest wait: SUCCESS (1.015s)
[97.850043] [050/164] (917s left) i915_getparams_basic (basic-eu-total)
[97.940485] Starting subtest: basic-eu-total
[97.943652] Subtest basic-eu-total: SUCCESS (0.000s)
[98.016458] [051/164] (917s left) i915_getparams_basic (basic-subslice-total)
[98.102361] Starting subtest: basic-subslice-total
[98.105648] Subtest basic-subslice-total: SUCCESS (0.000s)
[98.165336] [052/164] (917s left) i915_hangman (error-state-basic)
[98.255691] Starting subtest: error-state-basic
[98.269169] Subtest error-state-basic: SUCCESS (0.009s)
[98.317360] [053/164] (917s left) i915_pciid
[98.482306] [054/164] (917s left) kms_addfb_basic (addfb25-4-tiled)
[99.103026] Starting subtest: addfb25-4-tiled
[99.104824] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[99.594216] [055/164] (916s left) kms_addfb_basic (addfb25-bad-modifier)
[99.682926] Starting subtest: addfb25-bad-modifier
[99.684630] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[100.694584] [056/164] (914s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[100.784891] Starting subtest: addfb25-framebuffer-vs-set-tiling
[100.786656] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[101.792200] [057/164] (913s left) kms_addfb_basic (addfb25-modifier-no-flag)
[101.881116] Starting subtest: addfb25-modifier-no-flag
[101.882724] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[102.870983] [058/164] (912s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[102.964379] Starting subtest: addfb25-x-tiled-legacy
[102.966120] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[103.970952] [059/164] (911s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[104.063106] Starting subtest: addfb25-x-tiled-mismatch-legacy
[104.064918] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[105.068767] [060/164] (910s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[105.670915] Starting subtest: addfb25-yf-tiled-legacy
[105.672897] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[106.166652] [061/164] (909s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[106.795169] Starting subtest: addfb25-y-tiled-legacy
[106.797134] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[107.262656] [062/164] (908s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[107.882498] Starting subtest: addfb25-y-tiled-small-legacy
[107.886201] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[108.376739] [063/164] (907s left) kms_addfb_basic (bad-pitch-0)
[108.470190] Starting subtest: bad-pitch-0
[108.471936] Subtest bad-pitch-0: SUCCESS (0.000s)
[109.477170] [064/164] (906s left) kms_addfb_basic (bad-pitch-1024)
[109.565621] Starting subtest: bad-pitch-1024
[109.567263] Subtest bad-pitch-1024: SUCCESS (0.000s)
[110.590388] [065/164] (905s left) kms_addfb_basic (bad-pitch-128)
[110.678710] Starting subtest: bad-pitch-128
[110.680366] Subtest bad-pitch-128: SUCCESS (0.000s)
[111.687035] [066/164] (904s left) kms_addfb_basic (bad-pitch-256)
[111.777739] Starting subtest: bad-pitch-256
[111.779432] Subtest bad-pitch-256: SUCCESS (0.000s)
[112.803160] [067/164] (903s left) kms_addfb_basic (bad-pitch-32)
[112.894174] Starting subtest: bad-pitch-32
[112.896139] Subtest bad-pitch-32: SUCCESS (0.000s)
[113.900837] [068/164] (902s left) kms_addfb_basic (bad-pitch-63)
[113.989540] Starting subtest: bad-pitch-63
[113.991177] Subtest bad-pitch-63: SUCCESS (0.000s)
[115.030727] [069/164] (901s left) kms_addfb_basic (bad-pitch-65536)
[115.221200] Starting subtest: bad-pitch-65536
[115.245314] Subtest bad-pitch-65536: SUCCESS (0.000s)
[116.131615] [070/164] (899s left) kms_addfb_basic (bad-pitch-999)
[116.220795] Starting subtest: bad-pitch-999
[116.222491] Subtest bad-pitch-999: SUCCESS (0.000s)
[117.228749] [071/164] (898s left) kms_addfb_basic (basic)
[117.318352] Starting subtest: basic
[117.320193] Subtest basic: SUCCESS (0.000s)
[118.341882] [072/164] (897s left) kms_addfb_basic (basic-x-tiled-legacy)
[118.431855] Starting subtest: basic-x-tiled-legacy
[118.434859] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[119.456884] [073/164] (896s left) kms_addfb_basic (basic-y-tiled-legacy)
[119.549963] Starting subtest: basic-y-tiled-legacy
[119.551910] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[120.569165] [074/164] (895s left) kms_addfb_basic (bo-too-small)
[121.186959] Starting subtest: bo-too-small
[121.189100] Subtest bo-too-small: SUCCESS (0.000s)
[121.669631] [075/164] (894s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[122.281860] Starting subtest: bo-too-small-due-to-tiling
[122.283776] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[122.783224] [076/164] (893s left) kms_addfb_basic (clobberred-modifier)
[122.875271] Starting subtest: clobberred-modifier
[122.876942] Subtest clobberred-modifier: SUCCESS (0.000s)
[123.897995] [077/164] (892s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[123.987250] Starting subtest: framebuffer-vs-set-tiling
[123.988863] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[125.009473] [078/164] (891s left) kms_addfb_basic (invalid-get-prop)
[125.099513] Starting subtest: invalid-get-prop
[125.101277] Subtest invalid-get-prop: SUCCESS (0.000s)
[126.124942] [079/164] (890s left) kms_addfb_basic (invalid-get-prop-any)
[126.213237] Starting subtest: invalid-get-prop-any
[126.216488] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[127.241595] [080/164] (889s left) kms_addfb_basic (invalid-set-prop)
[127.334790] Starting subtest: invalid-set-prop
[127.337536] Subtest invalid-set-prop: SUCCESS (0.000s)
[128.353606] [081/164] (887s left) kms_addfb_basic (invalid-set-prop-any)
[128.444137] Starting subtest: invalid-set-prop-any
[128.446667] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[129.470369] [082/164] (886s left) kms_addfb_basic (no-handle)
[129.558209] Starting subtest: no-handle
[129.561763] Subtest no-handle: SUCCESS (0.000s)
[130.601525] [083/164] (885s left) kms_addfb_basic (size-max)
[131.227709] Starting subtest: size-max
[131.229599] Subtest size-max: SUCCESS (0.000s)
[131.715412] [084/164] (884s left) kms_addfb_basic (small-bo)
[132.334360] Starting subtest: small-bo
[132.336276] Subtest small-bo: SUCCESS (0.000s)
[132.825476] [085/164] (883s left) kms_addfb_basic (tile-pitch-mismatch)
[132.919769] Starting subtest: tile-pitch-mismatch
[132.921409] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[133.942335] [086/164] (882s left) kms_addfb_basic (too-high)
[134.567731] Starting subtest: too-high
[134.572663] Subtest too-high: SUCCESS (0.003s)
[135.059102] [087/164] (881s left) kms_addfb_basic (too-wide)
[135.678754] Starting subtest: too-wide
[135.680686] Subtest too-wide: SUCCESS (0.000s)
[136.154757] [088/164] (880s left) kms_addfb_basic (unused-handle)
[136.241924] Starting subtest: unused-handle
[136.243707] Subtest unused-handle: SUCCESS (0.000s)
[137.270416] [089/164] (879s left) kms_addfb_basic (unused-modifier)
[137.363786] Starting subtest: unused-modifier
[137.365517] Subtest unused-modifier: SUCCESS (0.000s)
[138.385775] [090/164] (878s left) kms_addfb_basic (unused-offsets)
[138.478366] Starting subtest: unused-offsets
[138.480116] Subtest unused-offsets: SUCCESS (0.000s)
[139.515530] [091/164] (877s left) kms_addfb_basic (unused-pitches)
[139.605692] Starting subtest: unused-pitches
[139.607332] Subtest unused-pitches: SUCCESS (0.000s)
[140.629124] [092/164] (875s left) kms_busy (basic)
[141.248247] Starting subtest: basic
[141.251415] Starting dynamic subtest: flip
[142.030616] Dynamic subtest flip: SUCCESS (0.775s)
[142.048982] Starting dynamic subtest: modeset
[142.741456] Dynamic subtest modeset: SUCCESS (0.713s)
[142.746864] Subtest basic: SUCCESS (1.492s)
[143.316780] [093/164] (873s left) kms_prop_blob (basic)
[143.411430] Starting subtest: basic
[143.413087] Subtest basic: SUCCESS (0.000s)
[143.481617] [094/164] (873s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[144.105551] Starting subtest: basic-busy-flip-before-cursor-atomic
[145.126987] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.018s)
[145.689224] [095/164] (870s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[146.314750] Starting subtest: basic-busy-flip-before-cursor-legacy
[147.330516] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.015s)
[147.896370] [096/164] (868s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[148.530139] Starting subtest: basic-flip-after-cursor-atomic
[149.554395] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.023s)
[150.102854] [097/164] (866s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[150.733092] Starting subtest: basic-flip-after-cursor-legacy
[151.744148] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.008s)
[152.292859] [098/164] (864s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[152.921974] Starting subtest: basic-flip-after-cursor-varying-size
[153.934539] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.012s)
[154.494257] [099/164] (862s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[155.129147] Starting subtest: basic-flip-before-cursor-atomic
[156.152614] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.017s)
[156.708622] [100/164] (860s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[157.346656] Starting subtest: basic-flip-before-cursor-legacy
[158.386113] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.035s)
[158.942938] [101/164] (857s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[159.583286] Starting subtest: basic-flip-before-cursor-varying-size
[160.600411] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.015s)
[161.177716] [102/164] (855s left) kms_flip (basic-flip-vs-dpms)
[161.658610] Starting subtest: basic-flip-vs-dpms
[161.660679] Starting dynamic subtest: A-VGA1
[162.400726] Dynamic subtest A-VGA1: SUCCESS (0.736s)
[162.410934] Starting dynamic subtest: B-VGA1
[163.038056] Dynamic subtest B-VGA1: SUCCESS (0.632s)
[163.053915] Starting dynamic subtest: A-HDMI-A1
[163.730036] Dynamic subtest A-HDMI-A1: SUCCESS (0.690s)
[163.750891] Starting dynamic subtest: B-HDMI-A1
[164.457516] Dynamic subtest B-HDMI-A1: SUCCESS (0.710s)
[164.459165] Subtest basic-flip-vs-dpms: SUCCESS (2.792s)
[165.049715] [103/164] (851s left) kms_flip (basic-flip-vs-modeset)
[165.530891] Starting subtest: basic-flip-vs-modeset
[165.533871] Starting dynamic subtest: A-VGA1
[166.270899] Dynamic subtest A-VGA1: SUCCESS (0.733s)
[166.284300] Starting dynamic subtest: B-VGA1
[166.982690] Dynamic subtest B-VGA1: SUCCESS (0.709s)
[166.995882] Starting dynamic subtest: A-HDMI-A1
[167.726860] Dynamic subtest A-HDMI-A1: SUCCESS (0.745s)
[167.740257] Starting dynamic subtest: B-HDMI-A1
[168.479825] Dynamic subtest B-HDMI-A1: SUCCESS (0.748s)
[168.481473] Subtest basic-flip-vs-modeset: SUCCESS (2.946s)
[169.095513] [104/164] (847s left) kms_flip (basic-flip-vs-wf_vblank)
[169.575854] Starting subtest: basic-flip-vs-wf_vblank
[169.580885] Starting dynamic subtest: A-VGA1
[170.646266] Dynamic subtest A-VGA1: SUCCESS (1.062s)
[170.659148] Starting dynamic subtest: B-VGA1
[171.618317] Dynamic subtest B-VGA1: SUCCESS (0.971s)
[171.630092] Starting dynamic subtest: A-HDMI-A1
[172.783579] Dynamic subtest A-HDMI-A1: SUCCESS (1.161s)
[172.803172] Starting dynamic subtest: B-HDMI-A1
[174.003830] Dynamic subtest B-HDMI-A1: SUCCESS (1.217s)
[174.006290] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.428s)
[174.675694] [105/164] (842s left) kms_flip (basic-plain-flip)
[175.214094] Starting subtest: basic-plain-flip
[175.302639] Starting dynamic subtest: A-VGA1
[175.936684] Dynamic subtest A-VGA1: SUCCESS (0.762s)
[175.950900] Starting dynamic subtest: B-VGA1
[176.625242] Dynamic subtest B-VGA1: SUCCESS (0.686s)
[176.640318] Starting dynamic subtest: A-HDMI-A1
[177.387657] Dynamic subtest A-HDMI-A1: SUCCESS (0.760s)
[177.399798] Starting dynamic subtest: B-HDMI-A1
[178.166417] Dynamic subtest B-HDMI-A1: SUCCESS (0.775s)
[178.168613] Subtest basic-plain-flip: SUCCESS (2.998s)
[178.833710] [106/164] (838s left) kms_force_connector_basic (force-connector-state)
[178.984265] Starting subtest: force-connector-state
[179.770239] Subtest force-connector-state: SUCCESS (0.784s)
[180.514585] [107/164] (836s left) kms_force_connector_basic (force-edid)
[180.663181] Starting subtest: force-edid
[180.970852] Subtest force-edid: SUCCESS (0.310s)
[181.645394] [108/164] (835s left) kms_force_connector_basic (force-load-detect)
[181.801587] Starting subtest: force-load-detect
[181.991384] Subtest force-load-detect: SUCCESS (0.196s)
[182.521961] [109/164] (834s left) kms_force_connector_basic (prune-stale-modes)
[182.673122] Starting subtest: prune-stale-modes
[182.983349] Subtest prune-stale-modes: SUCCESS (0.313s)
[183.638080] [110/164] (833s left) kms_frontbuffer_tracking (basic)
[184.274688] Starting subtest: basic
[184.560765] Subtest basic: SKIP (0.286s)
[185.116854] [111/164] (832s left) kms_hdmi_inject (inject-audio)
[185.293595] Starting subtest: inject-audio
[185.298862] Subtest inject-audio: SKIP (0.001s)
[185.434325] [112/164] (831s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[186.070525] Starting subtest: compare-crc-sanitycheck-xr24
[186.072258] Starting dynamic subtest: pipe-A-HDMI-A-1
[186.445164] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.371s)
[186.475017] Starting dynamic subtest: pipe-B-HDMI-A-1
[186.840951] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.390s)
[186.842883] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.770s)
[187.427271] [113/164] (829s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[188.063067] Starting subtest: compare-crc-sanitycheck-nv12
[188.064981] Starting dynamic subtest: pipe-A-HDMI-A-1
[188.068705] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[188.079084] Starting dynamic subtest: pipe-B-HDMI-A-1
[188.082906] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[188.088938] Subtest compare-crc-sanitycheck-nv12: SKIP (0.008s)
[188.574360] [114/164] (828s left) kms_pipe_crc_basic (hang-read-crc)
[189.212993] Starting subtest: hang-read-crc
[189.214921] Starting dynamic subtest: pipe-A-HDMI-A-1
[190.199879] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.985s)
[190.211881] Starting dynamic subtest: pipe-B-HDMI-A-1
[191.233935] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.028s)
[191.235912] Subtest hang-read-crc: SUCCESS (2.021s)
[191.785277] [115/164] (825s left) kms_pipe_crc_basic (nonblocking-crc)
[192.419322] Starting subtest: nonblocking-crc
[192.421244] Starting dynamic subtest: pipe-A-HDMI-A-1
[192.976899] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.556s)
[192.987630] Starting dynamic subtest: pipe-B-HDMI-A-1
[193.551844] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.571s)
[193.553886] Subtest nonblocking-crc: SUCCESS (1.134s)
[194.110665] [116/164] (823s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[194.745974] Starting subtest: nonblocking-crc-frame-sequence
[194.748515] Starting dynamic subtest: pipe-A-HDMI-A-1
[195.301986] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.554s)
[195.312659] Starting dynamic subtest: pipe-B-HDMI-A-1
[195.879502] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.574s)
[195.881481] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.133s)
[196.452747] [117/164] (820s left) kms_pipe_crc_basic (read-crc)
[197.089122] Starting subtest: read-crc
[197.090793] Starting dynamic subtest: pipe-A-HDMI-A-1
[197.575963] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.488s)
[197.588032] Starting dynamic subtest: pipe-B-HDMI-A-1
[198.085964] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.507s)
[198.088078] Subtest read-crc: SUCCESS (1.002s)
[198.659408] [118/164] (818s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[199.299597] Starting subtest: read-crc-frame-sequence
[199.301323] Starting dynamic subtest: pipe-A-HDMI-A-1
[199.782956] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.485s)
[199.793798] Starting dynamic subtest: pipe-B-HDMI-A-1
[200.282264] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.497s)
[200.284242] Subtest read-crc-frame-sequence: SUCCESS (0.989s)
[200.839890] [119/164] (816s left) kms_pm_backlight (basic-brightness)
[201.482095] Subtest basic-brightness: SKIP (0.000s)
[201.758661] [120/164] (815s left) kms_psr (primary_page_flip)
[201.852467] Subtest primary_page_flip: SKIP (0.000s)
[201.892050] [121/164] (815s left) kms_psr (cursor_plane_move)
[201.984268] Subtest cursor_plane_move: SKIP (0.000s)
[202.025680] [122/164] (815s left) kms_psr (sprite_plane_onoff)
[202.117071] Subtest sprite_plane_onoff: SKIP (0.000s)
[202.158687] [123/164] (815s left) kms_psr (primary_mmap_gtt)
[202.252867] Subtest primary_mmap_gtt: SKIP (0.000s)
[202.291102] [124/164] (815s left) kms_setmode (basic-clone-single-crtc)
[202.384630] Starting subtest: basic-clone-single-crtc
[202.389926] Subtest basic-clone-single-crtc: SKIP (0.000s)
[202.454916] [125/164] (815s left) i915_pm_rpm (basic-pci-d3-state)
[214.439876] Subtest basic-pci-d3-state: SKIP (0.000s)
[214.719100] [126/164] (802s left) i915_pm_rpm (basic-rte)
[214.811730] Starting subtest: basic-rte
[226.698045] Subtest basic-rte: SKIP (11.869s)
[226.957441] [127/164] (790s left) i915_pm_rps (basic-api)
[227.056281] Subtest basic-api: SKIP (0.000s)
[227.090077] [128/164] (790s left) prime_self_import (basic-llseek-bad)
[227.178709] Starting subtest: basic-llseek-bad
[227.183290] Subtest basic-llseek-bad: SUCCESS (0.003s)
[227.254778] [129/164] (790s left) prime_self_import (basic-llseek-size)
[227.344775] Starting subtest: basic-llseek-size
[227.348654] Subtest basic-llseek-size: SUCCESS (0.004s)
[227.420968] [130/164] (790s left) prime_self_import (basic-with_fd_dup)
[227.509086] Starting subtest: basic-with_fd_dup
[227.513017] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[227.586600] [131/164] (790s left) prime_self_import (basic-with_one_bo)
[227.678347] Starting subtest: basic-with_one_bo
[227.681769] Subtest basic-with_one_bo: SUCCESS (0.003s)
[227.758441] [132/164] (789s left) prime_self_import (basic-with_one_bo_two_files)
[227.846256] Starting subtest: basic-with_one_bo_two_files
[227.850260] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[227.918298] [133/164] (789s left) prime_self_import (basic-with_two_bos)
[228.005890] Starting subtest: basic-with_two_bos
[228.009510] Subtest basic-with_two_bos: SUCCESS (0.003s)
[228.086684] [134/164] (789s left) prime_vgem (basic-fence-flip)
[228.196060] Starting subtest: basic-fence-flip
[229.261754] Subtest basic-fence-flip: SUCCESS (1.064s)
[229.858744] [135/164] (787s left) prime_vgem (basic-fence-mmap)
[229.969050] Starting subtest: basic-fence-mmap
[230.012627] Subtest basic-fence-mmap: SUCCESS (0.043s)
[230.091873] [136/164] (787s left) prime_vgem (basic-fence-read)
[230.205533] Starting subtest: basic-fence-read
[230.273424] Subtest basic-fence-read: SUCCESS (0.071s)
[230.357838] [137/164] (787s left) prime_vgem (basic-gtt)
[230.450426] Starting subtest: basic-gtt
[230.470474] Subtest basic-gtt: SUCCESS (0.020s)
[230.558601] [138/164] (787s left) prime_vgem (basic-read)
[230.671952] Starting subtest: basic-read
[230.699846] Subtest basic-read: SUCCESS (0.032s)
[230.775763] [139/164] (787s left) prime_vgem (basic-write)
[230.886189] Starting subtest: basic-write
[230.920326] Subtest basic-write: SUCCESS (0.035s)
[231.005814] [140/164] (786s left) vgem_basic (setversion)
[231.115311] Starting subtest: setversion
[231.119202] Subtest setversion: SUCCESS (0.000s)
[231.173848] [141/164] (786s left) vgem_basic (create)
[231.281287] Starting subtest: create
[231.283397] Subtest create: SUCCESS (0.000s)
[231.337137] [142/164] (786s left) vgem_basic (debugfs)
[231.428491] Starting subtest: debugfs
[231.430234] Subtest debugfs: SUCCESS (0.001s)
[231.492642] [143/164] (786s left) vgem_basic (dmabuf-export)
[231.597110] Starting subtest: dmabuf-export
[231.600862] Subtest dmabuf-export: SUCCESS (0.003s)
[231.671125] [144/164] (786s left) vgem_basic (dmabuf-fence)
[231.761699] Starting subtest: dmabuf-fence
[231.763729] Subtest dmabuf-fence: SUCCESS (0.003s)
[231.820387] [145/164] (786s left) vgem_basic (dmabuf-fence-before)
[231.912937] Starting subtest: dmabuf-fence-before
[231.914899] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[231.973192] [146/164] (786s left) vgem_basic (dmabuf-mmap)
[232.077492] Starting subtest: dmabuf-mmap
[232.099063] Subtest dmabuf-mmap: SUCCESS (0.024s)
[232.153813] [147/164] (785s left) vgem_basic (mmap)
[232.260381] Starting subtest: mmap
[232.275794] Subtest mmap: SUCCESS (0.016s)
[232.337765] [148/164] (785s left) vgem_basic (second-client)
[232.427802] Starting subtest: second-client
[232.460702] Subtest second-client: SUCCESS (0.032s)
[232.521453] [149/164] (785s left) vgem_basic (sysfs)
[232.627985] Starting subtest: sysfs
[232.630116] Subtest sysfs: SUCCESS (0.001s)
[232.687871] [150/164] (785s left) core_hotunplug (unbind-rebind)
[232.825217] Starting subtest: unbind-rebind
[235.832809] Subtest unbind-rebind: SUCCESS (3.004s)
[235.861608] [151/164] (782s left) vgem_basic (unload)
[235.954879] Starting subtest: unload
[264.842985] Subtest unload: SUCCESS (28.889s)
[264.951965] [152/164] (753s left) i915_module_load (reload)
[265.040678] Starting subtest: reload
[267.490668] Subtest reload: SUCCESS (2.451s)
[267.516102] [153/164] (750s left) gem_lmem_swapping (basic)
[267.617617] Subtest basic: SKIP (0.000s)
[267.655636] [154/164] (750s left) gem_lmem_swapping (parallel-random-engines)
[267.747544] Subtest parallel-random-engines: SKIP (0.000s)
[267.789224] [155/164] (750s left) gem_lmem_swapping (random-engines)
[267.887285] Subtest random-engines: SKIP (0.000s)
[267.921419] [156/164] (750s left) gem_lmem_swapping (verify-random)
[268.016889] Subtest verify-random: SKIP (0.000s)
[268.054352] [157/164] (750s left) i915_pm_rpm (module-reload)
[280.047454] Subtest module-reload: SKIP (0.000s)
[280.301278] [158/164] (738s left) i915_selftest (live)
[281.011866] Starting subtest: live
[281.013753] Starting dynamic subtest: sanitycheck
[281.813086] Dynamic subtest sanitycheck: SUCCESS (0.801s)
[281.827436] Starting dynamic subtest: uncore
[282.563587] Dynamic subtest uncore: SUCCESS (0.747s)
[282.573788] Starting dynamic subtest: workarounds
[283.292626] Dynamic subtest workarounds: SUCCESS (0.726s)
[283.303404] Starting dynamic subtest: gt_engines
[283.983101] Dynamic subtest gt_engines: SUCCESS (0.688s)
[283.994535] Starting dynamic subtest: gt_timelines
[289.223154] Dynamic subtest gt_timelines: SUCCESS (5.236s)
[289.234120] Starting dynamic subtest: gt_contexts
[289.954678] Dynamic subtest gt_contexts: SUCCESS (0.729s)
[289.965934] Starting dynamic subtest: gt_lrc
[290.687181] Dynamic subtest gt_lrc: SUCCESS (0.730s)
[290.698873] Starting dynamic subtest: gt_mocs
[291.377557] Dynamic subtest gt_mocs: SUCCESS (0.687s)
[291.388483] Starting dynamic subtest: gt_pm
[292.562106] Dynamic subtest gt_pm: SUCCESS (1.182s)
[292.573355] Starting dynamic subtest: gt_heartbeat
[293.312532] Dynamic subtest gt_heartbeat: SUCCESS (0.747s)
[293.323467] Starting dynamic subtest: gt_tlb
[294.008531] Dynamic subtest gt_tlb: SUCCESS (0.694s)
[294.017451] Starting dynamic subtest: requests
[298.289690] Dynamic subtest requests: SUCCESS (4.279s)
[298.300816] Starting dynamic subtest: migrate
[299.009645] Dynamic subtest migrate: SUCCESS (0.717s)
[299.020140] Starting dynamic subtest: active
[299.691158] Dynamic subtest active: SUCCESS (0.679s)
[299.702453] Starting dynamic subtest: objects
[301.833659] Dynamic subtest objects: SUCCESS (2.139s)
[301.842650] Starting dynamic subtest: mman
[307.726787] Dynamic subtest mman: SUCCESS (5.892s)
[307.738333] Starting dynamic subtest: dmabuf
[308.436705] Dynamic subtest dmabuf: SUCCESS (0.707s)
[308.447845] Starting dynamic subtest: vma
[309.159473] Dynamic subtest vma: SUCCESS (0.721s)
[309.170532] Starting dynamic subtest: coherency
[311.013221] Dynamic subtest coherency: SUCCESS (1.851s)
[311.024463] Starting dynamic subtest: gtt
[315.201658] Dynamic subtest gtt: SUCCESS (4.187s)
[315.211566] Starting dynamic subtest: gem
[315.950829] Dynamic subtest gem: SUCCESS (0.746s)
[315.962173] Starting dynamic subtest: evict
[316.627639] Dynamic subtest evict: SUCCESS (0.675s)
[316.638880] Starting dynamic subtest: hugepages
[317.293072] Dynamic subtest hugepages: SUCCESS (0.663s)
[317.304444] Starting dynamic subtest: gem_contexts
[321.021676] Dynamic subtest gem_contexts: SUCCESS (3.725s)
[321.030693] Starting dynamic subtest: client
[321.710778] Dynamic subtest client: SUCCESS (0.688s)
[321.721538] Starting dynamic subtest: gem_migrate
[322.402034] Dynamic subtest gem_migrate: SUCCESS (0.689s)
[322.413156] Starting dynamic subtest: reset
[323.197448] Dynamic subtest reset: SUCCESS (0.792s)
[323.208147] Starting dynamic subtest: memory_region
[323.873585] Dynamic subtest memory_region: SUCCESS (0.673s)
[323.884344] Starting dynamic subtest: hangcheck
[326.123364] Dynamic subtest hangcheck: SUCCESS (2.247s)
[326.134609] Starting dynamic subtest: execlists
[326.828919] Dynamic subtest execlists: SUCCESS (0.704s)
[326.839672] Starting dynamic subtest: ring_submission
[327.540855] Dynamic subtest ring_submission: SUCCESS (0.709s)
[327.551474] Starting dynamic subtest: perf
[328.225891] Dynamic subtest perf: SUCCESS (0.683s)
[328.236880] Starting dynamic subtest: slpc
[328.905046] Dynamic subtest slpc: SUCCESS (0.678s)
[328.916981] Starting dynamic subtest: guc
[329.774602] Dynamic subtest guc: SUCCESS (0.866s)
[329.785474] Starting dynamic subtest: guc_multi_lrc
[330.472594] Dynamic subtest guc_multi_lrc: SUCCESS (0.696s)
[330.483532] Starting dynamic subtest: guc_hang
[331.187843] Dynamic subtest guc_hang: SUCCESS (0.712s)
[331.197790] Starting dynamic subtest: late_gt_pm
[331.867571] Dynamic subtest late_gt_pm: SUCCESS (0.678s)
[331.869486] Subtest live: SUCCESS (50.857s)
[331.894736] [159/164] (686s left) dmabuf (all-tests)
[332.003253] Starting subtest: all-tests
[332.005089] Starting dynamic subtest: sanitycheck
[332.057075] Dynamic subtest sanitycheck: SUCCESS (0.056s)
[332.069410] Starting dynamic subtest: dma_fence
[332.235577] Dynamic subtest dma_fence: SUCCESS (0.178s)
[332.249657] Starting dynamic subtest: dma_fence_chain
[349.713921] Dynamic subtest dma_fence_chain: SUCCESS (17.473s)
[349.726522] Starting dynamic subtest: dma_fence_unwrap
[349.771866] Dynamic subtest dma_fence_unwrap: SUCCESS (0.057s)
[349.790605] Starting dynamic subtest: dma_resv
[349.831634] Dynamic subtest dma_resv: SUCCESS (0.056s)
[349.833752] Subtest all-tests: SUCCESS (17.834s)
[349.856356] [160/164] (668s left) i915_suspend (basic-s2idle-without-i915)
[349.942137] Starting subtest: basic-s2idle-without-i915
[368.670228] Subtest basic-s2idle-without-i915: SUCCESS (3.310s)
[372.130548] [161/164] (664s left) i915_suspend (basic-s3-without-i915)
[372.225403] Starting subtest: basic-s3-without-i915
[390.169727] Subtest basic-s3-without-i915: SUCCESS (2.185s)
[397.442957] [162/164] (662s left) gem_exec_suspend (basic-s0)
[397.558594] Starting subtest: basic-S0
[397.560366] Starting dynamic subtest: smem
[414.397674] Dynamic subtest smem: SUCCESS (7.152s)
[414.399620] Subtest basic-S0: SUCCESS (7.154s)
[418.585919] [163/164] (654s left) gem_exec_suspend (basic-s3)
[418.694418] Starting subtest: basic-S3
[418.696537] Starting dynamic subtest: smem
[435.783840] Dynamic subtest smem: SUCCESS (2.075s)
[435.785912] Subtest basic-S3: SUCCESS (2.077s)
[442.984281] [164/164] (652s left) kms_pipe_crc_basic (suspend-read-crc)
[443.628658] Starting subtest: suspend-read-crc
[443.630376] Starting dynamic subtest: pipe-A-HDMI-A-1
[460.928945] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.204s)
[460.940982] Starting dynamic subtest: pipe-B-HDMI-A-1
[478.891000] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.088s)
[478.893093] Subtest suspend-read-crc: SUCCESS (4.298s)
[485.690314] Closing watchdogs
Done.