[125.520806] Initializing watchdogs
[125.521248]   /dev/watchdog0
[125.604381] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:22b1 Intel Cherryview (Gen8) Atom/Celeron/Pentium Processor x5-E8000/J3xxx/N3xxx Integrated Graphics Controller
[125.625953] [001/161] (960s left) i915_module_load (load)
[126.582880] Starting subtest: load
[126.588564] Subtest load: SKIP (0.008s)
[126.705862] [002/161] (959s left) core_auth (basic-auth)
[150.978362] Starting subtest: basic-auth
[150.989162] Subtest basic-auth: SUCCESS (0.008s)
[151.278704] [FACT core_auth (basic-auth)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[151.287466] [FACT core_auth (basic-auth)] new: kernel.kmod_is_loaded.amdgpu: true
[151.288175] [FACT core_auth (basic-auth)] new: kernel.kmod_is_loaded.i915: true
[151.292950] [FACT core_auth (basic-auth)] new: kernel.kmod_is_loaded.xe: true
[151.301901] [003/161] (935s left) debugfs_test (read_all_entries)
[151.614120] Starting subtest: read_all_entries
[151.897150] Subtest read_all_entries: SUCCESS (0.283s)
[152.711411] [004/161] (933s left) debugfs_test (basic-hwmon)
[153.013868] Starting subtest: basic-hwmon
[153.017956] Subtest basic-hwmon: SKIP (0.000s)
[153.742130] [005/161] (933s left) debugfs_test (sysfs)
[154.033902] Starting subtest: sysfs
[154.447427] Subtest sysfs: SUCCESS (0.412s)
[155.167641] [006/161] (931s left) fbdev (eof)
[155.519808] Starting subtest: eof
[155.521926] Subtest eof: SUCCESS (0.005s)
[155.757499] [007/161] (931s left) fbdev (info)
[156.039291] Starting subtest: info
[156.044456] Subtest info: SUCCESS (0.000s)
[156.295665] [008/161] (931s left) fbdev (nullptr)
[156.562211] Starting subtest: nullptr
[156.565051] Subtest nullptr: SUCCESS (0.000s)
[156.782431] [009/161] (930s left) fbdev (read)
[157.093348] Starting subtest: read
[159.295762] Subtest read: SUCCESS (2.203s)
[159.517606] [010/161] (928s left) fbdev (write)
[159.777084] Starting subtest: write
[161.014086] Subtest write: SUCCESS (1.237s)
[161.244232] [011/161] (926s left) gem_basic (bad-close)
[161.537787] Starting subtest: bad-close
[161.545436] Subtest bad-close: SUCCESS (0.000s)
[161.797765] [012/161] (926s left) gem_basic (create-close)
[162.094699] Starting subtest: create-close
[162.102360] Subtest create-close: SUCCESS (0.004s)
[162.338871] [013/161] (926s left) gem_basic (create-fd-close)
[162.647302] Starting subtest: create-fd-close
[162.653334] Subtest create-fd-close: SUCCESS (0.002s)
[162.919334] [014/161] (925s left) gem_busy (busy@all-engines)
[163.248316] Starting subtest: busy
[163.250169] Starting dynamic subtest: all-engines
[163.475703] Dynamic subtest all-engines: SUCCESS (0.235s)
[163.482648] Subtest busy: SUCCESS (0.244s)
[164.055567] [015/161] (924s left) gem_close_race (basic-process)
[164.409707] Starting subtest: basic-process
[164.577983] Subtest basic-process: SUCCESS (0.172s)
[164.958253] [016/161] (923s left) gem_close_race (basic-threads)
[165.297588] Starting subtest: basic-threads
[166.599736] Subtest basic-threads: SUCCESS (1.302s)
[166.967450] [017/161] (922s left) gem_ctx_create (basic)
[167.286312] Starting subtest: basic
[167.291746] Subtest basic: SUCCESS (0.001s)
[167.652731] [018/161] (921s left) gem_ctx_create (basic-files)
[167.981209] Starting subtest: basic-files
[170.062382] Subtest basic-files: SUCCESS (2.082s)
[170.429926] [019/161] (919s left) gem_ctx_exec (basic)
[170.707201] Starting subtest: basic
[170.726395] Subtest basic: SUCCESS (0.015s)
[170.963633] [020/161] (918s left) gem_exec_basic (basic)
[171.273667] Starting subtest: basic
[171.275800] Starting dynamic subtest: rcs0-smem
[171.280095] Dynamic subtest rcs0-smem: SUCCESS (0.007s)
[171.306736] Starting dynamic subtest: bcs0-smem
[171.308589] Dynamic subtest bcs0-smem: SUCCESS (0.024s)
[171.335163] Starting dynamic subtest: vcs0-smem
[171.336893] Dynamic subtest vcs0-smem: SUCCESS (0.025s)
[171.361472] Starting dynamic subtest: vecs0-smem
[171.363239] Dynamic subtest vecs0-smem: SUCCESS (0.025s)
[171.367650] Subtest basic: SUCCESS (0.096s)
[171.746295] [021/161] (918s left) gem_exec_create (basic)
[172.066385] Starting subtest: basic
[172.068995] Starting dynamic subtest: smem
[174.182477] Dynamic subtest smem: SUCCESS (2.108s)
[174.184304] Subtest basic: SUCCESS (2.110s)
[174.537375] [022/161] (915s left) gem_exec_fence (basic-busy)
[175.048084] Starting subtest: basic-busy
[175.054755] Starting dynamic subtest: rcs0
[175.116360] Dynamic subtest rcs0: SUCCESS (0.070s)
[175.159307] Starting dynamic subtest: bcs0
[175.167187] Dynamic subtest bcs0: SUCCESS (0.042s)
[175.196813] Starting dynamic subtest: vcs0
[175.252550] Dynamic subtest vcs0: SUCCESS (0.093s)
[175.297353] Starting dynamic subtest: vecs0
[175.302295] Dynamic subtest vecs0: SUCCESS (0.037s)
[175.306599] Subtest basic-busy: SUCCESS (0.258s)
[176.331737] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[176.343257] [023/161] (913s left) gem_exec_fence (basic-wait)
[176.870794] Starting subtest: basic-wait
[176.874199] Starting dynamic subtest: rcs0
[176.897146] Dynamic subtest rcs0: SUCCESS (0.030s)
[176.933685] Starting dynamic subtest: bcs0
[176.938408] Dynamic subtest bcs0: SUCCESS (0.034s)
[176.967071] Starting dynamic subtest: vcs0
[176.988242] Dynamic subtest vcs0: SUCCESS (0.051s)
[177.018950] Starting dynamic subtest: vecs0
[177.037251] Dynamic subtest vecs0: SUCCESS (0.046s)
[177.040717] Subtest basic-wait: SUCCESS (0.174s)
[177.898157] [024/161] (912s left) gem_exec_fence (basic-await)
[178.399808] Starting subtest: basic-await
[178.401836] Starting dynamic subtest: rcs0
[178.634730] Dynamic subtest rcs0: SUCCESS (0.234s)
[178.667974] Starting dynamic subtest: bcs0
[178.865926] Dynamic subtest bcs0: SUCCESS (0.225s)
[178.892210] Starting dynamic subtest: vcs0
[179.110181] Dynamic subtest vcs0: SUCCESS (0.240s)
[179.137800] Starting dynamic subtest: vecs0
[179.340897] Dynamic subtest vecs0: SUCCESS (0.227s)
[179.344614] Subtest basic-await: SUCCESS (0.945s)
[180.240887] [025/161] (910s left) gem_exec_fence (nb-await)
[180.743437] Starting subtest: nb-await
[180.748481] Starting dynamic subtest: rcs0
[180.840121] Dynamic subtest rcs0: SUCCESS (0.097s)
[180.873419] Starting dynamic subtest: bcs0
[180.946784] Dynamic subtest bcs0: SUCCESS (0.094s)
[180.975688] Starting dynamic subtest: vcs0
[181.060724] Dynamic subtest vcs0: SUCCESS (0.107s)
[181.089696] Starting dynamic subtest: vecs0
[181.152634] Dynamic subtest vecs0: SUCCESS (0.103s)
[181.154446] Subtest nb-await: SUCCESS (0.411s)
[182.043713] [026/161] (908s left) gem_exec_gttfill (basic)
[182.360579] Starting subtest: basic
[215.575307] Subtest basic: SUCCESS (33.214s)
[216.089862] [027/161] (875s left) gem_exec_parallel (engines)
[216.640717] Starting subtest: engines
[216.653824] Starting dynamic subtest: basic
[224.063238] Dynamic subtest basic: SUCCESS (7.434s)
[224.102923] Starting dynamic subtest: contexts
[234.675802] Dynamic subtest contexts: SUCCESS (10.610s)
[234.719602] Starting dynamic subtest: fds
[246.526269] Dynamic subtest fds: SUCCESS (11.845s)
[246.566784] Starting dynamic subtest: userptr
[253.036366] Dynamic subtest userptr: SUCCESS (6.510s)
[253.038084] Subtest engines: SUCCESS (36.408s)
[253.455928] [028/161] (837s left) gem_exec_store (basic)
[253.779484] Starting subtest: basic
[253.858216] Subtest basic: SUCCESS (0.083s)
[254.257169] [029/161] (837s left) gem_flink_basic (bad-flink)
[254.520129] Starting subtest: bad-flink
[254.524649] Subtest bad-flink: SUCCESS (0.000s)
[254.790735] [030/161] (837s left) gem_flink_basic (bad-open)
[255.049574] Starting subtest: bad-open
[255.052212] Subtest bad-open: SUCCESS (0.000s)
[255.304642] [031/161] (836s left) gem_flink_basic (basic)
[255.571454] Starting subtest: basic
[255.574447] Subtest basic: SUCCESS (0.000s)
[255.835252] [032/161] (836s left) gem_flink_basic (double-flink)
[256.113382] Starting subtest: double-flink
[256.116222] Subtest double-flink: SUCCESS (0.002s)
[256.379906] [033/161] (836s left) gem_flink_basic (flink-lifetime)
[256.644695] Starting subtest: flink-lifetime
[256.652882] Subtest flink-lifetime: SUCCESS (0.007s)
[256.906550] [034/161] (835s left) gem_huc_copy (huc-copy)
[257.181316] Subtest huc-copy: SKIP (0.000s)
[257.400798] [035/161] (835s left) gem_linear_blits (basic)
[257.980603] Starting subtest: basic
[258.015973] Subtest basic: SUCCESS (0.044s)
[258.313189] [036/161] (834s left) gem_mmap (basic)
[258.739137] Starting subtest: basic
[258.750289] Subtest basic: SUCCESS (0.001s)
[259.008852] [037/161] (834s left) gem_mmap_gtt (basic)
[259.285152] Starting subtest: basic
[259.289851] Subtest basic: SUCCESS (0.009s)
[259.561773] [038/161] (833s left) gem_render_linear_blits (basic)
[259.849908] Starting subtest: basic
[259.975769] Subtest basic: SUCCESS (0.122s)
[260.196246] [039/161] (833s left) gem_render_tiled_blits (basic)
[260.469546] Starting subtest: basic
[260.646135] Subtest basic: SUCCESS (0.170s)
[260.862536] [040/161] (833s left) gem_ringfill (basic-all)
[261.380282] Starting subtest: basic-all
[262.783967] Subtest basic-all: SUCCESS (1.403s)
[263.068462] [041/161] (831s left) gem_softpin (allocator-basic)
[263.349479] Starting subtest: allocator-basic
[263.720869] Subtest allocator-basic: SUCCESS (0.371s)
[264.069367] [042/161] (830s left) gem_softpin (allocator-basic-reserve)
[264.344584] Starting subtest: allocator-basic-reserve
[264.711203] Subtest allocator-basic-reserve: SUCCESS (0.364s)
[265.023381] [043/161] (829s left) gem_softpin (safe-alignment)
[265.380867] Starting subtest: safe-alignment
[265.429871] Subtest safe-alignment: SUCCESS (0.045s)
[265.696392] [044/161] (829s left) gem_sync (basic-all)
[266.016346] Starting subtest: basic-all
[269.143138] Subtest basic-all: SUCCESS (3.123s)
[269.555936] [045/161] (825s left) gem_sync (basic-each)
[269.872385] Starting subtest: basic-each
[272.907497] Subtest basic-each: SUCCESS (3.036s)
[273.314531] [046/161] (821s left) gem_tiled_blits (basic)
[273.810357] Starting subtest: basic
[273.894413] Subtest basic: SUCCESS (0.089s)
[274.196836] [047/161] (821s left) gem_tiled_fence_blits (basic)
[274.873481] Starting subtest: basic
[274.953663] Subtest basic: SUCCESS (0.069s)
[275.250809] [048/161] (820s left) gem_tiled_pread_basic
[276.659376] [049/161] (819s left) gem_wait (busy@all-engines)
[277.030633] Starting subtest: busy
[277.032736] Starting dynamic subtest: all-engines
[277.570646] Dynamic subtest all-engines: SUCCESS (0.539s)
[277.573360] Subtest busy: SUCCESS (0.543s)
[278.098091] [050/161] (817s left) gem_wait (wait@all-engines)
[278.458402] Starting subtest: wait
[278.462857] Starting dynamic subtest: all-engines
[279.500716] Dynamic subtest all-engines: SUCCESS (1.043s)
[279.503695] Subtest wait: SUCCESS (1.045s)
[280.004209] [051/161] (816s left) i915_getparams_basic (basic-eu-total)
[280.363676] Starting subtest: basic-eu-total
[280.370702] Subtest basic-eu-total: SUCCESS (0.000s)
[280.628571] [052/161] (815s left) i915_getparams_basic (basic-subslice-total)
[280.906251] Starting subtest: basic-subslice-total
[280.911707] Subtest basic-subslice-total: SUCCESS (0.000s)
[281.175477] [053/161] (815s left) i915_hangman (error-state-basic)
[281.481978] Starting subtest: error-state-basic
[281.515501] Subtest error-state-basic: SUCCESS (0.025s)
[281.805609] [054/161] (815s left) i915_pciid
[282.342129] [055/161] (814s left) kms_addfb_basic (addfb25-4-tiled)
[283.152267] Starting subtest: addfb25-4-tiled
[283.157143] Subtest addfb25-4-tiled: SUCCESS (0.004s)
[283.488207] [056/161] (813s left) kms_addfb_basic (addfb25-bad-modifier)
[284.277515] Starting subtest: addfb25-bad-modifier
[284.280674] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[284.677239] [057/161] (812s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[285.423198] Starting subtest: addfb25-framebuffer-vs-set-tiling
[285.425365] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[285.754916] [058/161] (812s left) kms_addfb_basic (addfb25-modifier-no-flag)
[286.733507] Starting subtest: addfb25-modifier-no-flag
[286.742077] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[286.982073] [059/161] (811s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[287.721731] Starting subtest: addfb25-x-tiled-legacy
[287.724745] Subtest addfb25-x-tiled-legacy: SUCCESS (0.002s)
[288.047434] [060/161] (810s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[288.819346] Starting subtest: addfb25-x-tiled-mismatch-legacy
[288.821687] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[289.098938] [061/161] (809s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[289.863343] Starting subtest: addfb25-yf-tiled-legacy
[289.866906] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[290.119577] [062/161] (808s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[290.898641] Starting subtest: addfb25-y-tiled-legacy
[290.904570] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[291.153152] [063/161] (807s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[291.932986] Starting subtest: addfb25-y-tiled-small-legacy
[291.938742] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[292.197828] [064/161] (806s left) kms_addfb_basic (bad-pitch-0)
[292.479270] Starting subtest: bad-pitch-0
[292.482697] Subtest bad-pitch-0: SUCCESS (0.001s)
[293.286153] [065/161] (806s left) kms_addfb_basic (bad-pitch-1024)
[293.579174] Starting subtest: bad-pitch-1024
[293.581551] Subtest bad-pitch-1024: SUCCESS (0.001s)
[294.342462] [066/161] (805s left) kms_addfb_basic (bad-pitch-128)
[294.617585] Starting subtest: bad-pitch-128
[294.620651] Subtest bad-pitch-128: SUCCESS (0.000s)
[295.415374] [067/161] (804s left) kms_addfb_basic (bad-pitch-256)
[295.691582] Starting subtest: bad-pitch-256
[295.694626] Subtest bad-pitch-256: SUCCESS (0.000s)
[296.481219] [068/161] (803s left) kms_addfb_basic (bad-pitch-32)
[296.747140] Starting subtest: bad-pitch-32
[296.751262] Subtest bad-pitch-32: SUCCESS (0.000s)
[297.511412] [069/161] (802s left) kms_addfb_basic (bad-pitch-63)
[297.777177] Starting subtest: bad-pitch-63
[297.780095] Subtest bad-pitch-63: SUCCESS (0.000s)
[298.529912] [070/161] (801s left) kms_addfb_basic (bad-pitch-65536)
[298.803206] Starting subtest: bad-pitch-65536
[298.805102] Subtest bad-pitch-65536: SUCCESS (0.002s)
[299.579488] [071/161] (801s left) kms_addfb_basic (bad-pitch-999)
[299.845406] Starting subtest: bad-pitch-999
[299.849266] Subtest bad-pitch-999: SUCCESS (0.000s)
[300.561736] [072/161] (800s left) kms_addfb_basic (basic)
[300.826241] Starting subtest: basic
[300.828283] Subtest basic: SUCCESS (0.000s)
[301.564928] [073/161] (799s left) kms_addfb_basic (basic-x-tiled-legacy)
[301.837795] Starting subtest: basic-x-tiled-legacy
[301.841201] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[302.540914] [074/161] (798s left) kms_addfb_basic (basic-y-tiled-legacy)
[302.813323] Starting subtest: basic-y-tiled-legacy
[302.821207] Subtest basic-y-tiled-legacy: SUCCESS (0.004s)
[303.570320] [075/161] (797s left) kms_addfb_basic (bo-too-small)
[304.298592] Starting subtest: bo-too-small
[304.305531] Subtest bo-too-small: SUCCESS (0.002s)
[304.565163] [076/161] (797s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[305.317611] Starting subtest: bo-too-small-due-to-tiling
[305.320323] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[305.582732] [077/161] (796s left) kms_addfb_basic (clobberred-modifier)
[305.843378] Starting subtest: clobberred-modifier
[305.845375] Subtest clobberred-modifier: SUCCESS (0.000s)
[306.592169] [078/161] (795s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[306.869454] Starting subtest: framebuffer-vs-set-tiling
[306.872098] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[307.600465] [079/161] (794s left) kms_addfb_basic (invalid-get-prop)
[307.869618] Starting subtest: invalid-get-prop
[307.873685] Subtest invalid-get-prop: SUCCESS (0.000s)
[308.622483] [080/161] (793s left) kms_addfb_basic (invalid-get-prop-any)
[308.891862] Starting subtest: invalid-get-prop-any
[308.894984] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[309.674664] [081/161] (793s left) kms_addfb_basic (invalid-set-prop)
[309.944171] Starting subtest: invalid-set-prop
[309.947536] Subtest invalid-set-prop: SUCCESS (0.000s)
[310.781481] [082/161] (792s left) kms_addfb_basic (invalid-set-prop-any)
[311.052436] Starting subtest: invalid-set-prop-any
[311.056522] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[311.911206] [083/161] (791s left) kms_addfb_basic (no-handle)
[312.199651] Starting subtest: no-handle
[312.203937] Subtest no-handle: SUCCESS (0.000s)
[313.217552] [084/161] (790s left) kms_addfb_basic (size-max)
[313.986478] Starting subtest: size-max
[313.988811] Subtest size-max: SUCCESS (0.001s)
[314.284899] [085/161] (789s left) kms_addfb_basic (small-bo)
[315.017826] Starting subtest: small-bo
[315.022769] Subtest small-bo: SUCCESS (0.000s)
[315.282623] [086/161] (788s left) kms_addfb_basic (tile-pitch-mismatch)
[315.560172] Starting subtest: tile-pitch-mismatch
[315.561948] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[316.315775] [087/161] (787s left) kms_addfb_basic (too-high)
[317.085689] Starting subtest: too-high
[317.089189] Subtest too-high: SUCCESS (0.007s)
[317.359550] [088/161] (786s left) kms_addfb_basic (too-wide)
[318.113961] Starting subtest: too-wide
[318.122560] Subtest too-wide: SUCCESS (0.002s)
[318.405185] [089/161] (786s left) kms_addfb_basic (unused-handle)
[318.675762] Starting subtest: unused-handle
[318.679313] Subtest unused-handle: SUCCESS (0.000s)
[319.531393] [090/161] (785s left) kms_addfb_basic (unused-modifier)
[319.800455] Starting subtest: unused-modifier
[319.803264] Subtest unused-modifier: SUCCESS (0.000s)
[320.564922] [091/161] (784s left) kms_addfb_basic (unused-offsets)
[320.826829] Starting subtest: unused-offsets
[320.830417] Subtest unused-offsets: SUCCESS (0.000s)
[321.597411] [092/161] (783s left) kms_addfb_basic (unused-pitches)
[321.868382] Starting subtest: unused-pitches
[321.872884] Subtest unused-pitches: SUCCESS (0.000s)
[322.632715] [093/161] (782s left) kms_busy (basic)
[323.430958] Starting subtest: basic
[323.432949] Starting dynamic subtest: flip
[324.418301] Dynamic subtest flip: SUCCESS (0.973s)
[324.490563] Starting dynamic subtest: modeset
[326.429140] Dynamic subtest modeset: SUCCESS (2.014s)
[326.436131] Subtest basic: SUCCESS (2.995s)
[327.192204] [094/161] (778s left) kms_prop_blob (basic)
[327.472851] Starting subtest: basic
[327.477130] Subtest basic: SUCCESS (0.002s)
[327.736252] [095/161] (777s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[328.510606] Starting subtest: basic-busy-flip-before-cursor-atomic
[329.581950] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.073s)
[330.298094] [096/161] (775s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[331.090161] Starting subtest: basic-busy-flip-before-cursor-legacy
[332.152310] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.065s)
[332.768324] [097/161] (773s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[333.569173] Starting subtest: basic-flip-after-cursor-atomic
[334.659798] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.087s)
[335.313536] [098/161] (771s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[336.078449] Starting subtest: basic-flip-after-cursor-legacy
[337.109622] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.036s)
[337.732820] [099/161] (768s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[338.546368] Starting subtest: basic-flip-after-cursor-varying-size
[339.612925] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.076s)
[340.305867] [100/161] (766s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[341.104065] Starting subtest: basic-flip-before-cursor-atomic
[342.144497] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.038s)
[342.784197] [101/161] (764s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[343.564664] Starting subtest: basic-flip-before-cursor-legacy
[344.616639] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.053s)
[345.344476] [102/161] (761s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[346.103118] Starting subtest: basic-flip-before-cursor-varying-size
[347.134758] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.040s)
[347.812844] [103/161] (759s left) kms_dsc (dsc-basic)
[348.591823] Subtest dsc-basic: SKIP (0.000s)
[348.812321] [104/161] (758s left) kms_flip (basic-flip-vs-dpms)
[349.596954] Starting subtest: basic-flip-vs-dpms
[349.614169] Starting dynamic subtest: C-HDMI-A2
[352.158920] Dynamic subtest C-HDMI-A2: SUCCESS (2.533s)
[352.164909] Subtest basic-flip-vs-dpms: SUCCESS (2.553s)
[352.848329] [105/161] (754s left) kms_flip (basic-flip-vs-modeset)
[353.655682] Starting subtest: basic-flip-vs-modeset
[353.672660] Starting dynamic subtest: C-HDMI-A2
[356.584107] Dynamic subtest C-HDMI-A2: SUCCESS (2.902s)
[356.593719] Subtest basic-flip-vs-modeset: SUCCESS (2.920s)
[357.310974] [106/161] (750s left) kms_flip (basic-flip-vs-wf_vblank)
[358.139110] Starting subtest: basic-flip-vs-wf_vblank
[358.146289] Starting dynamic subtest: C-HDMI-A2
[360.933248] Dynamic subtest C-HDMI-A2: SUCCESS (2.780s)
[360.935687] Subtest basic-flip-vs-wf_vblank: SUCCESS (2.798s)
[361.273212] [107/161] (746s left) kms_flip (basic-plain-flip)
[362.050612] Starting subtest: basic-plain-flip
[362.072282] Starting dynamic subtest: C-HDMI-A2
[364.587689] Dynamic subtest C-HDMI-A2: SUCCESS (2.513s)
[364.592820] Subtest basic-plain-flip: SUCCESS (2.540s)
[364.927924] [108/161] (743s left) kms_force_connector_basic (force-connector-state)
[365.377608] Starting subtest: force-connector-state
[366.302237] Subtest force-connector-state: SUCCESS (0.910s)
[367.870504] [109/161] (740s left) kms_force_connector_basic (force-edid)
[368.287309] Starting subtest: force-edid
[368.422107] Subtest force-edid: SUCCESS (0.131s)
[369.379333] [110/161] (739s left) kms_force_connector_basic (force-load-detect)
[369.767209] Starting subtest: force-load-detect
[369.772510] Subtest force-load-detect: SKIP (0.000s)
[370.469602] [111/161] (738s left) kms_force_connector_basic (prune-stale-modes)
[370.927434] Starting subtest: prune-stale-modes
[371.063777] Subtest prune-stale-modes: SUCCESS (0.139s)
[372.015326] [112/161] (737s left) kms_frontbuffer_tracking (basic)
[372.825514] Starting subtest: basic
[377.807816] Subtest basic: SUCCESS (4.977s)
[378.102494] [113/161] (731s left) kms_hdmi_inject (inject-audio)
[378.499924] Starting subtest: inject-audio
[379.163282] Subtest inject-audio: SUCCESS (0.667s)
[379.900456] [114/161] (729s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[380.701620] Starting subtest: compare-crc-sanitycheck-xr24
[380.704217] Starting dynamic subtest: pipe-C-HDMI-A-2
[381.267903] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.545s)
[381.273827] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.565s)
[381.922848] [115/161] (727s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[382.736846] Starting subtest: compare-crc-sanitycheck-nv12
[382.740057] Starting dynamic subtest: pipe-C-HDMI-A-2
[382.744579] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[382.750527] Subtest compare-crc-sanitycheck-nv12: SKIP (0.011s)
[383.016696] [116/161] (727s left) kms_pipe_crc_basic (hang-read-crc)
[383.824862] Starting subtest: hang-read-crc
[383.827718] Starting dynamic subtest: pipe-C-HDMI-A-2
[385.526715] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.701s)
[385.538766] Subtest hang-read-crc: SUCCESS (1.715s)
[386.184663] [117/161] (724s left) kms_pipe_crc_basic (nonblocking-crc)
[386.973961] Starting subtest: nonblocking-crc
[386.983377] Starting dynamic subtest: pipe-C-HDMI-A-2
[387.759978] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.777s)
[387.769600] Subtest nonblocking-crc: SUCCESS (0.801s)
[388.388377] [118/161] (722s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[389.143317] Starting subtest: nonblocking-crc-frame-sequence
[389.151185] Starting dynamic subtest: pipe-C-HDMI-A-2
[389.888574] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.730s)
[389.890483] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.747s)
[390.495885] [119/161] (720s left) kms_pipe_crc_basic (read-crc)
[391.250284] Starting subtest: read-crc
[391.252127] Starting dynamic subtest: pipe-C-HDMI-A-2
[391.957705] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.707s)
[391.962426] Subtest read-crc: SUCCESS (0.716s)
[392.581780] [120/161] (718s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[393.380116] Starting subtest: read-crc-frame-sequence
[393.391140] Starting dynamic subtest: pipe-C-HDMI-A-2
[394.111425] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.718s)
[394.113561] Subtest read-crc-frame-sequence: SUCCESS (0.730s)
[394.856206] [121/161] (716s left) kms_pm_backlight (basic-brightness)
[395.690504] Subtest basic-brightness: SKIP (0.000s)
[395.932727] [122/161] (715s left) kms_pm_rpm (basic-pci-d3-state)
[398.438942] Starting subtest: basic-pci-d3-state
[398.861451] Subtest basic-pci-d3-state: SUCCESS (0.415s)
[399.391281] [123/161] (712s left) kms_pm_rpm (basic-rte)
[399.659107] Starting subtest: basic-rte
[402.245845] Subtest basic-rte: SUCCESS (2.576s)
[403.359882] [124/161] (708s left) kms_psr (psr-primary-page-flip)
[404.090619] Subtest psr-primary-page-flip: SKIP (0.000s)
[404.345245] [125/161] (707s left) kms_psr (psr-cursor-plane-move)
[405.163096] Subtest psr-cursor-plane-move: SKIP (0.000s)
[405.413519] [126/161] (706s left) kms_psr (psr-sprite-plane-onoff)
[406.236376] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[406.473135] [127/161] (705s left) kms_psr (psr-primary-mmap-gtt)
[407.312732] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[407.557851] [128/161] (705s left) kms_setmode (basic-clone-single-crtc)
[407.834704] Starting subtest: basic-clone-single-crtc
[407.842835] Subtest basic-clone-single-crtc: SKIP (0.001s)
[408.120564] [129/161] (704s left) i915_pm_rps (basic-api)
[408.405679] Starting subtest: basic-api
[408.421953] Subtest basic-api: SUCCESS (0.016s)
[408.692444] [130/161] (704s left) prime_self_import (basic-llseek-bad)
[408.951414] Starting subtest: basic-llseek-bad
[408.965979] Subtest basic-llseek-bad: SUCCESS (0.010s)
[409.251158] [131/161] (704s left) prime_self_import (basic-llseek-size)
[409.519036] Starting subtest: basic-llseek-size
[409.534403] Subtest basic-llseek-size: SUCCESS (0.026s)
[409.813843] [132/161] (703s left) prime_self_import (basic-with_fd_dup)
[410.074998] Starting subtest: basic-with_fd_dup
[410.092491] Subtest basic-with_fd_dup: SUCCESS (0.015s)
[410.358515] [133/161] (703s left) prime_self_import (basic-with_one_bo)
[410.620769] Starting subtest: basic-with_one_bo
[410.638580] Subtest basic-with_one_bo: SUCCESS (0.018s)
[410.915352] [134/161] (703s left) prime_self_import (basic-with_one_bo_two_files)
[411.174593] Starting subtest: basic-with_one_bo_two_files
[411.189996] Subtest basic-with_one_bo_two_files: SUCCESS (0.015s)
[411.464530] [135/161] (702s left) prime_self_import (basic-with_two_bos)
[411.729651] Starting subtest: basic-with_two_bos
[411.744465] Subtest basic-with_two_bos: SUCCESS (0.017s)
[412.081300] [136/161] (702s left) prime_vgem (basic-fence-flip)
[412.399089] Starting subtest: basic-fence-flip
[413.364460] Subtest basic-fence-flip: SKIP (0.965s)
[413.674794] [137/161] (701s left) prime_vgem (basic-fence-mmap)
[413.979336] Starting subtest: basic-fence-mmap
[414.112554] Subtest basic-fence-mmap: SUCCESS (0.128s)
[414.398093] [138/161] (700s left) prime_vgem (basic-fence-read)
[414.713340] Starting subtest: basic-fence-read
[414.989164] Subtest basic-fence-read: SUCCESS (0.273s)
[415.279817] [139/161] (699s left) prime_vgem (basic-gtt)
[415.592782] Starting subtest: basic-gtt
[415.650103] Subtest basic-gtt: SUCCESS (0.048s)
[415.922285] [140/161] (699s left) prime_vgem (basic-read)
[416.234698] Starting subtest: basic-read
[416.357782] Subtest basic-read: SUCCESS (0.113s)
[416.630994] [141/161] (698s left) prime_vgem (basic-write)
[416.941260] Starting subtest: basic-write
[417.103348] Subtest basic-write: SUCCESS (0.158s)
[417.374765] [142/161] (698s left) vgem_basic (setversion)
[417.652928] Starting subtest: setversion
[417.657233] Subtest setversion: SUCCESS (0.000s)
[417.900503] [143/161] (698s left) vgem_basic (create)
[418.190182] Starting subtest: create
[418.195662] Subtest create: SUCCESS (0.002s)
[418.440669] [144/161] (697s left) vgem_basic (debugfs)
[418.726224] Starting subtest: debugfs
[418.729696] Subtest debugfs: SUCCESS (0.002s)
[418.965911] [145/161] (697s left) vgem_basic (dmabuf-export)
[419.249587] Starting subtest: dmabuf-export
[419.256216] Subtest dmabuf-export: SUCCESS (0.012s)
[419.528650] [146/161] (697s left) vgem_basic (dmabuf-fence)
[419.806257] Starting subtest: dmabuf-fence
[419.808255] Subtest dmabuf-fence: SUCCESS (0.003s)
[420.073392] [147/161] (696s left) vgem_basic (dmabuf-fence-before)
[420.356759] Starting subtest: dmabuf-fence-before
[420.358893] Subtest dmabuf-fence-before: SUCCESS (0.002s)
[420.607167] [148/161] (696s left) vgem_basic (dmabuf-mmap)
[420.887186] Starting subtest: dmabuf-mmap
[420.935127] Subtest dmabuf-mmap: SUCCESS (0.049s)
[421.188909] [149/161] (696s left) vgem_basic (mmap)
[421.475193] Starting subtest: mmap
[421.504945] Subtest mmap: SUCCESS (0.040s)
[421.762847] [150/161] (695s left) vgem_basic (second-client)
[422.044566] Starting subtest: second-client
[422.068267] Subtest second-client: SUCCESS (0.031s)
[422.325810] [151/161] (695s left) vgem_basic (sysfs)
[422.625688] Starting subtest: sysfs
[422.628234] Subtest sysfs: SUCCESS (0.002s)
[422.894375] [152/161] (695s left) core_hotunplug (unbind-rebind)
[423.352178] Starting subtest: unbind-rebind
[429.608207] Subtest unbind-rebind: SUCCESS (6.260s)
[429.910529] [153/161] (688s left) vgem_basic (unload)
[430.215102] Starting subtest: unload
[459.485098] Subtest unload: SUCCESS (29.299s)
[459.933242] [154/161] (658s left) i915_module_load (reload)
[460.223196] Starting subtest: reload
[468.086953] Subtest reload: SUCCESS (7.867s)
[468.570140] [155/161] (650s left) gem_lmem_swapping (basic)
[469.213352] Subtest basic: SKIP (0.000s)
[469.572198] [156/161] (649s left) gem_lmem_swapping (parallel-random-engines)
[470.009908] Subtest parallel-random-engines: SKIP (0.000s)
[470.248162] [157/161] (649s left) gem_lmem_swapping (random-engines)
[470.542801] Subtest random-engines: SKIP (0.000s)
[470.766355] [158/161] (648s left) gem_lmem_swapping (verify-random)
[471.068553] Subtest verify-random: SKIP (0.000s)
[471.304816] [159/161] (648s left) i915_pm_rpm (module-reload)
[474.011911] Starting subtest: module-reload
[493.615126] Subtest module-reload: SUCCESS (19.606s)
[493.755378] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[493.762819] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[493.779490] [160/161] (626s left) i915_selftest (live)
[494.073145] Starting subtest: live
[494.084121] Starting dynamic subtest: sanitycheck
[498.778732] Dynamic subtest sanitycheck: SUCCESS (4.697s)
[498.834294] Starting dynamic subtest: uncore
[503.322735] Dynamic subtest uncore: SUCCESS (4.529s)
[503.369285] Starting dynamic subtest: workarounds
[508.226810] Dynamic subtest workarounds: SUCCESS (4.894s)
[508.267897] Starting dynamic subtest: gt_engines
[513.482692] Dynamic subtest gt_engines: SUCCESS (5.241s)
[513.520208] Starting dynamic subtest: gt_timelines
[546.387768] Dynamic subtest gt_timelines: SUCCESS (32.898s)
[546.430145] Starting dynamic subtest: gt_contexts
[551.243951] Dynamic subtest gt_contexts: SUCCESS (4.847s)
[551.317985] Starting dynamic subtest: gt_lrc
[559.142650] Dynamic subtest gt_lrc: SUCCESS (7.870s)
[559.177382] Starting dynamic subtest: gt_mocs
[563.762348] Dynamic subtest gt_mocs: SUCCESS (4.600s)
[563.810044] Starting dynamic subtest: gt_pm
[569.701218] Dynamic subtest gt_pm: SUCCESS (5.932s)
[569.744297] Starting dynamic subtest: gt_heartbeat
[574.202209] Dynamic subtest gt_heartbeat: SUCCESS (4.491s)
[574.282623] Starting dynamic subtest: gt_tlb
[579.309917] Dynamic subtest gt_tlb: SUCCESS (5.101s)
[579.353380] Starting dynamic subtest: requests
[590.282532] Dynamic subtest requests: SUCCESS (10.960s)
[590.324878] Starting dynamic subtest: migrate
[598.889359] Dynamic subtest migrate: SUCCESS (8.601s)
[598.934366] Starting dynamic subtest: active
[603.458616] Dynamic subtest active: SUCCESS (4.552s)
[603.528541] Starting dynamic subtest: objects
[610.641650] Dynamic subtest objects: SUCCESS (7.173s)
[610.691203] Starting dynamic subtest: mman
[622.435853] Dynamic subtest mman: SUCCESS (11.781s)
[622.503547] Starting dynamic subtest: dmabuf
[627.184733] Dynamic subtest dmabuf: SUCCESS (4.729s)
[627.240425] Starting dynamic subtest: vma
[631.984154] Dynamic subtest vma: SUCCESS (4.777s)
[632.040221] Starting dynamic subtest: coherency
[643.207244] Dynamic subtest coherency: SUCCESS (11.216s)
[643.285338] Starting dynamic subtest: gtt
[655.844300] Dynamic subtest gtt: SUCCESS (12.628s)
[655.913924] Starting dynamic subtest: gem
[661.641724] Dynamic subtest gem: SUCCESS (5.772s)
[661.689844] Starting dynamic subtest: evict
[673.437125] Dynamic subtest evict: SUCCESS (11.787s)
[673.464322] Starting dynamic subtest: hugepages
[678.564450] Dynamic subtest hugepages: SUCCESS (5.124s)
[678.630340] Starting dynamic subtest: gem_contexts
[709.438807] Dynamic subtest gem_contexts: SUCCESS (30.860s)
[709.473769] Starting dynamic subtest: client
[714.243351] Dynamic subtest client: SUCCESS (4.801s)
[714.314333] Starting dynamic subtest: gem_migrate
[718.742192] Dynamic subtest gem_migrate: SUCCESS (4.488s)
[718.794211] Starting dynamic subtest: reset
[731.726978] Dynamic subtest reset: SUCCESS (12.960s)
[731.790881] Starting dynamic subtest: memory_region
[736.018667] Dynamic subtest memory_region: SUCCESS (4.282s)
[736.051160] Starting dynamic subtest: hangcheck
[764.075831] Dynamic subtest hangcheck: SUCCESS (28.047s)
[764.117079] Starting dynamic subtest: execlists
[775.137317] Dynamic subtest execlists: SUCCESS (11.043s)
[775.207150] Starting dynamic subtest: ring_submission
[779.637106] Dynamic subtest ring_submission: SUCCESS (4.497s)
[779.695499] Starting dynamic subtest: perf
[784.597091] Dynamic subtest perf: SUCCESS (4.918s)
[784.639911] Starting dynamic subtest: slpc
[789.253236] Dynamic subtest slpc: SUCCESS (4.642s)
[789.300606] Starting dynamic subtest: guc
[793.862791] Dynamic subtest guc: SUCCESS (4.603s)
[793.921360] Starting dynamic subtest: guc_multi_lrc
[798.345099] Dynamic subtest guc_multi_lrc: SUCCESS (4.469s)
[798.414167] Starting dynamic subtest: guc_hang
[802.976509] Dynamic subtest guc_hang: SUCCESS (4.613s)
[803.016418] Starting dynamic subtest: late_gt_pm
[807.587255] Dynamic subtest late_gt_pm: SUCCESS (4.595s)
[807.589509] Subtest live: SUCCESS (313.505s)
[807.779398] [161/161] (312s left) dmabuf (all-tests)
[808.072315] Starting subtest: all-tests
[808.082158] Starting dynamic subtest: sanitycheck
[808.141205] Dynamic subtest sanitycheck: SUCCESS (0.062s)
[808.178766] Starting dynamic subtest: dma_fence
[808.469180] Dynamic subtest dma_fence: SUCCESS (0.321s)
[808.503072] Starting dynamic subtest: dma_fence_chain