[21.326997] Initializing watchdogs [21.327131] /dev/watchdog0 [21.341703] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:591d Intel Kabylake (Gen9) HD Graphics P630 [21.348844] [001/162] (960s left) i915_module_load (load) [21.414741] Starting subtest: load [23.390865] Subtest load: SUCCESS (1.976s) [23.426879] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [23.428144] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [23.507285] [002/162] (958s left) core_auth (basic-auth) [24.024952] Starting subtest: basic-auth [24.089724] Subtest basic-auth: SUCCESS (0.002s) [24.474854] [003/162] (958s left) core_debugfs (read-all-entries) [24.874041] Starting subtest: read-all-entries [24.878105] Subtest read-all-entries: SUCCESS (0.004s) [24.915993] [004/162] (957s left) core_sysfs (read-all-entries) [24.965222] Starting subtest: read-all-entries [24.968644] Subtest read-all-entries: SUCCESS (0.003s) [25.008781] [005/162] (957s left) fbdev (eof) [25.065937] Subtest eof: SKIP (0.000s) [25.103813] [006/162] (957s left) fbdev (info) [25.160383] Subtest info: SKIP (0.000s) [25.199139] [007/162] (957s left) fbdev (nullptr) [25.254385] Subtest nullptr: SKIP (0.000s) [25.295099] [008/162] (957s left) fbdev (read) [25.347265] Subtest read: SKIP (0.000s) [25.387280] [009/162] (957s left) fbdev (write) [25.437950] Subtest write: SKIP (0.000s) [25.476053] [010/162] (957s left) gem_basic (bad-close) [25.525369] Starting subtest: bad-close [25.531765] Subtest bad-close: SUCCESS (0.000s) [25.570535] [011/162] (957s left) gem_basic (create-close) [25.619525] Starting subtest: create-close [25.625823] Subtest create-close: SUCCESS (0.000s) [25.683324] [012/162] (957s left) gem_basic (create-fd-close) [25.732465] Starting subtest: create-fd-close [25.738491] Subtest create-fd-close: SUCCESS (0.000s) [25.791928] [013/162] (957s left) gem_busy (busy@all-engines) [25.853699] Starting subtest: busy [25.856754] Starting dynamic subtest: all-engines [25.881285] Dynamic subtest all-engines: SUCCESS (0.027s) [25.884493] Subtest busy: SUCCESS (0.027s) [26.200421] [014/162] (956s left) gem_close_race (basic-process) [26.261542] Starting subtest: basic-process [26.314527] Subtest basic-process: SUCCESS (0.053s) [26.463705] [015/162] (956s left) gem_close_race (basic-threads) [26.521478] Starting subtest: basic-threads [27.789467] Subtest basic-threads: SUCCESS (1.268s) [27.943202] [016/162] (955s left) gem_ctx_create (basic) [28.001705] Starting subtest: basic [28.004988] Subtest basic: SUCCESS (0.000s) [28.148734] [017/162] (954s left) gem_ctx_create (basic-files) [28.207291] Starting subtest: basic-files [30.218843] Subtest basic-files: SUCCESS (2.011s) [30.411408] [018/162] (952s left) gem_ctx_exec (basic) [30.463946] Starting subtest: basic [30.467063] Subtest basic: SUCCESS (0.005s) [30.536277] [019/162] (952s left) gem_exec_basic (basic) [30.588246] Starting subtest: basic [30.591572] Starting dynamic subtest: rcs0-smem [30.594898] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [30.605699] Starting dynamic subtest: bcs0-smem [30.608902] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [30.619888] Starting dynamic subtest: vcs0-smem [30.623130] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [30.633968] Starting dynamic subtest: vecs0-smem [30.637110] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [30.640168] Subtest basic: SUCCESS (0.006s) [30.771666] [020/162] (952s left) gem_exec_create (basic) [30.830185] Starting subtest: basic [30.833328] Starting dynamic subtest: smem [32.867532] Dynamic subtest smem: SUCCESS (2.040s) [32.870815] Subtest basic: SUCCESS (2.040s) [33.015372] [021/162] (950s left) gem_exec_fence (basic-busy) [33.192424] Starting subtest: basic-busy [33.195884] Starting dynamic subtest: rcs0 [33.225235] Dynamic subtest rcs0: SUCCESS (0.036s) [33.237534] Starting dynamic subtest: bcs0 [33.255172] Dynamic subtest bcs0: SUCCESS (0.030s) [33.265795] Starting dynamic subtest: vcs0 [33.284178] Dynamic subtest vcs0: SUCCESS (0.029s) [33.296876] Starting dynamic subtest: vecs0 [33.322489] Dynamic subtest vecs0: SUCCESS (0.038s) [33.325738] Subtest basic-busy: SUCCESS (0.133s) [33.839489] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [33.843556] [022/162] (949s left) gem_exec_fence (basic-wait) [34.013937] Starting subtest: basic-wait [34.017265] Starting dynamic subtest: rcs0 [34.054412] Dynamic subtest rcs0: SUCCESS (0.040s) [34.075491] Starting dynamic subtest: bcs0 [34.090473] Dynamic subtest bcs0: SUCCESS (0.036s) [34.107714] Starting dynamic subtest: vcs0 [34.123155] Dynamic subtest vcs0: SUCCESS (0.032s) [34.134173] Starting dynamic subtest: vecs0 [34.155293] Dynamic subtest vecs0: SUCCESS (0.032s) [34.158483] Subtest basic-wait: SUCCESS (0.142s) [34.644142] [023/162] (948s left) gem_exec_fence (basic-await) [34.821296] Starting subtest: basic-await [34.825279] Starting dynamic subtest: rcs0 [34.900318] Dynamic subtest rcs0: SUCCESS (0.080s) [34.922251] Starting dynamic subtest: bcs0 [34.990144] Dynamic subtest bcs0: SUCCESS (0.089s) [35.008239] Starting dynamic subtest: vcs0 [35.076723] Dynamic subtest vcs0: SUCCESS (0.086s) [35.098329] Starting dynamic subtest: vecs0 [35.168358] Dynamic subtest vecs0: SUCCESS (0.091s) [35.171934] Subtest basic-await: SUCCESS (0.349s) [35.638835] [024/162] (947s left) gem_exec_fence (nb-await) [35.815179] Starting subtest: nb-await [35.818245] Starting dynamic subtest: rcs0 [35.880805] Dynamic subtest rcs0: SUCCESS (0.065s) [35.895007] Starting dynamic subtest: bcs0 [35.943324] Dynamic subtest bcs0: SUCCESS (0.062s) [35.965348] Starting dynamic subtest: vcs0 [36.009608] Dynamic subtest vcs0: SUCCESS (0.065s) [36.031877] Starting dynamic subtest: vecs0 [36.074882] Dynamic subtest vecs0: SUCCESS (0.065s) [36.078496] Subtest nb-await: SUCCESS (0.260s) [36.566055] [025/162] (946s left) gem_exec_gttfill (basic) [36.627500] Starting subtest: basic [39.747598] Subtest basic: SUCCESS (3.124s) [39.909925] [026/162] (943s left) gem_exec_parallel (engines) [40.041834] Starting subtest: engines [40.044980] Starting dynamic subtest: basic [41.735539] Dynamic subtest basic: SUCCESS (1.694s) [41.747550] Starting dynamic subtest: contexts [43.974093] Dynamic subtest contexts: SUCCESS (2.238s) [43.986671] Starting dynamic subtest: fds [46.192415] Dynamic subtest fds: SUCCESS (2.218s) [46.206076] Starting dynamic subtest: userptr [48.432715] Dynamic subtest userptr: SUCCESS (2.162s) [48.436154] Subtest engines: SUCCESS (8.313s) [48.608212] [027/162] (934s left) gem_exec_store (basic) [48.680589] Starting subtest: basic [48.735384] Subtest basic: SUCCESS (0.059s) [48.890304] [028/162] (934s left) gem_flink_basic (bad-flink) [48.942279] Starting subtest: bad-flink [48.945558] Subtest bad-flink: SUCCESS (0.000s) [48.991474] [029/162] (934s left) gem_flink_basic (bad-open) [49.038627] Starting subtest: bad-open [49.041887] Subtest bad-open: SUCCESS (0.000s) [49.087401] [030/162] (934s left) gem_flink_basic (basic) [49.140171] Starting subtest: basic [49.143291] Subtest basic: SUCCESS (0.000s) [49.199061] [031/162] (934s left) gem_flink_basic (double-flink) [49.248678] Starting subtest: double-flink [49.251709] Subtest double-flink: SUCCESS (0.000s) [49.311043] [032/162] (934s left) gem_flink_basic (flink-lifetime) [49.359225] Starting subtest: flink-lifetime [49.362552] Subtest flink-lifetime: SUCCESS (0.002s) [49.426547] [033/162] (934s left) gem_huc_copy (huc-copy) [49.481564] Starting subtest: huc-copy [49.488204] Subtest huc-copy: SKIP (0.000s) [49.552992] [034/162] (934s left) gem_linear_blits (basic) [49.678834] Starting subtest: basic [49.685729] Subtest basic: SUCCESS (0.006s) [49.780436] [035/162] (934s left) gem_mmap (basic) [49.914624] Starting subtest: basic [49.930752] Subtest basic: SUCCESS (0.000s) [49.980676] [036/162] (934s left) gem_mmap_gtt (basic) [50.035600] Starting subtest: basic [50.038724] Subtest basic: SUCCESS (0.001s) [50.083961] [037/162] (933s left) gem_render_linear_blits (basic) [50.138817] Starting subtest: basic [50.163746] Subtest basic: SUCCESS (0.026s) [50.227386] [038/162] (933s left) gem_render_tiled_blits (basic) [50.278772] Starting subtest: basic [50.310555] Subtest basic: SUCCESS (0.031s) [50.371906] [039/162] (933s left) gem_ringfill (basic-all) [50.619381] Starting subtest: basic-all [51.783872] Subtest basic-all: SUCCESS (1.137s) [51.873648] [040/162] (932s left) gem_softpin (allocator-basic) [51.932403] Starting subtest: allocator-basic [52.028225] Subtest allocator-basic: SUCCESS (0.096s) [52.128831] [041/162] (932s left) gem_softpin (allocator-basic-reserve) [52.183636] Starting subtest: allocator-basic-reserve [52.276091] Subtest allocator-basic-reserve: SUCCESS (0.093s) [52.358939] [042/162] (931s left) gem_softpin (safe-alignment) [52.415657] Starting subtest: safe-alignment [52.423976] Subtest safe-alignment: SUCCESS (0.011s) [52.499418] [043/162] (931s left) gem_sync (basic-all) [52.573568] Starting subtest: basic-all [54.875524] Subtest basic-all: SUCCESS (2.283s) [55.034634] [044/162] (929s left) gem_sync (basic-each) [55.112548] Starting subtest: basic-each [57.236427] Subtest basic-each: SUCCESS (2.119s) [57.392161] [045/162] (927s left) gem_tiled_blits (basic) [57.499842] Starting subtest: basic [57.513507] Subtest basic: SUCCESS (0.013s) [57.605885] [046/162] (926s left) gem_tiled_fence_blits (basic) [57.795414] Starting subtest: basic [57.804131] Subtest basic: SUCCESS (0.009s) [57.893690] [047/162] (926s left) gem_tiled_pread_basic (basic) [58.027938] Starting subtest: basic [58.158109] Subtest basic: SUCCESS (0.134s) [58.220037] [048/162] (926s left) gem_wait (busy@all-engines) [58.281901] Starting subtest: busy [58.285126] Starting dynamic subtest: all-engines [58.806303] Dynamic subtest all-engines: SUCCESS (0.519s) [58.809548] Subtest busy: SUCCESS (0.519s) [58.967769] [049/162] (925s left) gem_wait (wait@all-engines) [59.032595] Starting subtest: wait [59.036042] Starting dynamic subtest: all-engines [60.058333] Dynamic subtest all-engines: SUCCESS (1.019s) [60.061621] Subtest wait: SUCCESS (1.020s) [60.219888] [050/162] (924s left) i915_getparams_basic (basic-eu-total) [60.272332] Starting subtest: basic-eu-total [60.278551] Subtest basic-eu-total: SUCCESS (0.000s) [60.325989] [051/162] (924s left) i915_getparams_basic (basic-subslice-total) [60.374346] Starting subtest: basic-subslice-total [60.380517] Subtest basic-subslice-total: SUCCESS (0.000s) [60.431631] [052/162] (924s left) i915_hangman (error-state-basic) [60.488684] Starting subtest: error-state-basic [60.497657] Subtest error-state-basic: SUCCESS (0.006s) [60.567724] [053/162] (924s left) i915_pciid [60.675054] [054/162] (924s left) intel_hwmon (hwmon-read) [60.727691] Subtest hwmon-read: SKIP (0.000s) [60.775524] [055/162] (924s left) intel_hwmon (hwmon-write) [60.828259] Subtest hwmon-write: SKIP (0.000s) [60.874907] [056/162] (924s left) kms_addfb_basic (addfb25-4-tiled) [60.965356] Starting subtest: addfb25-4-tiled [60.968489] Subtest addfb25-4-tiled: SUCCESS (0.000s) [61.027172] [057/162] (924s left) kms_addfb_basic (addfb25-bad-modifier) [61.108099] Starting subtest: addfb25-bad-modifier [61.111135] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [61.172458] [058/162] (923s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [61.256428] Starting subtest: addfb25-framebuffer-vs-set-tiling [61.259468] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [61.328889] [059/162] (923s left) kms_addfb_basic (addfb25-modifier-no-flag) [61.409909] Starting subtest: addfb25-modifier-no-flag [61.412975] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [61.473569] [060/162] (923s left) kms_addfb_basic (addfb25-x-tiled-legacy) [61.552166] Starting subtest: addfb25-x-tiled-legacy [61.555569] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [61.613331] [061/162] (923s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [61.693548] Starting subtest: addfb25-x-tiled-mismatch-legacy [61.696913] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [61.744492] [062/162] (923s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [61.824512] Starting subtest: addfb25-yf-tiled-legacy [61.827605] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [61.885577] [063/162] (923s left) kms_addfb_basic (addfb25-y-tiled-legacy) [61.964629] Starting subtest: addfb25-y-tiled-legacy [61.967837] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [62.033589] [064/162] (923s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [62.112146] Starting subtest: addfb25-y-tiled-small-legacy [62.115404] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [62.176123] [065/162] (923s left) kms_addfb_basic (bad-pitch-0) [62.227236] Starting subtest: bad-pitch-0 [62.230640] Subtest bad-pitch-0: SUCCESS (0.000s) [62.312464] [066/162] (923s left) kms_addfb_basic (bad-pitch-1024) [62.363844] Starting subtest: bad-pitch-1024 [62.367730] Subtest bad-pitch-1024: SUCCESS (0.000s) [62.456621] [067/162] (923s left) kms_addfb_basic (bad-pitch-128) [62.509899] Starting subtest: bad-pitch-128 [62.513720] Subtest bad-pitch-128: SUCCESS (0.000s) [62.590488] [068/162] (922s left) kms_addfb_basic (bad-pitch-256) [62.642957] Starting subtest: bad-pitch-256 [62.646759] Subtest bad-pitch-256: SUCCESS (0.000s) [62.722136] [069/162] (922s left) kms_addfb_basic (bad-pitch-32) [62.772026] Starting subtest: bad-pitch-32 [62.776371] Subtest bad-pitch-32: SUCCESS (0.000s) [62.863637] [070/162] (922s left) kms_addfb_basic (bad-pitch-63) [62.913999] Starting subtest: bad-pitch-63 [62.918606] Subtest bad-pitch-63: SUCCESS (0.000s) [63.009912] [071/162] (922s left) kms_addfb_basic (bad-pitch-65536) [63.061977] Starting subtest: bad-pitch-65536 [63.065021] Subtest bad-pitch-65536: SUCCESS (0.000s) [63.153134] [072/162] (922s left) kms_addfb_basic (bad-pitch-999) [63.203674] Starting subtest: bad-pitch-999 [63.207101] Subtest bad-pitch-999: SUCCESS (0.000s) [63.292365] [073/162] (922s left) kms_addfb_basic (basic) [63.344747] Starting subtest: basic [63.349288] Subtest basic: SUCCESS (0.000s) [63.440642] [074/162] (922s left) kms_addfb_basic (basic-x-tiled-legacy) [63.491364] Starting subtest: basic-x-tiled-legacy [63.495965] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [63.576559] [075/162] (922s left) kms_addfb_basic (basic-y-tiled-legacy) [63.629889] Starting subtest: basic-y-tiled-legacy [63.632777] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [63.714388] [076/162] (922s left) kms_addfb_basic (bo-too-small) [63.790935] Starting subtest: bo-too-small [63.794145] Subtest bo-too-small: SUCCESS (0.001s) [63.856816] [077/162] (922s left) kms_addfb_basic (bo-too-small-due-to-tiling) [63.939540] Starting subtest: bo-too-small-due-to-tiling [63.942332] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [64.003461] [078/162] (922s left) kms_addfb_basic (clobberred-modifier) [64.052239] Starting subtest: clobberred-modifier [64.056147] Subtest clobberred-modifier: SUCCESS (0.000s) [64.136700] [079/162] (921s left) kms_addfb_basic (framebuffer-vs-set-tiling) [64.188939] Starting subtest: framebuffer-vs-set-tiling [64.192557] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [64.276997] [080/162] (921s left) kms_addfb_basic (invalid-get-prop) [64.326527] Starting subtest: invalid-get-prop [64.330200] Subtest invalid-get-prop: SUCCESS (0.000s) [64.415970] [081/162] (921s left) kms_addfb_basic (invalid-get-prop-any) [64.467569] Starting subtest: invalid-get-prop-any [64.471383] Subtest invalid-get-prop-any: SUCCESS (0.000s) [64.559305] [082/162] (921s left) kms_addfb_basic (invalid-set-prop) [64.615161] Starting subtest: invalid-set-prop [64.618296] Subtest invalid-set-prop: SUCCESS (0.000s) [64.701791] [083/162] (921s left) kms_addfb_basic (invalid-set-prop-any) [64.752528] Starting subtest: invalid-set-prop-any [64.758271] Subtest invalid-set-prop-any: SUCCESS (0.000s) [64.844359] [084/162] (921s left) kms_addfb_basic (no-handle) [64.934027] Starting subtest: no-handle [64.938678] Subtest no-handle: SUCCESS (0.000s) [65.157421] [085/162] (921s left) kms_addfb_basic (size-max) [65.477626] Starting subtest: size-max [65.542082] Subtest size-max: SUCCESS (0.000s) [66.088989] [086/162] (920s left) kms_addfb_basic (small-bo) [66.474161] Starting subtest: small-bo [66.478142] Subtest small-bo: SUCCESS (0.000s) [66.522349] [087/162] (920s left) kms_addfb_basic (tile-pitch-mismatch) [66.576324] Starting subtest: tile-pitch-mismatch [66.579656] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [66.709296] [088/162] (920s left) kms_addfb_basic (too-high) [66.797900] Starting subtest: too-high [66.800987] Subtest too-high: SUCCESS (0.001s) [67.245825] [089/162] (919s left) kms_addfb_basic (too-wide) [67.447949] Starting subtest: too-wide [67.450984] Subtest too-wide: SUCCESS (0.000s) [67.570843] [090/162] (919s left) kms_addfb_basic (unused-handle) [67.621393] Starting subtest: unused-handle [67.624871] Subtest unused-handle: SUCCESS (0.000s) [67.711225] [091/162] (919s left) kms_addfb_basic (unused-modifier) [67.764271] Starting subtest: unused-modifier [67.768516] Subtest unused-modifier: SUCCESS (0.000s) [67.851033] [092/162] (919s left) kms_addfb_basic (unused-offsets) [67.903246] Starting subtest: unused-offsets [67.906935] Subtest unused-offsets: SUCCESS (0.000s) [67.991852] [093/162] (919s left) kms_addfb_basic (unused-pitches) [68.042323] Starting subtest: unused-pitches [68.046656] Subtest unused-pitches: SUCCESS (0.000s) [68.136990] [094/162] (919s left) kms_busy (basic) [68.223174] Subtest basic: SKIP (0.000s) [68.267077] [095/162] (919s left) kms_prop_blob (basic) [68.317898] Starting subtest: basic [68.320937] Subtest basic: SUCCESS (0.000s) [68.364469] [096/162] (919s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [68.462950] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [68.507589] [097/162] (919s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [68.609647] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [68.654690] [098/162] (918s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [68.754128] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [68.799975] [099/162] (918s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [68.898918] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [68.945147] [100/162] (918s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [69.049113] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [69.095408] [101/162] (918s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [69.195342] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [69.242316] [102/162] (918s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [69.355138] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [69.402891] [103/162] (918s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [69.503222] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [69.549396] [104/162] (918s left) kms_dsc (dsc-basic) [69.634415] Subtest dsc-basic: SKIP (0.000s) [69.677684] [105/162] (918s left) kms_flip (basic-flip-vs-dpms) [69.756951] Starting subtest: basic-flip-vs-dpms [69.763200] Subtest basic-flip-vs-dpms: SKIP (0.001s) [69.806273] [106/162] (918s left) kms_flip (basic-flip-vs-modeset) [69.885927] Starting subtest: basic-flip-vs-modeset [69.892668] Subtest basic-flip-vs-modeset: SKIP (0.001s) [69.958381] [107/162] (918s left) kms_flip (basic-flip-vs-wf_vblank) [70.042921] Starting subtest: basic-flip-vs-wf_vblank [70.050391] Subtest basic-flip-vs-wf_vblank: SKIP (0.001s) [70.118459] [108/162] (917s left) kms_flip (basic-plain-flip) [70.197448] Starting subtest: basic-plain-flip [70.203960] Subtest basic-plain-flip: SKIP (0.001s) [70.249056] [109/162] (917s left) kms_force_connector_basic (force-connector-state) [70.396618] Starting subtest: force-connector-state [70.477233] Subtest force-connector-state: SUCCESS (0.078s) [70.650048] [110/162] (917s left) kms_force_connector_basic (force-edid) [70.797421] Starting subtest: force-edid [70.977964] Subtest force-edid: SUCCESS (0.186s) [71.066360] [111/162] (917s left) kms_force_connector_basic (force-load-detect) [71.217574] Starting subtest: force-load-detect [71.225787] Subtest force-load-detect: SKIP (0.000s) [71.288301] [112/162] (916s left) kms_force_connector_basic (prune-stale-modes) [71.437990] Starting subtest: prune-stale-modes [71.604821] Subtest prune-stale-modes: SUCCESS (0.170s) [71.688503] [113/162] (916s left) kms_frontbuffer_tracking (basic) [71.769122] Subtest basic: SKIP (0.000s) [71.824223] [114/162] (916s left) kms_hdmi_inject (inject-audio) [71.875570] Starting subtest: inject-audio [71.882194] Subtest inject-audio: SKIP (0.000s) [71.935071] [115/162] (916s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [72.015510] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [72.192632] [116/162] (916s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [72.576919] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [72.991455] [117/162] (916s left) kms_pipe_crc_basic (hang-read-crc) [73.379106] Subtest hang-read-crc: SKIP (0.000s) [73.551233] [118/162] (915s left) kms_pipe_crc_basic (nonblocking-crc) [73.633526] Subtest nonblocking-crc: SKIP (0.000s) [73.677957] [119/162] (915s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [73.765508] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [73.810836] [120/162] (915s left) kms_pipe_crc_basic (read-crc) [73.889472] Subtest read-crc: SKIP (0.000s) [73.933749] [121/162] (915s left) kms_pipe_crc_basic (read-crc-frame-sequence) [74.012844] Subtest read-crc-frame-sequence: SKIP (0.000s) [74.056267] [122/162] (915s left) kms_pm_backlight (basic-brightness) [74.139976] Subtest basic-brightness: SKIP (0.000s) [74.184347] [123/162] (915s left) kms_pm_rpm (basic-pci-d3-state) [85.586445] Starting subtest: basic-pci-d3-state [85.758597] Subtest basic-pci-d3-state: SUCCESS (0.176s) [85.816824] [124/162] (903s left) kms_pm_rpm (basic-rte) [85.867249] Starting subtest: basic-rte [97.391509] Subtest basic-rte: SUCCESS (11.520s) [97.695503] [125/162] (891s left) kms_psr (psr-primary-page-flip) [97.779429] Subtest psr-primary-page-flip: SKIP (0.000s) [97.823148] [126/162] (891s left) kms_psr (psr-cursor-plane-move) [97.901763] Subtest psr-cursor-plane-move: SKIP (0.000s) [97.945950] [127/162] (891s left) kms_psr (psr-sprite-plane-onoff) [98.028536] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [98.072848] [128/162] (891s left) kms_psr (psr-primary-mmap-gtt) [98.152691] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [98.196548] [129/162] (891s left) kms_setmode (basic-clone-single-crtc) [98.250697] Starting subtest: basic-clone-single-crtc [98.259702] Subtest basic-clone-single-crtc: SKIP (0.000s) [98.306683] [130/162] (891s left) i915_pm_rps (basic-api) [98.367065] Starting subtest: basic-api [98.370121] Subtest basic-api: SUCCESS (0.003s) [98.417858] [131/162] (891s left) prime_self_import (basic-llseek-bad) [98.465271] Starting subtest: basic-llseek-bad [98.471828] Subtest basic-llseek-bad: SUCCESS (0.002s) [98.539201] [132/162] (891s left) prime_self_import (basic-llseek-size) [98.589845] Starting subtest: basic-llseek-size [98.595993] Subtest basic-llseek-size: SUCCESS (0.003s) [98.658174] [133/162] (891s left) prime_self_import (basic-with_fd_dup) [98.707770] Starting subtest: basic-with_fd_dup [98.714190] Subtest basic-with_fd_dup: SUCCESS (0.002s) [98.773350] [134/162] (891s left) prime_self_import (basic-with_one_bo) [98.818445] Starting subtest: basic-with_one_bo [98.825153] Subtest basic-with_one_bo: SUCCESS (0.002s) [98.870783] [135/162] (891s left) prime_self_import (basic-with_one_bo_two_files) [98.920708] Starting subtest: basic-with_one_bo_two_files [98.926848] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [98.993388] [136/162] (891s left) prime_self_import (basic-with_two_bos) [99.042178] Starting subtest: basic-with_two_bos [99.048991] Subtest basic-with_two_bos: SUCCESS (0.003s) [99.111834] [137/162] (890s left) prime_vgem (basic-fence-flip) [99.171543] Starting subtest: basic-fence-flip [99.228271] Subtest basic-fence-flip: SKIP (0.059s) [99.276477] [138/162] (890s left) prime_vgem (basic-fence-mmap) [99.333198] Starting subtest: basic-fence-mmap [99.353423] Subtest basic-fence-mmap: SUCCESS (0.023s) [99.431469] [139/162] (890s left) prime_vgem (basic-fence-read) [99.484686] Starting subtest: basic-fence-read [99.529250] Subtest basic-fence-read: SUCCESS (0.046s) [99.601062] [140/162] (890s left) prime_vgem (basic-gtt) [99.657580] Starting subtest: basic-gtt [99.665501] Subtest basic-gtt: SUCCESS (0.012s) [99.740131] [141/162] (890s left) prime_vgem (basic-read) [99.793165] Starting subtest: basic-read [99.815184] Subtest basic-read: SUCCESS (0.023s) [99.887782] [142/162] (890s left) prime_vgem (basic-write) [99.939768] Starting subtest: basic-write [99.961758] Subtest basic-write: SUCCESS (0.023s) [100.036877] [143/162] (890s left) vgem_basic (setversion) [100.091326] Starting subtest: setversion [100.097905] Subtest setversion: SUCCESS (0.000s) [100.149383] [144/162] (890s left) vgem_basic (create) [100.202552] Starting subtest: create [100.205948] Subtest create: SUCCESS (0.000s) [100.259199] [145/162] (890s left) vgem_basic (debugfs) [100.312473] Starting subtest: debugfs [100.315776] Subtest debugfs: SUCCESS (0.000s) [100.366874] [146/162] (890s left) vgem_basic (dmabuf-export) [100.419517] Starting subtest: dmabuf-export [100.426049] Subtest dmabuf-export: SUCCESS (0.002s) [100.486366] [147/162] (890s left) vgem_basic (dmabuf-fence) [100.535625] Starting subtest: dmabuf-fence [100.538639] Subtest dmabuf-fence: SUCCESS (0.001s) [100.589201] [148/162] (890s left) vgem_basic (dmabuf-fence-before) [100.638417] Starting subtest: dmabuf-fence-before [100.641509] Subtest dmabuf-fence-before: SUCCESS (0.000s) [100.691706] [149/162] (889s left) vgem_basic (dmabuf-mmap) [100.741643] Starting subtest: dmabuf-mmap [100.748071] Subtest dmabuf-mmap: SUCCESS (0.009s) [100.794697] [150/162] (889s left) vgem_basic (mmap) [100.846649] Starting subtest: mmap [100.852766] Subtest mmap: SUCCESS (0.009s) [100.897338] [151/162] (889s left) vgem_basic (second-client) [100.948811] Starting subtest: second-client [100.954827] Subtest second-client: SUCCESS (0.003s) [101.001782] [152/162] (889s left) vgem_basic (sysfs) [101.052720] Starting subtest: sysfs [101.055801] Subtest sysfs: SUCCESS (0.001s) [101.106750] [153/162] (889s left) core_hotunplug (unbind-rebind) [101.216896] Starting subtest: unbind-rebind [104.674622] Subtest unbind-rebind: SUCCESS (3.456s) [104.720669] [154/162] (886s left) vgem_basic (unload) [104.771641] Starting subtest: unload [133.608142] Subtest unload: SUCCESS (28.839s) [133.674858] [155/162] (857s left) i915_module_load (reload) [133.721309] Starting subtest: reload [136.153958] Subtest reload: SUCCESS (2.434s) [136.201039] [156/162] (854s left) gem_lmem_swapping (basic) [136.265981] Subtest basic: SKIP (0.000s) [136.311908] [157/162] (854s left) gem_lmem_swapping (parallel-random-engines) [136.369220] Subtest parallel-random-engines: SKIP (0.000s) [136.412894] [158/162] (854s left) gem_lmem_swapping (random-engines) [136.466072] Subtest random-engines: SKIP (0.000s) [136.509464] [159/162] (854s left) gem_lmem_swapping (verify-random) [136.562622] Subtest verify-random: SKIP (0.000s) [136.607386] [160/162] (854s left) i915_pm_rpm (module-reload) [148.034818] Starting subtest: module-reload [175.500687] Subtest module-reload: SUCCESS (27.467s) [175.531973] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [175.532960] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [175.536975] [161/162] (815s left) i915_selftest (live) [175.587171] Starting subtest: live [175.590161] Starting dynamic subtest: sanitycheck [177.669549] Dynamic subtest sanitycheck: SUCCESS (2.081s) [177.681214] Starting dynamic subtest: uncore [179.739909] Dynamic subtest uncore: SUCCESS (2.072s) [179.751741] Starting dynamic subtest: workarounds [182.009835] Dynamic subtest workarounds: SUCCESS (2.262s) [182.021135] Starting dynamic subtest: gt_engines [184.545804] Dynamic subtest gt_engines: SUCCESS (2.545s) [184.557557] Starting dynamic subtest: gt_timelines [193.210424] Dynamic subtest gt_timelines: SUCCESS (8.662s) [193.223229] Starting dynamic subtest: gt_contexts [195.413845] Dynamic subtest gt_contexts: SUCCESS (2.204s) [195.425361] Starting dynamic subtest: gt_lrc [199.961920] Dynamic subtest gt_lrc: SUCCESS (4.547s) [199.974340] Starting dynamic subtest: gt_mocs [202.210203] Dynamic subtest gt_mocs: SUCCESS (2.245s) [202.221908] Starting dynamic subtest: gt_pm [208.647939] Dynamic subtest gt_pm: SUCCESS (6.439s) [208.659850] Starting dynamic subtest: gt_heartbeat [210.742383] Dynamic subtest gt_heartbeat: SUCCESS (2.090s) [210.755395] Starting dynamic subtest: gt_tlb [214.060878] Dynamic subtest gt_tlb: SUCCESS (3.321s) [214.076712] Starting dynamic subtest: requests [222.352216] Dynamic subtest requests: SUCCESS (8.290s) [222.364197] Starting dynamic subtest: migrate [227.496725] Dynamic subtest migrate: SUCCESS (5.144s) [227.508471] Starting dynamic subtest: active [229.593228] Dynamic subtest active: SUCCESS (2.088s) [229.604625] Starting dynamic subtest: objects [232.187890] Dynamic subtest objects: SUCCESS (2.601s) [232.199897] Starting dynamic subtest: mman [237.445185] Dynamic subtest mman: SUCCESS (5.256s) [237.457320] Starting dynamic subtest: dmabuf [239.543468] Dynamic subtest dmabuf: SUCCESS (2.087s) [239.555220] Starting dynamic subtest: vma [241.632393] Dynamic subtest vma: SUCCESS (2.091s) [241.643868] Starting dynamic subtest: coherency [244.446613] Dynamic subtest coherency: SUCCESS (2.821s) [244.458275] Starting dynamic subtest: gtt [253.924546] Dynamic subtest gtt: SUCCESS (9.476s) [253.936343] Starting dynamic subtest: gem [256.173187] Dynamic subtest gem: SUCCESS (2.245s) [256.185013] Starting dynamic subtest: evict [259.518875] Dynamic subtest evict: SUCCESS (3.347s) [259.532692] Starting dynamic subtest: hugepages [268.062886] Dynamic subtest hugepages: SUCCESS (8.543s) [268.078881] Starting dynamic subtest: gem_contexts [282.792919] Dynamic subtest gem_contexts: SUCCESS (14.729s) [282.805571] Starting dynamic subtest: client [284.963403] Dynamic subtest client: SUCCESS (2.161s) [284.979764] Starting dynamic subtest: gem_migrate [287.040597] Dynamic subtest gem_migrate: SUCCESS (2.085s) [287.052723] Starting dynamic subtest: reset [289.406692] Dynamic subtest reset: SUCCESS (2.317s) [289.474824] Starting dynamic subtest: memory_region [291.439407] Dynamic subtest memory_region: SUCCESS (2.079s) [291.451036] Starting dynamic subtest: hangcheck [316.600551] Dynamic subtest hangcheck: SUCCESS (25.162s) [316.612446] Starting dynamic subtest: execlists [326.904891] Dynamic subtest execlists: SUCCESS (10.303s) [326.917104] Starting dynamic subtest: ring_submission [328.982731] Dynamic subtest ring_submission: SUCCESS (2.070s) [328.994487] Starting dynamic subtest: perf [331.152875] Dynamic subtest perf: SUCCESS (2.174s) [331.165128] Starting dynamic subtest: slpc [333.232570] Dynamic subtest slpc: SUCCESS (2.071s) [333.247590] Starting dynamic subtest: guc [335.302576] Dynamic subtest guc: SUCCESS (2.074s) [335.314862] Starting dynamic subtest: guc_multi_lrc [337.382724] Dynamic subtest guc_multi_lrc: SUCCESS (2.074s) [337.393964] Starting dynamic subtest: guc_hang [339.442715] Dynamic subtest guc_hang: SUCCESS (2.064s) [339.455153] Starting dynamic subtest: late_gt_pm [341.577560] Dynamic subtest late_gt_pm: SUCCESS (2.139s) [341.580555] Subtest live: SUCCESS (165.992s) [341.619365] [162/162] (649s left) dmabuf (all-tests) [341.669629] Starting subtest: all-tests [341.675625] Subtest all-tests: SKIP (0.000s) [341.711741] 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.