[82.383674] Initializing watchdogs [82.384080] /dev/watchdog0 [82.472341] [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 [82.494410] [001/162] (960s left) i915_module_load (load) [83.705267] Starting subtest: load [89.220446] Subtest load: SUCCESS (5.621s) [89.604400] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [89.625460] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [89.682064] [002/162] (953s left) core_auth (basic-auth) [89.988897] Starting subtest: basic-auth [89.991848] Subtest basic-auth: SUCCESS (0.008s) [90.179833] [003/162] (953s left) core_debugfs (read-all-entries) [90.418311] Starting subtest: read-all-entries [90.430166] Subtest read-all-entries: SUCCESS (0.016s) [90.618623] [004/162] (953s left) core_sysfs (read-all-entries) [90.851329] Starting subtest: read-all-entries [90.871945] Subtest read-all-entries: SUCCESS (0.021s) [91.062915] [005/162] (952s left) fbdev (eof) [91.327185] Subtest eof: SKIP (0.000s) [91.500778] [006/162] (952s left) fbdev (info) [91.785235] Subtest info: SKIP (0.000s) [91.954893] [007/162] (952s left) fbdev (nullptr) [92.232295] Subtest nullptr: SKIP (0.000s) [92.392166] [008/162] (952s left) fbdev (read) [92.672205] Subtest read: SKIP (0.000s) [92.835130] [009/162] (951s left) fbdev (write) [93.117872] Subtest write: SKIP (0.000s) [93.282361] [010/162] (951s left) gem_basic (bad-close) [93.528125] Starting subtest: bad-close [93.535134] Subtest bad-close: SUCCESS (0.000s) [93.706052] [011/162] (951s left) gem_basic (create-close) [93.931364] Starting subtest: create-close [93.938740] Subtest create-close: SUCCESS (0.002s) [94.115112] [012/162] (951s left) gem_basic (create-fd-close) [94.332514] Starting subtest: create-fd-close [94.339483] Subtest create-fd-close: SUCCESS (0.002s) [94.519977] [013/162] (950s left) gem_busy (busy@all-engines) [94.817814] Starting subtest: busy [94.821226] Starting dynamic subtest: all-engines [94.986989] Dynamic subtest all-engines: SUCCESS (0.174s) [94.988739] Subtest busy: SUCCESS (0.178s) [95.507914] [014/162] (950s left) gem_close_race (basic-process) [95.798511] Starting subtest: basic-process [95.941659] Subtest basic-process: SUCCESS (0.143s) [96.260659] [015/162] (949s left) gem_close_race (basic-threads) [96.552103] Starting subtest: basic-threads [97.726651] Subtest basic-threads: SUCCESS (1.182s) [98.028455] [016/162] (947s left) gem_ctx_create (basic) [98.301842] Starting subtest: basic [98.304946] Subtest basic: SUCCESS (0.000s) [98.618993] [017/162] (947s left) gem_ctx_create (basic-files) [98.895225] Starting subtest: basic-files [100.964639] Subtest basic-files: SUCCESS (2.079s) [101.350534] [018/162] (944s left) gem_ctx_exec (basic) [101.583883] Starting subtest: basic [101.606937] Subtest basic: SUCCESS (0.018s) [101.805440] [019/162] (944s left) gem_exec_basic (basic) [102.069227] Starting subtest: basic [102.072767] Starting dynamic subtest: rcs0-smem [102.075571] Dynamic subtest rcs0-smem: SUCCESS (0.008s) [102.105815] Starting dynamic subtest: bcs0-smem [102.107646] Dynamic subtest bcs0-smem: SUCCESS (0.006s) [102.134413] Starting dynamic subtest: vcs0-smem [102.136107] Dynamic subtest vcs0-smem: SUCCESS (0.008s) [102.163699] Starting dynamic subtest: vecs0-smem [102.165360] Dynamic subtest vecs0-smem: SUCCESS (0.006s) [102.167145] Subtest basic: SUCCESS (0.041s) [102.415814] [020/162] (944s left) gem_exec_create (basic) [102.685397] Starting subtest: basic [102.690108] Starting dynamic subtest: smem [104.784510] Dynamic subtest smem: SUCCESS (2.097s) [104.786682] Subtest basic: SUCCESS (2.099s) [105.087808] [021/162] (941s left) gem_exec_fence (basic-busy) [105.525559] Starting subtest: basic-busy [105.530713] Starting dynamic subtest: rcs0 [105.565457] Dynamic subtest rcs0: SUCCESS (0.041s) [105.613769] Starting dynamic subtest: bcs0 [105.617053] Dynamic subtest bcs0: SUCCESS (0.038s) [105.651442] Starting dynamic subtest: vcs0 [105.655724] Dynamic subtest vcs0: SUCCESS (0.026s) [105.683248] Starting dynamic subtest: vecs0 [105.686293] Dynamic subtest vecs0: SUCCESS (0.027s) [105.687865] Subtest basic-busy: SUCCESS (0.139s) [106.645178] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [106.655668] [022/162] (940s left) gem_exec_fence (basic-wait) [107.079719] Starting subtest: basic-wait [107.086177] Starting dynamic subtest: rcs0 [107.110575] Dynamic subtest rcs0: SUCCESS (0.030s) [107.144889] Starting dynamic subtest: bcs0 [107.149799] Dynamic subtest bcs0: SUCCESS (0.037s) [107.178431] Starting dynamic subtest: vcs0 [107.183785] Dynamic subtest vcs0: SUCCESS (0.034s) [107.220094] Starting dynamic subtest: vecs0 [107.221669] Dynamic subtest vecs0: SUCCESS (0.029s) [107.223425] Subtest basic-wait: SUCCESS (0.140s) [108.022564] [023/162] (939s left) gem_exec_fence (basic-await) [108.465218] Starting subtest: basic-await [108.469146] Starting dynamic subtest: rcs0 [108.666235] Dynamic subtest rcs0: SUCCESS (0.199s) [108.703892] Starting dynamic subtest: bcs0 [108.863949] Dynamic subtest bcs0: SUCCESS (0.188s) [108.902705] Starting dynamic subtest: vcs0 [109.058108] Dynamic subtest vcs0: SUCCESS (0.196s) [109.094182] Starting dynamic subtest: vecs0 [109.246875] Dynamic subtest vecs0: SUCCESS (0.185s) [109.248813] Subtest basic-await: SUCCESS (0.787s) [110.078793] [024/162] (937s left) gem_exec_fence (nb-await) [110.513419] Starting subtest: nb-await [110.517480] Starting dynamic subtest: rcs0 [110.617231] Dynamic subtest rcs0: SUCCESS (0.100s) [110.656562] Starting dynamic subtest: bcs0 [110.705499] Dynamic subtest bcs0: SUCCESS (0.084s) [110.743921] Starting dynamic subtest: vcs0 [110.793227] Dynamic subtest vcs0: SUCCESS (0.086s) [110.832107] Starting dynamic subtest: vecs0 [110.884752] Dynamic subtest vecs0: SUCCESS (0.091s) [110.886832] Subtest nb-await: SUCCESS (0.372s) [111.683200] [025/162] (935s left) gem_exec_gttfill (basic) [111.956166] Starting subtest: basic [145.227273] Subtest basic: SUCCESS (33.269s) [145.599980] [026/162] (902s left) gem_exec_parallel (engines) [146.098252] Starting subtest: engines [146.104205] Starting dynamic subtest: basic [153.426302] Dynamic subtest basic: SUCCESS (7.330s) [153.460994] Starting dynamic subtest: contexts [164.793135] Dynamic subtest contexts: SUCCESS (11.362s) [164.830373] Starting dynamic subtest: fds [177.459861] Dynamic subtest fds: SUCCESS (12.667s) [177.500713] Starting dynamic subtest: userptr [184.632242] Dynamic subtest userptr: SUCCESS (7.163s) [184.634396] Subtest engines: SUCCESS (38.539s) [185.005900] [027/162] (863s left) gem_exec_store (basic) [185.283152] Starting subtest: basic [185.364571] Subtest basic: SUCCESS (0.080s) [185.710688] [028/162] (862s left) gem_flink_basic (bad-flink) [185.939780] Starting subtest: bad-flink [185.945364] Subtest bad-flink: SUCCESS (0.000s) [186.161637] [029/162] (862s left) gem_flink_basic (bad-open) [186.392245] Starting subtest: bad-open [186.395119] Subtest bad-open: SUCCESS (0.000s) [186.612321] [030/162] (862s left) gem_flink_basic (basic) [186.851991] Starting subtest: basic [186.855306] Subtest basic: SUCCESS (0.000s) [187.086420] [031/162] (861s left) gem_flink_basic (double-flink) [187.330672] Starting subtest: double-flink [187.338508] Subtest double-flink: SUCCESS (0.002s) [187.574636] [032/162] (861s left) gem_flink_basic (flink-lifetime) [187.790181] Starting subtest: flink-lifetime [187.798238] Subtest flink-lifetime: SUCCESS (0.009s) [188.012619] [033/162] (861s left) gem_huc_copy (huc-copy) [188.268939] Subtest huc-copy: SKIP (0.000s) [188.476493] [034/162] (861s left) gem_linear_blits (basic) [189.031420] Starting subtest: basic [189.084044] Subtest basic: SUCCESS (0.053s) [189.328976] [035/162] (860s left) gem_mmap (basic) [189.725807] Starting subtest: basic [189.746201] Subtest basic: SUCCESS (0.001s) [189.951194] [036/162] (860s left) gem_mmap_gtt (basic) [190.176197] Starting subtest: basic [190.183023] Subtest basic: SUCCESS (0.005s) [190.393275] [037/162] (859s left) gem_render_linear_blits (basic) [190.633686] Starting subtest: basic [190.760868] Subtest basic: SUCCESS (0.121s) [190.971819] [038/162] (859s left) gem_render_tiled_blits (basic) [191.210267] Starting subtest: basic [191.444874] Subtest basic: SUCCESS (0.225s) [191.663056] [039/162] (858s left) gem_ringfill (basic-all) [192.189271] Starting subtest: basic-all [193.514488] Subtest basic-all: SUCCESS (1.331s) [193.726502] [040/162] (857s left) gem_softpin (allocator-basic) [193.974817] Starting subtest: allocator-basic [194.413103] Subtest allocator-basic: SUCCESS (0.425s) [194.673172] [041/162] (856s left) gem_softpin (allocator-basic-reserve) [194.905217] Starting subtest: allocator-basic-reserve [195.332903] Subtest allocator-basic-reserve: SUCCESS (0.425s) [195.621249] [042/162] (855s left) gem_softpin (safe-alignment) [195.870804] Starting subtest: safe-alignment [195.931993] Subtest safe-alignment: SUCCESS (0.057s) [196.153324] [043/162] (855s left) gem_sync (basic-all) [196.430911] Starting subtest: basic-all [199.893404] Subtest basic-all: SUCCESS (3.458s) [200.236632] [044/162] (851s left) gem_sync (basic-each) [200.528248] Starting subtest: basic-each [203.569268] Subtest basic-each: SUCCESS (3.037s) [203.911116] [045/162] (847s left) gem_tiled_blits (basic) [204.376975] Starting subtest: basic [204.455550] Subtest basic: SUCCESS (0.086s) [204.701856] [046/162] (847s left) gem_tiled_fence_blits (basic) [205.354287] Starting subtest: basic [205.430903] Subtest basic: SUCCESS (0.070s) [205.649526] [047/162] (846s left) gem_tiled_pread_basic (basic) [206.036282] Starting subtest: basic [207.175213] Subtest basic: SUCCESS (1.139s) [207.387830] [048/162] (845s left) gem_wait (busy@all-engines) [207.697318] Starting subtest: busy [207.702675] Starting dynamic subtest: all-engines [208.239170] Dynamic subtest all-engines: SUCCESS (0.540s) [208.241206] Subtest busy: SUCCESS (0.542s) [208.641337] [049/162] (844s left) gem_wait (wait@all-engines) [208.941301] Starting subtest: wait [208.943445] Starting dynamic subtest: all-engines [209.996208] Dynamic subtest all-engines: SUCCESS (1.052s) [209.998082] Subtest wait: SUCCESS (1.058s) [210.416480] [050/162] (842s left) i915_getparams_basic (basic-eu-total) [210.639590] Starting subtest: basic-eu-total [210.647604] Subtest basic-eu-total: SUCCESS (0.000s) [210.850138] [051/162] (842s left) i915_getparams_basic (basic-subslice-total) [211.072386] Starting subtest: basic-subslice-total [211.079788] Subtest basic-subslice-total: SUCCESS (0.000s) [211.281647] [052/162] (842s left) i915_hangman (error-state-basic) [211.552406] Starting subtest: error-state-basic [211.613725] Subtest error-state-basic: SUCCESS (0.056s) [211.870424] [053/162] (841s left) i915_pciid [212.337313] [054/162] (841s left) intel_hwmon (hwmon-read) [212.554204] Subtest hwmon-read: SKIP (0.000s) [212.756938] [055/162] (841s left) intel_hwmon (hwmon-write) [212.990799] Subtest hwmon-write: SKIP (0.000s) [213.194135] [056/162] (841s left) kms_addfb_basic (addfb25-4-tiled) [213.794924] Starting subtest: addfb25-4-tiled [213.797518] Subtest addfb25-4-tiled: SUCCESS (0.001s) [214.012453] [057/162] (840s left) kms_addfb_basic (addfb25-bad-modifier) [214.630369] Starting subtest: addfb25-bad-modifier [214.635682] Subtest addfb25-bad-modifier: SUCCESS (0.002s) [214.853673] [058/162] (839s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [215.420476] Starting subtest: addfb25-framebuffer-vs-set-tiling [215.422921] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [215.637050] [059/162] (839s left) kms_addfb_basic (addfb25-modifier-no-flag) [216.188233] Starting subtest: addfb25-modifier-no-flag [216.192898] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [216.407059] [060/162] (838s left) kms_addfb_basic (addfb25-x-tiled-legacy) [217.022426] Starting subtest: addfb25-x-tiled-legacy [217.024613] Subtest addfb25-x-tiled-legacy: SUCCESS (0.002s) [217.256325] [061/162] (837s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [217.881701] Starting subtest: addfb25-x-tiled-mismatch-legacy [217.884992] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s) [218.099806] [062/162] (837s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [218.727946] Starting subtest: addfb25-yf-tiled-legacy [218.732128] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s) [218.936926] [063/162] (836s left) kms_addfb_basic (addfb25-y-tiled-legacy) [219.533439] Starting subtest: addfb25-y-tiled-legacy [219.537231] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s) [219.768967] [064/162] (836s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [220.314132] Starting subtest: addfb25-y-tiled-small-legacy [220.325203] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [220.703110] [065/162] (835s left) kms_addfb_basic (bad-pitch-0) [220.962728] Starting subtest: bad-pitch-0 [220.966754] Subtest bad-pitch-0: SUCCESS (0.000s) [221.823606] [066/162] (834s left) kms_addfb_basic (bad-pitch-1024) [222.053255] Starting subtest: bad-pitch-1024 [222.056143] Subtest bad-pitch-1024: SUCCESS (0.000s) [222.614891] [067/162] (834s left) kms_addfb_basic (bad-pitch-128) [222.838326] Starting subtest: bad-pitch-128 [222.841795] Subtest bad-pitch-128: SUCCESS (0.000s) [223.390276] [068/162] (833s left) kms_addfb_basic (bad-pitch-256) [223.622265] Starting subtest: bad-pitch-256 [223.624310] Subtest bad-pitch-256: SUCCESS (0.000s) [224.185320] [069/162] (833s left) kms_addfb_basic (bad-pitch-32) [224.415309] Starting subtest: bad-pitch-32 [224.417595] Subtest bad-pitch-32: SUCCESS (0.000s) [224.937503] [070/162] (832s left) kms_addfb_basic (bad-pitch-63) [225.164898] Starting subtest: bad-pitch-63 [225.167247] Subtest bad-pitch-63: SUCCESS (0.000s) [225.755462] [071/162] (831s left) kms_addfb_basic (bad-pitch-65536) [225.987236] Starting subtest: bad-pitch-65536 [225.990298] Subtest bad-pitch-65536: SUCCESS (0.001s) [226.545717] [072/162] (831s left) kms_addfb_basic (bad-pitch-999) [226.774192] Starting subtest: bad-pitch-999 [226.776435] Subtest bad-pitch-999: SUCCESS (0.000s) [227.388404] [073/162] (830s left) kms_addfb_basic (basic) [227.620111] Starting subtest: basic [227.623246] Subtest basic: SUCCESS (0.000s) [228.160171] [074/162] (830s left) kms_addfb_basic (basic-x-tiled-legacy) [228.390866] Starting subtest: basic-x-tiled-legacy [228.395679] Subtest basic-x-tiled-legacy: SUCCESS (0.004s) [228.975734] [075/162] (829s left) kms_addfb_basic (basic-y-tiled-legacy) [229.209248] Starting subtest: basic-y-tiled-legacy [229.212439] Subtest basic-y-tiled-legacy: SUCCESS (0.002s) [229.713848] [076/162] (828s left) kms_addfb_basic (bo-too-small) [230.324668] Starting subtest: bo-too-small [230.328517] Subtest bo-too-small: SUCCESS (0.001s) [230.545570] [077/162] (828s left) kms_addfb_basic (bo-too-small-due-to-tiling) [231.093272] Starting subtest: bo-too-small-due-to-tiling [231.098154] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [231.310865] [078/162] (827s left) kms_addfb_basic (clobberred-modifier) [231.549488] Starting subtest: clobberred-modifier [231.551463] Subtest clobberred-modifier: SUCCESS (0.000s) [232.070481] [079/162] (827s left) kms_addfb_basic (framebuffer-vs-set-tiling) [232.402946] Starting subtest: framebuffer-vs-set-tiling [232.426886] Subtest framebuffer-vs-set-tiling: SUCCESS (0.017s) [233.307250] [080/162] (826s left) kms_addfb_basic (invalid-get-prop) [233.864802] Starting subtest: invalid-get-prop [233.867380] Subtest invalid-get-prop: SUCCESS (0.000s) [234.861230] [081/162] (825s left) kms_addfb_basic (invalid-get-prop-any) [235.172194] Starting subtest: invalid-get-prop-any [235.176286] Subtest invalid-get-prop-any: SUCCESS (0.000s) [235.883077] [082/162] (824s left) kms_addfb_basic (invalid-set-prop) [236.128164] Starting subtest: invalid-set-prop [236.130203] Subtest invalid-set-prop: SUCCESS (0.000s) [236.644682] [083/162] (823s left) kms_addfb_basic (invalid-set-prop-any) [236.862144] Starting subtest: invalid-set-prop-any [236.864284] Subtest invalid-set-prop-any: SUCCESS (0.000s) [237.417511] [084/162] (823s left) kms_addfb_basic (no-handle) [237.637335] Starting subtest: no-handle [237.640475] Subtest no-handle: SUCCESS (0.000s) [238.238833] [085/162] (822s left) kms_addfb_basic (size-max) [238.802213] Starting subtest: size-max [238.806501] Subtest size-max: SUCCESS (0.001s) [239.023906] [086/162] (822s left) kms_addfb_basic (small-bo) [239.569512] Starting subtest: small-bo [239.571993] Subtest small-bo: SUCCESS (0.000s) [239.781737] [087/162] (821s left) kms_addfb_basic (tile-pitch-mismatch) [240.007622] Starting subtest: tile-pitch-mismatch [240.011201] Subtest tile-pitch-mismatch: SUCCESS (0.002s) [240.526843] [088/162] (821s left) kms_addfb_basic (too-high) [241.069180] Starting subtest: too-high [241.075827] Subtest too-high: SUCCESS (0.007s) [241.293422] [089/162] (820s left) kms_addfb_basic (too-wide) [241.886175] Starting subtest: too-wide [241.888206] Subtest too-wide: SUCCESS (0.000s) [242.107823] [090/162] (819s left) kms_addfb_basic (unused-handle) [242.347212] Starting subtest: unused-handle [242.349590] Subtest unused-handle: SUCCESS (0.000s) [242.910386] [091/162] (819s left) kms_addfb_basic (unused-modifier) [243.126896] Starting subtest: unused-modifier [243.130373] Subtest unused-modifier: SUCCESS (0.000s) [243.637714] [092/162] (818s left) kms_addfb_basic (unused-offsets) [243.870488] Starting subtest: unused-offsets [243.875237] Subtest unused-offsets: SUCCESS (0.001s) [244.399827] [093/162] (818s left) kms_addfb_basic (unused-pitches) [244.635422] Starting subtest: unused-pitches [244.638245] Subtest unused-pitches: SUCCESS (0.000s) [245.198044] [094/162] (817s left) kms_busy (basic) [245.795529] Subtest basic: SKIP (0.000s) [246.009618] [095/162] (817s left) kms_prop_blob (basic) [246.238502] Starting subtest: basic [246.241237] Subtest basic: SUCCESS (0.000s) [246.445841] [096/162] (816s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [247.043462] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [247.260181] [097/162] (816s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [247.846734] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [248.049136] [098/162] (815s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [248.636329] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [248.838420] [099/162] (815s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [249.383388] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [249.567738] [100/162] (814s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [250.175659] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [250.376771] [101/162] (813s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [250.978230] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [251.176455] [102/162] (813s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [251.783339] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [251.978373] [103/162] (812s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [252.559446] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [252.761899] [104/162] (812s left) kms_dsc (dsc-basic) [253.312200] Subtest dsc-basic: SKIP (0.000s) [253.522966] [105/162] (811s left) kms_flip (basic-flip-vs-dpms) [254.060247] Starting subtest: basic-flip-vs-dpms [254.080220] Subtest basic-flip-vs-dpms: SKIP (0.007s) [254.345419] [106/162] (811s left) kms_flip (basic-flip-vs-modeset) [254.890854] Starting subtest: basic-flip-vs-modeset [254.901092] Subtest basic-flip-vs-modeset: SKIP (0.006s) [255.164357] [107/162] (810s left) kms_flip (basic-flip-vs-wf_vblank) [255.766223] Starting subtest: basic-flip-vs-wf_vblank [255.776188] Subtest basic-flip-vs-wf_vblank: SKIP (0.008s) [256.054354] [108/162] (809s left) kms_flip (basic-plain-flip) [256.620155] Starting subtest: basic-plain-flip [256.629082] Subtest basic-plain-flip: SKIP (0.007s) [256.893721] [109/162] (809s left) kms_force_connector_basic (force-connector-state) [257.261168] Starting subtest: force-connector-state [257.961096] Subtest force-connector-state: SUCCESS (0.693s) [259.088270] [110/162] (807s left) kms_force_connector_basic (force-edid) [259.452451] Starting subtest: force-edid [259.679598] Subtest force-edid: SUCCESS (0.216s) [260.363234] [111/162] (806s left) kms_force_connector_basic (force-load-detect) [260.707402] Starting subtest: force-load-detect [260.715699] Subtest force-load-detect: SKIP (0.000s) [261.183575] [112/162] (805s left) kms_force_connector_basic (prune-stale-modes) [261.564390] Starting subtest: prune-stale-modes [261.911166] Subtest prune-stale-modes: SUCCESS (0.354s) [262.669489] [113/162] (804s left) kms_frontbuffer_tracking (basic) [263.261215] Subtest basic: SKIP (0.000s) [263.485892] [114/162] (803s left) kms_hdmi_inject (inject-audio) [263.739742] Starting subtest: inject-audio [264.260761] Subtest inject-audio: SUCCESS (0.528s) [264.780744] [115/162] (802s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [265.363900] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [265.583756] [116/162] (802s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [266.158760] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [266.371794] [117/162] (801s left) kms_pipe_crc_basic (hang-read-crc) [267.007711] Subtest hang-read-crc: SKIP (0.000s) [267.232275] [118/162] (800s left) kms_pipe_crc_basic (nonblocking-crc) [267.849836] Subtest nonblocking-crc: SKIP (0.000s) [268.082414] [119/162] (800s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [268.674835] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [268.896831] [120/162] (799s left) kms_pipe_crc_basic (read-crc) [269.457648] Subtest read-crc: SKIP (0.000s) [269.693589] [121/162] (798s left) kms_pipe_crc_basic (read-crc-frame-sequence) [270.248907] Subtest read-crc-frame-sequence: SKIP (0.000s) [270.480262] [122/162] (798s left) kms_pm_backlight (basic-brightness) [271.011216] Subtest basic-brightness: SKIP (0.000s) [271.232751] [123/162] (797s left) kms_pm_rpm (basic-pci-d3-state) [273.120097] Starting subtest: basic-pci-d3-state [273.340101] Subtest basic-pci-d3-state: SUCCESS (0.217s) [273.559799] [124/162] (795s left) kms_pm_rpm (basic-rte) [273.782220] Starting subtest: basic-rte [275.617724] Subtest basic-rte: SUCCESS (1.829s) [276.078422] [125/162] (793s left) kms_psr (psr-primary-page-flip) [276.639776] Subtest psr-primary-page-flip: SKIP (0.000s) [276.867628] [126/162] (792s left) kms_psr (psr-cursor-plane-move) [277.491171] Subtest psr-cursor-plane-move: SKIP (0.000s) [277.716928] [127/162] (792s left) kms_psr (psr-sprite-plane-onoff) [278.288419] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [278.511435] [128/162] (791s left) kms_psr (psr-primary-mmap-gtt) [279.077965] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [279.302466] [129/162] (791s left) kms_setmode (basic-clone-single-crtc) [279.547157] Starting subtest: basic-clone-single-crtc [279.562043] Subtest basic-clone-single-crtc: SKIP (0.001s) [279.785717] [130/162] (790s left) i915_pm_rps (basic-api) [280.058893] Starting subtest: basic-api [280.086346] Subtest basic-api: SUCCESS (0.020s) [280.316616] [131/162] (790s left) prime_self_import (basic-llseek-bad) [280.538184] Starting subtest: basic-llseek-bad [280.550223] Subtest basic-llseek-bad: SUCCESS (0.012s) [280.784988] [132/162] (790s left) prime_self_import (basic-llseek-size) [280.995810] Starting subtest: basic-llseek-size [281.017929] Subtest basic-llseek-size: SUCCESS (0.022s) [281.252744] [133/162] (789s left) prime_self_import (basic-with_fd_dup) [281.471279] Starting subtest: basic-with_fd_dup [281.483240] Subtest basic-with_fd_dup: SUCCESS (0.020s) [281.733450] [134/162] (789s left) prime_self_import (basic-with_one_bo) [281.960270] Starting subtest: basic-with_one_bo [281.973213] Subtest basic-with_one_bo: SUCCESS (0.018s) [282.216371] [135/162] (789s left) prime_self_import (basic-with_one_bo_two_files) [282.448825] Starting subtest: basic-with_one_bo_two_files [282.461708] Subtest basic-with_one_bo_two_files: SUCCESS (0.022s) [282.702240] [136/162] (789s left) prime_self_import (basic-with_two_bos) [282.913026] Starting subtest: basic-with_two_bos [282.927679] Subtest basic-with_two_bos: SUCCESS (0.016s) [283.159569] [137/162] (788s left) prime_vgem (basic-fence-flip) [283.433663] Starting subtest: basic-fence-flip [283.758415] Subtest basic-fence-flip: SKIP (0.325s) [283.999405] [138/162] (788s left) prime_vgem (basic-fence-mmap) [284.263182] Starting subtest: basic-fence-mmap [284.392876] Subtest basic-fence-mmap: SUCCESS (0.132s) [284.665520] [139/162] (787s left) prime_vgem (basic-fence-read) [284.933337] Starting subtest: basic-fence-read [285.286899] Subtest basic-fence-read: SUCCESS (0.355s) [285.538853] [140/162] (787s left) prime_vgem (basic-gtt) [285.806268] Starting subtest: basic-gtt [285.875755] Subtest basic-gtt: SUCCESS (0.062s) [286.120920] [141/162] (786s left) prime_vgem (basic-read) [286.377451] Starting subtest: basic-read [286.512637] Subtest basic-read: SUCCESS (0.131s) [286.749709] [142/162] (786s left) prime_vgem (basic-write) [287.001309] Starting subtest: basic-write [287.174253] Subtest basic-write: SUCCESS (0.172s) [287.403701] [143/162] (785s left) vgem_basic (setversion) [287.638152] Starting subtest: setversion [287.646237] Subtest setversion: SUCCESS (0.000s) [287.851259] [144/162] (785s left) vgem_basic (create) [288.078319] Starting subtest: create [288.080244] Subtest create: SUCCESS (0.001s) [288.296991] [145/162] (785s left) vgem_basic (debugfs) [288.529502] Starting subtest: debugfs [288.534352] Subtest debugfs: SUCCESS (0.002s) [288.751565] [146/162] (785s left) vgem_basic (dmabuf-export) [288.972731] Starting subtest: dmabuf-export [288.987383] Subtest dmabuf-export: SUCCESS (0.012s) [289.212194] [147/162] (784s left) vgem_basic (dmabuf-fence) [289.456370] Starting subtest: dmabuf-fence [289.461332] Subtest dmabuf-fence: SUCCESS (0.005s) [289.678979] [148/162] (784s left) vgem_basic (dmabuf-fence-before) [289.917159] Starting subtest: dmabuf-fence-before [289.919693] Subtest dmabuf-fence-before: SUCCESS (0.002s) [290.141260] [149/162] (784s left) vgem_basic (dmabuf-mmap) [290.378669] Starting subtest: dmabuf-mmap [290.421224] Subtest dmabuf-mmap: SUCCESS (0.049s) [290.649807] [150/162] (784s left) vgem_basic (mmap) [290.884279] Starting subtest: mmap [290.910811] Subtest mmap: SUCCESS (0.033s) [291.131735] [151/162] (783s left) vgem_basic (second-client) [291.373204] Starting subtest: second-client [291.404173] Subtest second-client: SUCCESS (0.027s) [291.628752] [152/162] (783s left) vgem_basic (sysfs) [291.859891] Starting subtest: sysfs [291.864735] Subtest sysfs: SUCCESS (0.004s) [292.091258] [153/162] (783s left) core_hotunplug (unbind-rebind) [292.530617] Starting subtest: unbind-rebind [298.161403] Subtest unbind-rebind: SUCCESS (5.630s) [298.384950] [154/162] (777s left) vgem_basic (unload) [298.612203] Starting subtest: unload [327.819757] Subtest unload: SUCCESS (29.208s) [328.176740] [155/162] (747s left) i915_module_load (reload) [328.389407] Starting subtest: reload [336.032411] Subtest reload: SUCCESS (7.627s) [336.396284] [156/162] (739s left) gem_lmem_swapping (basic) [336.699900] Subtest basic: SKIP (0.000s) [336.905701] [157/162] (739s left) gem_lmem_swapping (parallel-random-engines) [337.156859] Subtest parallel-random-engines: SKIP (0.000s) [337.392262] [158/162] (739s left) gem_lmem_swapping (random-engines) [337.646116] Subtest random-engines: SKIP (0.000s) [337.862665] [159/162] (739s left) gem_lmem_swapping (verify-random) [338.114168] Subtest verify-random: SKIP (0.000s) [338.326233] [160/162] (738s left) i915_pm_rpm (module-reload) [340.150727] Starting subtest: module-reload [359.352289] Subtest module-reload: SUCCESS (19.203s) [359.497913] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [359.503855] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [359.510588] [161/162] (717s left) i915_selftest (live) [359.757642] Starting subtest: live [359.762337] Starting dynamic subtest: sanitycheck [365.671476] Dynamic subtest sanitycheck: SUCCESS (5.908s) [365.707494] Starting dynamic subtest: uncore [371.611934] Dynamic subtest uncore: SUCCESS (5.934s) [371.699246] Starting dynamic subtest: workarounds [378.023099] Dynamic subtest workarounds: SUCCESS (6.400s) [378.057261] Starting dynamic subtest: gt_engines [384.667384] Dynamic subtest gt_engines: SUCCESS (6.641s) [384.702811] Starting dynamic subtest: gt_timelines [422.898556] Dynamic subtest gt_timelines: SUCCESS (38.221s) [422.932531] Starting dynamic subtest: gt_contexts [429.355427] Dynamic subtest gt_contexts: SUCCESS (6.450s) [429.387877] Starting dynamic subtest: gt_lrc [439.127114] Dynamic subtest gt_lrc: SUCCESS (9.767s) [439.164916] Starting dynamic subtest: gt_mocs [445.343061] Dynamic subtest gt_mocs: SUCCESS (6.211s) [445.380239] Starting dynamic subtest: gt_pm [452.553052] Dynamic subtest gt_pm: SUCCESS (7.204s) [452.591872] Starting dynamic subtest: gt_heartbeat [458.258248] Dynamic subtest gt_heartbeat: SUCCESS (5.697s) [458.332457] Starting dynamic subtest: gt_tlb [465.129206] Dynamic subtest gt_tlb: SUCCESS (6.856s) [465.166041] Starting dynamic subtest: requests [477.899286] Dynamic subtest requests: SUCCESS (12.764s) [477.940674] Starting dynamic subtest: migrate [488.463244] Dynamic subtest migrate: SUCCESS (10.553s) [488.503167] Starting dynamic subtest: active [494.407146] Dynamic subtest active: SUCCESS (5.935s) [494.483483] Starting dynamic subtest: objects [502.161621] Dynamic subtest objects: SUCCESS (7.754s) [502.199693] Starting dynamic subtest: mman [515.169988] Dynamic subtest mman: SUCCESS (13.002s) [515.206721] Starting dynamic subtest: dmabuf [521.600139] Dynamic subtest dmabuf: SUCCESS (6.418s) [521.635075] Starting dynamic subtest: vma [527.550995] Dynamic subtest vma: SUCCESS (5.948s) [527.593933] Starting dynamic subtest: coherency [539.335047] Dynamic subtest coherency: SUCCESS (11.773s) [539.374886] Starting dynamic subtest: gtt [553.492786] Dynamic subtest gtt: SUCCESS (14.151s) [553.530754] Starting dynamic subtest: gem [560.677613] Dynamic subtest gem: SUCCESS (7.174s) [560.713518] Starting dynamic subtest: evict [575.127160] Dynamic subtest evict: SUCCESS (14.445s) [575.170303] Starting dynamic subtest: hugepages [581.422292] Dynamic subtest hugepages: SUCCESS (6.287s) [581.465480] Starting dynamic subtest: gem_contexts [615.950923] Dynamic subtest gem_contexts: SUCCESS (34.523s) [615.998872] Starting dynamic subtest: client [621.980604] Dynamic subtest client: SUCCESS (6.022s) [622.020374] Starting dynamic subtest: gem_migrate [628.127110] Dynamic subtest gem_migrate: SUCCESS (6.133s) [628.161503] Starting dynamic subtest: reset [642.663067] Dynamic subtest reset: SUCCESS (14.528s) [642.696304] Starting dynamic subtest: memory_region [648.658232] Dynamic subtest memory_region: SUCCESS (5.984s) [648.794406] Starting dynamic subtest: hangcheck [678.309417] Dynamic subtest hangcheck: SUCCESS (29.650s) [678.351916] Starting dynamic subtest: execlists [690.740447] Dynamic subtest execlists: SUCCESS (12.422s) [690.780722] Starting dynamic subtest: ring_submission [697.149161] Dynamic subtest ring_submission: SUCCESS (6.399s) [697.281803] Starting dynamic subtest: perf [703.855404] Dynamic subtest perf: SUCCESS (6.687s) [703.896579] Starting dynamic subtest: slpc [709.845295] Dynamic subtest slpc: SUCCESS (5.973s) [709.883834] Starting dynamic subtest: guc [715.635084] Dynamic subtest guc: SUCCESS (5.782s) [715.689378] Starting dynamic subtest: guc_multi_lrc [721.835346] Dynamic subtest guc_multi_lrc: SUCCESS (6.191s) [721.873109] Starting dynamic subtest: guc_hang [727.738407] Dynamic subtest guc_hang: SUCCESS (5.893s) [727.828275] Starting dynamic subtest: late_gt_pm [733.825273] Dynamic subtest late_gt_pm: SUCCESS (6.075s) [733.853518] Subtest live: SUCCESS (374.074s) [734.027471] [162/162] (343s left) dmabuf (all-tests) [734.263810] Starting subtest: all-tests [734.267287] Starting dynamic subtest: sanitycheck [734.320591] Dynamic subtest sanitycheck: SUCCESS (0.057s) [734.387153] Starting dynamic subtest: dma_fence [734.513783] Dynamic subtest dma_fence: SUCCESS (0.185s) [734.587813] Starting dynamic subtest: dma_fence_chain [734.590885] Dynamic subtest dma_fence_chain: SKIP (0.001s) [734.652767] Starting dynamic subtest: dma_fence_unwrap [734.654502] Dynamic subtest dma_fence_unwrap: SUCCESS (0.062s) [734.691676] Starting dynamic subtest: dma_resv [734.693382] Dynamic subtest dma_resv: SUCCESS (0.064s) [734.694897] Subtest all-tests: SUCCESS (0.409s) [734.826698] 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.