[62.205525] Initializing watchdogs
[62.206131]   /dev/watchdog0
[62.228587] [001/160] (960s left) i915_module_load (load)
[62.656436] Starting subtest: load
[66.958175] Subtest load: SUCCESS (4.290s)
[67.047338] [002/160] (955s left) core_auth (basic-auth)
[67.882242] Starting subtest: basic-auth
[67.887733] Subtest basic-auth: SUCCESS (0.004s)
[68.025347] [003/160] (954s left) debugfs_test (read_all_entries)
[68.461612] Starting subtest: read_all_entries
[68.605329] Subtest read_all_entries: SUCCESS (0.141s)
[68.772288] [004/160] (954s left) debugfs_test (basic-hwmon)
[69.194834] Starting subtest: basic-hwmon
[69.202409] Subtest basic-hwmon: SKIP (0.000s)
[69.375393] [005/160] (953s left) fbdev (eof)
[69.786936] Starting subtest: eof
[69.791322] Subtest eof: SUCCESS (0.004s)
[69.906190] [006/160] (953s left) fbdev (info)
[70.294909] Starting subtest: info
[70.298584] Subtest info: SUCCESS (0.000s)
[70.427586] [007/160] (952s left) fbdev (nullptr)
[70.833818] Starting subtest: nullptr
[70.838308] Subtest nullptr: SUCCESS (0.000s)
[70.939253] [008/160] (952s left) fbdev (read)
[71.350687] Starting subtest: read
[71.633851] Subtest read: SUCCESS (0.283s)
[71.757306] [009/160] (951s left) fbdev (write)
[72.235840] Starting subtest: write
[72.396166] Subtest write: SUCCESS (0.161s)
[72.509481] [010/160] (950s left) gem_basic (bad-close)
[72.909361] Starting subtest: bad-close
[72.916687] Subtest bad-close: SUCCESS (0.000s)
[73.039627] [011/160] (950s left) gem_basic (create-close)
[73.429319] Starting subtest: create-close
[73.437824] Subtest create-close: SUCCESS (0.001s)
[73.557854] [012/160] (950s left) gem_basic (create-fd-close)
[73.954635] Starting subtest: create-fd-close
[73.963166] Subtest create-fd-close: SUCCESS (0.001s)
[74.075951] [013/160] (949s left) gem_busy (busy@all-engines)
[74.533724] Starting subtest: busy
[74.539217] Starting dynamic subtest: all-engines
[74.643865] Dynamic subtest all-engines: SUCCESS (0.109s)
[74.647253] Subtest busy: SUCCESS (0.113s)
[75.129527] [014/160] (948s left) gem_close_race (basic-process)
[75.607600] Starting subtest: basic-process
[75.786170] Subtest basic-process: SUCCESS (0.180s)
[76.053244] [015/160] (947s left) gem_close_race (basic-threads)
[76.530614] Starting subtest: basic-threads
[77.926593] Subtest basic-threads: SUCCESS (1.396s)
[78.201108] [016/160] (945s left) gem_ctx_create (basic)
[78.611671] Subtest basic: SKIP (0.000s)
[78.705160] [017/160] (945s left) gem_ctx_create (basic-files)
[79.115531] Subtest basic-files: SKIP (0.000s)
[79.224327] [018/160] (944s left) gem_ctx_exec (basic)
[79.639255] Subtest basic: SKIP (0.000s)
[79.759985] [019/160] (944s left) gem_exec_basic (basic)
[80.194316] Starting subtest: basic
[80.198270] Starting dynamic subtest: rcs0-smem
[80.201358] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[80.204257] Subtest basic: SUCCESS (0.006s)
[80.468863] [020/160] (943s left) gem_exec_create (basic)
[80.920893] Starting subtest: basic
[80.925525] Starting dynamic subtest: smem
[83.045666] Dynamic subtest smem: SUCCESS (2.123s)
[83.048625] Subtest basic: SUCCESS (2.125s)
[83.303402] [021/160] (941s left) gem_exec_fence (basic-busy)
[83.946258] Starting subtest: basic-busy
[83.950577] Starting dynamic subtest: rcs0
[83.978472] Dynamic subtest rcs0: SUCCESS (0.031s)
[83.981523] Subtest basic-busy: SUCCESS (0.034s)
[84.825165] [022/160] (939s left) gem_exec_fence (basic-wait)
[85.464543] Starting subtest: basic-wait
[85.468815] Starting dynamic subtest: rcs0
[85.502386] Dynamic subtest rcs0: SUCCESS (0.035s)
[85.505353] Subtest basic-wait: SUCCESS (0.038s)
[86.178229] [023/160] (938s left) gem_exec_fence (basic-await)
[86.858091] Starting subtest: basic-await
[86.861262] Starting dynamic subtest: rcs0
[86.975323] Dynamic subtest rcs0: SUCCESS (0.115s)
[86.978743] Subtest basic-await: SUCCESS (0.118s)
[87.646249] [024/160] (936s left) gem_exec_fence (nb-await)
[88.397683] Starting subtest: nb-await
[88.402328] Starting dynamic subtest: rcs0
[88.464676] Dynamic subtest rcs0: SUCCESS (0.066s)
[88.471568] Subtest nb-await: SUCCESS (0.070s)
[89.166299] [025/160] (935s left) gem_exec_gttfill (basic)
[89.631243] Starting subtest: basic
[103.020492] Subtest basic: SUCCESS (13.383s)
[103.369502] [026/160] (921s left) gem_exec_parallel (engines)
[104.216725] Starting subtest: engines
[104.223478] Starting dynamic subtest: basic
[107.741790] Dynamic subtest basic: SUCCESS (3.523s)
[107.783566] Starting dynamic subtest: contexts
[107.789974] Dynamic subtest contexts: SKIP (0.004s)
[107.824195] Starting dynamic subtest: fds
[107.830508] Dynamic subtest fds: SKIP (0.010s)
[107.864116] Starting dynamic subtest: userptr
[111.607800] Dynamic subtest userptr: SUCCESS (3.846s)
[111.610720] Subtest engines: SUCCESS (7.388s)
[111.881202] [027/160] (912s left) gem_exec_store (basic)
[112.346715] Starting subtest: basic
[112.403482] Subtest basic: SUCCESS (0.063s)
[112.678905] [028/160] (912s left) gem_flink_basic (bad-flink)
[113.071809] Starting subtest: bad-flink
[113.075113] Subtest bad-flink: SUCCESS (0.000s)
[113.210507] [029/160] (911s left) gem_flink_basic (bad-open)
[113.610569] Starting subtest: bad-open
[113.615481] Subtest bad-open: SUCCESS (0.000s)
[113.741273] [030/160] (911s left) gem_flink_basic (basic)
[114.135533] Starting subtest: basic
[114.138956] Subtest basic: SUCCESS (0.001s)
[114.275229] [031/160] (910s left) gem_flink_basic (double-flink)
[114.667505] Starting subtest: double-flink
[114.671685] Subtest double-flink: SUCCESS (0.000s)
[114.807945] [032/160] (910s left) gem_flink_basic (flink-lifetime)
[115.204269] Starting subtest: flink-lifetime
[115.208694] Subtest flink-lifetime: SUCCESS (0.007s)
[115.343334] [033/160] (909s left) gem_huc_copy (huc-copy)
[115.758414] Subtest huc-copy: SKIP (0.000s)
[115.868847] [034/160] (909s left) gem_linear_blits (basic)
[116.713690] Starting subtest: basic
[116.769853] Subtest basic: SUCCESS (0.056s)
[117.002537] [035/160] (908s left) gem_mmap (basic)
[117.692552] Starting subtest: basic
[117.708234] Subtest basic: SUCCESS (0.004s)
[117.830390] [036/160] (907s left) gem_mmap_gtt (basic)
[118.229376] Starting subtest: basic
[118.235296] Subtest basic: SUCCESS (0.004s)
[118.354901] [037/160] (907s left) gem_render_linear_blits (basic)
[118.764988] Starting subtest: basic
[118.897777] Subtest basic: SUCCESS (0.132s)
[119.023892] [038/160] (906s left) gem_render_tiled_blits (basic)
[119.425260] Starting subtest: basic
[119.563170] Subtest basic: SUCCESS (0.138s)
[119.689249] [039/160] (906s left) gem_ringfill (basic-all)
[120.137622] Starting subtest: basic-all
[121.330615] Subtest basic-all: SUCCESS (1.194s)
[121.470902] [040/160] (904s left) gem_softpin (allocator-basic)
[121.884848] Subtest allocator-basic: SKIP (0.000s)
[122.019965] [041/160] (903s left) gem_softpin (allocator-basic-reserve)
[122.428717] Subtest allocator-basic-reserve: SKIP (0.000s)
[122.581776] [042/160] (903s left) gem_softpin (safe-alignment)
[122.993125] Starting subtest: safe-alignment
[123.017604] Subtest safe-alignment: SUCCESS (0.029s)
[123.154153] [043/160] (903s left) gem_sync (basic-all)
[123.601857] Starting subtest: basic-all
[126.210336] Subtest basic-all: SUCCESS (2.606s)
[126.490942] [044/160] (899s left) gem_sync (basic-each)
[126.948457] Starting subtest: basic-each
[129.539288] Subtest basic-each: SUCCESS (2.590s)
[129.812398] [045/160] (896s left) gem_tiled_blits (basic)
[130.470490] Starting subtest: basic
[130.567661] Subtest basic: SUCCESS (0.097s)
[130.782736] [046/160] (895s left) gem_tiled_fence_blits (basic)
[131.789133] Starting subtest: basic
[131.862611] Subtest basic: SUCCESS (0.074s)
[132.085141] [047/160] (894s left) gem_tiled_pread_basic
[134.817349] [048/160] (891s left) gem_wait (busy@all-engines)
[135.315584] Starting subtest: busy
[135.318726] Starting dynamic subtest: all-engines
[135.847259] Dynamic subtest all-engines: SUCCESS (0.535s)
[135.851404] Subtest busy: SUCCESS (0.538s)
[136.254219] [049/160] (890s left) gem_wait (wait@all-engines)
[136.742794] Starting subtest: wait
[136.746377] Starting dynamic subtest: all-engines
[137.783577] Dynamic subtest all-engines: SUCCESS (1.040s)
[137.788233] Subtest wait: SUCCESS (1.043s)
[138.189797] [050/160] (888s left) i915_getparams_basic (basic-eu-total)
[138.596823] Starting subtest: basic-eu-total
[138.603255] Subtest basic-eu-total: SUCCESS (0.001s)
[138.736099] [051/160] (888s left) i915_getparams_basic (basic-subslice-total)
[139.141573] Starting subtest: basic-subslice-total
[139.147818] Subtest basic-subslice-total: SUCCESS (0.000s)
[139.278239] [052/160] (887s left) i915_hangman (error-state-basic)
[139.701700] Starting subtest: error-state-basic
[140.016237] Subtest error-state-basic: SUCCESS (0.311s)
[140.146942] [053/160] (886s left) i915_pciid
[140.683648] [054/160] (886s left) kms_addfb_basic (addfb25-4-tiled)
[141.148789] Starting subtest: addfb25-4-tiled
[141.152804] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[141.298745] [055/160] (885s left) kms_addfb_basic (addfb25-bad-modifier)
[141.709619] Starting subtest: addfb25-bad-modifier
[141.713233] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[141.917707] [056/160] (885s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[142.326632] Starting subtest: addfb25-framebuffer-vs-set-tiling
[142.330094] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[142.549748] [057/160] (884s left) kms_addfb_basic (addfb25-modifier-no-flag)
[142.954353] Starting subtest: addfb25-modifier-no-flag
[142.958536] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[143.152464] [058/160] (884s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[143.569688] Starting subtest: addfb25-x-tiled-legacy
[143.573855] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[143.762893] [059/160] (883s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[144.196220] Starting subtest: addfb25-x-tiled-mismatch-legacy
[144.199509] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[144.387756] [060/160] (883s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[144.852694] Starting subtest: addfb25-yf-tiled-legacy
[144.857189] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[145.018267] [061/160] (882s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[145.467965] Starting subtest: addfb25-y-tiled-legacy
[145.472569] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[145.621489] [062/160] (882s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[146.072779] Starting subtest: addfb25-y-tiled-small-legacy
[146.079779] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[146.207603] [063/160] (881s left) kms_addfb_basic (bad-pitch-0)
[146.602626] Starting subtest: bad-pitch-0
[146.606589] Subtest bad-pitch-0: SUCCESS (0.000s)
[146.788823] [064/160] (881s left) kms_addfb_basic (bad-pitch-1024)
[147.187504] Starting subtest: bad-pitch-1024
[147.191646] Subtest bad-pitch-1024: SUCCESS (0.000s)
[147.373431] [065/160] (880s left) kms_addfb_basic (bad-pitch-128)
[147.805753] Starting subtest: bad-pitch-128
[147.811374] Subtest bad-pitch-128: SUCCESS (0.000s)
[148.029227] [066/160] (880s left) kms_addfb_basic (bad-pitch-256)
[148.419448] Starting subtest: bad-pitch-256
[148.424462] Subtest bad-pitch-256: SUCCESS (0.000s)
[148.624808] [067/160] (879s left) kms_addfb_basic (bad-pitch-32)
[149.036491] Starting subtest: bad-pitch-32
[149.040727] Subtest bad-pitch-32: SUCCESS (0.000s)
[149.231194] [068/160] (879s left) kms_addfb_basic (bad-pitch-63)
[149.626766] Starting subtest: bad-pitch-63
[149.631769] Subtest bad-pitch-63: SUCCESS (0.000s)
[149.831830] [069/160] (878s left) kms_addfb_basic (bad-pitch-65536)
[150.229186] Starting subtest: bad-pitch-65536
[150.233403] Subtest bad-pitch-65536: SUCCESS (0.002s)
[150.412248] [070/160] (878s left) kms_addfb_basic (bad-pitch-999)
[150.815505] Starting subtest: bad-pitch-999
[150.819242] Subtest bad-pitch-999: SUCCESS (0.000s)
[151.029310] [071/160] (877s left) kms_addfb_basic (basic)
[151.446682] Starting subtest: basic
[151.451327] Subtest basic: SUCCESS (0.001s)
[151.626336] [072/160] (877s left) kms_addfb_basic (basic-x-tiled-legacy)
[152.042097] Starting subtest: basic-x-tiled-legacy
[152.045663] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[152.245647] [073/160] (876s left) kms_addfb_basic (basic-y-tiled-legacy)
[152.655217] Starting subtest: basic-y-tiled-legacy
[152.659489] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[152.831292] [074/160] (876s left) kms_addfb_basic (bo-too-small)
[153.274391] Starting subtest: bo-too-small
[153.278709] Subtest bo-too-small: SUCCESS (0.002s)
[153.444344] [075/160] (875s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[153.911120] Starting subtest: bo-too-small-due-to-tiling
[153.914521] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[154.064473] [076/160] (874s left) kms_addfb_basic (clobberred-modifier)
[154.459120] Starting subtest: clobberred-modifier
[154.463568] Subtest clobberred-modifier: SUCCESS (0.001s)
[154.648488] [077/160] (874s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[155.054611] Starting subtest: framebuffer-vs-set-tiling
[155.058642] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[155.232818] [078/160] (873s left) kms_addfb_basic (invalid-get-prop)
[155.630127] Starting subtest: invalid-get-prop
[155.634417] Subtest invalid-get-prop: SUCCESS (0.000s)
[155.816902] [079/160] (873s left) kms_addfb_basic (invalid-get-prop-any)
[156.215207] Starting subtest: invalid-get-prop-any
[156.219266] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[156.407381] [080/160] (872s left) kms_addfb_basic (invalid-set-prop)
[156.807665] Starting subtest: invalid-set-prop
[156.811664] Subtest invalid-set-prop: SUCCESS (0.000s)
[157.016739] [081/160] (872s left) kms_addfb_basic (invalid-set-prop-any)
[157.423805] Starting subtest: invalid-set-prop-any
[157.428977] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[157.614998] [082/160] (871s left) kms_addfb_basic (no-handle)
[158.019764] Starting subtest: no-handle
[158.023781] Subtest no-handle: SUCCESS (0.000s)
[158.211181] [083/160] (871s left) kms_addfb_basic (size-max)
[158.668240] Starting subtest: size-max
[158.673261] Subtest size-max: SUCCESS (0.001s)
[158.802783] [084/160] (870s left) kms_addfb_basic (small-bo)
[159.248163] Starting subtest: small-bo
[159.252233] Subtest small-bo: SUCCESS (0.000s)
[159.401846] [085/160] (870s left) kms_addfb_basic (tile-pitch-mismatch)
[159.815826] Starting subtest: tile-pitch-mismatch
[159.820166] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[160.019275] [086/160] (869s left) kms_addfb_basic (too-high)
[160.448764] Starting subtest: too-high
[160.453608] Subtest too-high: SUCCESS (0.005s)
[160.605475] [087/160] (869s left) kms_addfb_basic (too-wide)
[161.051883] Starting subtest: too-wide
[161.055613] Subtest too-wide: SUCCESS (0.000s)
[161.206350] [088/160] (868s left) kms_addfb_basic (unused-handle)
[161.604589] Starting subtest: unused-handle
[161.608606] Subtest unused-handle: SUCCESS (0.000s)
[161.912752] [089/160] (868s left) kms_addfb_basic (unused-modifier)
[162.606876] Starting subtest: unused-modifier
[162.613682] Subtest unused-modifier: SUCCESS (0.000s)
[162.849746] [090/160] (867s left) kms_addfb_basic (unused-offsets)
[163.459084] Starting subtest: unused-offsets
[163.466627] Subtest unused-offsets: SUCCESS (0.000s)
[163.709554] [091/160] (866s left) kms_addfb_basic (unused-pitches)
[164.242839] Starting subtest: unused-pitches
[164.247167] Subtest unused-pitches: SUCCESS (0.000s)
[164.446859] [092/160] (866s left) kms_busy (basic)
[164.940128] Starting subtest: basic
[164.945548] Starting dynamic subtest: flip
[166.377324] Dynamic subtest flip: SUCCESS (1.430s)
[166.425838] Starting dynamic subtest: modeset
[166.433354] Dynamic subtest modeset: SKIP (0.000s)
[166.437324] Subtest basic: SUCCESS (1.439s)
[166.647498] [093/160] (864s left) kms_prop_blob (basic)
[167.062106] Starting subtest: basic
[167.066675] Subtest basic: SUCCESS (0.000s)
[167.206604] [094/160] (863s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[167.662483] Starting subtest: basic-busy-flip-before-cursor-atomic
[167.676296] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.016s)
[167.811966] [095/160] (863s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[168.254406] Starting subtest: basic-busy-flip-before-cursor-legacy
[169.562808] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.304s)
[169.847444] [096/160] (861s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[170.309417] Starting subtest: basic-flip-after-cursor-atomic
[170.316170] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[170.466252] [097/160] (860s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[170.909685] Starting subtest: basic-flip-after-cursor-legacy
[172.165321] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.256s)
[172.432749] [098/160] (858s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[172.874996] Starting subtest: basic-flip-after-cursor-varying-size
[174.145470] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.269s)
[174.430511] [099/160] (856s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[174.879114] Starting subtest: basic-flip-before-cursor-atomic
[174.885661] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[175.036225] [100/160] (856s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[175.497816] Starting subtest: basic-flip-before-cursor-legacy
[176.753288] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.252s)
[177.028838] [101/160] (854s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[177.486731] Starting subtest: basic-flip-before-cursor-varying-size
[178.767714] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.287s)
[179.035167] [102/160] (852s left) kms_dsc (dsc-basic)
[179.476309] Subtest dsc-basic: SKIP (0.000s)
[179.591735] [103/160] (852s left) kms_flip (basic-flip-vs-dpms)
[180.041920] Starting subtest: basic-flip-vs-dpms
[180.046311] Starting dynamic subtest: A-VGA1
[181.762739] Dynamic subtest A-VGA1: SUCCESS (1.707s)
[181.808667] Starting dynamic subtest: B-VGA1
[183.243687] Dynamic subtest B-VGA1: SUCCESS (1.484s)
[183.247574] Subtest basic-flip-vs-dpms: SUCCESS (3.197s)
[183.643543] [104/160] (848s left) kms_flip (basic-flip-vs-modeset)
[184.105728] Starting subtest: basic-flip-vs-modeset
[184.110380] Starting dynamic subtest: A-VGA1
[185.686738] Dynamic subtest A-VGA1: SUCCESS (1.574s)
[185.734860] Starting dynamic subtest: B-VGA1
[186.980514] Dynamic subtest B-VGA1: SUCCESS (1.295s)
[186.984245] Subtest basic-flip-vs-modeset: SUCCESS (2.875s)
[187.362971] [105/160] (844s left) kms_flip (basic-flip-vs-wf_vblank)
[187.822225] Starting subtest: basic-flip-vs-wf_vblank
[187.826311] Starting dynamic subtest: A-VGA1
[189.738757] Dynamic subtest A-VGA1: SUCCESS (1.907s)
[189.786456] Starting dynamic subtest: B-VGA1
[191.427237] Dynamic subtest B-VGA1: SUCCESS (1.689s)
[191.431291] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.603s)
[191.845105] [106/160] (840s left) kms_flip (basic-plain-flip)
[192.286761] Starting subtest: basic-plain-flip
[192.291709] Starting dynamic subtest: A-VGA1
[193.896288] Dynamic subtest A-VGA1: SUCCESS (1.601s)
[193.940790] Starting dynamic subtest: B-VGA1
[195.286949] Dynamic subtest B-VGA1: SUCCESS (1.388s)
[195.291126] Subtest basic-plain-flip: SUCCESS (2.995s)
[195.717736] [107/160] (836s left) kms_force_connector_basic (force-connector-state)
[196.196398] Starting subtest: force-connector-state
[196.439167] Subtest force-connector-state: SUCCESS (0.244s)
[196.858828] [108/160] (835s left) kms_force_connector_basic (force-edid)
[197.327838] Starting subtest: force-edid
[197.411325] Subtest force-edid: SUCCESS (0.082s)
[197.668358] [109/160] (834s left) kms_force_connector_basic (force-load-detect)
[198.159872] Starting subtest: force-load-detect
[198.528836] Subtest force-load-detect: SUCCESS (0.378s)
[198.900665] [110/160] (833s left) kms_force_connector_basic (prune-stale-modes)
[199.358633] Starting subtest: prune-stale-modes
[199.447263] Subtest prune-stale-modes: SUCCESS (0.084s)
[199.696169] [111/160] (832s left) kms_frontbuffer_tracking (basic)
[200.206512] Subtest basic: SKIP (0.000s)
[200.310350] [112/160] (832s left) kms_hdmi_inject (inject-audio)
[200.713186] Subtest inject-audio: SKIP (0.000s)
[200.823285] [113/160] (831s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[201.282190] Starting subtest: compare-crc-sanitycheck-xr24
[201.286837] Starting dynamic subtest: pipe-A-VGA-1
[201.655798] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.365s)
[201.704482] Starting dynamic subtest: pipe-B-VGA-1
[202.134483] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.476s)
[202.138254] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.852s)
[202.400728] [114/160] (830s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[202.848741] Starting subtest: compare-crc-sanitycheck-nv12
[202.853457] Starting dynamic subtest: pipe-A-VGA-1
[202.864114] Dynamic subtest pipe-A-VGA-1: SKIP (0.001s)
[202.907309] Starting dynamic subtest: pipe-B-VGA-1
[202.914198] Dynamic subtest pipe-B-VGA-1: SKIP (0.001s)
[202.921384] Subtest compare-crc-sanitycheck-nv12: SKIP (0.012s)
[203.002354] [115/160] (829s left) kms_pipe_crc_basic (hang-read-crc)
[203.446746] Starting subtest: hang-read-crc
[203.450381] Starting dynamic subtest: pipe-A-VGA-1
[204.693651] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.244s)
[204.746850] Starting dynamic subtest: pipe-B-VGA-1
[206.139965] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.439s)
[206.143399] Subtest hang-read-crc: SUCCESS (2.696s)
[206.405700] [116/160] (826s left) kms_pipe_crc_basic (nonblocking-crc)
[206.850912] Starting subtest: nonblocking-crc
[206.855962] Starting dynamic subtest: pipe-A-VGA-1
[207.419983] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.565s)
[207.472658] Starting dynamic subtest: pipe-B-VGA-1
[208.090462] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.662s)
[208.095762] Subtest nonblocking-crc: SUCCESS (1.237s)
[208.347236] [117/160] (824s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[208.802629] Starting subtest: nonblocking-crc-frame-sequence
[208.810189] Starting dynamic subtest: pipe-A-VGA-1
[209.380986] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.573s)
[209.422467] Starting dynamic subtest: pipe-B-VGA-1
[210.076432] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.685s)
[210.080569] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.272s)
[210.326844] [118/160] (822s left) kms_pipe_crc_basic (read-crc)
[210.772106] Starting subtest: read-crc
[210.776543] Starting dynamic subtest: pipe-A-VGA-1
[211.254771] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.479s)
[211.304175] Starting dynamic subtest: pipe-B-VGA-1
[211.857403] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.597s)
[211.860582] Subtest read-crc: SUCCESS (1.089s)
[212.134476] [119/160] (821s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[212.581457] Starting subtest: read-crc-frame-sequence
[212.585657] Starting dynamic subtest: pipe-A-VGA-1
[213.089758] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.498s)
[213.151493] Starting dynamic subtest: pipe-B-VGA-1
[213.670270] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.581s)
[213.673439] Subtest read-crc-frame-sequence: SUCCESS (1.090s)
[213.939171] [120/160] (819s left) kms_pm_backlight (basic-brightness)
[214.377420] Subtest basic-brightness: SKIP (0.000s)
[214.485851] [121/160] (818s left) kms_pm_rpm (basic-pci-d3-state)
[226.354512] Subtest basic-pci-d3-state: SKIP (0.000s)
[226.450568] [122/160] (807s left) kms_pm_rpm (basic-rte)
[226.835621] Starting subtest: basic-rte
[238.314265] Subtest basic-rte: SKIP (11.462s)
[238.425527] [123/160] (795s left) kms_psr (psr-primary-page-flip)
[238.867385] Subtest psr-primary-page-flip: SKIP (0.000s)
[238.982278] [124/160] (794s left) kms_psr (psr-cursor-plane-move)
[239.435318] Subtest psr-cursor-plane-move: SKIP (0.000s)
[239.544159] [125/160] (794s left) kms_psr (psr-sprite-plane-onoff)
[240.019849] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[240.132822] [126/160] (793s left) kms_psr (psr-primary-mmap-gtt)
[240.586634] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[240.694682] [127/160] (793s left) kms_setmode (basic-clone-single-crtc)
[241.104464] Starting subtest: basic-clone-single-crtc
[241.117211] Subtest basic-clone-single-crtc: SKIP (0.000s)
[241.238241] [128/160] (792s left) i915_pm_rps (basic-api)
[241.649957] Subtest basic-api: SKIP (0.000s)
[241.744427] [129/160] (792s left) prime_self_import (basic-llseek-bad)
[242.125803] Starting subtest: basic-llseek-bad
[242.134472] Subtest basic-llseek-bad: SUCCESS (0.010s)
[242.286419] [130/160] (791s left) prime_self_import (basic-llseek-size)
[242.672364] Starting subtest: basic-llseek-size
[242.687951] Subtest basic-llseek-size: SUCCESS (0.017s)
[242.823472] [131/160] (791s left) prime_self_import (basic-with_fd_dup)
[243.215741] Starting subtest: basic-with_fd_dup
[243.231717] Subtest basic-with_fd_dup: SUCCESS (0.017s)
[243.372943] [132/160] (790s left) prime_self_import (basic-with_one_bo)
[243.750885] Starting subtest: basic-with_one_bo
[243.767928] Subtest basic-with_one_bo: SUCCESS (0.018s)
[243.896737] [133/160] (790s left) prime_self_import (basic-with_one_bo_two_files)
[244.316705] Starting subtest: basic-with_one_bo_two_files
[244.340437] Subtest basic-with_one_bo_two_files: SUCCESS (0.028s)
[244.500921] [134/160] (790s left) prime_self_import (basic-with_two_bos)
[244.897721] Starting subtest: basic-with_two_bos
[244.915230] Subtest basic-with_two_bos: SUCCESS (0.018s)
[245.058457] [135/160] (789s left) prime_vgem (basic-fence-flip)
[245.474783] Starting subtest: basic-fence-flip
[246.077833] Subtest basic-fence-flip: SUCCESS (0.598s)
[246.245728] [136/160] (788s left) prime_vgem (basic-fence-mmap)
[246.675799] Starting subtest: basic-fence-mmap
[246.845526] Subtest basic-fence-mmap: SUCCESS (0.169s)
[246.994608] [137/160] (787s left) prime_vgem (basic-fence-read)
[247.414242] Starting subtest: basic-fence-read
[247.682199] Subtest basic-fence-read: SUCCESS (0.266s)
[247.830095] [138/160] (787s left) prime_vgem (basic-gtt)
[248.246689] Starting subtest: basic-gtt
[248.322587] Subtest basic-gtt: SUCCESS (0.076s)
[248.479689] [139/160] (786s left) prime_vgem (basic-read)
[248.917548] Starting subtest: basic-read
[249.036523] Subtest basic-read: SUCCESS (0.121s)
[249.197490] [140/160] (785s left) prime_vgem (basic-write)
[249.616594] Starting subtest: basic-write
[249.744186] Subtest basic-write: SUCCESS (0.128s)
[249.898593] [141/160] (785s left) vgem_basic (setversion)
[250.316134] Starting subtest: setversion
[250.323768] Subtest setversion: SUCCESS (0.002s)
[250.430606] [142/160] (784s left) vgem_basic (create)
[250.846809] Starting subtest: create
[250.850915] Subtest create: SUCCESS (0.002s)
[250.962298] [143/160] (784s left) vgem_basic (debugfs)
[251.363958] Starting subtest: debugfs
[251.367574] Subtest debugfs: SUCCESS (0.003s)
[251.483327] [144/160] (783s left) vgem_basic (dmabuf-export)
[251.899816] Starting subtest: dmabuf-export
[251.909594] Subtest dmabuf-export: SUCCESS (0.011s)
[252.048694] [145/160] (783s left) vgem_basic (dmabuf-fence)
[252.448581] Starting subtest: dmabuf-fence
[252.452066] Subtest dmabuf-fence: SUCCESS (0.004s)
[252.581660] [146/160] (782s left) vgem_basic (dmabuf-fence-before)
[252.986887] Starting subtest: dmabuf-fence-before
[252.990472] Subtest dmabuf-fence-before: SUCCESS (0.002s)
[253.100484] [147/160] (782s left) vgem_basic (dmabuf-mmap)
[253.501542] Starting subtest: dmabuf-mmap
[253.579320] Subtest dmabuf-mmap: SUCCESS (0.079s)
[253.701517] [148/160] (782s left) vgem_basic (mmap)
[254.100796] Starting subtest: mmap
[254.157315] Subtest mmap: SUCCESS (0.059s)
[254.284944] [149/160] (781s left) vgem_basic (second-client)
[254.684523] Starting subtest: second-client
[254.717469] Subtest second-client: SUCCESS (0.033s)
[254.835773] [150/160] (781s left) vgem_basic (sysfs)
[255.234959] Starting subtest: sysfs
[255.238209] Subtest sysfs: SUCCESS (0.005s)
[255.370826] [151/160] (780s left) core_hotunplug (unbind-rebind)
[255.901638] Starting subtest: unbind-rebind
[260.292330] Subtest unbind-rebind: SUCCESS (4.386s)
[260.419957] [152/160] (775s left) vgem_basic (unload)
[260.849957] Starting subtest: unload
[290.162423] Subtest unload: SUCCESS (29.298s)
[290.411662] [153/160] (745s left) i915_module_load (reload)
[290.808535] Starting subtest: reload
[295.685608] Subtest reload: SUCCESS (4.873s)
[295.877272] [154/160] (740s left) gem_lmem_swapping (basic)
[296.680299] Subtest basic: SKIP (0.000s)
[296.854673] [155/160] (739s left) gem_lmem_swapping (parallel-random-engines)
[297.282288] Subtest parallel-random-engines: SKIP (0.000s)
[297.392822] [156/160] (739s left) gem_lmem_swapping (random-engines)
[297.803646] Subtest random-engines: SKIP (0.000s)
[297.909432] [157/160] (738s left) gem_lmem_swapping (verify-random)
[298.324105] Subtest verify-random: SKIP (0.000s)
[298.425642] [158/160] (738s left) i915_pm_rpm (module-reload)
[310.308119] Subtest module-reload: SKIP (0.000s)
[310.410299] [159/160] (726s left) i915_selftest (live)
[312.484779] Starting subtest: live
[312.488449] Starting dynamic subtest: sanitycheck
[314.830171] Dynamic subtest sanitycheck: SUCCESS (2.344s)
[314.859292] Starting dynamic subtest: uncore
[316.903937] Dynamic subtest uncore: SUCCESS (2.069s)
[316.934108] Starting dynamic subtest: workarounds
[319.025783] Dynamic subtest workarounds: SUCCESS (2.117s)
[319.063760] Starting dynamic subtest: gt_engines
[321.124752] Dynamic subtest gt_engines: SUCCESS (2.094s)
[321.155294] Starting dynamic subtest: gt_timelines
[331.203303] Dynamic subtest gt_timelines: SUCCESS (10.072s)
[331.233156] Starting dynamic subtest: gt_contexts
[333.343511] Dynamic subtest gt_contexts: SUCCESS (2.135s)
[333.380844] Starting dynamic subtest: gt_lrc
[335.485233] Dynamic subtest gt_lrc: SUCCESS (2.137s)
[335.515099] Starting dynamic subtest: gt_mocs
[337.578545] Dynamic subtest gt_mocs: SUCCESS (2.088s)
[337.607933] Starting dynamic subtest: gt_pm
[340.075186] Dynamic subtest gt_pm: SUCCESS (2.494s)
[340.105105] Starting dynamic subtest: gt_heartbeat
[342.232834] Dynamic subtest gt_heartbeat: SUCCESS (2.151s)
[342.270778] Starting dynamic subtest: gt_tlb
[344.322771] Dynamic subtest gt_tlb: SUCCESS (2.088s)
[344.356376] Starting dynamic subtest: requests
[349.070496] Dynamic subtest requests: SUCCESS (4.738s)
[349.100612] Starting dynamic subtest: migrate
[351.168713] Dynamic subtest migrate: SUCCESS (2.094s)
[351.199444] Starting dynamic subtest: active
[353.390212] Dynamic subtest active: SUCCESS (2.217s)
[353.419711] Starting dynamic subtest: objects
[356.523460] Dynamic subtest objects: SUCCESS (3.126s)
[356.553883] Starting dynamic subtest: mman
[368.333489] Dynamic subtest mman: SUCCESS (11.803s)
[368.371489] Starting dynamic subtest: dmabuf
[370.590489] Dynamic subtest dmabuf: SUCCESS (2.253s)
[370.620694] Starting dynamic subtest: vma
[372.738708] Dynamic subtest vma: SUCCESS (2.143s)
[372.777526] Starting dynamic subtest: coherency
[381.576545] Dynamic subtest coherency: SUCCESS (8.830s)
[381.607467] Starting dynamic subtest: gtt
[386.644435] Dynamic subtest gtt: SUCCESS (5.063s)
[386.674588] Starting dynamic subtest: gem
[388.814662] Dynamic subtest gem: SUCCESS (2.166s)
[388.844453] Starting dynamic subtest: evict
[390.907838] Dynamic subtest evict: SUCCESS (2.088s)
[390.946567] Starting dynamic subtest: hugepages
[393.011794] Dynamic subtest hugepages: SUCCESS (2.100s)
[393.041759] Starting dynamic subtest: gem_contexts
[395.065201] Dynamic subtest gem_contexts: SUCCESS (2.048s)
[395.096193] Starting dynamic subtest: client
[397.152299] Dynamic subtest client: SUCCESS (2.081s)
[397.188333] Starting dynamic subtest: gem_migrate
[399.268833] Dynamic subtest gem_migrate: SUCCESS (2.110s)
[399.304121] Starting dynamic subtest: reset
[401.928607] Dynamic subtest reset: SUCCESS (2.655s)
[401.967245] Starting dynamic subtest: memory_region
[404.016872] Dynamic subtest memory_region: SUCCESS (2.086s)
[404.047307] Starting dynamic subtest: hangcheck
[407.197604] Dynamic subtest hangcheck: SUCCESS (3.175s)
[407.228648] Starting dynamic subtest: execlists
[409.285454] Dynamic subtest execlists: SUCCESS (2.083s)
[409.315332] Starting dynamic subtest: ring_submission
[411.439528] Dynamic subtest ring_submission: SUCCESS (2.148s)
[411.469731] Starting dynamic subtest: perf
[413.505472] Dynamic subtest perf: SUCCESS (2.062s)
[413.544336] Starting dynamic subtest: slpc
[415.588608] Dynamic subtest slpc: SUCCESS (2.076s)
[415.625247] Starting dynamic subtest: guc
[417.683516] Dynamic subtest guc: SUCCESS (2.092s)
[417.714448] Starting dynamic subtest: guc_multi_lrc
[419.735712] Dynamic subtest guc_multi_lrc: SUCCESS (2.047s)
[419.767308] Starting dynamic subtest: guc_hang
[421.806728] Dynamic subtest guc_hang: SUCCESS (2.066s)
[421.837678] Starting dynamic subtest: late_gt_pm
[423.883778] Dynamic subtest late_gt_pm: SUCCESS (2.072s)
[423.887423] Subtest live: SUCCESS (111.346s)
[423.979803] [160/160] (612s left) dmabuf (all-tests)
[424.490982] Starting subtest: all-tests
[424.495598] Starting dynamic subtest: sanitycheck
[424.592794] Dynamic subtest sanitycheck: SUCCESS (0.099s)
[424.634830] Starting dynamic subtest: dma_fence
[424.813416] Dynamic subtest dma_fence: SUCCESS (0.215s)
[424.848100] Starting dynamic subtest: dma_fence_chain
[476.451183] Dynamic subtest dma_fence_chain: SUCCESS (51.608s)
[476.492678] Starting dynamic subtest: dma_fence_unwrap
[476.551490] Dynamic subtest dma_fence_unwrap: SUCCESS (0.096s)
[476.596946] Starting dynamic subtest: dma_resv
[476.659442] Dynamic subtest dma_resv: SUCCESS (0.104s)
[476.663617] Subtest all-tests: SUCCESS (52.145s)
[476.743707] Closing watchdogs
Done.