[85.793886] Initializing watchdogs [85.794467] /dev/watchdog0 [85.886637] [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 [85.911352] [001/162] (960s left) i915_module_load (load) [86.188232] Starting subtest: load [91.942980] Subtest load: SUCCESS (5.623s) [92.196361] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [92.208796] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [92.220383] [002/162] (954s left) core_auth (basic-auth) [92.569394] Starting subtest: basic-auth [92.573241] Subtest basic-auth: SUCCESS (0.004s) [92.748444] [003/162] (954s left) core_debugfs (read-all-entries) [92.978315] Starting subtest: read-all-entries [92.992227] Subtest read-all-entries: SUCCESS (0.013s) [93.208897] [004/162] (953s left) core_sysfs (read-all-entries) [93.447221] Starting subtest: read-all-entries [93.462840] Subtest read-all-entries: SUCCESS (0.020s) [93.659938] [005/162] (953s left) fbdev (eof) [93.959757] Subtest eof: SKIP (0.000s) [94.127965] [006/162] (953s left) fbdev (info) [94.397402] Subtest info: SKIP (0.000s) [94.561937] [007/162] (953s left) fbdev (nullptr) [94.841932] Subtest nullptr: SKIP (0.000s) [95.004367] [008/162] (952s left) fbdev (read) [95.279977] Subtest read: SKIP (0.000s) [95.448657] [009/162] (952s left) fbdev (write) [95.715990] Subtest write: SKIP (0.000s) [95.883286] [010/162] (952s left) gem_basic (bad-close) [96.129331] Starting subtest: bad-close [96.135168] Subtest bad-close: SUCCESS (0.000s) [96.309242] [011/162] (952s left) gem_basic (create-close) [96.545147] Starting subtest: create-close [96.551764] Subtest create-close: SUCCESS (0.000s) [96.720610] [012/162] (951s left) gem_basic (create-fd-close) [96.947323] Starting subtest: create-fd-close [96.958486] Subtest create-fd-close: SUCCESS (0.001s) [97.139431] [013/162] (951s left) gem_busy (busy@all-engines) [97.453114] Starting subtest: busy [97.456082] Starting dynamic subtest: all-engines [97.637773] Dynamic subtest all-engines: SUCCESS (0.186s) [97.642283] Subtest busy: SUCCESS (0.191s) [98.181723] [014/162] (950s left) gem_close_race (basic-process) [98.480524] Starting subtest: basic-process [98.617879] Subtest basic-process: SUCCESS (0.143s) [98.927481] [015/162] (950s left) gem_close_race (basic-threads) [99.214410] Starting subtest: basic-threads [100.434693] Subtest basic-threads: SUCCESS (1.213s) [100.752549] [016/162] (948s left) gem_ctx_create (basic) [101.019960] Starting subtest: basic [101.023142] Subtest basic: SUCCESS (0.000s) [101.324506] [017/162] (948s left) gem_ctx_create (basic-files) [101.610193] Starting subtest: basic-files [103.681352] Subtest basic-files: SUCCESS (2.064s) [104.090662] [018/162] (945s left) gem_ctx_exec (basic) [104.330769] Starting subtest: basic [104.350171] Subtest basic: SUCCESS (0.018s) [104.536687] [019/162] (945s left) gem_exec_basic (basic) [104.791608] Starting subtest: basic [104.795480] Starting dynamic subtest: rcs0-smem [104.798580] Dynamic subtest rcs0-smem: SUCCESS (0.008s) [104.837444] Starting dynamic subtest: bcs0-smem [104.839137] Dynamic subtest bcs0-smem: SUCCESS (0.004s) [104.866257] Starting dynamic subtest: vcs0-smem [104.867986] Dynamic subtest vcs0-smem: SUCCESS (0.004s) [104.894885] Starting dynamic subtest: vecs0-smem [104.896608] Dynamic subtest vecs0-smem: SUCCESS (0.003s) [104.898341] Subtest basic: SUCCESS (0.029s) [105.154493] [020/162] (944s left) gem_exec_create (basic) [105.446034] Starting subtest: basic [105.448347] Starting dynamic subtest: smem [107.541249] Dynamic subtest smem: SUCCESS (2.090s) [107.544092] Subtest basic: SUCCESS (2.094s) [107.859384] [021/162] (942s left) gem_exec_fence (basic-busy) [108.303520] Starting subtest: basic-busy [108.305801] Starting dynamic subtest: rcs0 [108.335331] Dynamic subtest rcs0: SUCCESS (0.032s) [108.397322] Starting dynamic subtest: bcs0 [108.404400] Dynamic subtest bcs0: SUCCESS (0.028s) [108.439660] Starting dynamic subtest: vcs0 [108.443966] Dynamic subtest vcs0: SUCCESS (0.041s) [108.473705] Starting dynamic subtest: vecs0 [108.480150] Dynamic subtest vecs0: SUCCESS (0.023s) [108.482443] Subtest basic-busy: SUCCESS (0.136s) [109.433662] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [109.440552] [022/162] (940s left) gem_exec_fence (basic-wait) [109.883641] Starting subtest: basic-wait [109.887110] Starting dynamic subtest: rcs0 [109.920206] Dynamic subtest rcs0: SUCCESS (0.034s) [109.965505] Starting dynamic subtest: bcs0 [109.975492] Dynamic subtest bcs0: SUCCESS (0.037s) [110.008285] Starting dynamic subtest: vcs0 [110.010428] Dynamic subtest vcs0: SUCCESS (0.036s) [110.043095] Starting dynamic subtest: vecs0 [110.044808] Dynamic subtest vecs0: SUCCESS (0.031s) [110.046599] Subtest basic-wait: SUCCESS (0.148s) [110.819758] [023/162] (939s left) gem_exec_fence (basic-await) [111.271900] Starting subtest: basic-await [111.274311] Starting dynamic subtest: rcs0 [111.475538] Dynamic subtest rcs0: SUCCESS (0.198s) [111.508050] Starting dynamic subtest: bcs0 [111.673810] Dynamic subtest bcs0: SUCCESS (0.195s) [111.709142] Starting dynamic subtest: vcs0 [111.880137] Dynamic subtest vcs0: SUCCESS (0.205s) [111.914903] Starting dynamic subtest: vecs0 [112.126668] Dynamic subtest vecs0: SUCCESS (0.245s) [112.136185] Subtest basic-await: SUCCESS (0.856s) [112.935618] [024/162] (937s left) gem_exec_fence (nb-await) [113.388177] Starting subtest: nb-await [113.391173] Starting dynamic subtest: rcs0 [113.491233] Dynamic subtest rcs0: SUCCESS (0.103s) [113.521190] Starting dynamic subtest: bcs0 [113.587627] Dynamic subtest bcs0: SUCCESS (0.093s) [113.620923] Starting dynamic subtest: vcs0 [113.675467] Dynamic subtest vcs0: SUCCESS (0.083s) [113.709261] Starting dynamic subtest: vecs0 [113.763276] Dynamic subtest vecs0: SUCCESS (0.084s) [113.766197] Subtest nb-await: SUCCESS (0.381s) [114.555780] [025/162] (936s left) gem_exec_gttfill (basic) [114.829933] Starting subtest: basic [147.927340] Subtest basic: SUCCESS (33.091s) [148.301373] [026/162] (902s left) gem_exec_parallel (engines) [148.796168] Starting subtest: engines [148.800160] Starting dynamic subtest: basic [157.762957] Dynamic subtest basic: SUCCESS (8.967s) [157.805483] Starting dynamic subtest: contexts [169.510096] Dynamic subtest contexts: SUCCESS (11.740s) [169.547255] Starting dynamic subtest: fds [182.449155] Dynamic subtest fds: SUCCESS (12.932s) [182.498312] Starting dynamic subtest: userptr [189.145539] Dynamic subtest userptr: SUCCESS (6.696s) [189.148344] Subtest engines: SUCCESS (40.351s) [189.510772] [027/162] (861s left) gem_exec_store (basic) [189.789662] Starting subtest: basic [189.871429] Subtest basic: SUCCESS (0.085s) [190.221066] [028/162] (861s left) gem_flink_basic (bad-flink) [190.443255] Starting subtest: bad-flink [190.445574] Subtest bad-flink: SUCCESS (0.000s) [190.645532] [029/162] (861s left) gem_flink_basic (bad-open) [190.872306] Starting subtest: bad-open [190.876042] Subtest bad-open: SUCCESS (0.000s) [191.098620] [030/162] (860s left) gem_flink_basic (basic) [191.328981] Starting subtest: basic [191.337691] Subtest basic: SUCCESS (0.001s) [191.543373] [031/162] (860s left) gem_flink_basic (double-flink) [191.764801] Starting subtest: double-flink [191.769154] Subtest double-flink: SUCCESS (0.001s) [191.972611] [032/162] (860s left) gem_flink_basic (flink-lifetime) [192.201252] Starting subtest: flink-lifetime [192.211768] Subtest flink-lifetime: SUCCESS (0.009s) [192.422624] [033/162] (860s left) gem_huc_copy (huc-copy) [192.665212] Subtest huc-copy: SKIP (0.000s) [192.877487] [034/162] (860s left) gem_linear_blits (basic) [193.487226] Starting subtest: basic [193.525689] Subtest basic: SUCCESS (0.051s) [193.798746] [035/162] (859s left) gem_mmap (basic) [194.258929] Starting subtest: basic [194.279132] Subtest basic: SUCCESS (0.002s) [194.481684] [036/162] (858s left) gem_mmap_gtt (basic) [194.710855] Starting subtest: basic [194.720607] Subtest basic: SUCCESS (0.005s) [194.937943] [037/162] (858s left) gem_render_linear_blits (basic) [195.189239] Starting subtest: basic [195.331665] Subtest basic: SUCCESS (0.137s) [195.541770] [038/162] (858s left) gem_render_tiled_blits (basic) [195.784310] Starting subtest: basic [195.995970] Subtest basic: SUCCESS (0.208s) [196.209743] [039/162] (857s left) gem_ringfill (basic-all) [196.715610] Starting subtest: basic-all [198.112123] Subtest basic-all: SUCCESS (1.400s) [198.349453] [040/162] (855s left) gem_softpin (allocator-basic) [198.597753] Starting subtest: allocator-basic [199.070865] Subtest allocator-basic: SUCCESS (0.449s) [199.335491] [041/162] (855s left) gem_softpin (allocator-basic-reserve) [199.570261] Starting subtest: allocator-basic-reserve [199.995177] Subtest allocator-basic-reserve: SUCCESS (0.424s) [200.274263] [042/162] (854s left) gem_softpin (safe-alignment) [200.532768] Starting subtest: safe-alignment [200.595471] Subtest safe-alignment: SUCCESS (0.063s) [200.834871] [043/162] (853s left) gem_sync (basic-all) [201.122113] Starting subtest: basic-all [204.866510] Subtest basic-all: SUCCESS (3.744s) [205.211272] [044/162] (849s left) gem_sync (basic-each) [205.503518] Starting subtest: basic-each [208.266428] Subtest basic-each: SUCCESS (2.757s) [208.601971] [045/162] (846s left) gem_tiled_blits (basic) [209.057350] Starting subtest: basic [209.166260] Subtest basic: SUCCESS (0.105s) [209.413673] [046/162] (846s left) gem_tiled_fence_blits (basic) [210.075371] Starting subtest: basic [210.142405] Subtest basic: SUCCESS (0.070s) [210.390870] [047/162] (845s left) gem_tiled_pread_basic (basic) [210.774309] Starting subtest: basic [211.849204] Subtest basic: SUCCESS (1.076s) [212.060830] [048/162] (843s left) gem_wait (busy@all-engines) [212.377306] Starting subtest: busy [212.383380] Starting dynamic subtest: all-engines [212.918939] Dynamic subtest all-engines: SUCCESS (0.544s) [212.920900] Subtest busy: SUCCESS (0.546s) [213.340402] [049/162] (842s left) gem_wait (wait@all-engines) [213.653413] Starting subtest: wait [213.662206] Starting dynamic subtest: all-engines [214.728066] Dynamic subtest all-engines: SUCCESS (1.068s) [214.731060] Subtest wait: SUCCESS (1.073s) [215.150158] [050/162] (841s left) i915_getparams_basic (basic-eu-total) [215.374126] Starting subtest: basic-eu-total [215.379764] Subtest basic-eu-total: SUCCESS (0.000s) [215.583521] [051/162] (840s left) i915_getparams_basic (basic-subslice-total) [215.800618] Starting subtest: basic-subslice-total [215.806805] Subtest basic-subslice-total: SUCCESS (0.000s) [216.019643] [052/162] (840s left) i915_hangman (error-state-basic) [216.290521] Starting subtest: error-state-basic [216.319272] Subtest error-state-basic: SUCCESS (0.022s) [216.617215] [053/162] (840s left) i915_pciid [217.049490] [054/162] (840s left) intel_hwmon (hwmon-read) [217.275311] Subtest hwmon-read: SKIP (0.000s) [217.484462] [055/162] (839s left) intel_hwmon (hwmon-write) [217.706530] Subtest hwmon-write: SKIP (0.000s) [217.920368] [056/162] (839s left) kms_addfb_basic (addfb25-4-tiled) [218.481384] Starting subtest: addfb25-4-tiled [218.485861] Subtest addfb25-4-tiled: SUCCESS (0.002s) [218.698857] [057/162] (839s left) kms_addfb_basic (addfb25-bad-modifier) [219.252573] Starting subtest: addfb25-bad-modifier [219.255596] Subtest addfb25-bad-modifier: SUCCESS (0.002s) [219.468902] [058/162] (838s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [220.085867] Starting subtest: addfb25-framebuffer-vs-set-tiling [220.089582] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.002s) [220.316772] [059/162] (837s left) kms_addfb_basic (addfb25-modifier-no-flag) [220.928450] Starting subtest: addfb25-modifier-no-flag [220.932181] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [221.159503] [060/162] (837s left) kms_addfb_basic (addfb25-x-tiled-legacy) [221.742219] Starting subtest: addfb25-x-tiled-legacy [221.745791] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [221.957070] [061/162] (836s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [222.552874] Starting subtest: addfb25-x-tiled-mismatch-legacy [222.557642] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s) [222.783938] [062/162] (836s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [223.392423] Starting subtest: addfb25-yf-tiled-legacy [223.394426] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.003s) [223.612476] [063/162] (835s left) kms_addfb_basic (addfb25-y-tiled-legacy) [224.211731] Starting subtest: addfb25-y-tiled-legacy [224.213785] Subtest addfb25-y-tiled-legacy: SUCCESS (0.004s) [224.430090] [064/162] (834s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [225.066231] Starting subtest: addfb25-y-tiled-small-legacy [225.076533] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [225.285364] [065/162] (834s left) kms_addfb_basic (bad-pitch-0) [225.524892] Starting subtest: bad-pitch-0 [225.528276] Subtest bad-pitch-0: SUCCESS (0.000s) [226.048164] [066/162] (833s left) kms_addfb_basic (bad-pitch-1024) [226.282261] Starting subtest: bad-pitch-1024 [226.284251] Subtest bad-pitch-1024: SUCCESS (0.000s) [226.808470] [067/162] (833s left) kms_addfb_basic (bad-pitch-128) [227.032197] Starting subtest: bad-pitch-128 [227.035235] Subtest bad-pitch-128: SUCCESS (0.000s) [227.561236] [068/162] (832s left) kms_addfb_basic (bad-pitch-256) [227.787321] Starting subtest: bad-pitch-256 [227.790366] Subtest bad-pitch-256: SUCCESS (0.001s) [228.395839] [069/162] (831s left) kms_addfb_basic (bad-pitch-32) [228.652310] Starting subtest: bad-pitch-32 [228.657281] Subtest bad-pitch-32: SUCCESS (0.000s) [229.301408] [070/162] (831s left) kms_addfb_basic (bad-pitch-63) [229.539503] Starting subtest: bad-pitch-63 [229.542437] Subtest bad-pitch-63: SUCCESS (0.000s) [230.122716] [071/162] (830s left) kms_addfb_basic (bad-pitch-65536) [230.345244] Starting subtest: bad-pitch-65536 [230.349376] Subtest bad-pitch-65536: SUCCESS (0.001s) [230.901479] [072/162] (830s left) kms_addfb_basic (bad-pitch-999) [231.130190] Starting subtest: bad-pitch-999 [231.133338] Subtest bad-pitch-999: SUCCESS (0.000s) [231.671430] [073/162] (829s left) kms_addfb_basic (basic) [231.897395] Starting subtest: basic [231.900491] Subtest basic: SUCCESS (0.000s) [232.413343] [074/162] (829s left) kms_addfb_basic (basic-x-tiled-legacy) [232.658986] Starting subtest: basic-x-tiled-legacy [232.664208] Subtest basic-x-tiled-legacy: SUCCESS (0.001s) [233.225279] [075/162] (828s left) kms_addfb_basic (basic-y-tiled-legacy) [233.447575] Starting subtest: basic-y-tiled-legacy [233.452214] Subtest basic-y-tiled-legacy: SUCCESS (0.002s) [233.991758] [076/162] (827s left) kms_addfb_basic (bo-too-small) [234.574399] Starting subtest: bo-too-small [234.576418] Subtest bo-too-small: SUCCESS (0.001s) [234.797432] [077/162] (827s left) kms_addfb_basic (bo-too-small-due-to-tiling) [235.432232] Starting subtest: bo-too-small-due-to-tiling [235.436280] Subtest bo-too-small-due-to-tiling: SUCCESS (0.003s) [235.659620] [078/162] (826s left) kms_addfb_basic (clobberred-modifier) [235.892903] Starting subtest: clobberred-modifier [235.897821] Subtest clobberred-modifier: SUCCESS (0.001s) [236.473946] [079/162] (825s left) kms_addfb_basic (framebuffer-vs-set-tiling) [236.721197] Starting subtest: framebuffer-vs-set-tiling [236.724256] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [237.278742] [080/162] (825s left) kms_addfb_basic (invalid-get-prop) [237.512185] Starting subtest: invalid-get-prop [237.514368] Subtest invalid-get-prop: SUCCESS (0.000s) [238.026437] [081/162] (824s left) kms_addfb_basic (invalid-get-prop-any) [238.250300] Starting subtest: invalid-get-prop-any [238.252358] Subtest invalid-get-prop-any: SUCCESS (0.000s) [238.807575] [082/162] (824s left) kms_addfb_basic (invalid-set-prop) [239.040447] Starting subtest: invalid-set-prop [239.043271] Subtest invalid-set-prop: SUCCESS (0.000s) [239.564260] [083/162] (823s left) kms_addfb_basic (invalid-set-prop-any) [239.798715] Starting subtest: invalid-set-prop-any [239.803221] Subtest invalid-set-prop-any: SUCCESS (0.000s) [240.374296] [084/162] (823s left) kms_addfb_basic (no-handle) [240.617342] Starting subtest: no-handle [240.621350] Subtest no-handle: SUCCESS (0.000s) [241.157951] [085/162] (822s left) kms_addfb_basic (size-max) [241.684523] Starting subtest: size-max [241.689271] Subtest size-max: SUCCESS (0.001s) [241.903168] [086/162] (822s left) kms_addfb_basic (small-bo) [242.446921] Starting subtest: small-bo [242.449842] Subtest small-bo: SUCCESS (0.001s) [242.670772] [087/162] (821s left) kms_addfb_basic (tile-pitch-mismatch) [242.903202] Starting subtest: tile-pitch-mismatch [242.906216] Subtest tile-pitch-mismatch: SUCCESS (0.002s) [243.468102] [088/162] (820s left) kms_addfb_basic (too-high) [244.137644] Starting subtest: too-high [244.142987] Subtest too-high: SUCCESS (0.004s) [244.358934] [089/162] (820s left) kms_addfb_basic (too-wide) [244.913624] Starting subtest: too-wide [244.915971] Subtest too-wide: SUCCESS (0.000s) [245.186283] [090/162] (819s left) kms_addfb_basic (unused-handle) [245.445325] Starting subtest: unused-handle [245.447479] Subtest unused-handle: SUCCESS (0.000s) [246.001520] [091/162] (819s left) kms_addfb_basic (unused-modifier) [246.234767] Starting subtest: unused-modifier [246.238210] Subtest unused-modifier: SUCCESS (0.000s) [246.829214] [092/162] (818s left) kms_addfb_basic (unused-offsets) [247.065525] Starting subtest: unused-offsets [247.068134] Subtest unused-offsets: SUCCESS (0.000s) [247.628425] [093/162] (817s left) kms_addfb_basic (unused-pitches) [247.874597] Starting subtest: unused-pitches [247.879243] Subtest unused-pitches: SUCCESS (0.002s) [248.513125] [094/162] (817s left) kms_busy (basic) [249.046387] Subtest basic: SKIP (0.000s) [249.278800] [095/162] (816s left) kms_prop_blob (basic) [249.508217] Starting subtest: basic [249.511127] Subtest basic: SUCCESS (0.000s) [249.711371] [096/162] (816s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [250.343695] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [250.564930] [097/162] (815s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [251.169370] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [251.378809] [098/162] (815s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [251.963169] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [252.157594] [099/162] (814s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [252.783679] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [252.982840] [100/162] (813s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [253.578194] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [253.772832] [101/162] (813s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [254.390097] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [254.588576] [102/162] (812s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [255.195867] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [255.433459] [103/162] (812s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [256.073146] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [256.278348] [104/162] (811s left) kms_dsc (dsc-basic) [256.892410] Subtest dsc-basic: SKIP (0.000s) [257.108819] [105/162] (810s left) kms_flip (basic-flip-vs-dpms) [257.638274] Starting subtest: basic-flip-vs-dpms [257.643907] Subtest basic-flip-vs-dpms: SKIP (0.007s) [257.910395] [106/162] (810s left) kms_flip (basic-flip-vs-modeset) [258.454196] Starting subtest: basic-flip-vs-modeset [258.473196] Subtest basic-flip-vs-modeset: SKIP (0.011s) [258.762224] [107/162] (809s left) kms_flip (basic-flip-vs-wf_vblank) [259.341144] Starting subtest: basic-flip-vs-wf_vblank [259.353081] Subtest basic-flip-vs-wf_vblank: SKIP (0.009s) [259.616639] [108/162] (809s left) kms_flip (basic-plain-flip) [260.192132] Starting subtest: basic-plain-flip [260.206045] Subtest basic-plain-flip: SKIP (0.008s) [260.473142] [109/162] (808s left) kms_force_connector_basic (force-connector-state) [260.804659] Starting subtest: force-connector-state [261.521207] Subtest force-connector-state: SUCCESS (0.721s) [262.719606] [110/162] (806s left) kms_force_connector_basic (force-edid) [263.126087] Starting subtest: force-edid [263.393902] Subtest force-edid: SUCCESS (0.272s) [264.090477] [111/162] (805s left) kms_force_connector_basic (force-load-detect) [264.443164] Starting subtest: force-load-detect [264.449323] Subtest force-load-detect: SKIP (0.000s) [264.907554] [112/162] (804s left) kms_force_connector_basic (prune-stale-modes) [265.245674] Starting subtest: prune-stale-modes [265.505708] Subtest prune-stale-modes: SUCCESS (0.265s) [266.142177] [113/162] (803s left) kms_frontbuffer_tracking (basic) [266.743797] Subtest basic: SKIP (0.000s) [266.976414] [114/162] (803s left) kms_hdmi_inject (inject-audio) [267.224127] Starting subtest: inject-audio [267.777327] Subtest inject-audio: SUCCESS (0.554s) [268.306367] [115/162] (801s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [268.845400] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [269.077961] [116/162] (801s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [269.632377] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [269.848102] [117/162] (800s left) kms_pipe_crc_basic (hang-read-crc) [270.428885] Subtest hang-read-crc: SKIP (0.000s) [270.659396] [118/162] (800s left) kms_pipe_crc_basic (nonblocking-crc) [271.218563] Subtest nonblocking-crc: SKIP (0.000s) [271.444512] [119/162] (799s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [272.034403] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [272.272983] [120/162] (799s left) kms_pipe_crc_basic (read-crc) [272.855181] Subtest read-crc: SKIP (0.000s) [273.072809] [121/162] (798s left) kms_pipe_crc_basic (read-crc-frame-sequence) [273.675237] Subtest read-crc-frame-sequence: SKIP (0.000s) [273.977715] [122/162] (797s left) kms_pm_backlight (basic-brightness) [274.505223] Subtest basic-brightness: SKIP (0.000s) [274.722571] [123/162] (797s left) kms_pm_rpm (basic-pci-d3-state) [276.591208] Starting subtest: basic-pci-d3-state [276.808891] Subtest basic-pci-d3-state: SUCCESS (0.220s) [277.038490] [124/162] (795s left) kms_pm_rpm (basic-rte) [277.265802] Starting subtest: basic-rte [279.044360] Subtest basic-rte: SUCCESS (1.776s) [279.512702] [125/162] (792s left) kms_psr (psr-primary-page-flip) [280.095968] Subtest psr-primary-page-flip: SKIP (0.000s) [280.328629] [126/162] (792s left) kms_psr (psr-cursor-plane-move) [280.930423] Subtest psr-cursor-plane-move: SKIP (0.000s) [281.150552] [127/162] (791s left) kms_psr (psr-sprite-plane-onoff) [281.696950] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [281.924341] [128/162] (791s left) kms_psr (psr-primary-mmap-gtt) [282.491080] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [282.720640] [129/162] (790s left) kms_setmode (basic-clone-single-crtc) [282.948495] Starting subtest: basic-clone-single-crtc [282.963862] Subtest basic-clone-single-crtc: SKIP (0.001s) [283.180767] [130/162] (790s left) i915_pm_rps (basic-api) [283.464889] Starting subtest: basic-api [283.489597] Subtest basic-api: SUCCESS (0.022s) [283.734402] [131/162] (789s left) prime_self_import (basic-llseek-bad) [283.955046] Starting subtest: basic-llseek-bad [283.972747] Subtest basic-llseek-bad: SUCCESS (0.014s) [284.210228] [132/162] (789s left) prime_self_import (basic-llseek-size) [284.426204] Starting subtest: basic-llseek-size [284.447599] Subtest basic-llseek-size: SUCCESS (0.021s) [284.693698] [133/162] (789s left) prime_self_import (basic-with_fd_dup) [284.914090] Starting subtest: basic-with_fd_dup [284.930972] Subtest basic-with_fd_dup: SUCCESS (0.020s) [285.176504] [134/162] (789s left) prime_self_import (basic-with_one_bo) [285.405939] Starting subtest: basic-with_one_bo [285.420194] Subtest basic-with_one_bo: SUCCESS (0.016s) [285.657972] [135/162] (788s left) prime_self_import (basic-with_one_bo_two_files) [285.885406] Starting subtest: basic-with_one_bo_two_files [285.891659] Subtest basic-with_one_bo_two_files: SUCCESS (0.015s) [286.126210] [136/162] (788s left) prime_self_import (basic-with_two_bos) [286.341914] Starting subtest: basic-with_two_bos [286.369458] Subtest basic-with_two_bos: SUCCESS (0.028s) [286.612698] [137/162] (788s left) prime_vgem (basic-fence-flip) [286.888999] Starting subtest: basic-fence-flip [287.205888] Subtest basic-fence-flip: SKIP (0.316s) [287.461259] [138/162] (787s left) prime_vgem (basic-fence-mmap) [287.739321] Starting subtest: basic-fence-mmap [287.875173] Subtest basic-fence-mmap: SUCCESS (0.138s) [288.122664] [139/162] (787s left) prime_vgem (basic-fence-read) [288.386142] Starting subtest: basic-fence-read [288.763871] Subtest basic-fence-read: SUCCESS (0.322s) [289.054721] [140/162] (786s left) prime_vgem (basic-gtt) [289.321946] Starting subtest: basic-gtt [289.385722] Subtest basic-gtt: SUCCESS (0.057s) [289.626657] [141/162] (786s left) prime_vgem (basic-read) [289.891100] Starting subtest: basic-read [290.029906] Subtest basic-read: SUCCESS (0.132s) [290.269872] [142/162] (785s left) prime_vgem (basic-write) [290.536539] Starting subtest: basic-write [290.711363] Subtest basic-write: SUCCESS (0.179s) [290.960744] [143/162] (785s left) vgem_basic (setversion) [291.199635] Starting subtest: setversion [291.207317] Subtest setversion: SUCCESS (0.001s) [291.427663] [144/162] (785s left) vgem_basic (create) [291.662184] Starting subtest: create [291.665387] Subtest create: SUCCESS (0.001s) [291.876692] [145/162] (784s left) vgem_basic (debugfs) [292.096593] Starting subtest: debugfs [292.099836] Subtest debugfs: SUCCESS (0.002s) [292.330942] [146/162] (784s left) vgem_basic (dmabuf-export) [292.567750] Starting subtest: dmabuf-export [292.586692] Subtest dmabuf-export: SUCCESS (0.016s) [292.824744] [147/162] (784s left) vgem_basic (dmabuf-fence) [293.056255] Starting subtest: dmabuf-fence [293.058450] Subtest dmabuf-fence: SUCCESS (0.004s) [293.288901] [148/162] (784s left) vgem_basic (dmabuf-fence-before) [293.507433] Starting subtest: dmabuf-fence-before [293.512279] Subtest dmabuf-fence-before: SUCCESS (0.002s) [293.746511] [149/162] (783s left) vgem_basic (dmabuf-mmap) [293.986280] Starting subtest: dmabuf-mmap [294.031109] Subtest dmabuf-mmap: SUCCESS (0.046s) [294.260744] [150/162] (783s left) vgem_basic (mmap) [294.501895] Starting subtest: mmap [294.528328] Subtest mmap: SUCCESS (0.036s) [294.751394] [151/162] (783s left) vgem_basic (second-client) [294.988472] Starting subtest: second-client [295.012547] Subtest second-client: SUCCESS (0.021s) [295.231918] [152/162] (783s left) vgem_basic (sysfs) [295.467279] Starting subtest: sysfs [295.469370] Subtest sysfs: SUCCESS (0.003s) [295.688275] [153/162] (782s left) core_hotunplug (unbind-rebind) [296.111265] Starting subtest: unbind-rebind [301.547362] Subtest unbind-rebind: SUCCESS (5.430s) [301.765690] [154/162] (776s left) vgem_basic (unload) [301.998620] Starting subtest: unload [331.256972] Subtest unload: SUCCESS (29.252s) [331.599922] [155/162] (747s left) i915_module_load (reload) [331.826302] Starting subtest: reload [339.271470] Subtest reload: SUCCESS (7.435s) [339.729153] [156/162] (739s left) gem_lmem_swapping (basic) [340.046604] Subtest basic: SKIP (0.000s) [340.259968] [157/162] (739s left) gem_lmem_swapping (parallel-random-engines) [340.507231] Subtest parallel-random-engines: SKIP (0.000s) [340.710913] [158/162] (739s left) gem_lmem_swapping (random-engines) [340.976108] Subtest random-engines: SKIP (0.000s) [341.199864] [159/162] (738s left) gem_lmem_swapping (verify-random) [341.441296] Subtest verify-random: SKIP (0.000s) [341.656492] [160/162] (738s left) i915_pm_rpm (module-reload) [343.520118] Starting subtest: module-reload [362.288454] Subtest module-reload: SUCCESS (18.772s) [362.433824] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [362.439600] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [362.446664] [161/162] (717s left) i915_selftest (live) [362.693577] Starting subtest: live [362.697061] Starting dynamic subtest: sanitycheck [368.884746] Dynamic subtest sanitycheck: SUCCESS (6.191s) [368.921847] Starting dynamic subtest: uncore [374.707855] Dynamic subtest uncore: SUCCESS (5.816s) [374.809550] Starting dynamic subtest: workarounds [382.011403] Dynamic subtest workarounds: SUCCESS (7.288s) [382.047378] Starting dynamic subtest: gt_engines [388.576687] Dynamic subtest gt_engines: SUCCESS (6.565s) [388.619355] Starting dynamic subtest: gt_timelines [428.331497] Dynamic subtest gt_timelines: SUCCESS (39.745s) [428.371604] Starting dynamic subtest: gt_contexts [434.519880] Dynamic subtest gt_contexts: SUCCESS (6.182s) [434.556574] Starting dynamic subtest: gt_lrc [443.983731] Dynamic subtest gt_lrc: SUCCESS (9.453s) [444.024667] Starting dynamic subtest: gt_mocs [449.909429] Dynamic subtest gt_mocs: SUCCESS (5.919s) [449.977184] Starting dynamic subtest: gt_pm [457.410110] Dynamic subtest gt_pm: SUCCESS (7.493s) [457.445512] Starting dynamic subtest: gt_heartbeat [463.464097] Dynamic subtest gt_heartbeat: SUCCESS (6.049s) [463.540251] Starting dynamic subtest: gt_tlb [470.279704] Dynamic subtest gt_tlb: SUCCESS (6.804s) [470.326039] Starting dynamic subtest: requests [482.867077] Dynamic subtest requests: SUCCESS (12.579s) [482.908886] Starting dynamic subtest: migrate [493.201478] Dynamic subtest migrate: SUCCESS (10.323s) [493.238090] Starting dynamic subtest: active [499.268131] Dynamic subtest active: SUCCESS (6.062s) [499.309792] Starting dynamic subtest: objects [506.949490] Dynamic subtest objects: SUCCESS (7.671s) [506.988332] Starting dynamic subtest: mman [520.324642] Dynamic subtest mman: SUCCESS (13.369s) [520.362729] Starting dynamic subtest: dmabuf [526.405882] Dynamic subtest dmabuf: SUCCESS (6.075s) [526.446655] Starting dynamic subtest: vma [532.342168] Dynamic subtest vma: SUCCESS (5.926s) [532.392351] Starting dynamic subtest: coherency [544.036857] Dynamic subtest coherency: SUCCESS (11.686s) [544.127221] Starting dynamic subtest: gtt [558.353527] Dynamic subtest gtt: SUCCESS (14.307s) [558.395346] Starting dynamic subtest: gem [565.679170] Dynamic subtest gem: SUCCESS (7.319s) [565.719087] Starting dynamic subtest: evict [580.367479] Dynamic subtest evict: SUCCESS (14.680s) [580.411886] Starting dynamic subtest: hugepages [587.049894] Dynamic subtest hugepages: SUCCESS (6.670s) [587.089787] Starting dynamic subtest: gem_contexts [622.095461] Dynamic subtest gem_contexts: SUCCESS (35.035s) [622.137208] Starting dynamic subtest: client [628.166970] Dynamic subtest client: SUCCESS (6.059s) [628.220397] Starting dynamic subtest: gem_migrate [634.200384] Dynamic subtest gem_migrate: SUCCESS (6.023s) [634.289649] Starting dynamic subtest: reset [648.691301] Dynamic subtest reset: SUCCESS (14.484s) [648.777321] Starting dynamic subtest: memory_region [654.738948] Dynamic subtest memory_region: SUCCESS (6.044s) [654.778851] Starting dynamic subtest: hangcheck [684.322172] Dynamic subtest hangcheck: SUCCESS (29.575s) [684.363593] Starting dynamic subtest: execlists [696.788110] Dynamic subtest execlists: SUCCESS (12.458s) [696.843354] Starting dynamic subtest: ring_submission [702.937617] Dynamic subtest ring_submission: SUCCESS (6.141s) [702.978293] Starting dynamic subtest: perf [709.465230] Dynamic subtest perf: SUCCESS (6.519s) [709.506153] Starting dynamic subtest: slpc [715.483183] Dynamic subtest slpc: SUCCESS (6.010s) [715.523400] Starting dynamic subtest: guc [721.373328] Dynamic subtest guc: SUCCESS (5.885s) [721.434805] Starting dynamic subtest: guc_multi_lrc [727.249361] Dynamic subtest guc_multi_lrc: SUCCESS (5.863s) [727.303277] Starting dynamic subtest: guc_hang [733.361989] Dynamic subtest guc_hang: SUCCESS (6.105s) [733.401404] Starting dynamic subtest: late_gt_pm [739.400387] Dynamic subtest late_gt_pm: SUCCESS (6.031s) [739.403231] Subtest live: SUCCESS (376.694s) [739.683726] [162/162] (340s left) dmabuf (all-tests) [739.934997] Starting subtest: all-tests [739.937349] Starting dynamic subtest: sanitycheck [740.009664] Dynamic subtest sanitycheck: SUCCESS (0.074s) [740.078078] Starting dynamic subtest: dma_fence [740.211503] Dynamic subtest dma_fence: SUCCESS (0.192s) [740.288565] Starting dynamic subtest: dma_fence_chain [740.294472] Dynamic subtest dma_fence_chain: SKIP (0.001s) [740.345104] Starting dynamic subtest: dma_fence_unwrap [740.348256] Dynamic subtest dma_fence_unwrap: SUCCESS (0.068s) [740.393076] Starting dynamic subtest: dma_resv [740.394671] Dynamic subtest dma_resv: SUCCESS (0.079s) [740.396356] Subtest all-tests: SUCCESS (0.460s) [740.551657] 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.