[138.659855] Initializing watchdogs [138.660558] /dev/watchdog0 [138.748234] [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 [138.771511] [001/162] (960s left) i915_module_load (load) [139.054446] Starting subtest: load [144.508944] Subtest load: SUCCESS (5.448s) [144.939525] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [144.960476] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [144.985271] [002/162] (954s left) core_auth (basic-auth) [145.292674] Starting subtest: basic-auth [145.301744] Subtest basic-auth: SUCCESS (0.018s) [145.500212] [003/162] (954s left) core_debugfs (read-all-entries) [145.736223] Starting subtest: read-all-entries [145.743198] Subtest read-all-entries: SUCCESS (0.014s) [145.930074] [004/162] (954s left) core_sysfs (read-all-entries) [146.169241] Starting subtest: read-all-entries [146.183542] Subtest read-all-entries: SUCCESS (0.017s) [146.360949] [005/162] (953s left) fbdev (eof) [146.631351] Subtest eof: SKIP (0.000s) [146.799116] [006/162] (953s left) fbdev (info) [147.056269] Subtest info: SKIP (0.000s) [147.220310] [007/162] (953s left) fbdev (nullptr) [147.493180] Subtest nullptr: SKIP (0.000s) [147.659459] [008/162] (953s left) fbdev (read) [147.930030] Subtest read: SKIP (0.000s) [148.093662] [009/162] (952s left) fbdev (write) [148.373506] Subtest write: SKIP (0.000s) [148.547316] [010/162] (952s left) gem_basic (bad-close) [148.784599] Starting subtest: bad-close [148.791875] Subtest bad-close: SUCCESS (0.000s) [148.964485] [011/162] (952s left) gem_basic (create-close) [149.219618] Starting subtest: create-close [149.230960] Subtest create-close: SUCCESS (0.000s) [149.402883] [012/162] (952s left) gem_basic (create-fd-close) [149.623220] Starting subtest: create-fd-close [149.629426] Subtest create-fd-close: SUCCESS (0.001s) [149.798993] [013/162] (951s left) gem_busy (busy@all-engines) [150.106196] Starting subtest: busy [150.109204] Starting dynamic subtest: all-engines [150.276386] Dynamic subtest all-engines: SUCCESS (0.172s) [150.281254] Subtest busy: SUCCESS (0.174s) [150.791566] [014/162] (951s left) gem_close_race (basic-process) [151.082391] Starting subtest: basic-process [151.215994] Subtest basic-process: SUCCESS (0.134s) [151.535733] [015/162] (950s left) gem_close_race (basic-threads) [151.821939] Starting subtest: basic-threads [153.150943] Subtest basic-threads: SUCCESS (1.324s) [153.522273] [016/162] (948s left) gem_ctx_create (basic) [153.806562] Starting subtest: basic [153.808572] Subtest basic: SUCCESS (0.000s) [154.115137] [017/162] (948s left) gem_ctx_create (basic-files) [154.396297] Starting subtest: basic-files [156.463195] Subtest basic-files: SUCCESS (2.063s) [156.828825] [018/162] (945s left) gem_ctx_exec (basic) [157.071968] Starting subtest: basic [157.093152] Subtest basic: SUCCESS (0.020s) [157.289249] [019/162] (945s left) gem_exec_basic (basic) [157.542165] Starting subtest: basic [157.546344] Starting dynamic subtest: rcs0-smem [157.548751] Dynamic subtest rcs0-smem: SUCCESS (0.007s) [157.585101] Starting dynamic subtest: bcs0-smem [157.588200] Dynamic subtest bcs0-smem: SUCCESS (0.004s) [157.618369] Starting dynamic subtest: vcs0-smem [157.622997] Dynamic subtest vcs0-smem: SUCCESS (0.004s) [157.653128] Starting dynamic subtest: vecs0-smem [157.658100] Dynamic subtest vecs0-smem: SUCCESS (0.004s) [157.665840] Subtest basic: SUCCESS (0.024s) [157.875524] [020/162] (945s left) gem_exec_create (basic) [158.154225] Starting subtest: basic [158.158409] Starting dynamic subtest: smem [160.245396] Dynamic subtest smem: SUCCESS (2.089s) [160.247251] Subtest basic: SUCCESS (2.096s) [160.549481] [021/162] (942s left) gem_exec_fence (basic-busy) [160.987198] Starting subtest: basic-busy [160.990551] Starting dynamic subtest: rcs0 [161.022548] Dynamic subtest rcs0: SUCCESS (0.037s) [161.084069] Starting dynamic subtest: bcs0 [161.090169] Dynamic subtest bcs0: SUCCESS (0.036s) [161.153375] Starting dynamic subtest: vcs0 [161.156654] Dynamic subtest vcs0: SUCCESS (0.035s) [161.185727] Starting dynamic subtest: vecs0 [161.188670] Dynamic subtest vecs0: SUCCESS (0.038s) [161.190318] Subtest basic-busy: SUCCESS (0.159s) [162.096999] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [162.104162] [022/162] (941s left) gem_exec_fence (basic-wait) [162.541054] Starting subtest: basic-wait [162.543100] Starting dynamic subtest: rcs0 [162.572151] Dynamic subtest rcs0: SUCCESS (0.033s) [162.632382] Starting dynamic subtest: bcs0 [162.635172] Dynamic subtest bcs0: SUCCESS (0.036s) [162.686444] Starting dynamic subtest: vcs0 [162.689681] Dynamic subtest vcs0: SUCCESS (0.040s) [162.718779] Starting dynamic subtest: vecs0 [162.723633] Dynamic subtest vecs0: SUCCESS (0.025s) [162.727554] Subtest basic-wait: SUCCESS (0.144s) [163.471479] [023/162] (940s left) gem_exec_fence (basic-await) [163.910545] Starting subtest: basic-await [163.915118] Starting dynamic subtest: rcs0 [164.122486] Dynamic subtest rcs0: SUCCESS (0.209s) [164.151451] Starting dynamic subtest: bcs0 [164.322715] Dynamic subtest bcs0: SUCCESS (0.196s) [164.352712] Starting dynamic subtest: vcs0 [164.511201] Dynamic subtest vcs0: SUCCESS (0.188s) [164.549804] Starting dynamic subtest: vecs0 [164.709659] Dynamic subtest vecs0: SUCCESS (0.191s) [164.712434] Subtest basic-await: SUCCESS (0.803s) [165.499136] [024/162] (938s left) gem_exec_fence (nb-await) [165.930164] Starting subtest: nb-await [165.933024] Starting dynamic subtest: rcs0 [166.041121] Dynamic subtest rcs0: SUCCESS (0.105s) [166.077527] Starting dynamic subtest: bcs0 [166.136891] Dynamic subtest bcs0: SUCCESS (0.085s) [166.168926] Starting dynamic subtest: vcs0 [166.217592] Dynamic subtest vcs0: SUCCESS (0.081s) [166.250147] Starting dynamic subtest: vecs0 [166.302521] Dynamic subtest vecs0: SUCCESS (0.085s) [166.304670] Subtest nb-await: SUCCESS (0.368s) [167.095872] [025/162] (936s left) gem_exec_gttfill (basic) [167.371358] Starting subtest: basic [199.670230] Subtest basic: SUCCESS (32.302s) [200.029225] [026/162] (904s left) gem_exec_parallel (engines) [200.494109] Starting subtest: engines [200.497208] Starting dynamic subtest: basic [209.632402] Dynamic subtest basic: SUCCESS (9.131s) [209.669802] Starting dynamic subtest: contexts [220.449443] Dynamic subtest contexts: SUCCESS (10.811s) [220.486834] Starting dynamic subtest: fds [233.399595] Dynamic subtest fds: SUCCESS (12.956s) [233.477225] Starting dynamic subtest: userptr [240.835314] Dynamic subtest userptr: SUCCESS (7.424s) [240.837246] Subtest engines: SUCCESS (40.341s) [241.217050] [027/162] (863s left) gem_exec_store (basic) [241.489053] Starting subtest: basic [241.565088] Subtest basic: SUCCESS (0.078s) [241.900902] [028/162] (862s left) gem_flink_basic (bad-flink) [242.117215] Starting subtest: bad-flink [242.120274] Subtest bad-flink: SUCCESS (0.000s) [242.314422] [029/162] (862s left) gem_flink_basic (bad-open) [242.526902] Starting subtest: bad-open [242.532309] Subtest bad-open: SUCCESS (0.000s) [242.731982] [030/162] (862s left) gem_flink_basic (basic) [242.966124] Starting subtest: basic [242.968502] Subtest basic: SUCCESS (0.000s) [243.181485] [031/162] (862s left) gem_flink_basic (double-flink) [243.432539] Starting subtest: double-flink [243.436426] Subtest double-flink: SUCCESS (0.000s) [243.638885] [032/162] (861s left) gem_flink_basic (flink-lifetime) [243.866127] Starting subtest: flink-lifetime [243.876550] Subtest flink-lifetime: SUCCESS (0.009s) [244.072623] [033/162] (861s left) gem_huc_copy (huc-copy) [244.317187] Subtest huc-copy: SKIP (0.000s) [244.514672] [034/162] (861s left) gem_linear_blits (basic) [245.064125] Starting subtest: basic [245.118072] Subtest basic: SUCCESS (0.049s) [245.372714] [035/162] (860s left) gem_mmap (basic) [245.756388] Starting subtest: basic [245.771306] Subtest basic: SUCCESS (0.001s) [245.963514] [036/162] (860s left) gem_mmap_gtt (basic) [246.197251] Starting subtest: basic [246.199374] Subtest basic: SUCCESS (0.004s) [246.401723] [037/162] (860s left) gem_render_linear_blits (basic) [246.645196] Starting subtest: basic [246.773495] Subtest basic: SUCCESS (0.123s) [246.974488] [038/162] (859s left) gem_render_tiled_blits (basic) [247.219141] Starting subtest: basic [247.397234] Subtest basic: SUCCESS (0.171s) [247.604938] [039/162] (859s left) gem_ringfill (basic-all) [248.186091] Starting subtest: basic-all [249.572687] Subtest basic-all: SUCCESS (1.386s) [249.797510] [040/162] (857s left) gem_softpin (allocator-basic) [250.050166] Starting subtest: allocator-basic [250.470788] Subtest allocator-basic: SUCCESS (0.413s) [250.745542] [041/162] (856s left) gem_softpin (allocator-basic-reserve) [251.003304] Starting subtest: allocator-basic-reserve [251.425433] Subtest allocator-basic-reserve: SUCCESS (0.417s) [251.703465] [042/162] (855s left) gem_softpin (safe-alignment) [251.948662] Starting subtest: safe-alignment [252.009463] Subtest safe-alignment: SUCCESS (0.054s) [252.235694] [043/162] (855s left) gem_sync (basic-all) [252.513188] Starting subtest: basic-all [256.001644] Subtest basic-all: SUCCESS (3.481s) [256.357882] [044/162] (851s left) gem_sync (basic-each) [256.640877] Starting subtest: basic-each [259.782167] Subtest basic-each: SUCCESS (3.142s) [260.113318] [045/162] (848s left) gem_tiled_blits (basic) [260.584904] Starting subtest: basic [260.672661] Subtest basic: SUCCESS (0.085s) [260.940407] [046/162] (847s left) gem_tiled_fence_blits (basic) [261.581251] Starting subtest: basic [261.645641] Subtest basic: SUCCESS (0.069s) [261.911905] [047/162] (846s left) gem_tiled_pread_basic (basic) [262.293439] Starting subtest: basic [263.323228] Subtest basic: SUCCESS (1.028s) [263.526400] [048/162] (845s left) gem_wait (busy@all-engines) [263.822787] Starting subtest: busy [263.826127] Starting dynamic subtest: all-engines [264.362303] Dynamic subtest all-engines: SUCCESS (0.543s) [264.367619] Subtest busy: SUCCESS (0.545s) [264.786731] [049/162] (844s left) gem_wait (wait@all-engines) [265.086237] Starting subtest: wait [265.091231] Starting dynamic subtest: all-engines [266.133754] Dynamic subtest all-engines: SUCCESS (1.050s) [266.142270] Subtest wait: SUCCESS (1.051s) [266.541550] [050/162] (842s left) i915_getparams_basic (basic-eu-total) [266.755805] Starting subtest: basic-eu-total [266.760243] Subtest basic-eu-total: SUCCESS (0.000s) [266.961726] [051/162] (842s left) i915_getparams_basic (basic-subslice-total) [267.174846] Starting subtest: basic-subslice-total [267.181180] Subtest basic-subslice-total: SUCCESS (0.000s) [267.380990] [052/162] (842s left) i915_hangman (error-state-basic) [267.656198] Starting subtest: error-state-basic [267.707693] Subtest error-state-basic: SUCCESS (0.048s) [267.990661] [053/162] (841s left) i915_pciid [268.540284] [054/162] (841s left) intel_hwmon (hwmon-read) [268.771783] Subtest hwmon-read: SKIP (0.000s) [268.977275] [055/162] (841s left) intel_hwmon (hwmon-write) [269.205083] Subtest hwmon-write: SKIP (0.000s) [269.407180] [056/162] (841s left) kms_addfb_basic (addfb25-4-tiled) [270.000410] Starting subtest: addfb25-4-tiled [270.002799] Subtest addfb25-4-tiled: SUCCESS (0.002s) [270.215249] [057/162] (840s left) kms_addfb_basic (addfb25-bad-modifier) [270.766381] Starting subtest: addfb25-bad-modifier [270.769366] Subtest addfb25-bad-modifier: SUCCESS (0.003s) [271.000778] [058/162] (839s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [271.610027] Starting subtest: addfb25-framebuffer-vs-set-tiling [271.614390] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [271.824384] [059/162] (839s left) kms_addfb_basic (addfb25-modifier-no-flag) [272.392851] Starting subtest: addfb25-modifier-no-flag [272.396661] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [272.599739] [060/162] (838s left) kms_addfb_basic (addfb25-x-tiled-legacy) [273.246676] Starting subtest: addfb25-x-tiled-legacy [273.285191] Subtest addfb25-x-tiled-legacy: SUCCESS (0.003s) [273.528695] [061/162] (838s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [274.068774] Starting subtest: addfb25-x-tiled-mismatch-legacy [274.072816] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s) [274.284604] [062/162] (837s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [274.887490] Starting subtest: addfb25-yf-tiled-legacy [274.892281] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s) [275.103953] [063/162] (836s left) kms_addfb_basic (addfb25-y-tiled-legacy) [275.645370] Starting subtest: addfb25-y-tiled-legacy [275.650142] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s) [275.861069] [064/162] (836s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [276.403494] Starting subtest: addfb25-y-tiled-small-legacy [276.410586] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [276.617558] [065/162] (835s left) kms_addfb_basic (bad-pitch-0) [276.834974] Starting subtest: bad-pitch-0 [276.840208] Subtest bad-pitch-0: SUCCESS (0.000s) [277.329456] [066/162] (835s left) kms_addfb_basic (bad-pitch-1024) [277.567574] Starting subtest: bad-pitch-1024 [277.569506] Subtest bad-pitch-1024: SUCCESS (0.000s) [278.122467] [067/162] (834s left) kms_addfb_basic (bad-pitch-128) [278.354179] Starting subtest: bad-pitch-128 [278.357598] Subtest bad-pitch-128: SUCCESS (0.000s) [278.958702] [068/162] (834s left) kms_addfb_basic (bad-pitch-256) [279.175804] Starting subtest: bad-pitch-256 [279.181275] Subtest bad-pitch-256: SUCCESS (0.000s) [279.747976] [069/162] (833s left) kms_addfb_basic (bad-pitch-32) [279.986348] Starting subtest: bad-pitch-32 [279.989335] Subtest bad-pitch-32: SUCCESS (0.000s) [280.583502] [070/162] (832s left) kms_addfb_basic (bad-pitch-63) [280.817410] Starting subtest: bad-pitch-63 [280.820162] Subtest bad-pitch-63: SUCCESS (0.000s) [281.347708] [071/162] (832s left) kms_addfb_basic (bad-pitch-65536) [281.594074] Starting subtest: bad-pitch-65536 [281.597258] Subtest bad-pitch-65536: SUCCESS (0.002s) [282.147975] [072/162] (831s left) kms_addfb_basic (bad-pitch-999) [282.368284] Starting subtest: bad-pitch-999 [282.372388] Subtest bad-pitch-999: SUCCESS (0.000s) [282.903671] [073/162] (831s left) kms_addfb_basic (basic) [283.131430] Starting subtest: basic [283.135120] Subtest basic: SUCCESS (0.000s) [283.664190] [074/162] (830s left) kms_addfb_basic (basic-x-tiled-legacy) [283.898221] Starting subtest: basic-x-tiled-legacy [283.902421] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [284.455422] [075/162] (830s left) kms_addfb_basic (basic-y-tiled-legacy) [284.686198] Starting subtest: basic-y-tiled-legacy [284.688397] Subtest basic-y-tiled-legacy: SUCCESS (0.002s) [285.209147] [076/162] (829s left) kms_addfb_basic (bo-too-small) [285.828433] Starting subtest: bo-too-small [285.830704] Subtest bo-too-small: SUCCESS (0.003s) [286.054091] [077/162] (828s left) kms_addfb_basic (bo-too-small-due-to-tiling) [286.632444] Starting subtest: bo-too-small-due-to-tiling [286.637321] Subtest bo-too-small-due-to-tiling: SUCCESS (0.003s) [286.852152] [078/162] (828s left) kms_addfb_basic (clobberred-modifier) [287.085353] Starting subtest: clobberred-modifier [287.087828] Subtest clobberred-modifier: SUCCESS (0.002s) [287.660563] [079/162] (827s left) kms_addfb_basic (framebuffer-vs-set-tiling) [287.924788] Starting subtest: framebuffer-vs-set-tiling [287.927149] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [288.583437] [080/162] (827s left) kms_addfb_basic (invalid-get-prop) [288.887194] Starting subtest: invalid-get-prop [288.890192] Subtest invalid-get-prop: SUCCESS (0.000s) [289.428344] [081/162] (826s left) kms_addfb_basic (invalid-get-prop-any) [289.644307] Starting subtest: invalid-get-prop-any [289.647944] Subtest invalid-get-prop-any: SUCCESS (0.000s) [290.201938] [082/162] (825s left) kms_addfb_basic (invalid-set-prop) [290.432156] Starting subtest: invalid-set-prop [290.435307] Subtest invalid-set-prop: SUCCESS (0.000s) [291.024299] [083/162] (825s left) kms_addfb_basic (invalid-set-prop-any) [291.256304] Starting subtest: invalid-set-prop-any [291.258269] Subtest invalid-set-prop-any: SUCCESS (0.000s) [291.804510] [084/162] (824s left) kms_addfb_basic (no-handle) [292.030437] Starting subtest: no-handle [292.034151] Subtest no-handle: SUCCESS (0.000s) [292.632849] [085/162] (824s left) kms_addfb_basic (size-max) [293.165596] Starting subtest: size-max [293.169947] Subtest size-max: SUCCESS (0.001s) [293.381514] [086/162] (823s left) kms_addfb_basic (small-bo) [294.005352] Starting subtest: small-bo [294.007457] Subtest small-bo: SUCCESS (0.001s) [294.221592] [087/162] (822s left) kms_addfb_basic (tile-pitch-mismatch) [294.461372] Starting subtest: tile-pitch-mismatch [294.464104] Subtest tile-pitch-mismatch: SUCCESS (0.002s) [295.027579] [088/162] (822s left) kms_addfb_basic (too-high) [295.595730] Starting subtest: too-high [295.603578] Subtest too-high: SUCCESS (0.008s) [295.824710] [089/162] (821s left) kms_addfb_basic (too-wide) [296.491568] Starting subtest: too-wide [296.497201] Subtest too-wide: SUCCESS (0.001s) [296.736945] [090/162] (820s left) kms_addfb_basic (unused-handle) [296.970913] Starting subtest: unused-handle [296.973591] Subtest unused-handle: SUCCESS (0.000s) [297.575729] [091/162] (820s left) kms_addfb_basic (unused-modifier) [297.800313] Starting subtest: unused-modifier [297.803207] Subtest unused-modifier: SUCCESS (0.000s) [298.299568] [092/162] (819s left) kms_addfb_basic (unused-offsets) [298.521458] Starting subtest: unused-offsets [298.526117] Subtest unused-offsets: SUCCESS (0.000s) [299.026078] [093/162] (819s left) kms_addfb_basic (unused-pitches) [299.263698] Starting subtest: unused-pitches [299.265699] Subtest unused-pitches: SUCCESS (0.000s) [299.844253] [094/162] (818s left) kms_busy (basic) [300.424802] Subtest basic: SKIP (0.000s) [300.627920] [095/162] (818s left) kms_prop_blob (basic) [300.856938] Starting subtest: basic [300.861276] Subtest basic: SUCCESS (0.000s) [301.072535] [096/162] (817s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [301.678164] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [301.861984] [097/162] (817s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [302.439236] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [302.629313] [098/162] (816s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [303.243147] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [303.573413] [099/162] (816s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [304.190165] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [304.389359] [100/162] (815s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [304.986388] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [305.169161] [101/162] (814s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [305.764163] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [305.960719] [102/162] (814s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [306.517162] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [306.709776] [103/162] (813s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [307.303176] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [307.508270] [104/162] (813s left) kms_dsc (dsc-basic) [308.065178] Subtest dsc-basic: SKIP (0.000s) [308.277273] [105/162] (812s left) kms_flip (basic-flip-vs-dpms) [308.855128] Starting subtest: basic-flip-vs-dpms [308.870183] Subtest basic-flip-vs-dpms: SKIP (0.008s) [309.133155] [106/162] (811s left) kms_flip (basic-flip-vs-modeset) [309.703116] Starting subtest: basic-flip-vs-modeset [309.717191] Subtest basic-flip-vs-modeset: SKIP (0.008s) [309.967153] [107/162] (811s left) kms_flip (basic-flip-vs-wf_vblank) [310.534220] Starting subtest: basic-flip-vs-wf_vblank [310.549164] Subtest basic-flip-vs-wf_vblank: SKIP (0.011s) [310.828654] [108/162] (810s left) kms_flip (basic-plain-flip) [311.558078] Starting subtest: basic-plain-flip [311.585353] Subtest basic-plain-flip: SKIP (0.020s) [312.040515] [109/162] (809s left) kms_force_connector_basic (force-connector-state) [312.522148] Starting subtest: force-connector-state [313.181359] Subtest force-connector-state: SUCCESS (0.646s) [314.138708] [110/162] (807s left) kms_force_connector_basic (force-edid) [314.571301] Starting subtest: force-edid [314.868664] Subtest force-edid: SUCCESS (0.299s) [315.505553] [111/162] (806s left) kms_force_connector_basic (force-load-detect) [315.882672] Starting subtest: force-load-detect [315.886798] Subtest force-load-detect: SKIP (0.000s) [316.402755] [112/162] (806s left) kms_force_connector_basic (prune-stale-modes) [316.791615] Starting subtest: prune-stale-modes [317.114700] Subtest prune-stale-modes: SUCCESS (0.331s) [317.743833] [113/162] (805s left) kms_frontbuffer_tracking (basic) [318.462136] Subtest basic: SKIP (0.000s) [318.722597] [114/162] (804s left) kms_hdmi_inject (inject-audio) [318.973769] Starting subtest: inject-audio [319.468507] Subtest inject-audio: SUCCESS (0.483s) [319.897813] [115/162] (803s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [320.436682] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [320.662217] [116/162] (802s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [321.265521] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [321.490966] [117/162] (802s left) kms_pipe_crc_basic (hang-read-crc) [322.034448] Subtest hang-read-crc: SKIP (0.000s) [322.252985] [118/162] (801s left) kms_pipe_crc_basic (nonblocking-crc) [322.831790] Subtest nonblocking-crc: SKIP (0.000s) [323.058596] [119/162] (800s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [323.598158] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [323.807598] [120/162] (800s left) kms_pipe_crc_basic (read-crc) [324.328556] Subtest read-crc: SKIP (0.000s) [324.541846] [121/162] (799s left) kms_pipe_crc_basic (read-crc-frame-sequence) [325.188348] Subtest read-crc-frame-sequence: SKIP (0.000s) [325.410942] [122/162] (799s left) kms_pm_backlight (basic-brightness) [325.986362] Subtest basic-brightness: SKIP (0.000s) [326.208491] [123/162] (798s left) kms_pm_rpm (basic-pci-d3-state) [328.140400] Starting subtest: basic-pci-d3-state [328.360165] Subtest basic-pci-d3-state: SUCCESS (0.216s) [328.590583] [124/162] (796s left) kms_pm_rpm (basic-rte) [328.807407] Starting subtest: basic-rte [330.604732] Subtest basic-rte: SUCCESS (1.790s) [331.058312] [125/162] (794s left) kms_psr (psr-primary-page-flip) [331.570994] Subtest psr-primary-page-flip: SKIP (0.000s) [331.792103] [126/162] (793s left) kms_psr (psr-cursor-plane-move) [332.400171] Subtest psr-cursor-plane-move: SKIP (0.000s) [332.648639] [127/162] (793s left) kms_psr (psr-sprite-plane-onoff) [333.190237] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [333.471737] [128/162] (792s left) kms_psr (psr-primary-mmap-gtt) [334.059373] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [334.292917] [129/162] (791s left) kms_setmode (basic-clone-single-crtc) [334.534169] Starting subtest: basic-clone-single-crtc [334.545371] Subtest basic-clone-single-crtc: SKIP (0.002s) [334.770555] [130/162] (791s left) i915_pm_rps (basic-api) [335.054210] Starting subtest: basic-api [335.070120] Subtest basic-api: SUCCESS (0.018s) [335.293634] [131/162] (791s left) prime_self_import (basic-llseek-bad) [335.500558] Starting subtest: basic-llseek-bad [335.521162] Subtest basic-llseek-bad: SUCCESS (0.020s) [335.766539] [132/162] (791s left) prime_self_import (basic-llseek-size) [335.997800] Starting subtest: basic-llseek-size [336.016757] Subtest basic-llseek-size: SUCCESS (0.021s) [336.253478] [133/162] (790s left) prime_self_import (basic-with_fd_dup) [336.465259] Starting subtest: basic-with_fd_dup [336.487611] Subtest basic-with_fd_dup: SUCCESS (0.022s) [336.713499] [134/162] (790s left) prime_self_import (basic-with_one_bo) [336.931336] Starting subtest: basic-with_one_bo [336.951274] Subtest basic-with_one_bo: SUCCESS (0.016s) [337.186762] [135/162] (790s left) prime_self_import (basic-with_one_bo_two_files) [337.410208] Starting subtest: basic-with_one_bo_two_files [337.428490] Subtest basic-with_one_bo_two_files: SUCCESS (0.018s) [337.655728] [136/162] (790s left) prime_self_import (basic-with_two_bos) [337.873558] Starting subtest: basic-with_two_bos [337.894438] Subtest basic-with_two_bos: SUCCESS (0.024s) [338.132616] [137/162] (789s left) prime_vgem (basic-fence-flip) [338.406301] Starting subtest: basic-fence-flip [338.677262] Subtest basic-fence-flip: SKIP (0.271s) [338.923718] [138/162] (789s left) prime_vgem (basic-fence-mmap) [339.183466] Starting subtest: basic-fence-mmap [339.303811] Subtest basic-fence-mmap: SUCCESS (0.118s) [339.547752] [139/162] (788s left) prime_vgem (basic-fence-read) [339.818405] Starting subtest: basic-fence-read [340.105167] Subtest basic-fence-read: SUCCESS (0.286s) [340.348306] [140/162] (788s left) prime_vgem (basic-gtt) [340.605928] Starting subtest: basic-gtt [340.651952] Subtest basic-gtt: SUCCESS (0.045s) [340.898624] [141/162] (787s left) prime_vgem (basic-read) [341.155265] Starting subtest: basic-read [341.271540] Subtest basic-read: SUCCESS (0.119s) [341.531283] [142/162] (787s left) prime_vgem (basic-write) [341.796102] Starting subtest: basic-write [341.967824] Subtest basic-write: SUCCESS (0.174s) [342.216426] [143/162] (786s left) vgem_basic (setversion) [342.448159] Starting subtest: setversion [342.454213] Subtest setversion: SUCCESS (0.000s) [342.658369] [144/162] (786s left) vgem_basic (create) [342.888586] Starting subtest: create [342.892327] Subtest create: SUCCESS (0.001s) [343.116056] [145/162] (786s left) vgem_basic (debugfs) [343.344177] Starting subtest: debugfs [343.346278] Subtest debugfs: SUCCESS (0.002s) [343.565446] [146/162] (786s left) vgem_basic (dmabuf-export) [343.802126] Starting subtest: dmabuf-export [343.818362] Subtest dmabuf-export: SUCCESS (0.020s) [344.062384] [147/162] (785s left) vgem_basic (dmabuf-fence) [344.313387] Starting subtest: dmabuf-fence [344.316756] Subtest dmabuf-fence: SUCCESS (0.005s) [344.529941] [148/162] (785s left) vgem_basic (dmabuf-fence-before) [344.762480] Starting subtest: dmabuf-fence-before [344.765375] Subtest dmabuf-fence-before: SUCCESS (0.002s) [344.999286] [149/162] (785s left) vgem_basic (dmabuf-mmap) [345.243231] Starting subtest: dmabuf-mmap [345.281492] Subtest dmabuf-mmap: SUCCESS (0.043s) [345.510825] [150/162] (785s left) vgem_basic (mmap) [345.752142] Starting subtest: mmap [345.791391] Subtest mmap: SUCCESS (0.044s) [346.021676] [151/162] (784s left) vgem_basic (second-client) [346.260786] Starting subtest: second-client [346.274153] Subtest second-client: SUCCESS (0.016s) [346.489263] [152/162] (784s left) vgem_basic (sysfs) [346.720271] Starting subtest: sysfs [346.722214] Subtest sysfs: SUCCESS (0.003s) [346.937366] [153/162] (784s left) core_hotunplug (unbind-rebind) [347.356851] Starting subtest: unbind-rebind [352.881852] Subtest unbind-rebind: SUCCESS (5.523s) [353.105314] [154/162] (778s left) vgem_basic (unload) [353.330133] Starting subtest: unload [382.562214] Subtest unload: SUCCESS (29.230s) [382.909924] [155/162] (748s left) i915_module_load (reload) [383.128687] Starting subtest: reload [390.754304] Subtest reload: SUCCESS (7.605s) [391.179954] [156/162] (740s left) gem_lmem_swapping (basic) [391.464394] Subtest basic: SKIP (0.000s) [391.675465] [157/162] (740s left) gem_lmem_swapping (parallel-random-engines) [391.915661] Subtest parallel-random-engines: SKIP (0.000s) [392.116393] [158/162] (740s left) gem_lmem_swapping (random-engines) [392.382712] Subtest random-engines: SKIP (0.000s) [392.584843] [159/162] (740s left) gem_lmem_swapping (verify-random) [392.842634] Subtest verify-random: SKIP (0.000s) [393.049573] [160/162] (739s left) i915_pm_rpm (module-reload) [395.096184] Starting subtest: module-reload [413.838490] Subtest module-reload: SUCCESS (18.740s) [413.982940] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [413.988601] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [413.995613] [161/162] (719s left) i915_selftest (live) [414.237958] Starting subtest: live [414.240301] Starting dynamic subtest: sanitycheck [420.443469] Dynamic subtest sanitycheck: SUCCESS (6.204s) [420.482805] Starting dynamic subtest: uncore [426.121662] Dynamic subtest uncore: SUCCESS (5.670s) [426.165239] Starting dynamic subtest: workarounds [432.276870] Dynamic subtest workarounds: SUCCESS (6.145s) [432.312449] Starting dynamic subtest: gt_engines [438.665293] Dynamic subtest gt_engines: SUCCESS (6.384s) [438.770876] Starting dynamic subtest: gt_timelines [476.662359] Dynamic subtest gt_timelines: SUCCESS (37.985s) [476.710347] Starting dynamic subtest: gt_contexts [482.956135] Dynamic subtest gt_contexts: SUCCESS (6.285s) [482.993097] Starting dynamic subtest: gt_lrc [492.521205] Dynamic subtest gt_lrc: SUCCESS (9.556s) [492.558992] Starting dynamic subtest: gt_mocs [498.278483] Dynamic subtest gt_mocs: SUCCESS (5.751s) [498.356822] Starting dynamic subtest: gt_pm [505.713609] Dynamic subtest gt_pm: SUCCESS (7.417s) [505.746372] Starting dynamic subtest: gt_heartbeat [511.729427] Dynamic subtest gt_heartbeat: SUCCESS (6.010s) [511.766683] Starting dynamic subtest: gt_tlb [518.513784] Dynamic subtest gt_tlb: SUCCESS (6.775s) [518.549426] Starting dynamic subtest: requests [530.786741] Dynamic subtest requests: SUCCESS (12.268s) [530.828787] Starting dynamic subtest: migrate [541.192193] Dynamic subtest migrate: SUCCESS (10.394s) [541.232900] Starting dynamic subtest: active [547.143121] Dynamic subtest active: SUCCESS (5.935s) [547.279559] Starting dynamic subtest: objects [554.748709] Dynamic subtest objects: SUCCESS (7.597s) [554.787633] Starting dynamic subtest: mman [567.840872] Dynamic subtest mman: SUCCESS (13.086s) [567.882923] Starting dynamic subtest: dmabuf [574.018983] Dynamic subtest dmabuf: SUCCESS (6.169s) [574.082870] Starting dynamic subtest: vma [580.258329] Dynamic subtest vma: SUCCESS (6.230s) [580.291478] Starting dynamic subtest: coherency [592.085391] Dynamic subtest coherency: SUCCESS (11.823s) [592.119650] Starting dynamic subtest: gtt [606.290199] Dynamic subtest gtt: SUCCESS (14.202s) [606.334308] Starting dynamic subtest: gem [613.900446] Dynamic subtest gem: SUCCESS (7.599s) [613.936116] Starting dynamic subtest: evict [628.699398] Dynamic subtest evict: SUCCESS (14.794s) [628.738699] Starting dynamic subtest: hugepages [635.273685] Dynamic subtest hugepages: SUCCESS (6.565s) [635.307770] Starting dynamic subtest: gem_contexts [671.265602] Dynamic subtest gem_contexts: SUCCESS (35.988s) [671.305601] Starting dynamic subtest: client [677.226742] Dynamic subtest client: SUCCESS (5.949s) [677.282797] Starting dynamic subtest: gem_migrate [683.300991] Dynamic subtest gem_migrate: SUCCESS (6.059s) [683.343791] Starting dynamic subtest: reset [698.213911] Dynamic subtest reset: SUCCESS (14.904s) [698.255399] Starting dynamic subtest: memory_region [704.219565] Dynamic subtest memory_region: SUCCESS (5.993s) [704.263133] Starting dynamic subtest: hangcheck [733.981457] Dynamic subtest hangcheck: SUCCESS (29.754s) [734.020967] Starting dynamic subtest: execlists [746.559554] Dynamic subtest execlists: SUCCESS (12.569s) [746.601472] Starting dynamic subtest: ring_submission [752.367285] Dynamic subtest ring_submission: SUCCESS (5.799s) [752.454281] Starting dynamic subtest: perf [758.909674] Dynamic subtest perf: SUCCESS (6.529s) [758.953339] Starting dynamic subtest: slpc [765.036153] Dynamic subtest slpc: SUCCESS (6.113s) [765.075945] Starting dynamic subtest: guc [771.090910] Dynamic subtest guc: SUCCESS (6.049s) [771.135884] Starting dynamic subtest: guc_multi_lrc [777.141928] Dynamic subtest guc_multi_lrc: SUCCESS (6.040s) [777.182296] Starting dynamic subtest: guc_hang [783.202583] Dynamic subtest guc_hang: SUCCESS (6.052s) [783.252089] Starting dynamic subtest: late_gt_pm [789.406690] Dynamic subtest late_gt_pm: SUCCESS (6.191s) [789.417542] Subtest live: SUCCESS (375.167s) [789.578720] [162/162] (343s left) dmabuf (all-tests) [789.811367] Starting subtest: all-tests [789.817557] Starting dynamic subtest: sanitycheck [789.877439] Dynamic subtest sanitycheck: SUCCESS (0.068s) [789.973718] Starting dynamic subtest: dma_fence [790.075274] Dynamic subtest dma_fence: SUCCESS (0.189s) [790.151893] Starting dynamic subtest: dma_fence_chain [790.155107] Dynamic subtest dma_fence_chain: SKIP (0.002s) [790.190728] Starting dynamic subtest: dma_fence_unwrap [790.194841] Dynamic subtest dma_fence_unwrap: SUCCESS (0.073s) [790.249170] Starting dynamic subtest: dma_resv [790.262979] Dynamic subtest dma_resv: SUCCESS (0.085s) [790.274176] Subtest all-tests: SUCCESS (0.461s) [790.421548] Closing watchdogs results: parsing output: 0/ for test: i915_module_load results: parsing output: 1/ for test: core_auth results: parsing output: 2/ for test: core_debugfs results: parsing output: 3/ for test: core_sysfs results: parsing output: 4/ for test: fbdev results: parsing output: 5/ for test: fbdev results: parsing output: 6/ for test: fbdev results: parsing output: 7/ for test: fbdev results: parsing output: 8/ for test: fbdev results: parsing output: 9/ for test: gem_basic results: parsing output: 10/ for test: gem_basic results: parsing output: 11/ for test: gem_basic results: parsing output: 12/ for test: gem_busy results: parsing output: 13/ for test: gem_close_race results: parsing output: 14/ for test: gem_close_race results: parsing output: 15/ for test: gem_ctx_create results: parsing output: 16/ for test: gem_ctx_create results: parsing output: 17/ for test: gem_ctx_exec results: parsing output: 18/ for test: gem_exec_basic results: parsing output: 19/ for test: gem_exec_create results: parsing output: 20/ for test: gem_exec_fence results: parsing output: 21/ for test: gem_exec_fence results: parsing output: 22/ for test: gem_exec_fence results: parsing output: 23/ for test: gem_exec_fence results: parsing output: 24/ for test: gem_exec_gttfill results: parsing output: 25/ for test: gem_exec_parallel results: parsing output: 26/ for test: gem_exec_store results: parsing output: 27/ for test: gem_flink_basic results: parsing output: 28/ for test: gem_flink_basic results: parsing output: 29/ for test: gem_flink_basic results: parsing output: 30/ for test: gem_flink_basic results: parsing output: 31/ for test: gem_flink_basic results: parsing output: 32/ for test: gem_huc_copy results: parsing output: 33/ for test: gem_linear_blits results: parsing output: 34/ for test: gem_mmap results: parsing output: 35/ for test: gem_mmap_gtt results: parsing output: 36/ for test: gem_render_linear_blits results: parsing output: 37/ for test: gem_render_tiled_blits results: parsing output: 38/ for test: gem_ringfill results: parsing output: 39/ for test: gem_softpin results: parsing output: 40/ for test: gem_softpin results: parsing output: 41/ for test: gem_softpin results: parsing output: 42/ for test: gem_sync results: parsing output: 43/ for test: gem_sync results: parsing output: 44/ for test: gem_tiled_blits results: parsing output: 45/ for test: gem_tiled_fence_blits results: parsing output: 46/ for test: gem_tiled_pread_basic results: parsing output: 47/ for test: gem_wait results: parsing output: 48/ for test: gem_wait results: parsing output: 49/ for test: i915_getparams_basic results: parsing output: 50/ for test: i915_getparams_basic results: parsing output: 51/ for test: i915_hangman results: parsing output: 52/ for test: i915_pciid results: parsing output: 53/ for test: intel_hwmon results: parsing output: 54/ for test: intel_hwmon results: parsing output: 55/ for test: kms_addfb_basic results: parsing output: 56/ for test: kms_addfb_basic results: parsing output: 57/ for test: kms_addfb_basic results: parsing output: 58/ for test: kms_addfb_basic results: parsing output: 59/ for test: kms_addfb_basic results: parsing output: 60/ for test: kms_addfb_basic results: parsing output: 61/ for test: kms_addfb_basic results: parsing output: 62/ for test: kms_addfb_basic results: parsing output: 63/ for test: kms_addfb_basic results: parsing output: 64/ for test: kms_addfb_basic results: parsing output: 65/ for test: kms_addfb_basic results: parsing output: 66/ for test: kms_addfb_basic results: parsing output: 67/ for test: kms_addfb_basic results: parsing output: 68/ for test: kms_addfb_basic results: parsing output: 69/ for test: kms_addfb_basic results: parsing output: 70/ for test: kms_addfb_basic results: parsing output: 71/ for test: kms_addfb_basic results: parsing output: 72/ for test: kms_addfb_basic results: parsing output: 73/ for test: kms_addfb_basic results: parsing output: 74/ for test: kms_addfb_basic results: parsing output: 75/ for test: kms_addfb_basic results: parsing output: 76/ for test: kms_addfb_basic results: parsing output: 77/ for test: kms_addfb_basic results: parsing output: 78/ for test: kms_addfb_basic results: parsing output: 79/ for test: kms_addfb_basic results: parsing output: 80/ for test: kms_addfb_basic results: parsing output: 81/ for test: kms_addfb_basic results: parsing output: 82/ for test: kms_addfb_basic results: parsing output: 83/ for test: kms_addfb_basic results: parsing output: 84/ for test: kms_addfb_basic results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_addfb_basic results: parsing output: 87/ for test: kms_addfb_basic results: parsing output: 88/ for test: kms_addfb_basic results: parsing output: 89/ for test: kms_addfb_basic results: parsing output: 90/ for test: kms_addfb_basic results: parsing output: 91/ for test: kms_addfb_basic results: parsing output: 92/ for test: kms_addfb_basic results: parsing output: 93/ for test: kms_busy results: parsing output: 94/ for test: kms_prop_blob results: parsing output: 95/ for test: kms_cursor_legacy results: parsing output: 96/ for test: kms_cursor_legacy results: parsing output: 97/ for test: kms_cursor_legacy results: parsing output: 98/ for test: kms_cursor_legacy results: parsing output: 99/ for test: kms_cursor_legacy results: parsing output: 100/ for test: kms_cursor_legacy results: parsing output: 101/ for test: kms_cursor_legacy results: parsing output: 102/ for test: kms_cursor_legacy results: parsing output: 103/ for test: kms_dsc results: parsing output: 104/ for test: kms_flip results: parsing output: 105/ for test: kms_flip results: parsing output: 106/ for test: kms_flip results: parsing output: 107/ for test: kms_flip results: parsing output: 108/ for test: kms_force_connector_basic results: parsing output: 109/ for test: kms_force_connector_basic results: parsing output: 110/ for test: kms_force_connector_basic results: parsing output: 111/ for test: kms_force_connector_basic results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_hdmi_inject results: parsing output: 114/ for test: kms_pipe_crc_basic results: parsing output: 115/ for test: kms_pipe_crc_basic results: parsing output: 116/ for test: kms_pipe_crc_basic results: parsing output: 117/ for test: kms_pipe_crc_basic results: parsing output: 118/ for test: kms_pipe_crc_basic results: parsing output: 119/ for test: kms_pipe_crc_basic results: parsing output: 120/ for test: kms_pipe_crc_basic results: parsing output: 121/ for test: kms_pm_backlight results: parsing output: 122/ for test: kms_pm_rpm results: parsing output: 123/ for test: kms_pm_rpm results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: kms_psr results: parsing output: 127/ for test: kms_psr results: parsing output: 128/ for test: kms_setmode results: parsing output: 129/ for test: i915_pm_rps results: parsing output: 130/ for test: prime_self_import results: parsing output: 131/ for test: prime_self_import results: parsing output: 132/ for test: prime_self_import results: parsing output: 133/ for test: prime_self_import results: parsing output: 134/ for test: prime_self_import results: parsing output: 135/ for test: prime_self_import results: parsing output: 136/ for test: prime_vgem results: parsing output: 137/ for test: prime_vgem results: parsing output: 138/ for test: prime_vgem results: parsing output: 139/ for test: prime_vgem results: parsing output: 140/ for test: prime_vgem results: parsing output: 141/ for test: prime_vgem results: parsing output: 142/ for test: vgem_basic results: parsing output: 143/ for test: vgem_basic results: parsing output: 144/ for test: vgem_basic results: parsing output: 145/ for test: vgem_basic results: parsing output: 146/ for test: vgem_basic results: parsing output: 147/ for test: vgem_basic results: parsing output: 148/ for test: vgem_basic results: parsing output: 149/ for test: vgem_basic results: parsing output: 150/ for test: vgem_basic results: parsing output: 151/ for test: vgem_basic results: parsing output: 152/ for test: core_hotunplug results: parsing output: 153/ for test: vgem_basic results: parsing output: 154/ for test: i915_module_load results: parsing output: 155/ for test: gem_lmem_swapping results: parsing output: 156/ for test: gem_lmem_swapping results: parsing output: 157/ for test: gem_lmem_swapping results: parsing output: 158/ for test: gem_lmem_swapping results: parsing output: 159/ for test: i915_pm_rpm results: parsing output: 160/ for test: i915_selftest results: parsing output: 161/ for test: dmabuf Done.