[49.096312] Initializing watchdogs [49.096461] /dev/watchdog0 [49.105888] [001/171] (960s left) i915_module_load (load) [49.220527] Starting subtest: load [51.102153] Subtest load: SUCCESS (1.878s) [51.137388] [002/171] (958s left) core_auth (basic-auth) [51.372728] Starting subtest: basic-auth [51.374670] Subtest basic-auth: SUCCESS (0.001s) [51.439039] [003/171] (958s left) debugfs_test (read_all_entries) [51.553822] Starting subtest: read_all_entries [51.616601] Subtest read_all_entries: SUCCESS (0.062s) [52.418424] [004/171] (957s left) debugfs_test (basic-hwmon) [52.529308] Starting subtest: basic-hwmon [52.532796] Subtest basic-hwmon: SKIP (0.000s) [53.117043] [005/171] (956s left) fbdev (eof) [53.227815] Starting subtest: eof [53.229472] Subtest eof: SUCCESS (0.000s) [53.282895] [006/171] (956s left) fbdev (info) [53.389086] Starting subtest: info [53.390711] Subtest info: SUCCESS (0.000s) [53.449751] [007/171] (956s left) fbdev (nullptr) [53.560449] Starting subtest: nullptr [53.562249] Subtest nullptr: SUCCESS (0.000s) [53.619428] [008/171] (956s left) fbdev (read) [53.727131] Starting subtest: read [53.939764] Subtest read: SUCCESS (0.213s) [54.001415] [009/171] (955s left) fbdev (write) [54.109469] Starting subtest: write [54.210531] Subtest write: SUCCESS (0.100s) [54.269103] [010/171] (955s left) gem_basic (bad-close) [54.377847] Starting subtest: bad-close [54.381241] Subtest bad-close: SUCCESS (0.000s) [54.449978] [011/171] (955s left) gem_basic (create-close) [54.557730] Starting subtest: create-close [54.561419] Subtest create-close: SUCCESS (0.000s) [54.633872] [012/171] (955s left) gem_basic (create-fd-close) [54.742671] Starting subtest: create-fd-close [54.745853] Subtest create-fd-close: SUCCESS (0.000s) [54.815563] [013/171] (955s left) gem_busy (busy@all-engines) [54.940747] Starting subtest: busy [54.942400] Starting dynamic subtest: all-engines [54.965225] Dynamic subtest all-engines: SUCCESS (0.027s) [54.967072] Subtest busy: SUCCESS (0.027s) [55.330066] [014/171] (954s left) gem_close_race (basic-process) [55.456757] Starting subtest: basic-process [55.503200] Subtest basic-process: SUCCESS (0.046s) [55.683106] [015/171] (954s left) gem_close_race (basic-threads) [55.809068] Starting subtest: basic-threads [56.947834] Subtest basic-threads: SUCCESS (1.141s) [57.130860] [016/171] (952s left) gem_ctx_create (basic) [57.255677] Starting subtest: basic [57.257637] Subtest basic: SUCCESS (0.001s) [57.445346] [017/171] (952s left) gem_ctx_create (basic-files) [57.561829] Starting subtest: basic-files [59.580770] Subtest basic-files: SUCCESS (2.019s) [59.856365] [018/171] (950s left) gem_ctx_exec (basic) [60.017711] Starting subtest: basic [60.019408] Subtest basic: SUCCESS (0.001s) [60.075317] [019/171] (949s left) gem_exec_basic (basic) [60.193892] Starting subtest: basic [60.195690] Starting dynamic subtest: rcs0-smem [60.197379] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [60.205026] Starting dynamic subtest: vcs0-smem [60.206668] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [60.208221] Subtest basic: SUCCESS (0.002s) [60.369458] [020/171] (949s left) gem_exec_create (basic) [60.488158] Starting subtest: basic [60.490050] Starting dynamic subtest: smem [62.519308] Dynamic subtest smem: SUCCESS (2.031s) [62.521305] Subtest basic: SUCCESS (2.031s) [62.913408] [021/171] (947s left) gem_exec_fence (basic-busy) [63.154861] Starting subtest: basic-busy [63.158204] Starting dynamic subtest: rcs0 [63.163813] Dynamic subtest rcs0: SUCCESS (0.010s) [63.173194] Starting dynamic subtest: vcs0 [63.176877] Dynamic subtest vcs0: SUCCESS (0.010s) [63.178918] Subtest basic-busy: SUCCESS (0.020s) [63.650186] [022/171] (946s left) gem_exec_fence (basic-wait) [63.890063] Starting subtest: basic-wait [63.891773] Starting dynamic subtest: rcs0 [63.899101] Dynamic subtest rcs0: SUCCESS (0.011s) [63.908037] Starting dynamic subtest: vcs0 [63.909893] Dynamic subtest vcs0: SUCCESS (0.009s) [63.911838] Subtest basic-wait: SUCCESS (0.020s) [64.348368] [023/171] (945s left) gem_exec_fence (basic-await) [64.586963] Starting subtest: basic-await [64.588705] Starting dynamic subtest: rcs0 [64.652495] Dynamic subtest rcs0: SUCCESS (0.067s) [64.660608] Starting dynamic subtest: vcs0 [64.719160] Dynamic subtest vcs0: SUCCESS (0.067s) [64.721241] Subtest basic-await: SUCCESS (0.134s) [65.162665] [024/171] (944s left) gem_exec_fence (nb-await) [65.404236] Starting subtest: nb-await [65.406130] Starting dynamic subtest: rcs0 [65.455344] Dynamic subtest rcs0: SUCCESS (0.054s) [65.467702] Starting dynamic subtest: vcs0 [65.510547] Dynamic subtest vcs0: SUCCESS (0.055s) [65.512506] Subtest nb-await: SUCCESS (0.109s) [65.963228] [025/171] (944s left) gem_exec_gttfill (basic) [66.083102] Starting subtest: basic [73.409766] Subtest basic: SUCCESS (7.327s) [73.602386] [026/171] (936s left) gem_exec_parallel (engines) [73.812694] Starting subtest: engines [73.814716] Starting dynamic subtest: basic [75.599231] Dynamic subtest basic: SUCCESS (1.785s) [75.607928] Starting dynamic subtest: contexts [77.625695] Dynamic subtest contexts: SUCCESS (2.024s) [77.637089] Starting dynamic subtest: fds [77.640235] Dynamic subtest fds: SKIP (0.001s) [77.648804] Starting dynamic subtest: userptr [79.473249] Dynamic subtest userptr: SUCCESS (1.849s) [79.475161] Subtest engines: SUCCESS (5.660s) [79.648815] [027/171] (930s left) gem_exec_store (basic) [79.766813] Starting subtest: basic [79.793276] Subtest basic: SUCCESS (0.027s) [79.967274] [028/171] (930s left) gem_flink_basic (bad-flink) [80.078489] Starting subtest: bad-flink [80.080070] Subtest bad-flink: SUCCESS (0.000s) [80.147915] [029/171] (930s left) gem_flink_basic (bad-open) [80.255093] Starting subtest: bad-open [80.256779] Subtest bad-open: SUCCESS (0.000s) [80.333819] [030/171] (929s left) gem_flink_basic (basic) [80.441945] Starting subtest: basic [80.444302] Subtest basic: SUCCESS (0.000s) [80.514997] [031/171] (929s left) gem_flink_basic (double-flink) [80.621429] Starting subtest: double-flink [80.623128] Subtest double-flink: SUCCESS (0.000s) [80.700653] [032/171] (929s left) gem_flink_basic (flink-lifetime) [80.813868] Starting subtest: flink-lifetime [80.816176] Subtest flink-lifetime: SUCCESS (0.001s) [80.883398] [033/171] (929s left) gem_huc_copy (huc-copy) [80.999947] Subtest huc-copy: SKIP (0.000s) [81.035669] [034/171] (929s left) gem_linear_blits (basic) [81.255898] Starting subtest: basic [81.268965] Subtest basic: SUCCESS (0.013s) [81.379522] [035/171] (928s left) gem_mmap (basic) [81.587055] Starting subtest: basic [81.595516] Subtest basic: SUCCESS (0.000s) [81.663368] [036/171] (928s left) gem_mmap_gtt (basic) [81.773847] Starting subtest: basic [81.775738] Subtest basic: SUCCESS (0.001s) [81.831380] [037/171] (928s left) gem_render_linear_blits (basic) [81.942737] Starting subtest: basic [81.986411] Subtest basic: SUCCESS (0.040s) [82.033682] [038/171] (928s left) gem_render_tiled_blits (basic) [82.147677] Starting subtest: basic [82.183238] Subtest basic: SUCCESS (0.038s) [82.233460] [039/171] (928s left) gem_ringfill (basic-all) [82.398945] Starting subtest: basic-all [83.504746] Subtest basic-all: SUCCESS (1.107s) [83.576177] [040/171] (926s left) gem_softpin (allocator-basic) [83.695234] Subtest allocator-basic: SKIP (0.000s) [83.759706] [041/171] (926s left) gem_softpin (allocator-basic-reserve) [83.872552] Subtest allocator-basic-reserve: SKIP (0.000s) [83.941667] [042/171] (926s left) gem_softpin (safe-alignment) [84.057793] Starting subtest: safe-alignment [84.059734] Subtest safe-alignment: SUCCESS (0.006s) [84.141367] [043/171] (926s left) gem_sync (basic-all) [84.262464] Starting subtest: basic-all [86.451674] Subtest basic-all: SUCCESS (2.189s) [86.636959] [044/171] (923s left) gem_sync (basic-each) [86.755439] Starting subtest: basic-each [88.810926] Subtest basic-each: SUCCESS (2.053s) [88.981607] [045/171] (921s left) gem_tiled_blits (basic) [89.194757] Starting subtest: basic [89.217862] Subtest basic: SUCCESS (0.023s) [89.329840] [046/171] (921s left) gem_tiled_fence_blits (basic) [89.653422] Starting subtest: basic [89.663779] Subtest basic: SUCCESS (0.011s) [89.782323] [047/171] (920s left) gem_tiled_pread_basic [90.229405] [048/171] (920s left) gem_wait (busy@all-engines) [90.352096] Starting subtest: busy [90.354805] Starting dynamic subtest: all-engines [90.865127] Dynamic subtest all-engines: SUCCESS (0.513s) [90.866953] Subtest busy: SUCCESS (0.513s) [91.062384] [049/171] (919s left) gem_wait (wait@all-engines) [91.186145] Starting subtest: wait [91.188853] Starting dynamic subtest: all-engines [92.202825] Dynamic subtest all-engines: SUCCESS (1.016s) [92.204562] Subtest wait: SUCCESS (1.017s) [92.409090] [050/171] (918s left) i915_getparams_basic (basic-eu-total) [92.528542] Starting subtest: basic-eu-total [92.532319] Subtest basic-eu-total: SUCCESS (0.000s) [92.591107] [051/171] (918s left) i915_getparams_basic (basic-subslice-total) [92.697959] Starting subtest: basic-subslice-total [92.701353] Subtest basic-subslice-total: SUCCESS (0.000s) [92.773439] [052/171] (917s left) i915_hangman (error-state-basic) [92.889045] Starting subtest: error-state-basic [92.899020] Subtest error-state-basic: SUCCESS (0.010s) [92.944793] [053/171] (917s left) i915_pciid [93.126167] [054/171] (917s left) kms_addfb_basic (addfb25-bad-modifier) [93.743898] Starting subtest: addfb25-bad-modifier [93.745733] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [94.768635] [055/171] (915s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [95.390091] Starting subtest: addfb25-framebuffer-vs-set-tiling [95.391856] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [96.232605] [056/171] (914s left) kms_addfb_basic (addfb25-modifier-no-flag) [96.851988] Starting subtest: addfb25-modifier-no-flag [96.853876] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [97.712744] [057/171] (913s left) kms_addfb_basic (addfb25-x-tiled-legacy) [98.329820] Starting subtest: addfb25-x-tiled-legacy [98.331573] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [99.176205] [058/171] (911s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [99.788537] Starting subtest: addfb25-x-tiled-mismatch-legacy [99.790290] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [100.639847] [059/171] (910s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [101.675802] Starting subtest: addfb25-yf-tiled-legacy [101.677490] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [102.136771] [060/171] (908s left) kms_addfb_basic (addfb25-y-tiled-legacy) [103.137939] Starting subtest: addfb25-y-tiled-legacy [103.139641] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s) [103.600648] [061/171] (907s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [104.594777] Starting subtest: addfb25-y-tiled-small-legacy [104.598424] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [105.263800] [062/171] (905s left) kms_addfb_basic (bad-pitch-0) [105.377087] Starting subtest: bad-pitch-0 [105.378766] Subtest bad-pitch-0: SUCCESS (0.000s) [106.728295] [063/171] (904s left) kms_addfb_basic (bad-pitch-1024) [106.839950] Starting subtest: bad-pitch-1024 [106.841691] Subtest bad-pitch-1024: SUCCESS (0.000s) [108.174625] [064/171] (902s left) kms_addfb_basic (bad-pitch-128) [108.284554] Starting subtest: bad-pitch-128 [108.286264] Subtest bad-pitch-128: SUCCESS (0.000s) [109.622227] [065/171] (901s left) kms_addfb_basic (bad-pitch-256) [109.732334] Starting subtest: bad-pitch-256 [109.734033] Subtest bad-pitch-256: SUCCESS (0.000s) [111.085402] [066/171] (899s left) kms_addfb_basic (bad-pitch-32) [111.198390] Starting subtest: bad-pitch-32 [111.200156] Subtest bad-pitch-32: SUCCESS (0.000s) [112.566086] [067/171] (898s left) kms_addfb_basic (bad-pitch-63) [112.679685] Starting subtest: bad-pitch-63 [112.681487] Subtest bad-pitch-63: SUCCESS (0.000s) [114.046339] [068/171] (896s left) kms_addfb_basic (bad-pitch-65536) [114.162441] Starting subtest: bad-pitch-65536 [114.164641] Subtest bad-pitch-65536: SUCCESS (0.000s) [115.842775] [069/171] (895s left) kms_addfb_basic (bad-pitch-999) [115.954223] Starting subtest: bad-pitch-999 [115.955990] Subtest bad-pitch-999: SUCCESS (0.000s) [117.340435] [070/171] (893s left) kms_addfb_basic (basic) [117.456667] Starting subtest: basic [117.458374] Subtest basic: SUCCESS (0.000s) [118.803703] [071/171] (892s left) kms_addfb_basic (basic-x-tiled-legacy) [120.220594] Starting subtest: basic-x-tiled-legacy [120.222477] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [120.300391] [072/171] (890s left) kms_addfb_basic (basic-y-tiled-legacy) [121.746173] Starting subtest: basic-y-tiled-legacy [121.770846] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [121.882752] [073/171] (889s left) kms_addfb_basic (bo-too-small) [122.610922] Starting subtest: bo-too-small [122.612842] Subtest bo-too-small: SUCCESS (0.000s) [123.394749] [074/171] (887s left) kms_addfb_basic (bo-too-small-due-to-tiling) [124.017110] Starting subtest: bo-too-small-due-to-tiling [124.018739] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [124.891421] [075/171] (886s left) kms_addfb_basic (clobberred-modifier) [125.047121] Starting subtest: clobberred-modifier [125.049064] Subtest clobberred-modifier: SUCCESS (0.000s) [126.671410] [076/171] (884s left) kms_addfb_basic (framebuffer-vs-set-tiling) [128.120241] Starting subtest: framebuffer-vs-set-tiling [128.122147] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [128.218145] [077/171] (883s left) kms_addfb_basic (invalid-get-prop) [129.667442] Starting subtest: invalid-get-prop [129.669432] Subtest invalid-get-prop: SUCCESS (0.000s) [129.765652] [078/171] (881s left) kms_addfb_basic (invalid-get-prop-any) [131.204484] Starting subtest: invalid-get-prop-any [131.206281] Subtest invalid-get-prop-any: SUCCESS (0.000s) [131.295270] [079/171] (880s left) kms_addfb_basic (invalid-set-prop) [132.719300] Starting subtest: invalid-set-prop [132.721081] Subtest invalid-set-prop: SUCCESS (0.000s) [132.809034] [080/171] (878s left) kms_addfb_basic (invalid-set-prop-any) [134.234395] Starting subtest: invalid-set-prop-any [134.236286] Subtest invalid-set-prop-any: SUCCESS (0.000s) [134.322912] [081/171] (877s left) kms_addfb_basic (no-handle) [134.438946] Starting subtest: no-handle [134.440621] Subtest no-handle: SUCCESS (0.000s) [136.052517] [082/171] (875s left) kms_addfb_basic (size-max) [136.701124] Starting subtest: size-max [136.702789] Subtest size-max: SUCCESS (0.000s) [137.582596] [083/171] (873s left) kms_addfb_basic (small-bo) [138.229127] Starting subtest: small-bo [138.231053] Subtest small-bo: SUCCESS (0.000s) [139.114215] [084/171] (872s left) kms_addfb_basic (tile-pitch-mismatch) [140.552846] Starting subtest: tile-pitch-mismatch [140.554796] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [140.643306] [085/171] (870s left) kms_addfb_basic (too-high) [141.288915] Starting subtest: too-high [141.290787] Subtest too-high: SUCCESS (0.002s) [142.189338] [086/171] (869s left) kms_addfb_basic (too-wide) [142.833053] Starting subtest: too-wide [142.834775] Subtest too-wide: SUCCESS (0.000s) [143.737031] [087/171] (867s left) kms_addfb_basic (unused-handle) [143.862071] Starting subtest: unused-handle [143.863813] Subtest unused-handle: SUCCESS (0.000s) [145.267380] [088/171] (866s left) kms_addfb_basic (unused-modifier) [145.379963] Starting subtest: unused-modifier [145.381651] Subtest unused-modifier: SUCCESS (0.000s) [146.997305] [089/171] (864s left) kms_addfb_basic (unused-offsets) [147.111192] Starting subtest: unused-offsets [147.112846] Subtest unused-offsets: SUCCESS (0.000s) [148.545467] [090/171] (863s left) kms_addfb_basic (unused-pitches) [148.702608] Starting subtest: unused-pitches [148.704286] Subtest unused-pitches: SUCCESS (0.000s) [150.174599] [091/171] (861s left) kms_busy (basic) [150.837208] Starting subtest: basic [150.838937] Starting dynamic subtest: flip [151.607761] Dynamic subtest flip: SUCCESS (0.765s) [151.628645] Starting dynamic subtest: modeset [152.341337] Dynamic subtest modeset: SUCCESS (0.729s) [152.348534] Subtest basic: SUCCESS (1.505s) [152.528791] [092/171] (859s left) kms_chamelium_hpd (dp-hpd-fast) [153.294641] Subtest dp-hpd-fast: SKIP (0.000s) [153.429475] [093/171] (858s left) kms_chamelium_edid (dp-edid-read) [154.209456] Subtest dp-edid-read: SKIP (0.000s) [154.358798] [094/171] (857s left) kms_chamelium_frames (dp-crc-fast) [155.184070] Subtest dp-crc-fast: SKIP (0.000s) [155.328369] [095/171] (856s left) kms_chamelium_hpd (hdmi-hpd-fast) [156.099776] Subtest hdmi-hpd-fast: SKIP (0.000s) [156.439448] [096/171] (855s left) kms_chamelium_edid (hdmi-edid-read) [157.184205] Subtest hdmi-edid-read: SKIP (0.000s) [157.537397] [097/171] (854s left) kms_chamelium_frames (hdmi-crc-fast) [158.298579] Subtest hdmi-crc-fast: SKIP (0.000s) [158.440533] [098/171] (853s left) kms_chamelium_hpd (vga-hpd-fast) [159.212461] Subtest vga-hpd-fast: SKIP (0.000s) [159.358278] [099/171] (852s left) kms_chamelium_edid (vga-edid-read) [160.130463] Subtest vga-edid-read: SKIP (0.000s) [160.280904] [100/171] (851s left) kms_prop_blob (basic) [160.399802] Starting subtest: basic [160.401612] Subtest basic: SUCCESS (0.000s) [160.471841] [101/171] (851s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [161.137777] Starting subtest: basic-busy-flip-before-cursor-atomic [162.192340] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.053s) [162.368705] [102/171] (849s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [163.037726] Starting subtest: basic-busy-flip-before-cursor-legacy [164.078207] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.043s) [164.225333] [103/171] (847s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [164.881905] Starting subtest: basic-flip-after-cursor-atomic [165.930055] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.049s) [166.099413] [104/171] (845s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [166.764921] Starting subtest: basic-flip-after-cursor-legacy [167.836991] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.075s) [168.381293] [105/171] (843s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [169.044940] Starting subtest: basic-flip-after-cursor-varying-size [170.056135] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.020s) [170.216236] [106/171] (841s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [170.897882] Starting subtest: basic-flip-before-cursor-atomic [171.934519] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.042s) [172.110872] [107/171] (839s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [172.790664] Starting subtest: basic-flip-before-cursor-legacy [173.830782] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.045s) [174.005194] [108/171] (838s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [174.667618] Starting subtest: basic-flip-before-cursor-varying-size [175.708805] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.042s) [175.883652] [109/171] (836s left) kms_flip (basic-flip-vs-dpms) [176.399196] Starting subtest: basic-flip-vs-dpms [176.400825] Starting dynamic subtest: A-VGA1 [177.208841] Dynamic subtest A-VGA1: SUCCESS (0.817s) [177.225264] Starting dynamic subtest: B-VGA1 [177.926399] Dynamic subtest B-VGA1: SUCCESS (0.718s) [177.944175] Starting dynamic subtest: A-HDMI-A1 [178.700748] Dynamic subtest A-HDMI-A1: SUCCESS (0.775s) [178.717702] Starting dynamic subtest: B-HDMI-A1 [179.499077] Dynamic subtest B-HDMI-A1: SUCCESS (0.776s) [179.500688] Subtest basic-flip-vs-dpms: SUCCESS (3.094s) [180.086882] [110/171] (832s left) kms_flip (basic-flip-vs-modeset) [180.599169] Starting subtest: basic-flip-vs-modeset [180.600771] Starting dynamic subtest: A-VGA1 [181.402714] Dynamic subtest A-VGA1: SUCCESS (0.809s) [181.424620] Starting dynamic subtest: B-VGA1 [182.058444] Dynamic subtest B-VGA1: SUCCESS (0.655s) [182.078642] Starting dynamic subtest: A-HDMI-A1 [182.893277] Dynamic subtest A-HDMI-A1: SUCCESS (0.834s) [182.906672] Starting dynamic subtest: B-HDMI-A1 [183.725593] Dynamic subtest B-HDMI-A1: SUCCESS (0.825s) [183.727271] Subtest basic-flip-vs-modeset: SUCCESS (3.129s) [183.896530] [111/171] (828s left) kms_flip (basic-flip-vs-wf_vblank) [184.410120] Starting subtest: basic-flip-vs-wf_vblank [184.411740] Starting dynamic subtest: A-VGA1 [185.493053] Dynamic subtest A-VGA1: SUCCESS (1.086s) [185.509615] Starting dynamic subtest: B-VGA1 [186.509971] Dynamic subtest B-VGA1: SUCCESS (1.016s) [186.525688] Starting dynamic subtest: A-HDMI-A1 [187.725658] Dynamic subtest A-HDMI-A1: SUCCESS (1.209s) [187.753613] Starting dynamic subtest: B-HDMI-A1 [189.003070] Dynamic subtest B-HDMI-A1: SUCCESS (1.267s) [189.009359] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.592s) [189.268950] [112/171] (822s left) kms_flip (basic-plain-flip) [189.777445] Starting subtest: basic-plain-flip [189.779087] Starting dynamic subtest: A-VGA1 [190.582807] Dynamic subtest A-VGA1: SUCCESS (0.810s) [190.604568] Starting dynamic subtest: B-VGA1 [191.301960] Dynamic subtest B-VGA1: SUCCESS (0.713s) [191.320691] Starting dynamic subtest: A-HDMI-A1 [192.106534] Dynamic subtest A-HDMI-A1: SUCCESS (0.786s) [192.133061] Starting dynamic subtest: B-HDMI-A1 [192.870746] Dynamic subtest B-HDMI-A1: SUCCESS (0.780s) [192.877221] Subtest basic-plain-flip: SUCCESS (3.105s) [193.495617] [113/171] (818s left) kms_force_connector_basic (force-connector-state) [193.678875] Starting subtest: force-connector-state [194.511348] Subtest force-connector-state: SUCCESS (0.833s) [195.065534] [114/171] (817s left) kms_force_connector_basic (force-edid) [195.245260] Starting subtest: force-edid [195.564284] Subtest force-edid: SUCCESS (0.320s) [196.031561] [115/171] (816s left) kms_force_connector_basic (force-load-detect) [196.201964] Starting subtest: force-load-detect [196.431248] Subtest force-load-detect: SUCCESS (0.228s) [196.983365] [116/171] (815s left) kms_force_connector_basic (prune-stale-modes) [197.154347] Starting subtest: prune-stale-modes [197.477974] Subtest prune-stale-modes: SUCCESS (0.322s) [197.948916] [117/171] (814s left) kms_frontbuffer_tracking (basic) [198.620086] Starting subtest: basic [198.917739] Subtest basic: SKIP (0.293s) [199.029558] [118/171] (813s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [199.696625] Starting subtest: compare-crc-sanitycheck [199.698357] Starting dynamic subtest: pipe-A-HDMI-A-1 [200.095679] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.396s) [200.116660] Starting dynamic subtest: pipe-B-HDMI-A-1 [200.576379] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.473s) [200.578127] Subtest compare-crc-sanitycheck: SUCCESS (0.878s) [200.747239] [119/171] (811s left) kms_pipe_crc_basic (hang-read-crc) [201.403704] Starting subtest: hang-read-crc [201.405411] Starting dynamic subtest: pipe-A-HDMI-A-1 [202.465473] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.068s) [202.481771] Starting dynamic subtest: pipe-B-HDMI-A-1 [203.586551] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.119s) [203.588773] Subtest hang-read-crc: SUCCESS (2.190s) [203.778023] [120/171] (808s left) kms_pipe_crc_basic (nonblocking-crc) [204.533708] Starting subtest: nonblocking-crc [204.535415] Starting dynamic subtest: pipe-A-HDMI-A-1 [205.089375] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.564s) [205.109665] Starting dynamic subtest: pipe-B-HDMI-A-1 [205.719574] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.628s) [205.721319] Subtest nonblocking-crc: SUCCESS (1.196s) [206.111103] [121/171] (806s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [206.772621] Starting subtest: nonblocking-crc-frame-sequence [206.774327] Starting dynamic subtest: pipe-A-HDMI-A-1 [207.338881] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.571s) [207.354679] Starting dynamic subtest: pipe-B-HDMI-A-1 [207.977079] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.635s) [207.978811] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.210s) [208.148574] [122/171] (804s left) kms_pipe_crc_basic (read-crc) [208.810660] Starting subtest: read-crc [208.812382] Starting dynamic subtest: pipe-A-HDMI-A-1 [209.311753] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.483s) [209.336773] Starting dynamic subtest: pipe-B-HDMI-A-1 [209.819329] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.505s) [209.842425] Subtest read-crc: SUCCESS (0.993s) [210.015157] [123/171] (802s left) kms_pipe_crc_basic (read-crc-frame-sequence) [210.933863] Starting subtest: read-crc-frame-sequence [211.086504] Starting dynamic subtest: pipe-A-HDMI-A-1 [211.404730] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.486s) [211.623317] Starting dynamic subtest: pipe-B-HDMI-A-1 [211.699746] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.520s) [211.701409] Subtest read-crc-frame-sequence: SUCCESS (1.009s) [211.863920] [124/171] (800s left) kms_psr (primary_page_flip) [211.986759] Subtest primary_page_flip: SKIP (0.000s) [212.018634] [125/171] (800s left) kms_psr (cursor_plane_move) [212.136074] Subtest cursor_plane_move: SKIP (0.000s) [212.169139] [126/171] (800s left) kms_psr (sprite_plane_onoff) [212.282503] Subtest sprite_plane_onoff: SKIP (0.000s) [212.317835] [127/171] (800s left) kms_psr (primary_mmap_gtt) [212.436728] Subtest primary_mmap_gtt: SKIP (0.000s) [212.467568] [128/171] (800s left) kms_setmode (basic-clone-single-crtc) [212.586339] Starting subtest: basic-clone-single-crtc [212.591496] Subtest basic-clone-single-crtc: SKIP (0.000s) [212.661883] [129/171] (799s left) i915_pm_backlight (basic-brightness) [213.359308] Subtest basic-brightness: SKIP (0.000s) [213.415958] [130/171] (799s left) i915_pm_rpm (basic-pci-d3-state) [225.408788] Subtest basic-pci-d3-state: SKIP (0.000s) [225.674894] [131/171] (787s left) i915_pm_rpm (basic-rte) [225.789199] Starting subtest: basic-rte [237.678795] Subtest basic-rte: SKIP (11.870s) [237.961852] [132/171] (774s left) i915_pm_rps (basic-api) [238.082800] Subtest basic-api: SKIP (0.000s) [238.116730] [133/171] (774s left) prime_self_import (basic-llseek-bad) [238.230263] Starting subtest: basic-llseek-bad [238.232072] Subtest basic-llseek-bad: SUCCESS (0.002s) [238.313254] [134/171] (774s left) prime_self_import (basic-llseek-size) [238.424277] Starting subtest: basic-llseek-size [238.425925] Subtest basic-llseek-size: SUCCESS (0.003s) [238.496938] [135/171] (774s left) prime_self_import (basic-with_fd_dup) [238.610740] Starting subtest: basic-with_fd_dup [238.612543] Subtest basic-with_fd_dup: SUCCESS (0.003s) [238.678658] [136/171] (774s left) prime_self_import (basic-with_one_bo) [238.786248] Starting subtest: basic-with_one_bo [238.791870] Subtest basic-with_one_bo: SUCCESS (0.006s) [238.847464] [137/171] (773s left) prime_self_import (basic-with_one_bo_two_files) [238.961146] Starting subtest: basic-with_one_bo_two_files [238.962776] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [239.045368] [138/171] (773s left) prime_self_import (basic-with_two_bos) [239.158445] Starting subtest: basic-with_two_bos [239.160170] Subtest basic-with_two_bos: SUCCESS (0.004s) [239.244486] [139/171] (773s left) prime_vgem (basic-fence-flip) [239.379075] Starting subtest: basic-fence-flip [240.470378] Subtest basic-fence-flip: SUCCESS (1.093s) [240.630564] [140/171] (772s left) prime_vgem (basic-fence-mmap) [240.760715] Starting subtest: basic-fence-mmap [240.797291] Subtest basic-fence-mmap: SUCCESS (0.037s) [240.878885] [141/171] (772s left) prime_vgem (basic-fence-read) [241.014374] Starting subtest: basic-fence-read [241.072961] Subtest basic-fence-read: SUCCESS (0.062s) [241.148309] [142/171] (771s left) prime_vgem (basic-gtt) [241.277788] Starting subtest: basic-gtt [241.293601] Subtest basic-gtt: SUCCESS (0.018s) [241.364807] [143/171] (771s left) prime_vgem (basic-read) [241.494814] Starting subtest: basic-read [241.520837] Subtest basic-read: SUCCESS (0.029s) [241.595164] [144/171] (771s left) prime_vgem (basic-write) [241.729054] Starting subtest: basic-write [241.759771] Subtest basic-write: SUCCESS (0.031s) [241.829995] [145/171] (771s left) prime_vgem (basic-userptr) [241.958379] Starting subtest: basic-userptr [241.974086] Subtest basic-userptr: SKIP (0.015s) [242.051463] [146/171] (770s left) vgem_basic (setversion) [242.169102] Starting subtest: setversion [242.173114] Subtest setversion: SUCCESS (0.000s) [242.229695] [147/171] (770s left) vgem_basic (create) [242.352664] Starting subtest: create [242.354806] Subtest create: SUCCESS (0.000s) [242.414138] [148/171] (770s left) vgem_basic (debugfs) [242.535683] Starting subtest: debugfs [242.537873] Subtest debugfs: SUCCESS (0.001s) [242.594434] [149/171] (770s left) vgem_basic (dmabuf-export) [242.719683] Starting subtest: dmabuf-export [242.722080] Subtest dmabuf-export: SUCCESS (0.003s) [242.793826] [150/171] (770s left) vgem_basic (dmabuf-fence) [242.918474] Starting subtest: dmabuf-fence [242.920607] Subtest dmabuf-fence: SUCCESS (0.001s) [242.976875] [151/171] (770s left) vgem_basic (dmabuf-fence-before) [243.102913] Starting subtest: dmabuf-fence-before [243.104919] Subtest dmabuf-fence-before: SUCCESS (0.001s) [243.160138] [152/171] (770s left) vgem_basic (dmabuf-mmap) [243.283774] Starting subtest: dmabuf-mmap [243.307930] Subtest dmabuf-mmap: SUCCESS (0.026s) [243.359692] [153/171] (769s left) vgem_basic (mmap) [243.482538] Starting subtest: mmap [243.498946] Subtest mmap: SUCCESS (0.016s) [243.560088] [154/171] (769s left) vgem_basic (second-client) [243.682790] Starting subtest: second-client [243.730683] Subtest second-client: SUCCESS (0.049s) [243.792745] [155/171] (769s left) vgem_basic (sysfs) [243.916353] Starting subtest: sysfs [243.918522] Subtest sysfs: SUCCESS (0.001s) [243.975317] [156/171] (769s left) core_hotunplug (unbind-rebind) [244.114452] Starting subtest: unbind-rebind [245.482625] Subtest unbind-rebind: SUCCESS (1.367s) [245.523138] [157/171] (767s left) vgem_basic (unload) [245.686718] Starting subtest: unload [274.444261] Subtest unload: SUCCESS (28.756s) [274.546962] [158/171] (738s left) i915_module_load (reload) [274.655598] Starting subtest: reload [277.064702] Subtest reload: SUCCESS (2.401s) [277.101899] [159/171] (736s left) gem_lmem_swapping (basic) [277.288869] Subtest basic: SKIP (0.000s) [277.318112] [160/171] (736s left) gem_lmem_swapping (parallel-random-engines) [277.437960] Subtest parallel-random-engines: SKIP (0.000s) [277.484048] [161/171] (735s left) gem_lmem_swapping (random-engines) [277.601999] Subtest random-engines: SKIP (0.000s) [277.633849] [162/171] (735s left) gem_lmem_swapping (verify-random) [277.751914] Subtest verify-random: SKIP (0.000s) [277.783559] [163/171] (735s left) i915_pm_rpm (module-reload) [289.799264] Subtest module-reload: SKIP (0.000s) [290.075929] [164/171] (723s left) i915_selftest (live) [290.764077] Starting subtest: live [290.766721] Starting dynamic subtest: sanitycheck [291.539024] Dynamic subtest sanitycheck: SUCCESS (0.775s) [291.551125] Starting dynamic subtest: uncore [292.221044] Dynamic subtest uncore: SUCCESS (0.681s) [292.234485] Starting dynamic subtest: workarounds [292.899219] Dynamic subtest workarounds: SUCCESS (0.677s) [292.913740] Starting dynamic subtest: gt_engines [293.616252] Dynamic subtest gt_engines: SUCCESS (0.715s) [293.626514] Starting dynamic subtest: gt_timelines [298.558671] Dynamic subtest gt_timelines: SUCCESS (4.941s) [298.570241] Starting dynamic subtest: gt_contexts [299.297154] Dynamic subtest gt_contexts: SUCCESS (0.719s) [299.320092] Starting dynamic subtest: gt_lrc [299.956161] Dynamic subtest gt_lrc: SUCCESS (0.658s) [299.978806] Starting dynamic subtest: gt_mocs [300.646893] Dynamic subtest gt_mocs: SUCCESS (0.708s) [300.657137] Starting dynamic subtest: gt_pm [301.822879] Dynamic subtest gt_pm: SUCCESS (1.175s) [301.834108] Starting dynamic subtest: gt_heartbeat [302.579815] Dynamic subtest gt_heartbeat: SUCCESS (0.756s) [302.591100] Starting dynamic subtest: requests [306.896721] Dynamic subtest requests: SUCCESS (4.316s) [306.908122] Starting dynamic subtest: migrate [307.596376] Dynamic subtest migrate: SUCCESS (0.698s) [307.607370] Starting dynamic subtest: active [308.332861] Dynamic subtest active: SUCCESS (0.735s) [308.342994] Starting dynamic subtest: objects [310.519929] Dynamic subtest objects: SUCCESS (2.186s) [310.531451] Starting dynamic subtest: mman [316.500505] Dynamic subtest mman: SUCCESS (5.980s) [316.510372] Starting dynamic subtest: dmabuf [317.245078] Dynamic subtest dmabuf: SUCCESS (0.743s) [317.256080] Starting dynamic subtest: vma [317.944698] Dynamic subtest vma: SUCCESS (0.698s) [317.954878] Starting dynamic subtest: coherency [319.768035] Dynamic subtest coherency: SUCCESS (1.822s) [319.780272] Starting dynamic subtest: gtt [323.699479] Dynamic subtest gtt: SUCCESS (3.930s) [323.710814] Starting dynamic subtest: gem [324.505289] Dynamic subtest gem: SUCCESS (0.804s) [324.515997] Starting dynamic subtest: evict [325.168870] Dynamic subtest evict: SUCCESS (0.663s) [325.177505] Starting dynamic subtest: hugepages [325.875796] Dynamic subtest hugepages: SUCCESS (0.705s) [325.887176] Starting dynamic subtest: gem_contexts [329.645251] Dynamic subtest gem_contexts: SUCCESS (3.768s) [329.655207] Starting dynamic subtest: client [330.329415] Dynamic subtest client: SUCCESS (0.683s) [330.340540] Starting dynamic subtest: gem_migrate [331.016291] Dynamic subtest gem_migrate: SUCCESS (0.686s) [331.026971] Starting dynamic subtest: reset [331.843882] Dynamic subtest reset: SUCCESS (0.827s) [331.855919] Starting dynamic subtest: memory_region [332.541898] Dynamic subtest memory_region: SUCCESS (0.697s) [332.552834] Starting dynamic subtest: hangcheck [334.810174] Dynamic subtest hangcheck: SUCCESS (2.267s) [334.821163] Starting dynamic subtest: execlists [335.486147] Dynamic subtest execlists: SUCCESS (0.676s) [335.501885] Starting dynamic subtest: ring_submission [336.199751] Dynamic subtest ring_submission: SUCCESS (0.712s) [336.210992] Starting dynamic subtest: perf [336.879865] Dynamic subtest perf: SUCCESS (0.679s) [336.888326] Starting dynamic subtest: slpc [337.586804] Dynamic subtest slpc: SUCCESS (0.705s) [337.597969] Starting dynamic subtest: guc [338.249934] Dynamic subtest guc: SUCCESS (0.662s) [338.260620] Starting dynamic subtest: guc_multi_lrc [338.963942] Dynamic subtest guc_multi_lrc: SUCCESS (0.712s) [338.975081] Starting dynamic subtest: guc_hang [339.655976] Dynamic subtest guc_hang: SUCCESS (0.691s) [339.665495] Starting dynamic subtest: late_gt_pm [340.364390] Dynamic subtest late_gt_pm: SUCCESS (0.707s) [340.368721] Subtest live: SUCCESS (49.602s) [340.442963] [165/171] (673s left) dmabuf (all-tests) [340.566202] Starting subtest: all-tests [340.568162] Starting dynamic subtest: sanitycheck [340.597340] Dynamic subtest sanitycheck: SUCCESS (0.029s) [340.606586] Starting dynamic subtest: dma_fence [340.728235] Dynamic subtest dma_fence: SUCCESS (0.131s) [340.746426] Starting dynamic subtest: dma_fence_chain [357.780533] Dynamic subtest dma_fence_chain: SUCCESS (17.051s) [357.793112] Starting dynamic subtest: dma_fence_unwrap [357.813938] Dynamic subtest dma_fence_unwrap: SUCCESS (0.032s) [357.827537] Starting dynamic subtest: dma_resv [357.854108] Dynamic subtest dma_resv: SUCCESS (0.039s) [357.856124] Subtest all-tests: SUCCESS (17.287s) [357.874703] [166/171] (655s left) i915_suspend (basic-s2idle-without-i915) [357.984149] Starting subtest: basic-s2idle-without-i915 [376.546529] Subtest basic-s2idle-without-i915: SUCCESS (3.201s) [378.984202] [167/171] (651s left) i915_suspend (basic-s3-without-i915) [379.102608] Starting subtest: basic-s3-without-i915 [396.804709] Subtest basic-s3-without-i915: SUCCESS (2.230s) [403.786865] [168/171] (649s left) gem_exec_suspend (basic-s0) [403.927186] Starting subtest: basic-S0 [403.930278] Starting dynamic subtest: smem [421.189064] Dynamic subtest smem: SUCCESS (6.970s) [421.190780] Subtest basic-S0: SUCCESS (6.972s) [424.067919] [169/171] (641s left) gem_exec_suspend (basic-s3) [424.191165] Starting subtest: basic-S3 [424.194907] Starting dynamic subtest: smem [441.322284] Dynamic subtest smem: SUCCESS (2.024s) [441.323977] Subtest basic-S3: SUCCESS (2.026s) [451.508407] [170/171] (639s left) kms_chamelium_hpd (common-hpd-after-suspend) [452.290662] Subtest common-hpd-after-suspend: SKIP (0.000s) [452.666273] [171/171] (638s left) kms_pipe_crc_basic (suspend-read-crc) [453.354904] Starting subtest: suspend-read-crc [453.377669] Starting dynamic subtest: pipe-A-HDMI-A-1 [470.591341] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.137s) [470.611650] Starting dynamic subtest: pipe-B-HDMI-A-1 [488.576586] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.216s) [488.578503] Subtest suspend-read-crc: SUCCESS (4.357s) [495.628409] Closing watchdogs Done.