builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1502416001.75 results: success (0) revision: bb88ccb10454a78b8fa4a7d6c45bdf6fc47de3cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-10 18:46:41.750857) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-10 18:46:41.751326) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-10 18:46:41.751614) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-10 18:46:41.771286) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 18:46:41.771654) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-10 18:46:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 216M=0s 2017-08-10 18:46:41 (216 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117254 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 18:46:41.906101) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 18:46:41.906530) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015512 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 18:46:41.960817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 18:46:41.961270) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bb88ccb10454a78b8fa4a7d6c45bdf6fc47de3cd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev bb88ccb10454a78b8fa4a7d6c45bdf6fc47de3cd --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-10 18:46:41,984 truncating revision to first 12 chars 2017-08-10 18:46:41,984 Setting DEBUG logging. 2017-08-10 18:46:41,984 attempt 1/10 2017-08-10 18:46:41,984 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bb88ccb10454?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-10 18:46:42,288 unpacking tar archive at: mozilla-central-bb88ccb10454/testing/mozharness/ program finished with exit code 0 elapsedTime=0.588731 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 18:46:42.566185) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-10 18:46:42.566510) ========= script_repo_revision: bb88ccb10454a78b8fa4a7d6c45bdf6fc47de3cd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-10 18:46:42.566898) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-10 18:46:42.567194) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-10 18:46:42.576898) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-10 18:46:42.577200) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:46:42 INFO - MultiFileLogger online at 20170810 18:46:42 in /builds/slave/test 18:46:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:46:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:46:42 INFO - {'append_to_log': False, 18:46:42 INFO - 'base_work_dir': '/builds/slave/test', 18:46:42 INFO - 'blob_upload_branch': 'Firefox', 18:46:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:46:42 INFO - 'branch': 'Firefox', 18:46:42 INFO - 'buildbot_json_path': 'buildprops.json', 18:46:42 INFO - 'code_coverage': False, 18:46:42 INFO - 'config_files': ('talos/linux_config.py',), 18:46:42 INFO - 'default_actions': ('clobber', 18:46:42 INFO - 'read-buildbot-config', 18:46:42 INFO - 'download-and-extract', 18:46:42 INFO - 'populate-webroot', 18:46:42 INFO - 'create-virtualenv', 18:46:42 INFO - 'install', 18:46:42 INFO - 'setup-mitmproxy', 18:46:42 INFO - 'run-tests'), 18:46:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:46:42 INFO - 'disable_ccov_upload': False, 18:46:42 INFO - 'download_minidump_stackwalk': True, 18:46:42 INFO - 'download_symbols': 'ondemand', 18:46:42 INFO - 'enable_stylo': False, 18:46:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:46:42 INFO - 'tooltool.py': '/tools/tooltool.py', 18:46:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:46:42 INFO - '/tools/misc-python/virtualenv.py')}, 18:46:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:46:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:46:42 INFO - 'gecko_profile': False, 18:46:42 INFO - 'gecko_profile_interval': 0, 18:46:42 INFO - 'installer_path': 'installer.exe', 18:46:42 INFO - 'log_level': 'info', 18:46:42 INFO - 'log_name': 'talos', 18:46:42 INFO - 'log_to_console': True, 18:46:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:46:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:46:42 INFO - 'opt_config_files': (), 18:46:42 INFO - 'pip_index': False, 18:46:42 INFO - 'suite': 'dromaeojs-e10s', 18:46:42 INFO - 'system_bits': '32', 18:46:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:46:42 INFO - 'title': 'talos-linux64-ix-012', 18:46:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:46:42 INFO - 'use_talos_json': True, 18:46:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:46:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:46:42 INFO - 'work_dir': 'build'} 18:46:42 INFO - [mozharness: 2017-08-11 01:46:42.706871Z] Running clobber step. 18:46:42 INFO - Running pre-action listener: _resource_record_pre_action 18:46:42 INFO - Running main action method: clobber 18:46:42 INFO - rmtree: /builds/slave/test/build 18:46:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:46:43 INFO - Running post-action listener: _resource_record_post_action 18:46:43 INFO - [mozharness: 2017-08-11 01:46:43.728978Z] Finished clobber step (success) 18:46:43 INFO - [mozharness: 2017-08-11 01:46:43.729080Z] Running read-buildbot-config step. 18:46:43 INFO - Running pre-action listener: _resource_record_pre_action 18:46:43 INFO - Running main action method: read_buildbot_config 18:46:43 INFO - Using buildbot properties: 18:46:43 INFO - { 18:46:43 INFO - "project": "", 18:46:43 INFO - "product": "firefox", 18:46:43 INFO - "who": "ffxbld@noreply.mozilla.org", 18:46:43 INFO - "installer_path": "public/build/target.tar.bz2", 18:46:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 18:46:43 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:46:43 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 18:46:43 INFO - "stage_platform": "linux64-stylosequential", 18:46:43 INFO - "basedir": "/builds/slave/test", 18:46:43 INFO - "buildnumber": 143, 18:46:43 INFO - "platform": "ubuntu64_hw_styloseq", 18:46:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:46:43 INFO - "slavebuilddir": "test", 18:46:43 INFO - "taskId": "EV7TAbsASrKT3jzqLd6_Dw", 18:46:43 INFO - "branch": "mozilla-central", 18:46:43 INFO - "script_repo_revision": "production", 18:46:43 INFO - "revision": "bb88ccb10454a78b8fa4a7d6c45bdf6fc47de3cd", 18:46:43 INFO - "slavename": "talos-linux64-ix-012", 18:46:43 INFO - "repo_path": "mozilla-central" 18:46:43 INFO - } 18:46:43 INFO - Finding installer, test and symbols from parent task. 18:46:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EV7TAbsASrKT3jzqLd6_Dw'}, attempt #1 18:46:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EV7TAbsASrKT3jzqLd6_Dw'}, attempt #1 18:46:44 INFO - Task dependencies: FQylf4SMTjqgA4sl_IbrWA 18:46:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA'}, attempt #1 18:46:45 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.tar.bz2 18:46:45 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.test_packages.json 18:46:45 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.crashreporter-symbols.zip 18:46:45 INFO - Running post-action listener: _resource_record_post_action 18:46:45 INFO - [mozharness: 2017-08-11 01:46:45.111913Z] Finished read-buildbot-config step (success) 18:46:45 INFO - [mozharness: 2017-08-11 01:46:45.112133Z] Running download-and-extract step. 18:46:45 INFO - Running pre-action listener: _resource_record_pre_action 18:46:45 INFO - Running main action method: download_and_extract 18:46:45 INFO - mkdir: /builds/slave/test/build/tests 18:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:45 INFO - trying https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.test_packages.json 18:46:45 INFO - Downloading https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:46:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:46:45 INFO - Downloaded 989 bytes. 18:46:45 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:46:45 INFO - Using the following test package requirements: 18:46:45 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:46:45 INFO - u'common': [u'target.common.tests.zip'], 18:46:45 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:46:45 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:46:45 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:46:45 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:46:45 INFO - u'mozbase': [u'target.common.tests.zip'], 18:46:45 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:46:45 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:46:45 INFO - u'web-platform': [u'target.common.tests.zip', 18:46:45 INFO - u'target.web-platform.tests.tar.gz'], 18:46:45 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:46:45 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:46:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.common.tests.zip 18:46:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:46:45 INFO - Fetch https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.common.tests.zip into memory 18:46:46 INFO - Content-Length response header: 54343511 18:46:46 INFO - Bytes received: 54343511 18:46:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:46:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.common.tests.zip 18:46:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:46:58 INFO - Fetch https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.common.tests.zip into memory 18:46:59 INFO - Content-Length response header: 54343511 18:46:59 INFO - Bytes received: 54343511 18:47:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.talos.tests.zip 18:47:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:47:12 INFO - Fetch https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.talos.tests.zip into memory 18:47:13 INFO - Content-Length response header: 14496008 18:47:13 INFO - Bytes received: 14496008 18:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:13 INFO - trying https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.tar.bz2 18:47:13 INFO - Downloading https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:47:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:47:14 INFO - Downloaded 61958491 bytes. 18:47:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.tar.bz2 18:47:14 INFO - mkdir: /builds/slave/test/properties 18:47:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:47:14 INFO - Writing to file /builds/slave/test/properties/build_url 18:47:14 INFO - Contents: 18:47:14 INFO - build_url:https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.tar.bz2 18:47:14 INFO - Running post-action listener: _resource_record_post_action 18:47:14 INFO - Running post-action listener: set_extra_try_arguments 18:47:14 INFO - [mozharness: 2017-08-11 01:47:14.730489Z] Finished download-and-extract step (success) 18:47:14 INFO - [mozharness: 2017-08-11 01:47:14.730587Z] Running populate-webroot step. 18:47:14 INFO - Running pre-action listener: _resource_record_pre_action 18:47:14 INFO - Running main action method: populate_webroot 18:47:14 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:47:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:47:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:47:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:47:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:47:14 INFO - 'tests': ['damp', 'tps']}, 18:47:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:47:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:47:14 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:47:14 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:47:14 INFO - 'other-e10s': {'tests': ['a11yr', 18:47:14 INFO - 'ts_paint', 18:47:14 INFO - 'tpaint', 18:47:14 INFO - 'sessionrestore', 18:47:14 INFO - 'sessionrestore_many_windows', 18:47:14 INFO - 'sessionrestore_no_auto_restore', 18:47:14 INFO - 'tabpaint']}, 18:47:14 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:47:14 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:47:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:47:14 INFO - 'tsvgr_opacity', 18:47:14 INFO - 'tart', 18:47:14 INFO - 'tscrollx', 18:47:14 INFO - 'tsvg_static']}, 18:47:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:47:14 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:47:14 INFO - 'talos_options': ['--mitmproxy', 18:47:14 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:47:14 INFO - '--firstNonBlankPaint'], 18:47:14 INFO - 'tests': ['tp6_google', 18:47:14 INFO - 'tp6_youtube', 18:47:14 INFO - 'tp6_amazon', 18:47:14 INFO - 'tp6_facebook']}, 18:47:14 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:47:14 INFO - 'talos_options': ['--stylo', 18:47:14 INFO - '--mitmproxy', 18:47:14 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:47:14 INFO - '--firstNonBlankPaint'], 18:47:14 INFO - 'tests': ['tp6_google', 18:47:14 INFO - 'tp6_youtube', 18:47:14 INFO - 'tp6_amazon', 18:47:14 INFO - 'tp6_facebook']}, 18:47:14 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:47:14 INFO - 'talos_options': ['--stylo', 18:47:14 INFO - '--stylo-threads=1', 18:47:14 INFO - '--mitmproxy', 18:47:14 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:47:14 INFO - '--firstNonBlankPaint'], 18:47:14 INFO - 'tests': ['tp6_google', 18:47:14 INFO - 'tp6_youtube', 18:47:14 INFO - 'tp6_amazon', 18:47:14 INFO - 'tp6_facebook']}, 18:47:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:47:14 INFO - 'talos_options': ['--xperf_path', 18:47:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:47:14 INFO - 'tests': ['tp5n']}}} 18:47:14 INFO - Running post-action listener: _resource_record_post_action 18:47:14 INFO - [mozharness: 2017-08-11 01:47:14.739013Z] Finished populate-webroot step (success) 18:47:14 INFO - [mozharness: 2017-08-11 01:47:14.739104Z] Running create-virtualenv step. 18:47:14 INFO - Running pre-action listener: _resource_record_pre_action 18:47:14 INFO - Running main action method: create_virtualenv 18:47:14 INFO - Creating virtualenv /builds/slave/test/build/venv 18:47:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:47:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:47:14 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:47:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:47:14 INFO - Using real prefix '/usr' 18:47:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:47:15 INFO - Installing distribute.............................................................................................................................................................................................done. 18:47:17 INFO - Installing pip.................done. 18:47:17 INFO - Return code: 0 18:47:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:47:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:47:17 INFO - Reading from file tmpfile_stdout 18:47:17 INFO - Output received: 18:47:17 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:47:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:47:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1267b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126af00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1265ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1266050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:47:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:47:17 INFO - Using env: {'DISPLAY': ':0', 18:47:17 INFO - 'HOME': '/home/cltbld', 18:47:17 INFO - 'LANG': 'en_US.UTF-8', 18:47:17 INFO - 'LANGUAGE': 'en_US:en', 18:47:17 INFO - 'LOGNAME': 'cltbld', 18:47:17 INFO - 'MAIL': '/var/mail/cltbld', 18:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:17 INFO - 'MOZ_NO_REMOTE': '1', 18:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:17 INFO - 'NO_EM_RESTART': '1', 18:47:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:17 INFO - 'PWD': '/builds/slave/test', 18:47:17 INFO - 'SHELL': '/bin/bash', 18:47:17 INFO - 'SHLVL': '1', 18:47:17 INFO - 'TERM': 'linux', 18:47:17 INFO - 'TMOUT': '86400', 18:47:17 INFO - 'USER': 'cltbld', 18:47:17 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713', 18:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:17 INFO - '_': '/tools/buildbot/bin/python'} 18:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:47:17 INFO - Cleaning up... 18:47:17 INFO - Return code: 0 18:47:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:47:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1267b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126af00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1265ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1266050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:47:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:47:17 INFO - Using env: {'DISPLAY': ':0', 18:47:17 INFO - 'HOME': '/home/cltbld', 18:47:17 INFO - 'LANG': 'en_US.UTF-8', 18:47:17 INFO - 'LANGUAGE': 'en_US:en', 18:47:17 INFO - 'LOGNAME': 'cltbld', 18:47:17 INFO - 'MAIL': '/var/mail/cltbld', 18:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:17 INFO - 'MOZ_NO_REMOTE': '1', 18:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:17 INFO - 'NO_EM_RESTART': '1', 18:47:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:17 INFO - 'PWD': '/builds/slave/test', 18:47:17 INFO - 'SHELL': '/bin/bash', 18:47:17 INFO - 'SHLVL': '1', 18:47:17 INFO - 'TERM': 'linux', 18:47:17 INFO - 'TMOUT': '86400', 18:47:17 INFO - 'USER': 'cltbld', 18:47:17 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713', 18:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:17 INFO - '_': '/tools/buildbot/bin/python'} 18:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:17 INFO - Downloading/unpacking psutil>=3.1.1 18:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:47:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:47:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:47:19 INFO - Installing collected packages: psutil 18:47:19 INFO - Running setup.py install for psutil 18:47:19 INFO - building 'psutil._psutil_linux' extension 18:47:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:47:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:47:19 INFO - building 'psutil._psutil_posix' extension 18:47:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:47:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:47:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:47:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:47:19 INFO - Successfully installed psutil 18:47:19 INFO - Cleaning up... 18:47:19 INFO - Return code: 0 18:47:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1267b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126af00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1265ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1266050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:47:19 INFO - Using env: {'DISPLAY': ':0', 18:47:19 INFO - 'HOME': '/home/cltbld', 18:47:19 INFO - 'LANG': 'en_US.UTF-8', 18:47:19 INFO - 'LANGUAGE': 'en_US:en', 18:47:19 INFO - 'LOGNAME': 'cltbld', 18:47:19 INFO - 'MAIL': '/var/mail/cltbld', 18:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:19 INFO - 'MOZ_NO_REMOTE': '1', 18:47:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:19 INFO - 'NO_EM_RESTART': '1', 18:47:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:19 INFO - 'PWD': '/builds/slave/test', 18:47:19 INFO - 'SHELL': '/bin/bash', 18:47:19 INFO - 'SHLVL': '1', 18:47:19 INFO - 'TERM': 'linux', 18:47:19 INFO - 'TMOUT': '86400', 18:47:19 INFO - 'USER': 'cltbld', 18:47:19 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713', 18:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:19 INFO - '_': '/tools/buildbot/bin/python'} 18:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:47:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:47:21 INFO - Installing collected packages: mozsystemmonitor 18:47:21 INFO - Running setup.py install for mozsystemmonitor 18:47:21 INFO - Successfully installed mozsystemmonitor 18:47:21 INFO - Cleaning up... 18:47:21 INFO - Return code: 0 18:47:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1267b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126af00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1265ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1266050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:47:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:47:21 INFO - Using env: {'DISPLAY': ':0', 18:47:21 INFO - 'HOME': '/home/cltbld', 18:47:21 INFO - 'LANG': 'en_US.UTF-8', 18:47:21 INFO - 'LANGUAGE': 'en_US:en', 18:47:21 INFO - 'LOGNAME': 'cltbld', 18:47:21 INFO - 'MAIL': '/var/mail/cltbld', 18:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:21 INFO - 'MOZ_NO_REMOTE': '1', 18:47:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:21 INFO - 'NO_EM_RESTART': '1', 18:47:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:21 INFO - 'PWD': '/builds/slave/test', 18:47:21 INFO - 'SHELL': '/bin/bash', 18:47:21 INFO - 'SHLVL': '1', 18:47:21 INFO - 'TERM': 'linux', 18:47:21 INFO - 'TMOUT': '86400', 18:47:21 INFO - 'USER': 'cltbld', 18:47:21 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713', 18:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:21 INFO - '_': '/tools/buildbot/bin/python'} 18:47:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:21 INFO - Downloading/unpacking jsonschema==2.5.1 18:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:47:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:22 INFO - Downloading functools32-3.2.3-2.tar.gz 18:47:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:47:22 INFO - warning: no files found matching '*.txt' 18:47:22 INFO - no previously-included directories found matching 'build' 18:47:22 INFO - no previously-included directories found matching 'dist' 18:47:22 INFO - no previously-included directories found matching '.git*' 18:47:22 INFO - Installing collected packages: jsonschema, functools32 18:47:22 INFO - Running setup.py install for functools32 18:47:22 INFO - warning: no files found matching '*.txt' 18:47:22 INFO - no previously-included directories found matching 'build' 18:47:22 INFO - no previously-included directories found matching 'dist' 18:47:22 INFO - no previously-included directories found matching '.git*' 18:47:22 INFO - Successfully installed jsonschema functools32 18:47:22 INFO - Cleaning up... 18:47:22 INFO - Return code: 0 18:47:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1267b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126af00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1265ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1266050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:47:22 INFO - Using env: {'DISPLAY': ':0', 18:47:22 INFO - 'HOME': '/home/cltbld', 18:47:22 INFO - 'LANG': 'en_US.UTF-8', 18:47:22 INFO - 'LANGUAGE': 'en_US:en', 18:47:22 INFO - 'LOGNAME': 'cltbld', 18:47:22 INFO - 'MAIL': '/var/mail/cltbld', 18:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:22 INFO - 'MOZ_NO_REMOTE': '1', 18:47:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:22 INFO - 'NO_EM_RESTART': '1', 18:47:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:22 INFO - 'PWD': '/builds/slave/test', 18:47:22 INFO - 'SHELL': '/bin/bash', 18:47:22 INFO - 'SHLVL': '1', 18:47:22 INFO - 'TERM': 'linux', 18:47:22 INFO - 'TMOUT': '86400', 18:47:22 INFO - 'USER': 'cltbld', 18:47:22 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713', 18:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:22 INFO - '_': '/tools/buildbot/bin/python'} 18:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:47:23 INFO - Cleaning up... 18:47:23 INFO - Return code: 0 18:47:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1267b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126af00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1265ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1266050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:47:23 INFO - Using env: {'DISPLAY': ':0', 18:47:23 INFO - 'HOME': '/home/cltbld', 18:47:23 INFO - 'LANG': 'en_US.UTF-8', 18:47:23 INFO - 'LANGUAGE': 'en_US:en', 18:47:23 INFO - 'LOGNAME': 'cltbld', 18:47:23 INFO - 'MAIL': '/var/mail/cltbld', 18:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:23 INFO - 'MOZ_NO_REMOTE': '1', 18:47:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:23 INFO - 'NO_EM_RESTART': '1', 18:47:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:23 INFO - 'PWD': '/builds/slave/test', 18:47:23 INFO - 'SHELL': '/bin/bash', 18:47:23 INFO - 'SHLVL': '1', 18:47:23 INFO - 'TERM': 'linux', 18:47:23 INFO - 'TMOUT': '86400', 18:47:23 INFO - 'USER': 'cltbld', 18:47:23 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713', 18:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:23 INFO - '_': '/tools/buildbot/bin/python'} 18:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:23 INFO - Downloading/unpacking blobuploader==1.2.4 18:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:24 INFO - Downloading blobuploader-1.2.4.tar.gz 18:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:47:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:47:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:24 INFO - Downloading docopt-0.6.1.tar.gz 18:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:47:25 INFO - Installing collected packages: blobuploader, requests, docopt 18:47:25 INFO - Running setup.py install for blobuploader 18:47:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:47:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:47:25 INFO - Running setup.py install for requests 18:47:25 INFO - Running setup.py install for docopt 18:47:25 INFO - Successfully installed blobuploader requests docopt 18:47:25 INFO - Cleaning up... 18:47:25 INFO - Return code: 0 18:47:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1267b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126af00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1265ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1266050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:47:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:47:25 INFO - Using env: {'DISPLAY': ':0', 18:47:25 INFO - 'HOME': '/home/cltbld', 18:47:25 INFO - 'LANG': 'en_US.UTF-8', 18:47:25 INFO - 'LANGUAGE': 'en_US:en', 18:47:25 INFO - 'LOGNAME': 'cltbld', 18:47:25 INFO - 'MAIL': '/var/mail/cltbld', 18:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:25 INFO - 'MOZ_NO_REMOTE': '1', 18:47:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:25 INFO - 'NO_EM_RESTART': '1', 18:47:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:25 INFO - 'PWD': '/builds/slave/test', 18:47:25 INFO - 'SHELL': '/bin/bash', 18:47:25 INFO - 'SHLVL': '1', 18:47:25 INFO - 'TERM': 'linux', 18:47:25 INFO - 'TMOUT': '86400', 18:47:25 INFO - 'USER': 'cltbld', 18:47:25 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713', 18:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:25 INFO - '_': '/tools/buildbot/bin/python'} 18:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:47:25 INFO - Running setup.py (path:/tmp/pip-lqs5nT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:47:25 INFO - Running setup.py (path:/tmp/pip-Te9T9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:47:26 INFO - Running setup.py (path:/tmp/pip-iGmD93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:47:26 INFO - Running setup.py (path:/tmp/pip-fEIUbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:47:26 INFO - Running setup.py (path:/tmp/pip-_FB0oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:47:26 INFO - Running setup.py (path:/tmp/pip-ClYq1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:47:26 INFO - Running setup.py (path:/tmp/pip-196OPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:47:26 INFO - Running setup.py (path:/tmp/pip-tn5wrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:47:26 INFO - Running setup.py (path:/tmp/pip-QjLZnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:47:26 INFO - Running setup.py (path:/tmp/pip-Aittna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:47:26 INFO - Running setup.py (path:/tmp/pip-7Ans8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:47:26 INFO - Running setup.py (path:/tmp/pip-GthKzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:47:26 INFO - Running setup.py (path:/tmp/pip-nhuTNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:47:26 INFO - Running setup.py (path:/tmp/pip-KxLUQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:47:26 INFO - Running setup.py (path:/tmp/pip-pkg7yF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:47:26 INFO - Running setup.py (path:/tmp/pip-ZSLt9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:47:27 INFO - Running setup.py (path:/tmp/pip-vZeygL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:47:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:47:27 INFO - Running setup.py install for manifestparser 18:47:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:47:27 INFO - Running setup.py install for mozcrash 18:47:27 INFO - Running setup.py install for mozdebug 18:47:27 INFO - Running setup.py install for mozdevice 18:47:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:47:27 INFO - Running setup.py install for mozfile 18:47:27 INFO - Running setup.py install for mozhttpd 18:47:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:47:27 INFO - Running setup.py install for mozinfo 18:47:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:47:27 INFO - Running setup.py install for mozInstall 18:47:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:47:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:47:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:47:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:47:27 INFO - Running setup.py install for mozleak 18:47:27 INFO - Running setup.py install for mozlog 18:47:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:47:28 INFO - Running setup.py install for moznetwork 18:47:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:47:28 INFO - Running setup.py install for mozprocess 18:47:28 INFO - Running setup.py install for mozprofile 18:47:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:47:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:47:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:47:28 INFO - Running setup.py install for mozrunner 18:47:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:47:28 INFO - Running setup.py install for mozscreenshot 18:47:28 INFO - Running setup.py install for moztest 18:47:28 INFO - Running setup.py install for mozversion 18:47:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:47:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:47:28 INFO - Cleaning up... 18:47:28 INFO - Return code: 0 18:47:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1267b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126af00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1265ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1266050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:47:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:47:28 INFO - Using env: {'DISPLAY': ':0', 18:47:28 INFO - 'HOME': '/home/cltbld', 18:47:28 INFO - 'LANG': 'en_US.UTF-8', 18:47:28 INFO - 'LANGUAGE': 'en_US:en', 18:47:28 INFO - 'LOGNAME': 'cltbld', 18:47:28 INFO - 'MAIL': '/var/mail/cltbld', 18:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:28 INFO - 'MOZ_NO_REMOTE': '1', 18:47:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:28 INFO - 'NO_EM_RESTART': '1', 18:47:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:28 INFO - 'PWD': '/builds/slave/test', 18:47:28 INFO - 'SHELL': '/bin/bash', 18:47:28 INFO - 'SHLVL': '1', 18:47:28 INFO - 'TERM': 'linux', 18:47:28 INFO - 'TMOUT': '86400', 18:47:28 INFO - 'USER': 'cltbld', 18:47:28 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713', 18:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:28 INFO - '_': '/tools/buildbot/bin/python'} 18:47:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:47:29 INFO - Running setup.py (path:/tmp/pip-g3fajf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:47:29 INFO - Running setup.py (path:/tmp/pip-BPusGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:47:29 INFO - Running setup.py (path:/tmp/pip-Lt9dja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:47:29 INFO - Running setup.py (path:/tmp/pip-pDEitZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:47:29 INFO - Running setup.py (path:/tmp/pip-8NzWXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:47:29 INFO - Running setup.py (path:/tmp/pip-vKT5_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:47:29 INFO - Running setup.py (path:/tmp/pip-jTyZ9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:47:29 INFO - Running setup.py (path:/tmp/pip-2QZLUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:47:29 INFO - Running setup.py (path:/tmp/pip-3RGw89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:47:29 INFO - Running setup.py (path:/tmp/pip-gpa0rX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:47:29 INFO - Running setup.py (path:/tmp/pip-Lk1KAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:47:29 INFO - Running setup.py (path:/tmp/pip-NybouN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:47:29 INFO - Running setup.py (path:/tmp/pip-O85XcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:47:30 INFO - Running setup.py (path:/tmp/pip-buZX0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:47:30 INFO - Running setup.py (path:/tmp/pip-DHZXSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:47:30 INFO - Running setup.py (path:/tmp/pip-ekFtm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:47:30 INFO - Running setup.py (path:/tmp/pip-lOpcDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:47:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:31 INFO - Downloading blessings-1.6.tar.gz 18:47:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:47:31 INFO - Installing collected packages: blessings 18:47:31 INFO - Running setup.py install for blessings 18:47:31 INFO - Successfully installed blessings 18:47:31 INFO - Cleaning up... 18:47:31 INFO - Return code: 0 18:47:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:47:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:47:31 INFO - Reading from file tmpfile_stdout 18:47:31 INFO - Current package versions: 18:47:31 INFO - argparse == 1.2.1 18:47:31 INFO - blessings == 1.6 18:47:31 INFO - blobuploader == 1.2.4 18:47:31 INFO - docopt == 0.6.1 18:47:31 INFO - functools32 == 3.2.3-2 18:47:31 INFO - jsonschema == 2.5.1 18:47:31 INFO - manifestparser == 1.1 18:47:31 INFO - mozInstall == 1.13 18:47:31 INFO - mozcrash == 1.0 18:47:31 INFO - mozdebug == 0.1 18:47:31 INFO - mozdevice == 0.51 18:47:31 INFO - mozfile == 1.2 18:47:31 INFO - mozhttpd == 0.7 18:47:31 INFO - mozinfo == 0.10 18:47:31 INFO - mozleak == 0.1 18:47:31 INFO - mozlog == 3.5 18:47:31 INFO - moznetwork == 0.27 18:47:31 INFO - mozprocess == 0.25 18:47:31 INFO - mozprofile == 0.28 18:47:31 INFO - mozrunner == 6.13 18:47:31 INFO - mozscreenshot == 0.1 18:47:31 INFO - mozsystemmonitor == 0.3 18:47:31 INFO - moztest == 0.8 18:47:31 INFO - mozversion == 1.4 18:47:31 INFO - psutil == 3.1.1 18:47:31 INFO - requests == 1.2.3 18:47:31 INFO - wsgiref == 0.1.2 18:47:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1267b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126af00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1265ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1266050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:47:31 INFO - Using env: {'DISPLAY': ':0', 18:47:31 INFO - 'HOME': '/home/cltbld', 18:47:31 INFO - 'LANG': 'en_US.UTF-8', 18:47:31 INFO - 'LANGUAGE': 'en_US:en', 18:47:31 INFO - 'LOGNAME': 'cltbld', 18:47:31 INFO - 'MAIL': '/var/mail/cltbld', 18:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:31 INFO - 'MOZ_NO_REMOTE': '1', 18:47:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:31 INFO - 'NO_EM_RESTART': '1', 18:47:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:31 INFO - 'PWD': '/builds/slave/test', 18:47:31 INFO - 'SHELL': '/bin/bash', 18:47:31 INFO - 'SHLVL': '1', 18:47:31 INFO - 'TERM': 'linux', 18:47:31 INFO - 'TMOUT': '86400', 18:47:31 INFO - 'USER': 'cltbld', 18:47:31 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713', 18:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:31 INFO - '_': '/tools/buildbot/bin/python'} 18:47:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:47:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:47:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:47:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:47:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:47:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:47:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:47:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:47:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:47:32 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:47:33 INFO - Installing collected packages: simplejson 18:47:33 INFO - Running setup.py install for simplejson 18:47:33 INFO - building 'simplejson._speedups' extension 18:47:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 18:47:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 18:47:34 INFO - Successfully installed simplejson 18:47:34 INFO - Cleaning up... 18:47:34 INFO - Return code: 0 18:47:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1267b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126af00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1265ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1266050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:47:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:47:34 INFO - Using env: {'DISPLAY': ':0', 18:47:34 INFO - 'HOME': '/home/cltbld', 18:47:34 INFO - 'LANG': 'en_US.UTF-8', 18:47:34 INFO - 'LANGUAGE': 'en_US:en', 18:47:34 INFO - 'LOGNAME': 'cltbld', 18:47:34 INFO - 'MAIL': '/var/mail/cltbld', 18:47:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:34 INFO - 'MOZ_NO_REMOTE': '1', 18:47:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:34 INFO - 'NO_EM_RESTART': '1', 18:47:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:34 INFO - 'PWD': '/builds/slave/test', 18:47:34 INFO - 'SHELL': '/bin/bash', 18:47:34 INFO - 'SHLVL': '1', 18:47:34 INFO - 'TERM': 'linux', 18:47:34 INFO - 'TMOUT': '86400', 18:47:34 INFO - 'USER': 'cltbld', 18:47:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713', 18:47:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:34 INFO - '_': '/tools/buildbot/bin/python'} 18:47:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:47:34 INFO - Cleaning up... 18:47:34 INFO - Return code: 0 18:47:34 INFO - Running post-action listener: _resource_record_post_action 18:47:34 INFO - Running post-action listener: _start_resource_monitoring 18:47:34 INFO - Starting resource monitoring. 18:47:34 INFO - [mozharness: 2017-08-11 01:47:34.569895Z] Finished create-virtualenv step (success) 18:47:34 INFO - [mozharness: 2017-08-11 01:47:34.570358Z] Running install step. 18:47:34 INFO - Running pre-action listener: _resource_record_pre_action 18:47:34 INFO - Running main action method: install 18:47:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:47:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:47:34 INFO - Reading from file tmpfile_stdout 18:47:34 INFO - Detecting whether we're running mozinstall >=1.0... 18:47:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:47:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:47:34 INFO - Reading from file tmpfile_stdout 18:47:34 INFO - Output received: 18:47:34 INFO - Usage: mozinstall [options] installer 18:47:34 INFO - Options: 18:47:34 INFO - -h, --help show this help message and exit 18:47:34 INFO - -d DEST, --destination=DEST 18:47:34 INFO - Directory to install application into. [default: 18:47:34 INFO - "/builds/slave/test"] 18:47:34 INFO - --app=APP Application being installed. [default: firefox] 18:47:34 INFO - mkdir: /builds/slave/test/build/application 18:47:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:47:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:47:52 INFO - Reading from file tmpfile_stdout 18:47:52 INFO - Output received: 18:47:52 INFO - /builds/slave/test/build/application/firefox/firefox 18:47:52 INFO - Running post-action listener: _resource_record_post_action 18:47:52 INFO - [mozharness: 2017-08-11 01:47:52.906933Z] Finished install step (success) 18:47:52 INFO - [mozharness: 2017-08-11 01:47:52.907182Z] Running setup-mitmproxy step. 18:47:52 INFO - Running pre-action listener: _resource_record_pre_action 18:47:52 INFO - Running main action method: setup_mitmproxy 18:47:52 INFO - Skipping: mitmproxy is not required 18:47:52 INFO - Running post-action listener: _resource_record_post_action 18:47:52 INFO - [mozharness: 2017-08-11 01:47:52.908315Z] Finished setup-mitmproxy step (success) 18:47:52 INFO - [mozharness: 2017-08-11 01:47:52.908534Z] Running run-tests step. 18:47:52 INFO - Running pre-action listener: _resource_record_pre_action 18:47:52 INFO - Running pre-action listener: _set_gcov_prefix 18:47:52 INFO - Running main action method: run_tests 18:47:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:47:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:47:52 INFO - Python 2.7.3 18:47:52 INFO - Return code: 0 18:47:52 INFO - grabbing minidump binary from tooltool 18:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:52 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126af00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1265ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1266050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:47:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:47:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:47:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:47:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:47:53 INFO - Return code: 0 18:47:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:47:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:47:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:47:53 INFO - ENV: RUST_BACKTRACE is now full 18:47:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:47:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:47:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:47:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:47:53 INFO - Using env: {'DISPLAY': ':0', 18:47:53 INFO - 'HOME': '/home/cltbld', 18:47:53 INFO - 'LANG': 'en_US.UTF-8', 18:47:53 INFO - 'LANGUAGE': 'en_US:en', 18:47:53 INFO - 'LOGNAME': 'cltbld', 18:47:53 INFO - 'MAIL': '/var/mail/cltbld', 18:47:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:47:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:47:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:53 INFO - 'MOZ_NO_REMOTE': '1', 18:47:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:47:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:53 INFO - 'NO_EM_RESTART': '1', 18:47:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:53 INFO - 'PWD': '/builds/slave/test', 18:47:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:47:53 INFO - 'RUST_BACKTRACE': 'full', 18:47:53 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:47:53 INFO - 'SHELL': '/bin/bash', 18:47:53 INFO - 'SHLVL': '1', 18:47:53 INFO - 'STYLO_FORCE_ENABLED': '1', 18:47:53 INFO - 'TERM': 'linux', 18:47:53 INFO - 'TMOUT': '86400', 18:47:53 INFO - 'USER': 'cltbld', 18:47:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713', 18:47:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:53 INFO - '_': '/tools/buildbot/bin/python'} 18:47:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:47:53 INFO - mozversion application_buildid: 20170811005950 18:47:53 INFO - mozversion application_changeset: bb88ccb10454a78b8fa4a7d6c45bdf6fc47de3cd 18:47:53 INFO - mozversion application_display_name: Nightly 18:47:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:47:53 INFO - mozversion application_name: Firefox 18:47:53 INFO - mozversion application_remotingname: firefox 18:47:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:47:53 INFO - mozversion application_vendor: Mozilla 18:47:53 INFO - mozversion application_version: 57.0a1 18:47:53 INFO - mozversion platform_buildid: 20170811005950 18:47:53 INFO - mozversion platform_changeset: bb88ccb10454a78b8fa4a7d6c45bdf6fc47de3cd 18:47:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:47:53 INFO - mozversion platform_version: 57.0a1 18:47:53 INFO - using testdate: 1502416073 18:47:53 INFO - actual date: 1502416073 18:47:53 INFO - starting webserver on 'localhost:51455' 18:47:53 INFO - SUITE-START | Running 2 tests 18:47:53 INFO - TEST-START | dromaeo_css 18:47:53 INFO - Initialising browser for dromaeo_css test... 18:47:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51455/getInfo.html -profile /tmp/tmpwN1tAH/profile 18:47:53 INFO - TEST-INFO | started process 4150 (/builds/slave/test/build/application/firefox/firefox http://localhost:51455/getInfo.html) 18:47:58 INFO - TEST-INFO | 4150: exit 0 18:47:58 INFO - Browser initialized. 18:47:58 INFO - Running cycle 1/1 for dromaeo_css test... 18:47:58 INFO - TEST-INFO | started process 4381 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwN1tAH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:47:59 INFO - PID 4381 | 18:47:59 INFO - PID 4381 | (/builds/slave/test/build/application/firefox/firefox:4435): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:47:59 INFO - PID 4381 | 18:48:10 INFO - PID 4381 | RSS: Main: 168144896 18:48:10 INFO - PID 4381 | 18:51:09 INFO - PID 4381 | Cycle 1(1): loaded http://localhost:51455/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51455/tests/dromaeo/cssquery-ext.html) 18:51:11 INFO - PID 4381 | RSS: Main: 175149056 18:51:11 INFO - PID 4381 | 18:54:12 INFO - PID 4381 | Cycle 1(1): loaded http://localhost:51455/tests/dromaeo/cssquery-ext.html (next: http://localhost:51455/tests/dromaeo/cssquery-jquery.html) 18:54:13 INFO - PID 4381 | RSS: Main: 172347392 18:54:13 INFO - PID 4381 | 18:57:15 INFO - PID 4381 | Cycle 1(1): loaded http://localhost:51455/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51455/tests/dromaeo/cssquery-mootools.html) 18:57:15 INFO - PID 4381 | RSS: Main: 172544000 18:57:15 INFO - PID 4381 | 19:00:17 INFO - PID 4381 | Cycle 1(1): loaded http://localhost:51455/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51455/tests/dromaeo/cssquery-prototype.html) 19:00:18 INFO - PID 4381 | RSS: Main: 172507136 19:00:18 INFO - PID 4381 | 19:03:22 INFO - PID 4381 | Cycle 1(1): loaded http://localhost:51455/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51455/tests/dromaeo/cssquery-yui.html) 19:03:22 INFO - PID 4381 | RSS: Main: 176525312 19:03:22 INFO - PID 4381 | 19:06:24 INFO - PID 4381 | Cycle 1(1): loaded http://localhost:51455/tests/dromaeo/cssquery-yui.html (next: http://localhost:51455/tests/dromaeo/cssquery-dojo.html) 19:06:24 INFO - PID 4381 | RSS: Main: 177291264 19:06:24 INFO - PID 4381 | 19:06:24 INFO - PID 4381 | __start_tp_report 19:06:24 INFO - PID 4381 | _x_x_mozilla_page_load 19:06:24 INFO - PID 4381 | _x_x_mozilla_page_load_details 19:06:24 INFO - PID 4381 | |i|pagename|runs| 19:06:24 INFO - PID 4381 | |0;dojo.html;3119.82840943748;3160.956884228205;3165.5884734984443;3169.8256595887224;3181.061586831884;6242.032484964832;6259.123722678829;6286.057091436287;6310.179676642036;6324.715387807548;6279.40345667162;6285.151504546885;6299.086632438294;6404.327545607703;6449.838754031151;5807.651540907559;5809.622374545641;5832.475077243047;5852.151438041481;5896.911546326808;5765.769369225247;5776.046952252873;5820.505257053155;5838.678872662002;5935.792247271346;5684.289463817023;5709.6574205547595;5738.31140263169;5751.194832723422;5792.971035144818;5697.287839020122;5757;5782.479576838063;5794.82615521535;5798.391168927286;5683.374828768832;5694.629849059798;5760.164776107483;5771.855703607402;5784.68184249866;6151.569390142692;6195.721192546302;6199.070139479069;6245.656488893109;6258.87482250357;6475.061116138134;6642.800715978528;6711.161104861892;6723.159605049369;6733.595984240961;6806.659667016679;6811.318868113199;6881.277465866112;6894.517383783137;6911.17065952084;6284.937150628527;6292.87414251717;6305.274893387227;6361.650109244036;6374.936250637481;6918.308169183142;6963.338482844122;7004.229534751174;7042.7887163385185;7049.929500704928;6530.151080359523;6626.9337306627285;6630.96684516584;6704;6708.932910670831;6737.663116844138;6788.083608712859;6800.353966373186;6820.215675197316;6826.044353790473;6696.2968888267005;6698.129243198353;6792.76225332111;6800;6808.353206445379;6712.12742343502;6719.764808231688;6719.798406047827;6792.218894827158;6830.7609233676585;5404.621676482687;5488.91766623501;5500.339959204921;5503.394626591072;5506.063969125258;4669.41632295963;4680.4149481314835;4683.227267500893;4686.133065382915;4689.179393606105;5796.21751063601;5811.767529298781;5858;5876.9118463223085;5883.852903677443;6734.124563806674;6813.727450902007;6837.282085381063;6845.178578570603;6846.520743548003;5758.481736643722;5789.073748200268;5847.26909136358;5877.9118313225335;5885.352611212763;5799.855003624859;5845.41545845412;5941.970290148522;5948.2862056553495;5955.642661440327;6628.8674226515195;6636.13730215069;6646;6649.634270115093;6652.767153149616;6825.55633883796;6851.314868513208;6861.382475577222;6862.794116176523;6881.208661004049;6552.180977377828;6605.9009114864275;6639.269680335063;6646.700898459484;6655.068290439245;6499.025146228104;6601.075849380994;6610.041543976193;6614.371634694697;6624.436922861611;6749.932500675127;6761.492888033319;6771.153605799275;6775.525713200226;6778.0510728497065;6442.8389290268115;6550.934490655032;6558.540902136805;6559.344065593403;6562.50781191403;6483.286838447672;6542.34576542342;6555.508336874658;6558.770443034471;6562.671866406756;6420.454261387835;6497.740090396331;6517.120188774455;6584.111144995364;6585.539012269287;6515.869682606227;6530.771423000172;6550.574212676161;6623.873941430064;6652.73389064432;6374.426301632875;6393.552451328363;6403.295637479967;6413.967930160319;6418.422341989243 19:06:24 INFO - PID 4381 | |1;ext.html;835.0855812884889;838.3042075077686;867.3451544084215;899.7615631857559;902.5622573052069;42261;43209;43270.78364608181;43405;43453.565464345345;39090.60909390905;39147.21705565887;39166.41250381246;39171.80414097933;39231.607683923154;7043.190033146189;7160.391366733834;7210.963945180293;7221.747238846641;7230.168530618967;7076.575405475663;7164.247753985835;7165.2476489968585;7167.820804479878;7175.533590316612;7095.609741464217;7116.786496405116;7118.3949364303835;7152.785416437489;7174.426045916341;7069.151701795766;7105.609191494465;7105.680244388989;7110.6800193990875;7115.359617634386;6462.515311351621;6487.643179625119;6572.572782769104;6579.407853293179;6581.243157036906;34426.655733442596;34456.48315275273;34458.310833783435;34469;34654;3384.5938487381427;3436.862525499002;3444.3111377724554;3444.51776751255;3448.5344478495585;27465;27618.033368832195;27662.86168569144;27669.03158389467;27691.307717307027;4508.571685689854;4538.7503687297185;4547.386102876102;4556.066006468666;4590.517995610447;182587;183129;183551;183925.08037459862;184003;21654.891725541587;21658.133674653152;21742.565148696936;21758.564828703336;21844.45388865259;55413.722931385084;56648.150277745866;56729.71635141881;56872.715636421555;56973.430265696814;14418.13491190532;14520.782188267185;14541.27293635314;14541.27293635314;14542.345594448276;11122.110231181487;11308.830367544493;11447.08423326132;11457.541698331974;11458;14696.412143514353;14738.852611473962;14821.481248156262;14837.332320045623;15000;5954.697710995049;6110.150605118835;6116.204893363834;6157;6178.7219575119225;1004.6533945788691;1011.4993078426226;1043.0508237503834;1046.1944302886886;1051.2220956492295;22834.31497055091;23471.53056938886;23782.762172378054;29552.261193469905;29577.26056848596;1092.5629748100823;1112.6161474291519;1113.582406597526;1115.9553617855195;1116.625930313338;11996.340201289013;12394.75210495785;12397.93801030989;12434.62696119118;12471;238192;241018;241454;241494;241712;53411;54244.37266882;54339.72830135903;55349.16976245279;57565.424345756845;1455.8107446031947;1500.8724258438156;1505.4881340344116;1508.9622759431102;1524.05508584676;25667.844946977806;26729;26845.597316039883;27065.052723155382;27290.45419091647;37771.244575108896;38160.618393815705;38184.427233592076;38423.615763842005;38443.80778096092;201026;201283;201387;201721;202534;33216.501752474214;34218.48672269868;35123.648763512036;35138.824305878305;35158.82420587983;42747.358789618804;43069.138617228105;43079.13841723085;43101.78449107734;43445.78277108594;32276.35447291088;32295.67704322927;32354.514682279314;32372.838135809172;32431.351372971938;30811.537826932166;31069.844650776602;33849.661503385636;35125.824370877985;35200.647993519735;38019.61980380161;38113.2377352457;38218;38316.80841595774;38452.80773596114;33535.329293414485;33860.49209261814;34001.82999084989;34286.82856585701;35071.824640877654;23701.644475332538;24347.878260608584;24690.876545617157;24901.377465563506;25062.874685627183 19:06:24 INFO - PID 4381 | |2;jquery.html;574.2592056247441;578.9623674461158;590.1619700025965;593.1340243244861;607.2682417686688;22011.449713757163;22730.431739206506;23517;23528.647070293937;23539.646905296435;25607.231783046493;25897.74102258977;26149.34626634335;26217.60673589898;26421.73578264217;6448.451881590058;6525.510586705992;6562.835929101763;6595.241547222083;6609.471242300604;6141.447269745722;6492.220933487988;6608.966955165218;6624.56940298879;6688.732450701966;6655.633940133291;6663.766768163116;6666.233383160926;6669.833254168636;6670.266270710218;6623.403893649571;6632;6673.03241030048;6673.299303573103;6673.966630166842;6200.038993955944;6202.937970620326;6205.472534834545;6222.751089956441;6230.283517395467;29254.268643283875;29811.254718632208;30453.543196852064;31428.37143257145;31431;1957.119296316649;1992.8007199279955;2013.536886516095;2015.556577552936;2016.3648450737971;19996.500087497785;20224.797752022438;20264.594708105757;20310.695339569917;20325.288614898556;2390.34265576966;2513.962290565643;2520.5337012652717;2527.2670925431785;2545.185540627;136716;140036.29981850128;140873;141373;141764;14611.92694036523;14883.70232595342;15351.53945381618;15784.447544335893;15905.840941590435;23957.16149934744;24005.039798408216;24045.639315410284;24127;24148.87925560361;9325.813483730288;9635.807283854283;9738.513074346254;9752.122308992224;9752.26857985654;6919.37725604698;8530.317574594017;8605.053444121142;8688.13118688126;8735.606897689619;8069.878951815727;9312.255019598417;9429.339946203838;9520.761980950394;9656.806863862683;2847.8181554655002;2855.9000434984678;2874.016140777888;2889.7977141599886;3016.502277124294;969.2004096620317;978.7553111722069;983.537737263485;988.1946213835845;992.538469611634;19587.412377628694;19612.90193549023;19902.701459478118;20196.798032019786;20328.59342813165;1022.5705203814416;1023.8873723890366;1031.9845202321972;1035.7100011996654;1037.699067270483;10927.562897484011;10946;11127.221094523306;11159.27464714791;11167.329960202414;434241;434269;461312;472383;475885;115562;115900;118777;119744.4012779948;121019.39490302668;1209.818527220924;1226.1478272600457;1241.975160496785;1253.893419059372;1259.527677121098;17692.557686057953;17791.377301794375;17899.37352192667;18135.546611334823;18227.817721822612;55311.44688553224;55526.444735552126;56032.15951760808;57118.71440642936;57983;71049.64475177591;71263.28736712773;71422.64288678524;71699;72299.63850180716;14636.41454341857;15125.924370378078;15286;15308.387664493295;15309.698675612697;23081.88459057694;23323.766762332838;23346.649800253348;23361;23487.295381138592;17583.912080439517;18153.546161346072;18848.52878678044;18858.811411885705;18879;16305.429309974093;16709.74935375946;16802.907810992736;17089.401870934456;17094.487165385057;19199.712004320227;19251.4224573263;19317.4204773857;19348.129334180278;19416;14697.779533307223;14830.703385932437;14873.851261487247;14954.25228738537;15023.6995260092;18194.636107278046;18477.445676629723;18623.255069797597;18624.720629190844;18636.068196589844 19:06:24 INFO - PID 4381 | |3;mootools.html;1340.128916204467;1383.4673650644504;1387.8403983541882;1395.5394719742483;1403.8455769865313;13734.244616546099;14425.278736063194;14466;14474.855251447483;14476.13143211408;13761.243131627756;14715.190664513448;14718.484853030146;14733;14831.184284864328;2658.508175987439;2697.757201851833;2700.216937088242;2700.405910699643;2702.5270577648835;2583.4962182374443;2588.4434846507997;2617.947641047178;2678.1429942418436;2682.9060982865603;2660.401409682825;2682.8658567071666;2685.717999610042;2686.5029969455713;2686.865656717166;2570.691517017951;2583.9483210335875;2584.8449093054383;2595.9610605840926;2599.6750406199226;2418.153646223825;2423.1397853762014;2436.926892193237;2454.3005243505695;2471.147454128323;13925.164490130624;14256.358463869046;14274;14275.714485710332;14284;7261.346478816879;7390.630468476555;7548.698052077911;7574.280443357872;7598.582077985709;4962.643355208208;5012.974935125301;5089.262057001714;5133.409657889353;5179.14544100223;1805.8194180581968;1807.322254154692;1820.5357633803296;1869.9626007479774;1874.7000479923147;23603.527929441487;23645.76354236453;23823.523529529484;23832;23948.640770388458;6225.28409232935;6272.466840318532;6310.337414571404;6380.202474690664;6465.676716164173;15043.247837608076;15565.922170389076;16307.1031093291;16327.918360408123;16337.509874703777;7440.218777028443;7690.115636701739;7699.576523291161;7701.960235368154;7702.037245344332;6841.521093523505;7009.158900931819;7042.647867606599;7055.89416158758;7075.327843854826;4928.654994150446;5015.874603134951;5122.897542049138;5155.200943853709;5173.663711858717;1430.6494908747422;1445.262915912871;1458.2562892924684;1463.604826696786;1464.0922627970726;838.9748307550783;864.0624921959744;882.0209567380202;884.1512148337539;884.2881480408333;7016.5088443808445;7021;7027.262137475492;7037.472189585802;7107.111611048619;720.2941117704679;725.2964624314407;727.9745208917662;730.9305615966475;738.8079099434186;4348.869533913988;4414.55854414556;4455.420795296591;4483.103379324149;4512.2554778461845;18418.631627367646;18781.436556903314;18784.62430751377;19083.61832763365;20028;18468.538286542946;18578.628427431646;19527.511812204524;19649.410517684493;19778.60442791136;10493.422861742678;11168;11184.496697648625;11213.271137376045;11216;7842.451028427955;8188.467749596257;8221.424500284922;8269.917300826915;8277.337812975067;16704.916475417544;17002.48992530226;17294.82705172932;17296.394626188023;17371.652566948338;16724.58188545296;17059.402920897708;17398.391056313474;17431.128443578025;17628.823711762718;11482.827757583476;11797.174197806415;11813.468393922467;11830.290182589073;11843.170978031456;12824.102312838011;12962.351882405654;13074.346282685638;13082.607521774362;13087.541936032194;10597.735056623646;10632.362058276529;10682.679519614425;10712;10857.565697372333;10243.795124097625;10327.070563649308;10397.220208484545;10530.631427899987;10564.313319634199;9247.352685311964;9379.217948589747;9392.154706076486;9406;9434.95282523583;6532.216134063943;6553.705083271169;6569.967150164219;6601.33986601336;6644.800655980328;6588;6842.384185423137;6854.931450685429;6870.484713646597;6873.20958089826 19:06:24 INFO - PID 4381 | |4;prototype.html;501.1555771803917;501.4709481497021;508.99236511452335;530.68954661523;535.5983012740445;6313.842153946153;6347.714352854121;6350.841228969278;6379.362063793618;6382.617042977413;6229.283632382266;6267.153934218879;6274.811755647326;6281.466075383586;6296.929521981263;5138.511841375082;5159.200323949775;5170.663906846043;5190.7664155112925;5230.73846307685;4788.497207793166;4914.164592019365;5084.084864724348;5089.389273287192;5136.383633963929;4908.460069392364;4930.457649658535;4957.752112394384;4966.882451448413;5007.098722229997;4896.335246016354;4923.77842997066;4941.962187940537;4954.925676114861;4997.275395067732;4408.757518336491;4410.9854733411175;4433.578810013044;4452;4493.3709280700405;5990.610610310359;6071.241094863142;6092.756289748405;6104.328523862371;6106.419890110433;5706.629069110494;5745.253117094792;5763.366029736726;5781.306243250795;5787.189793428924;6501.9674901625185;6536.967315163393;6565.179352580927;6605;6649.401553860127;4867.415910090812;4907.141250281222;4922.704637721712;4937.950620493821;4938.9012219755405;6740.191177058735;6744.156980377453;6905.482088843357;6913.997470366819;6969.4424446044195;4999.400071991385;5020.2720605511995;5044.621653375938;5063.518965698253;5074.594032477393;5063.189889617717;5090.389153301628;5120.283160357553;5121.103806833789;5148.433672296044;5657.490825825613;5690.658560486384;5718.828435146952;5734.025215713339;5767.8558036049435;6627;6671.299513551105;6690.59856408617;6694.698738556776;6725.6973436195485;1764.1620230390463;1793.8744287899983;1803.2967142814314;1812.392848395776;1818.9181486833124;1191.237607930925;1234.2964510229083;1242.9440675169458;1258.314218750783;1264.3551788587886;5717.542596592262;5763.423657634203;5767.625104368287;5786.61121330886;5814.476697097281;6680.164979377578;6726.899096513556;6779.102016340624;6862.691178896962;6882.139732533434;5677.914831277534;5709.571782116358;5728.226689396878;5758;5775.768969241268;3636.5453818472292;3642.307961487309;3643.0509677322507;3659.213269147146;3665.9816700916326;6510.9023364649565;6589.80230593083;6592.604443733391;6649.102371179829;6684.732610695615;6531.608103513804;6989.6370207810005;6991.056207412036;7024.5434046786795;7048.506604537633;6468.967655161694;6513.381228783258;6533.509986750918;6559.934400655932;6569.605823650596;6692.966535167293;6805.693743781443;6822.897656535057;6856.382925536725;6872.244053154049;6645.003249512612;6662.200535935719;6683.732650694113;6686.5653732507235;6749.86500269982;6517.185351831021;6523.478121750154;6530.640814755234;6592.406683398517;6594.703238354382;5068.214426763858;5091.236314552847;5099.515546023122;5099.770510327118;5125.128728116304;6618.371254730985;6669.46644268467;6824.795256142125;6867.4975762360555;6888.793336199922;6536.039188243603;6551.344865513411;6581.901271481028;6588.40704336612;6647.169103862017;6382.297947225708;6460.676966151767;6510.804675859732;6513.088167656437;6543.738250470118;6487.156669632917;6493.155889734304;6497.610143391223;6504.544681872224;6539.673016349258;6526.641034743135;6563.638999855054;6570.441512471493;6619.073329733745;6680.331966803281;6386.744530218925;6414.422701956846;6450.967745161244;6452.741890324334;6465.418112369909 19:06:24 INFO - PID 4381 | |5;yui.html;886.9068747781482;893.4728510178994;916.5783739479839;921.4379228670509;922.8062106957539;18341.54146146347;19167;19258.614827703437;19262.42212733617;19294.614107717854;17775.64448711025;17782.46652600421;17872.55318617032;18933.621327573474;22700.432489187737;1045.503385891703;1068.4924660786103;1070.9303895246824;1071.9249652524327;1072.5816931396762;1057.4078516031047;1074.5862842805498;1075;1075.1828610256223;1081.3079629037422;1051.8895515970828;1089.2103225161734;1093.6445655162065;1127.9718007049808;1139.3676509537204;1086.1202426034938;1090.3675867996583;1090.9618163364323;1091.1107447430397;1091.3233795047042;796.1361922314296;796.1998191817245;797.5533701127388;797.6490344248571;798.1260519730886;20140.295089671938;20173.394798155932;20388.592228155354;20598.27906023297;21256;21176.894115529478;21840.45398865041;22334.77665223343;22503.437414064614;22629.547409051727;16436.424725134562;16438.260278287507;16574.585635359093;16587.585310367216;16920;3655.6527129922615;3677.0439685681918;3686.5391826021746;3690.2066055797864;3710.5547334320054;124251;125499;129374;129840;129934;16502.917485412498;17059;17067;17171.656566868594;17332.13339333028;31043.68956310453;31185.376292474022;31475.213119672193;31581.210469738442;32268;8409.831803363899;8505.064442911274;8584.570771461527;8586.484810911365;8606.784830379165;4257.489101307863;4286.249906266391;4304.935425968613;4345.760983145894;4395.846145384896;5370.597205209625;5455.563554915597;5475.67145971243;5484.424135465799;5492.80775172867;972.4845831709206;997.9051990060933;1011.6443965086819;1015.8774554117741;1020.132887046005;679.9966000169967;685.3557655803529;689.407109885498;696.1854630082815;704.4998051383575;11885.702857428634;11912.404379780975;12261.14172007951;12333.444994975069;12578.056645751605;686.0566720758957;687.4672129099888;692.9882371737219;698.8916717908733;698.8951657251351;5439.5376393006245;5654.802081927113;5729.541636669056;5730.426957304237;5732.3121225453215;107563;111013;112134;113057.43471282591;113256;71892.64053679699;94895.52552237194;96941.51529242449;99257;105841.94158058321;80501;81921.59039204766;83121.16878831256;86633.5668321667;89891.55054224687;12310.50757969707;12356.876431235933;12785.87214127884;13074.738505230032;13273.933630332172;38080.23839523138;39781.60218397779;39866.80066599648;40086.198276033734;40395.79802100971;69211;69540.65229673819;71065;73029.26970730224;75269;18608.255669773058;18801.435956921316;18858.52853678669;18905.71641425407;19234.8076519233;20886.47783805356;20984.475388115417;21146.682799758324;21148.365549033555;21266.149354025667;18617.81382186215;19146.712799307745;19268.13293401772;19272.13275402582;19357.709634355215;19887.502812429226;19896.30362937348;20196.293129740978;20316.89841550783;20814.37556873296;18308.176132074354;18318.542036449195;18448.907755461136;18631.068446577887;18686.43940681782;13433.529826456028;13645.658858528219;14222.502212422516;14350.784738228725;14552.781708274173;13929.651758706113;14519.854801451851;14577.562673119823;14650.974431789673;15315.310811013309 19:06:24 INFO - PID 4381 | __end_tp_report 19:06:24 INFO - PID 4381 | __start_cc_report 19:06:24 INFO - PID 4381 | _x_x_mozilla_cycle_collect,391 19:06:24 INFO - PID 4381 | __end_cc_report 19:06:24 INFO - PID 4381 | __startTimestamp1502417184915__endTimestamp 19:06:24 INFO - PID 4381 | 19:06:24 INFO - PID 4381 | ------- Summary: start ------- 19:06:24 INFO - PID 4381 | Number of tests: 6 19:06:24 INFO - PID 4381 | 19:06:24 INFO - PID 4381 | [#0] dojo.html Cycles:165 Average:6220.98 Median:6475.06 stddev:741.12 (11.4%) stddev-sans-first:702.33 19:06:24 INFO - PID 4381 | Values: 3119.8 3161.0 3165.6 3169.8 3181.1 6242.0 6259.1 6286.1 6310.2 6324.7 6279.4 6285.2 6299.1 6404.3 6449.8 5807.7 5809.6 5832.5 5852.2 5896.9 5765.8 5776.0 5820.5 5838.7 5935.8 5684.3 5709.7 5738.3 5751.2 5793.0 5697.3 5757.0 5782.5 5794.8 5798.4 5683.4 5694.6 5760.2 5771.9 5784.7 6151.6 6195.7 6199.1 6245.7 6258.9 6475.1 6642.8 6711.2 6723.2 6733.6 6806.7 6811.3 6881.3 6894.5 6911.2 6284.9 6292.9 6305.3 6361.7 6374.9 6918.3 6963.3 7004.2 7042.8 7049.9 6530.2 6626.9 6631.0 6704.0 6708.9 6737.7 6788.1 6800.4 6820.2 6826.0 6696.3 6698.1 6792.8 6800.0 6808.4 6712.1 6719.8 6719.8 6792.2 6830.8 5404.6 5488.9 5500.3 5503.4 5506.1 4669.4 4680.4 4683.2 4686.1 4689.2 5796.2 5811.8 5858.0 5876.9 5883.9 6734.1 6813.7 6837.3 6845.2 6846.5 5758.5 5789.1 5847.3 5877.9 5885.4 5799.9 5845.4 5942.0 5948.3 5955.6 6628.9 6636.1 6646.0 6649.6 6652.8 6825.6 6851.3 6861.4 6862.8 6881.2 6552.2 6605.9 6639.3 6646.7 6655.1 6499.0 6601.1 6610.0 6614.4 6624.4 6749.9 6761.5 6771.2 6775.5 6778.1 6442.8 6550.9 6558.5 6559.3 6562.5 6483.3 6542.3 6555.5 6558.8 6562.7 6420.5 6497.7 6517.1 6584.1 6585.5 6515.9 6530.8 6550.6 6623.9 6652.7 6374.4 6393.6 6403.3 6414.0 6418.4 19:06:24 INFO - PID 4381 | 19:06:24 INFO - PID 4381 | [#1] ext.html Cycles:180 Average:37251.34 Median:18931.76 stddev:54584.55 (288.3%) stddev-sans-first:54669.19 19:06:24 INFO - PID 4381 | Values: 835.1 838.3 867.3 899.8 902.6 42261.0 43209.0 43270.8 43405.0 43453.6 39090.6 39147.2 39166.4 39171.8 39231.6 7043.2 7160.4 7211.0 7221.7 7230.2 7076.6 7164.2 7165.2 7167.8 7175.5 7095.6 7116.8 7118.4 7152.8 7174.4 7069.2 7105.6 7105.7 7110.7 7115.4 6462.5 6487.6 6572.6 6579.4 6581.2 34426.7 34456.5 34458.3 34469.0 34654.0 3384.6 3436.9 3444.3 3444.5 3448.5 27465.0 27618.0 27662.9 27669.0 27691.3 4508.6 4538.8 4547.4 4556.1 4590.5 182587.0 183129.0 183551.0 183925.1 184003.0 21654.9 21658.1 21742.6 21758.6 21844.5 55413.7 56648.2 56729.7 56872.7 56973.4 14418.1 14520.8 14541.3 14541.3 14542.3 11122.1 11308.8 11447.1 11457.5 11458.0 14696.4 14738.9 14821.5 14837.3 15000.0 5954.7 6110.2 6116.2 6157.0 6178.7 1004.7 1011.5 1043.1 1046.2 1051.2 22834.3 23471.5 23782.8 29552.3 29577.3 1092.6 1112.6 1113.6 1116.0 1116.6 11996.3 12394.8 12397.9 12434.6 12471.0 238192.0 241018.0 241454.0 241494.0 241712.0 53411.0 54244.4 54339.7 55349.2 57565.4 1455.8 1500.9 1505.5 1509.0 1524.1 25667.8 26729.0 26845.6 27065.1 27290.5 37771.2 38160.6 38184.4 38423.6 38443.8 201026.0 201283.0 201387.0 201721.0 202534.0 33216.5 34218.5 35123.6 35138.8 35158.8 42747.4 43069.1 43079.1 43101.8 43445.8 32276.4 32295.7 32354.5 32372.8 32431.4 30811.5 31069.8 33849.7 35125.8 35200.6 38019.6 38113.2 38218.0 38316.8 38452.8 33535.3 33860.5 34001.8 34286.8 35071.8 23701.6 24347.9 24690.9 24901.4 25062.9 19:06:24 INFO - PID 4381 | 19:06:24 INFO - PID 4381 | [#2] jquery.html Cycles:180 Average:34094.87 Median:13173.75 stddev:77497.49 (588.3%) stddev-sans-first:77674.02 19:06:24 INFO - PID 4381 | Values: 574.3 579.0 590.2 593.1 607.3 22011.4 22730.4 23517.0 23528.6 23539.6 25607.2 25897.7 26149.3 26217.6 26421.7 6448.5 6525.5 6562.8 6595.2 6609.5 6141.4 6492.2 6609.0 6624.6 6688.7 6655.6 6663.8 6666.2 6669.8 6670.3 6623.4 6632.0 6673.0 6673.3 6674.0 6200.0 6202.9 6205.5 6222.8 6230.3 29254.3 29811.3 30453.5 31428.4 31431.0 1957.1 1992.8 2013.5 2015.6 2016.4 19996.5 20224.8 20264.6 20310.7 20325.3 2390.3 2514.0 2520.5 2527.3 2545.2 136716.0 140036.3 140873.0 141373.0 141764.0 14611.9 14883.7 15351.5 15784.4 15905.8 23957.2 24005.0 24045.6 24127.0 24148.9 9325.8 9635.8 9738.5 9752.1 9752.3 6919.4 8530.3 8605.1 8688.1 8735.6 8069.9 9312.3 9429.3 9520.8 9656.8 2847.8 2855.9 2874.0 2889.8 3016.5 969.2 978.8 983.5 988.2 992.5 19587.4 19612.9 19902.7 20196.8 20328.6 1022.6 1023.9 1032.0 1035.7 1037.7 10927.6 10946.0 11127.2 11159.3 11167.3 434241.0 434269.0 461312.0 472383.0 475885.0 115562.0 115900.0 118777.0 119744.4 121019.4 1209.8 1226.1 1242.0 1253.9 1259.5 17692.6 17791.4 17899.4 18135.5 18227.8 55311.4 55526.4 56032.2 57118.7 57983.0 71049.6 71263.3 71422.6 71699.0 72299.6 14636.4 15125.9 15286.0 15308.4 15309.7 23081.9 23323.8 23346.6 23361.0 23487.3 17583.9 18153.5 18848.5 18858.8 18879.0 16305.4 16709.7 16802.9 17089.4 17094.5 19199.7 19251.4 19317.4 19348.1 19416.0 14697.8 14830.7 14873.9 14954.3 15023.7 18194.6 18477.4 18623.3 18624.7 18636.1 19:06:24 INFO - PID 4381 | 19:06:24 INFO - PID 4381 | [#3] mootools.html Cycles:180 Average:8683.27 Median:2577.09 stddev:6046.63 (234.6%) stddev-sans-first:6038.42 19:06:24 INFO - PID 4381 | Values: 1340.1 1383.5 1387.8 1395.5 1403.8 13734.2 14425.3 14466.0 14474.9 14476.1 13761.2 14715.2 14718.5 14733.0 14831.2 2658.5 2697.8 2700.2 2700.4 2702.5 2583.5 2588.4 2617.9 2678.1 2682.9 2660.4 2682.9 2685.7 2686.5 2686.9 2570.7 2583.9 2584.8 2596.0 2599.7 2418.2 2423.1 2436.9 2454.3 2471.1 13925.2 14256.4 14274.0 14275.7 14284.0 7261.3 7390.6 7548.7 7574.3 7598.6 4962.6 5013.0 5089.3 5133.4 5179.1 1805.8 1807.3 1820.5 1870.0 1874.7 23603.5 23645.8 23823.5 23832.0 23948.6 6225.3 6272.5 6310.3 6380.2 6465.7 15043.2 15565.9 16307.1 16327.9 16337.5 7440.2 7690.1 7699.6 7702.0 7702.0 6841.5 7009.2 7042.6 7055.9 7075.3 4928.7 5015.9 5122.9 5155.2 5173.7 1430.6 1445.3 1458.3 1463.6 1464.1 839.0 864.1 882.0 884.2 884.3 7016.5 7021.0 7027.3 7037.5 7107.1 720.3 725.3 728.0 730.9 738.8 4348.9 4414.6 4455.4 4483.1 4512.3 18418.6 18781.4 18784.6 19083.6 20028.0 18468.5 18578.6 19527.5 19649.4 19778.6 10493.4 11168.0 11184.5 11213.3 11216.0 7842.5 8188.5 8221.4 8269.9 8277.3 16704.9 17002.5 17294.8 17296.4 17371.7 16724.6 17059.4 17398.4 17431.1 17628.8 11482.8 11797.2 11813.5 11830.3 11843.2 12824.1 12962.4 13074.3 13082.6 13087.5 10597.7 10632.4 10682.7 10712.0 10857.6 10243.8 10327.1 10397.2 10530.6 10564.3 9247.4 9379.2 9392.2 9406.0 9435.0 6532.2 6553.7 6570.0 6601.3 6644.8 6588.0 6842.4 6854.9 6870.5 6873.2 19:06:24 INFO - PID 4381 | 19:06:24 INFO - PID 4381 | [#4] prototype.html Cycles:180 Average:5553.01 Median:6248.22 stddev:1553.30 (24.9%) stddev-sans-first:1510.66 19:06:24 INFO - PID 4381 | Values: 501.2 501.5 509.0 530.7 535.6 6313.8 6347.7 6350.8 6379.4 6382.6 6229.3 6267.2 6274.8 6281.5 6296.9 5138.5 5159.2 5170.7 5190.8 5230.7 4788.5 4914.2 5084.1 5089.4 5136.4 4908.5 4930.5 4957.8 4966.9 5007.1 4896.3 4923.8 4942.0 4954.9 4997.3 4408.8 4411.0 4433.6 4452.0 4493.4 5990.6 6071.2 6092.8 6104.3 6106.4 5706.6 5745.3 5763.4 5781.3 5787.2 6502.0 6537.0 6565.2 6605.0 6649.4 4867.4 4907.1 4922.7 4938.0 4938.9 6740.2 6744.2 6905.5 6914.0 6969.4 4999.4 5020.3 5044.6 5063.5 5074.6 5063.2 5090.4 5120.3 5121.1 5148.4 5657.5 5690.7 5718.8 5734.0 5767.9 6627.0 6671.3 6690.6 6694.7 6725.7 1764.2 1793.9 1803.3 1812.4 1818.9 1191.2 1234.3 1242.9 1258.3 1264.4 5717.5 5763.4 5767.6 5786.6 5814.5 6680.2 6726.9 6779.1 6862.7 6882.1 5677.9 5709.6 5728.2 5758.0 5775.8 3636.5 3642.3 3643.1 3659.2 3666.0 6510.9 6589.8 6592.6 6649.1 6684.7 6531.6 6989.6 6991.1 7024.5 7048.5 6469.0 6513.4 6533.5 6559.9 6569.6 6693.0 6805.7 6822.9 6856.4 6872.2 6645.0 6662.2 6683.7 6686.6 6749.9 6517.2 6523.5 6530.6 6592.4 6594.7 5068.2 5091.2 5099.5 5099.8 5125.1 6618.4 6669.5 6824.8 6867.5 6888.8 6536.0 6551.3 6581.9 6588.4 6647.2 6382.3 6460.7 6510.8 6513.1 6543.7 6487.2 6493.2 6497.6 6504.5 6539.7 6526.6 6563.6 6570.4 6619.1 6680.3 6386.7 6414.4 6451.0 6452.7 6465.4 19:06:24 INFO - PID 4381 | 19:06:24 INFO - PID 4381 | [#5] yui.html Cycles:180 Average:23942.09 Median:20156.84 stddev:32102.39 (159.3%) stddev-sans-first:32145.76 19:06:24 INFO - PID 4381 | Values: 886.9 893.5 916.6 921.4 922.8 18341.5 19167.0 19258.6 19262.4 19294.6 17775.6 17782.5 17872.6 18933.6 22700.4 1045.5 1068.5 1070.9 1071.9 1072.6 1057.4 1074.6 1075.0 1075.2 1081.3 1051.9 1089.2 1093.6 1128.0 1139.4 1086.1 1090.4 1091.0 1091.1 1091.3 796.1 796.2 797.6 797.6 798.1 20140.3 20173.4 20388.6 20598.3 21256.0 21176.9 21840.5 22334.8 22503.4 22629.5 16436.4 16438.3 16574.6 16587.6 16920.0 3655.7 3677.0 3686.5 3690.2 3710.6 124251.0 125499.0 129374.0 129840.0 129934.0 16502.9 17059.0 17067.0 17171.7 17332.1 31043.7 31185.4 31475.2 31581.2 32268.0 8409.8 8505.1 8584.6 8586.5 8606.8 4257.5 4286.2 4304.9 4345.8 4395.8 5370.6 5455.6 5475.7 5484.4 5492.8 972.5 997.9 1011.6 1015.9 1020.1 680.0 685.4 689.4 696.2 704.5 11885.7 11912.4 12261.1 12333.4 12578.1 686.1 687.5 693.0 698.9 698.9 5439.5 5654.8 5729.5 5730.4 5732.3 107563.0 111013.0 112134.0 113057.4 113256.0 71892.6 94895.5 96941.5 99257.0 105841.9 80501.0 81921.6 83121.2 86633.6 89891.6 12310.5 12356.9 12785.9 13074.7 13273.9 38080.2 39781.6 39866.8 40086.2 40395.8 69211.0 69540.7 71065.0 73029.3 75269.0 18608.3 18801.4 18858.5 18905.7 19234.8 20886.5 20984.5 21146.7 21148.4 21266.1 18617.8 19146.7 19268.1 19272.1 19357.7 19887.5 19896.3 20196.3 20316.9 20814.4 18308.2 18318.5 18448.9 18631.1 18686.4 13433.5 13645.7 14222.5 14350.8 14552.8 13929.7 14519.9 14577.6 14651.0 15315.3 19:06:24 INFO - PID 4381 | -------- Summary: end -------- 19:06:24 INFO - PID 4381 | 19:06:25 INFO - TEST-INFO | 4381: exit 0 19:06:25 INFO - TEST-OK | dromaeo_css | took 1112290ms 19:06:25 INFO - TEST-START | kraken 19:06:25 INFO - Initialising browser for kraken test... 19:06:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51455/getInfo.html -profile /tmp/tmpVrqB65/profile 19:06:25 INFO - TEST-INFO | started process 4762 (/builds/slave/test/build/application/firefox/firefox http://localhost:51455/getInfo.html) 19:06:30 INFO - TEST-INFO | 4762: exit 0 19:06:31 INFO - Browser initialized. 19:06:31 INFO - Running cycle 1/1 for kraken test... 19:06:31 INFO - TEST-INFO | started process 4997 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVrqB65/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:06:32 INFO - PID 4997 | 19:06:32 INFO - PID 4997 | (/builds/slave/test/build/application/firefox/firefox:5051): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:06:32 INFO - PID 4997 | 19:06:42 INFO - PID 4997 | RSS: Main: 167944192 19:06:42 INFO - PID 4997 | 19:06:45 INFO - PID 4997 | Cycle 1(1): loaded http://localhost:51455/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51455/tests/kraken/driver.html?testName=audio-beat-detection) 19:06:46 INFO - PID 4997 | RSS: Main: 173891584 19:06:46 INFO - PID 4997 | 19:06:48 INFO - PID 4997 | Cycle 1(1): loaded http://localhost:51455/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51455/tests/kraken/driver.html?testName=audio-dft) 19:06:49 INFO - PID 4997 | RSS: Main: 178024448 19:06:49 INFO - PID 4997 | 19:06:52 INFO - PID 4997 | Cycle 1(1): loaded http://localhost:51455/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51455/tests/kraken/driver.html?testName=audio-fft) 19:06:53 INFO - PID 4997 | RSS: Main: 172175360 19:06:53 INFO - PID 4997 | 19:06:55 INFO - PID 4997 | Cycle 1(1): loaded http://localhost:51455/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51455/tests/kraken/driver.html?testName=audio-oscillator) 19:06:55 INFO - PID 4997 | RSS: Main: 172773376 19:06:55 INFO - PID 4997 | 19:06:58 INFO - PID 4997 | Cycle 1(1): loaded http://localhost:51455/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51455/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:06:58 INFO - PID 4997 | RSS: Main: 172879872 19:06:58 INFO - PID 4997 | 19:07:01 INFO - PID 4997 | Cycle 1(1): loaded http://localhost:51455/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51455/tests/kraken/driver.html?testName=imaging-darkroom) 19:07:02 INFO - PID 4997 | RSS: Main: 173842432 19:07:02 INFO - PID 4997 | 19:07:06 INFO - PID 4997 | Cycle 1(1): loaded http://localhost:51455/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51455/tests/kraken/driver.html?testName=imaging-desaturate) 19:07:06 INFO - PID 4997 | RSS: Main: 173645824 19:07:06 INFO - PID 4997 | 19:07:09 INFO - PID 4997 | Cycle 1(1): loaded http://localhost:51455/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51455/tests/kraken/driver.html?testName=json-parse-financial) 19:07:10 INFO - PID 4997 | RSS: Main: 174174208 19:07:10 INFO - PID 4997 | 19:07:12 INFO - PID 4997 | Cycle 1(1): loaded http://localhost:51455/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51455/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:07:12 INFO - PID 4997 | RSS: Main: 174252032 19:07:12 INFO - PID 4997 | 19:07:14 INFO - PID 4997 | Cycle 1(1): loaded http://localhost:51455/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51455/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:07:15 INFO - PID 4997 | RSS: Main: 174297088 19:07:15 INFO - PID 4997 | 19:07:17 INFO - PID 4997 | Cycle 1(1): loaded http://localhost:51455/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51455/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:07:18 INFO - PID 4997 | RSS: Main: 174120960 19:07:18 INFO - PID 4997 | 19:07:20 INFO - PID 4997 | Cycle 1(1): loaded http://localhost:51455/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51455/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:07:21 INFO - PID 4997 | RSS: Main: 174370816 19:07:21 INFO - PID 4997 | 19:07:24 INFO - PID 4997 | Cycle 1(1): loaded http://localhost:51455/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51455/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:07:25 INFO - PID 4997 | RSS: Main: 174370816 19:07:25 INFO - PID 4997 | 19:07:27 INFO - PID 4997 | Cycle 1(1): loaded http://localhost:51455/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51455/tests/kraken/driver.html?testName=ai-astar) 19:07:27 INFO - PID 4997 | RSS: Main: 175947776 19:07:27 INFO - PID 4997 | 19:07:27 INFO - PID 4997 | __start_tp_report 19:07:27 INFO - PID 4997 | _x_x_mozilla_page_load 19:07:27 INFO - PID 4997 | _x_x_mozilla_page_load_details 19:07:27 INFO - PID 4997 | |i|pagename|runs| 19:07:27 INFO - PID 4997 | |0;ai-astar;101;110;110;108;106;123;109;102;107;108 19:07:27 INFO - PID 4997 | |1;audio-beat-detection;149;124;152;181;117;145;152;117;170;127 19:07:27 INFO - PID 4997 | |2;audio-dft;164;168;164;162;163;168;168;164;167;163 19:07:27 INFO - PID 4997 | |3;audio-fft;74;74;78;169;82;75;75;86;100;75 19:07:27 INFO - PID 4997 | |4;audio-oscillator;79;79;129;79;80;78;125;80;82;140 19:07:27 INFO - PID 4997 | |5;imaging-gaussian-blur;116;114;114;114;114;119;114;119;115;117 19:07:27 INFO - PID 4997 | |6;imaging-darkroom;150;150;150;150;150;150;150;154;155;151 19:07:27 INFO - PID 4997 | |7;imaging-desaturate;95;94;99;94;99;94;94;94;99;94 19:07:27 INFO - PID 4997 | |8;json-parse-financial;54;55;54;55;56;63;56;65;55;61 19:07:27 INFO - PID 4997 | |9;json-stringify-tinderbox;54;53;59;54;55;54;56;53;57;58 19:07:27 INFO - PID 4997 | |10;stanford-crypto-aes;82;76;79;90;77;83;79;92;88;79 19:07:27 INFO - PID 4997 | |11;stanford-crypto-ccm;140;128;125;130;136;132;134;125;136;172 19:07:27 INFO - PID 4997 | |12;stanford-crypto-pbkdf2;177;179;188;176;171;188;173;183;180;176 19:07:27 INFO - PID 4997 | |13;stanford-crypto-sha256-iterative;70;68;72;71;73;72;68;67;65;65 19:07:27 INFO - PID 4997 | __end_tp_report 19:07:27 INFO - PID 4997 | __start_cc_report 19:07:27 INFO - PID 4997 | _x_x_mozilla_cycle_collect,952 19:07:27 INFO - PID 4997 | __end_cc_report 19:07:27 INFO - PID 4997 | __startTimestamp1502417247442__endTimestamp 19:07:27 INFO - PID 4997 | 19:07:27 INFO - PID 4997 | ------- Summary: start ------- 19:07:27 INFO - PID 4997 | Number of tests: 14 19:07:27 INFO - PID 4997 | 19:07:27 INFO - PID 4997 | [#0] ai-astar Cycles:10 Average:108.40 Median:108.50 stddev:5.99 (5.5%) stddev-sans-first:5.72 19:07:27 INFO - PID 4997 | Values: 101.0 110.0 110.0 108.0 106.0 123.0 109.0 102.0 107.0 108.0 19:07:27 INFO - PID 4997 | 19:07:27 INFO - PID 4997 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:150.50 stddev:21.97 (14.6%) stddev-sans-first:23.20 19:07:27 INFO - PID 4997 | Values: 149.0 124.0 152.0 181.0 117.0 145.0 152.0 117.0 170.0 127.0 19:07:27 INFO - PID 4997 | 19:07:27 INFO - PID 4997 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.50 stddev:2.38 (1.4%) stddev-sans-first:2.49 19:07:27 INFO - PID 4997 | Values: 164.0 168.0 164.0 162.0 163.0 168.0 168.0 164.0 167.0 163.0 19:07:27 INFO - PID 4997 | 19:07:27 INFO - PID 4997 | [#3] audio-fft Cycles:10 Average:88.80 Median:75.00 stddev:29.32 (39.1%) stddev-sans-first:30.61 19:07:27 INFO - PID 4997 | Values: 74.0 74.0 78.0 169.0 82.0 75.0 75.0 86.0 100.0 75.0 19:07:27 INFO - PID 4997 | 19:07:27 INFO - PID 4997 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:79.00 stddev:25.29 (32.0%) stddev-sans-first:26.15 19:07:27 INFO - PID 4997 | Values: 79.0 79.0 129.0 79.0 80.0 78.0 125.0 80.0 82.0 140.0 19:07:27 INFO - PID 4997 | 19:07:27 INFO - PID 4997 | [#5] imaging-gaussian-blur Cycles:10 Average:115.60 Median:115.50 stddev:2.07 (1.8%) stddev-sans-first:2.19 19:07:27 INFO - PID 4997 | Values: 116.0 114.0 114.0 114.0 114.0 119.0 114.0 119.0 115.0 117.0 19:07:27 INFO - PID 4997 | 19:07:27 INFO - PID 4997 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:150.00 stddev:1.89 (1.3%) stddev-sans-first:1.96 19:07:27 INFO - PID 4997 | Values: 150.0 150.0 150.0 150.0 150.0 150.0 150.0 154.0 155.0 151.0 19:07:27 INFO - PID 4997 | 19:07:27 INFO - PID 4997 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:94.50 stddev:2.37 (2.5%) stddev-sans-first:2.50 19:07:27 INFO - PID 4997 | Values: 95.0 94.0 99.0 94.0 99.0 94.0 94.0 94.0 99.0 94.0 19:07:27 INFO - PID 4997 | 19:07:27 INFO - PID 4997 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:56.00 stddev:4.03 (7.2%) stddev-sans-first:4.09 19:07:27 INFO - PID 4997 | Values: 54.0 55.0 54.0 55.0 56.0 63.0 56.0 65.0 55.0 61.0 19:07:27 INFO - PID 4997 | 19:07:27 INFO - PID 4997 | [#9] json-stringify-tinderbox Cycles:10 Average:55.30 Median:55.50 stddev:2.11 (3.8%) stddev-sans-first:2.19 19:07:27 INFO - PID 4997 | Values: 54.0 53.0 59.0 54.0 55.0 54.0 56.0 53.0 57.0 58.0 19:07:27 INFO - PID 4997 | 19:07:27 INFO - PID 4997 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.50 stddev:5.64 (6.8%) stddev-sans-first:5.98 19:07:27 INFO - PID 4997 | Values: 82.0 76.0 79.0 90.0 77.0 83.0 79.0 92.0 88.0 79.0 19:07:27 INFO - PID 4997 | 19:07:27 INFO - PID 4997 | [#11] stanford-crypto-ccm Cycles:10 Average:135.80 Median:135.00 stddev:13.64 (10.1%) stddev-sans-first:14.38 19:07:27 INFO - PID 4997 | Values: 140.0 128.0 125.0 130.0 136.0 132.0 134.0 125.0 136.0 172.0 19:07:27 INFO - PID 4997 | 19:07:27 INFO - PID 4997 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.10 Median:179.50 stddev:5.78 (3.2%) stddev-sans-first:6.08 19:07:27 INFO - PID 4997 | Values: 177.0 179.0 188.0 176.0 171.0 188.0 173.0 183.0 180.0 176.0 19:07:27 INFO - PID 4997 | 19:07:27 INFO - PID 4997 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:70.50 stddev:2.92 (4.1%) stddev-sans-first:3.08 19:07:27 INFO - PID 4997 | Values: 70.0 68.0 72.0 71.0 73.0 72.0 68.0 67.0 65.0 65.0 19:07:27 INFO - PID 4997 | -------- Summary: end -------- 19:07:27 INFO - PID 4997 | 19:07:27 INFO - PID 4997 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:07:28 INFO - TEST-INFO | 4997: exit 0 19:07:28 INFO - TEST-OK | kraken | took 62759ms 19:07:28 INFO - SUITE-END | took 1175s 19:07:28 INFO - Completed test suite (00:19:35) 19:07:28 INFO - javascript benchmark 19:07:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8469.077509389266, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3119.82840943748, 3160.956884228205, 3165.5884734984443, 3169.8256595887224, 3181.061586831884, 6242.032484964832, 6259.123722678829, 6286.057091436287, 6310.179676642036, 6324.715387807548, 6279.40345667162, 6285.151504546885, 6299.086632438294, 6404.327545607703, 6449.838754031151, 5807.651540907559, 5809.622374545641, 5832.475077243047, 5852.151438041481, 5896.911546326808, 5765.769369225247, 5776.046952252873, 5820.505257053155, 5838.678872662002, 5935.792247271346, 5684.289463817023, 5709.6574205547595, 5738.31140263169, 5751.194832723422, 5792.971035144818, 5697.287839020122, 5757.0, 5782.479576838063, 5794.82615521535, 5798.391168927286, 5683.374828768832, 5694.629849059798, 5760.164776107483, 5771.855703607402, 5784.68184249866, 6151.569390142692, 6195.721192546302, 6199.070139479069, 6245.656488893109, 6258.87482250357, 6475.061116138134, 6642.800715978528, 6711.161104861892, 6723.159605049369, 6733.595984240961, 6806.659667016679, 6811.318868113199, 6881.277465866112, 6894.517383783137, 6911.17065952084, 6284.937150628527, 6292.87414251717, 6305.274893387227, 6361.650109244036, 6374.936250637481, 6918.308169183142, 6963.338482844122, 7004.229534751174, 7042.7887163385185, 7049.929500704928, 6530.151080359523, 6626.9337306627285, 6630.96684516584, 6704.0, 6708.932910670831, 6737.663116844138, 6788.083608712859, 6800.353966373186, 6820.215675197316, 6826.044353790473, 6696.2968888267005, 6698.129243198353, 6792.76225332111, 6800.0, 6808.353206445379, 6712.12742343502, 6719.764808231688, 6719.798406047827, 6792.218894827158, 6830.7609233676585, 5404.621676482687, 5488.91766623501, 5500.339959204921, 5503.394626591072, 5506.063969125258, 4669.41632295963, 4680.4149481314835, 4683.227267500893, 4686.133065382915, 4689.179393606105, 5796.21751063601, 5811.767529298781, 5858.0, 5876.9118463223085, 5883.852903677443, 6734.124563806674, 6813.727450902007, 6837.282085381063, 6845.178578570603, 6846.520743548003, 5758.481736643722, 5789.073748200268, 5847.26909136358, 5877.9118313225335, 5885.352611212763, 5799.855003624859, 5845.41545845412, 5941.970290148522, 5948.2862056553495, 5955.642661440327, 6628.8674226515195, 6636.13730215069, 6646.0, 6649.634270115093, 6652.767153149616, 6825.55633883796, 6851.314868513208, 6861.382475577222, 6862.794116176523, 6881.208661004049, 6552.180977377828, 6605.9009114864275, 6639.269680335063, 6646.700898459484, 6655.068290439245, 6499.025146228104, 6601.075849380994, 6610.041543976193, 6614.371634694697, 6624.436922861611, 6749.932500675127, 6761.492888033319, 6771.153605799275, 6775.525713200226, 6778.0510728497065, 6442.8389290268115, 6550.934490655032, 6558.540902136805, 6559.344065593403, 6562.50781191403, 6483.286838447672, 6542.34576542342, 6555.508336874658, 6558.770443034471, 6562.671866406756, 6420.454261387835, 6497.740090396331, 6517.120188774455, 6584.111144995364, 6585.539012269287, 6515.869682606227, 6530.771423000172, 6550.574212676161, 6623.873941430064, 6652.73389064432, 6374.426301632875, 6393.552451328363, 6403.295637479967, 6413.967930160319, 6418.422341989243], "value": 6164.530875083624, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.0855812884889, 838.3042075077686, 867.3451544084215, 899.7615631857559, 902.5622573052069, 42261.0, 43209.0, 43270.78364608181, 43405.0, 43453.565464345345, 39090.60909390905, 39147.21705565887, 39166.41250381246, 39171.80414097933, 39231.607683923154, 7043.190033146189, 7160.391366733834, 7210.963945180293, 7221.747238846641, 7230.168530618967, 7076.575405475663, 7164.247753985835, 7165.2476489968585, 7167.820804479878, 7175.533590316612, 7095.609741464217, 7116.786496405116, 7118.3949364303835, 7152.785416437489, 7174.426045916341, 7069.151701795766, 7105.609191494465, 7105.680244388989, 7110.6800193990875, 7115.359617634386, 6462.515311351621, 6487.643179625119, 6572.572782769104, 6579.407853293179, 6581.243157036906, 34426.655733442596, 34456.48315275273, 34458.310833783435, 34469.0, 34654.0, 3384.5938487381427, 3436.862525499002, 3444.3111377724554, 3444.51776751255, 3448.5344478495585, 27465.0, 27618.033368832195, 27662.86168569144, 27669.03158389467, 27691.307717307027, 4508.571685689854, 4538.7503687297185, 4547.386102876102, 4556.066006468666, 4590.517995610447, 182587.0, 183129.0, 183551.0, 183925.08037459862, 184003.0, 21654.891725541587, 21658.133674653152, 21742.565148696936, 21758.564828703336, 21844.45388865259, 55413.722931385084, 56648.150277745866, 56729.71635141881, 56872.715636421555, 56973.430265696814, 14418.13491190532, 14520.782188267185, 14541.27293635314, 14541.27293635314, 14542.345594448276, 11122.110231181487, 11308.830367544493, 11447.08423326132, 11457.541698331974, 11458.0, 14696.412143514353, 14738.852611473962, 14821.481248156262, 14837.332320045623, 15000.0, 5954.697710995049, 6110.150605118835, 6116.204893363834, 6157.0, 6178.7219575119225, 1004.6533945788691, 1011.4993078426226, 1043.0508237503834, 1046.1944302886886, 1051.2220956492295, 22834.31497055091, 23471.53056938886, 23782.762172378054, 29552.261193469905, 29577.26056848596, 1092.5629748100823, 1112.6161474291519, 1113.582406597526, 1115.9553617855195, 1116.625930313338, 11996.340201289013, 12394.75210495785, 12397.93801030989, 12434.62696119118, 12471.0, 238192.0, 241018.0, 241454.0, 241494.0, 241712.0, 53411.0, 54244.37266882, 54339.72830135903, 55349.16976245279, 57565.424345756845, 1455.8107446031947, 1500.8724258438156, 1505.4881340344116, 1508.9622759431102, 1524.05508584676, 25667.844946977806, 26729.0, 26845.597316039883, 27065.052723155382, 27290.45419091647, 37771.244575108896, 38160.618393815705, 38184.427233592076, 38423.615763842005, 38443.80778096092, 201026.0, 201283.0, 201387.0, 201721.0, 202534.0, 33216.501752474214, 34218.48672269868, 35123.648763512036, 35138.824305878305, 35158.82420587983, 42747.358789618804, 43069.138617228105, 43079.13841723085, 43101.78449107734, 43445.78277108594, 32276.35447291088, 32295.67704322927, 32354.514682279314, 32372.838135809172, 32431.351372971938, 30811.537826932166, 31069.844650776602, 33849.661503385636, 35125.824370877985, 35200.647993519735, 38019.61980380161, 38113.2377352457, 38218.0, 38316.80841595774, 38452.80773596114, 33535.329293414485, 33860.49209261814, 34001.82999084989, 34286.82856585701, 35071.824640877654, 23701.644475332538, 24347.878260608584, 24690.876545617157, 24901.377465563506, 25062.874685627183], "value": 16659.441432552503, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.2592056247441, 578.9623674461158, 590.1619700025965, 593.1340243244861, 607.2682417686688, 22011.449713757163, 22730.431739206506, 23517.0, 23528.647070293937, 23539.646905296435, 25607.231783046493, 25897.74102258977, 26149.34626634335, 26217.60673589898, 26421.73578264217, 6448.451881590058, 6525.510586705992, 6562.835929101763, 6595.241547222083, 6609.471242300604, 6141.447269745722, 6492.220933487988, 6608.966955165218, 6624.56940298879, 6688.732450701966, 6655.633940133291, 6663.766768163116, 6666.233383160926, 6669.833254168636, 6670.266270710218, 6623.403893649571, 6632.0, 6673.03241030048, 6673.299303573103, 6673.966630166842, 6200.038993955944, 6202.937970620326, 6205.472534834545, 6222.751089956441, 6230.283517395467, 29254.268643283875, 29811.254718632208, 30453.543196852064, 31428.37143257145, 31431.0, 1957.119296316649, 1992.8007199279955, 2013.536886516095, 2015.556577552936, 2016.3648450737971, 19996.500087497785, 20224.797752022438, 20264.594708105757, 20310.695339569917, 20325.288614898556, 2390.34265576966, 2513.962290565643, 2520.5337012652717, 2527.2670925431785, 2545.185540627, 136716.0, 140036.29981850128, 140873.0, 141373.0, 141764.0, 14611.92694036523, 14883.70232595342, 15351.53945381618, 15784.447544335893, 15905.840941590435, 23957.16149934744, 24005.039798408216, 24045.639315410284, 24127.0, 24148.87925560361, 9325.813483730288, 9635.807283854283, 9738.513074346254, 9752.122308992224, 9752.26857985654, 6919.37725604698, 8530.317574594017, 8605.053444121142, 8688.13118688126, 8735.606897689619, 8069.878951815727, 9312.255019598417, 9429.339946203838, 9520.761980950394, 9656.806863862683, 2847.8181554655002, 2855.9000434984678, 2874.016140777888, 2889.7977141599886, 3016.502277124294, 969.2004096620317, 978.7553111722069, 983.537737263485, 988.1946213835845, 992.538469611634, 19587.412377628694, 19612.90193549023, 19902.701459478118, 20196.798032019786, 20328.59342813165, 1022.5705203814416, 1023.8873723890366, 1031.9845202321972, 1035.7100011996654, 1037.699067270483, 10927.562897484011, 10946.0, 11127.221094523306, 11159.27464714791, 11167.329960202414, 434241.0, 434269.0, 461312.0, 472383.0, 475885.0, 115562.0, 115900.0, 118777.0, 119744.4012779948, 121019.39490302668, 1209.818527220924, 1226.1478272600457, 1241.975160496785, 1253.893419059372, 1259.527677121098, 17692.557686057953, 17791.377301794375, 17899.37352192667, 18135.546611334823, 18227.817721822612, 55311.44688553224, 55526.444735552126, 56032.15951760808, 57118.71440642936, 57983.0, 71049.64475177591, 71263.28736712773, 71422.64288678524, 71699.0, 72299.63850180716, 14636.41454341857, 15125.924370378078, 15286.0, 15308.387664493295, 15309.698675612697, 23081.88459057694, 23323.766762332838, 23346.649800253348, 23361.0, 23487.295381138592, 17583.912080439517, 18153.546161346072, 18848.52878678044, 18858.811411885705, 18879.0, 16305.429309974093, 16709.74935375946, 16802.907810992736, 17089.401870934456, 17094.487165385057, 19199.712004320227, 19251.4224573263, 19317.4204773857, 19348.129334180278, 19416.0, 14697.779533307223, 14830.703385932437, 14873.851261487247, 14954.25228738537, 15023.6995260092, 18194.636107278046, 18477.445676629723, 18623.255069797597, 18624.720629190844, 18636.068196589844], "value": 12075.280936827761, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.128916204467, 1383.4673650644504, 1387.8403983541882, 1395.5394719742483, 1403.8455769865313, 13734.244616546099, 14425.278736063194, 14466.0, 14474.855251447483, 14476.13143211408, 13761.243131627756, 14715.190664513448, 14718.484853030146, 14733.0, 14831.184284864328, 2658.508175987439, 2697.757201851833, 2700.216937088242, 2700.405910699643, 2702.5270577648835, 2583.4962182374443, 2588.4434846507997, 2617.947641047178, 2678.1429942418436, 2682.9060982865603, 2660.401409682825, 2682.8658567071666, 2685.717999610042, 2686.5029969455713, 2686.865656717166, 2570.691517017951, 2583.9483210335875, 2584.8449093054383, 2595.9610605840926, 2599.6750406199226, 2418.153646223825, 2423.1397853762014, 2436.926892193237, 2454.3005243505695, 2471.147454128323, 13925.164490130624, 14256.358463869046, 14274.0, 14275.714485710332, 14284.0, 7261.346478816879, 7390.630468476555, 7548.698052077911, 7574.280443357872, 7598.582077985709, 4962.643355208208, 5012.974935125301, 5089.262057001714, 5133.409657889353, 5179.14544100223, 1805.8194180581968, 1807.322254154692, 1820.5357633803296, 1869.9626007479774, 1874.7000479923147, 23603.527929441487, 23645.76354236453, 23823.523529529484, 23832.0, 23948.640770388458, 6225.28409232935, 6272.466840318532, 6310.337414571404, 6380.202474690664, 6465.676716164173, 15043.247837608076, 15565.922170389076, 16307.1031093291, 16327.918360408123, 16337.509874703777, 7440.218777028443, 7690.115636701739, 7699.576523291161, 7701.960235368154, 7702.037245344332, 6841.521093523505, 7009.158900931819, 7042.647867606599, 7055.89416158758, 7075.327843854826, 4928.654994150446, 5015.874603134951, 5122.897542049138, 5155.200943853709, 5173.663711858717, 1430.6494908747422, 1445.262915912871, 1458.2562892924684, 1463.604826696786, 1464.0922627970726, 838.9748307550783, 864.0624921959744, 882.0209567380202, 884.1512148337539, 884.2881480408333, 7016.5088443808445, 7021.0, 7027.262137475492, 7037.472189585802, 7107.111611048619, 720.2941117704679, 725.2964624314407, 727.9745208917662, 730.9305615966475, 738.8079099434186, 4348.869533913988, 4414.55854414556, 4455.420795296591, 4483.103379324149, 4512.2554778461845, 18418.631627367646, 18781.436556903314, 18784.62430751377, 19083.61832763365, 20028.0, 18468.538286542946, 18578.628427431646, 19527.511812204524, 19649.410517684493, 19778.60442791136, 10493.422861742678, 11168.0, 11184.496697648625, 11213.271137376045, 11216.0, 7842.451028427955, 8188.467749596257, 8221.424500284922, 8269.917300826915, 8277.337812975067, 16704.916475417544, 17002.48992530226, 17294.82705172932, 17296.394626188023, 17371.652566948338, 16724.58188545296, 17059.402920897708, 17398.391056313474, 17431.128443578025, 17628.823711762718, 11482.827757583476, 11797.174197806415, 11813.468393922467, 11830.290182589073, 11843.170978031456, 12824.102312838011, 12962.351882405654, 13074.346282685638, 13082.607521774362, 13087.541936032194, 10597.735056623646, 10632.362058276529, 10682.679519614425, 10712.0, 10857.565697372333, 10243.795124097625, 10327.070563649308, 10397.220208484545, 10530.631427899987, 10564.313319634199, 9247.352685311964, 9379.217948589747, 9392.154706076486, 9406.0, 9434.95282523583, 6532.216134063943, 6553.705083271169, 6569.967150164219, 6601.33986601336, 6644.800655980328, 6588.0, 6842.384185423137, 6854.931450685429, 6870.484713646597, 6873.20958089826], "value": 6249.683706171148, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.1555771803917, 501.4709481497021, 508.99236511452335, 530.68954661523, 535.5983012740445, 6313.842153946153, 6347.714352854121, 6350.841228969278, 6379.362063793618, 6382.617042977413, 6229.283632382266, 6267.153934218879, 6274.811755647326, 6281.466075383586, 6296.929521981263, 5138.511841375082, 5159.200323949775, 5170.663906846043, 5190.7664155112925, 5230.73846307685, 4788.497207793166, 4914.164592019365, 5084.084864724348, 5089.389273287192, 5136.383633963929, 4908.460069392364, 4930.457649658535, 4957.752112394384, 4966.882451448413, 5007.098722229997, 4896.335246016354, 4923.77842997066, 4941.962187940537, 4954.925676114861, 4997.275395067732, 4408.757518336491, 4410.9854733411175, 4433.578810013044, 4452.0, 4493.3709280700405, 5990.610610310359, 6071.241094863142, 6092.756289748405, 6104.328523862371, 6106.419890110433, 5706.629069110494, 5745.253117094792, 5763.366029736726, 5781.306243250795, 5787.189793428924, 6501.9674901625185, 6536.967315163393, 6565.179352580927, 6605.0, 6649.401553860127, 4867.415910090812, 4907.141250281222, 4922.704637721712, 4937.950620493821, 4938.9012219755405, 6740.191177058735, 6744.156980377453, 6905.482088843357, 6913.997470366819, 6969.4424446044195, 4999.400071991385, 5020.2720605511995, 5044.621653375938, 5063.518965698253, 5074.594032477393, 5063.189889617717, 5090.389153301628, 5120.283160357553, 5121.103806833789, 5148.433672296044, 5657.490825825613, 5690.658560486384, 5718.828435146952, 5734.025215713339, 5767.8558036049435, 6627.0, 6671.299513551105, 6690.59856408617, 6694.698738556776, 6725.6973436195485, 1764.1620230390463, 1793.8744287899983, 1803.2967142814314, 1812.392848395776, 1818.9181486833124, 1191.237607930925, 1234.2964510229083, 1242.9440675169458, 1258.314218750783, 1264.3551788587886, 5717.542596592262, 5763.423657634203, 5767.625104368287, 5786.61121330886, 5814.476697097281, 6680.164979377578, 6726.899096513556, 6779.102016340624, 6862.691178896962, 6882.139732533434, 5677.914831277534, 5709.571782116358, 5728.226689396878, 5758.0, 5775.768969241268, 3636.5453818472292, 3642.307961487309, 3643.0509677322507, 3659.213269147146, 3665.9816700916326, 6510.9023364649565, 6589.80230593083, 6592.604443733391, 6649.102371179829, 6684.732610695615, 6531.608103513804, 6989.6370207810005, 6991.056207412036, 7024.5434046786795, 7048.506604537633, 6468.967655161694, 6513.381228783258, 6533.509986750918, 6559.934400655932, 6569.605823650596, 6692.966535167293, 6805.693743781443, 6822.897656535057, 6856.382925536725, 6872.244053154049, 6645.003249512612, 6662.200535935719, 6683.732650694113, 6686.5653732507235, 6749.86500269982, 6517.185351831021, 6523.478121750154, 6530.640814755234, 6592.406683398517, 6594.703238354382, 5068.214426763858, 5091.236314552847, 5099.515546023122, 5099.770510327118, 5125.128728116304, 6618.371254730985, 6669.46644268467, 6824.795256142125, 6867.4975762360555, 6888.793336199922, 6536.039188243603, 6551.344865513411, 6581.901271481028, 6588.40704336612, 6647.169103862017, 6382.297947225708, 6460.676966151767, 6510.804675859732, 6513.088167656437, 6543.738250470118, 6487.156669632917, 6493.155889734304, 6497.610143391223, 6504.544681872224, 6539.673016349258, 6526.641034743135, 6563.638999855054, 6570.441512471493, 6619.073329733745, 6680.331966803281, 6386.744530218925, 6414.422701956846, 6450.967745161244, 6452.741890324334, 6465.418112369909], "value": 5097.072675573794, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [886.9068747781482, 893.4728510178994, 916.5783739479839, 921.4379228670509, 922.8062106957539, 18341.54146146347, 19167.0, 19258.614827703437, 19262.42212733617, 19294.614107717854, 17775.64448711025, 17782.46652600421, 17872.55318617032, 18933.621327573474, 22700.432489187737, 1045.503385891703, 1068.4924660786103, 1070.9303895246824, 1071.9249652524327, 1072.5816931396762, 1057.4078516031047, 1074.5862842805498, 1075.0, 1075.1828610256223, 1081.3079629037422, 1051.8895515970828, 1089.2103225161734, 1093.6445655162065, 1127.9718007049808, 1139.3676509537204, 1086.1202426034938, 1090.3675867996583, 1090.9618163364323, 1091.1107447430397, 1091.3233795047042, 796.1361922314296, 796.1998191817245, 797.5533701127388, 797.6490344248571, 798.1260519730886, 20140.295089671938, 20173.394798155932, 20388.592228155354, 20598.27906023297, 21256.0, 21176.894115529478, 21840.45398865041, 22334.77665223343, 22503.437414064614, 22629.547409051727, 16436.424725134562, 16438.260278287507, 16574.585635359093, 16587.585310367216, 16920.0, 3655.6527129922615, 3677.0439685681918, 3686.5391826021746, 3690.2066055797864, 3710.5547334320054, 124251.0, 125499.0, 129374.0, 129840.0, 129934.0, 16502.917485412498, 17059.0, 17067.0, 17171.656566868594, 17332.13339333028, 31043.68956310453, 31185.376292474022, 31475.213119672193, 31581.210469738442, 32268.0, 8409.831803363899, 8505.064442911274, 8584.570771461527, 8586.484810911365, 8606.784830379165, 4257.489101307863, 4286.249906266391, 4304.935425968613, 4345.760983145894, 4395.846145384896, 5370.597205209625, 5455.563554915597, 5475.67145971243, 5484.424135465799, 5492.80775172867, 972.4845831709206, 997.9051990060933, 1011.6443965086819, 1015.8774554117741, 1020.132887046005, 679.9966000169967, 685.3557655803529, 689.407109885498, 696.1854630082815, 704.4998051383575, 11885.702857428634, 11912.404379780975, 12261.14172007951, 12333.444994975069, 12578.056645751605, 686.0566720758957, 687.4672129099888, 692.9882371737219, 698.8916717908733, 698.8951657251351, 5439.5376393006245, 5654.802081927113, 5729.541636669056, 5730.426957304237, 5732.3121225453215, 107563.0, 111013.0, 112134.0, 113057.43471282591, 113256.0, 71892.64053679699, 94895.52552237194, 96941.51529242449, 99257.0, 105841.94158058321, 80501.0, 81921.59039204766, 83121.16878831256, 86633.5668321667, 89891.55054224687, 12310.50757969707, 12356.876431235933, 12785.87214127884, 13074.738505230032, 13273.933630332172, 38080.23839523138, 39781.60218397779, 39866.80066599648, 40086.198276033734, 40395.79802100971, 69211.0, 69540.65229673819, 71065.0, 73029.26970730224, 75269.0, 18608.255669773058, 18801.435956921316, 18858.52853678669, 18905.71641425407, 19234.8076519233, 20886.47783805356, 20984.475388115417, 21146.682799758324, 21148.365549033555, 21266.149354025667, 18617.81382186215, 19146.712799307745, 19268.13293401772, 19272.13275402582, 19357.709634355215, 19887.502812429226, 19896.30362937348, 20196.293129740978, 20316.89841550783, 20814.37556873296, 18308.176132074354, 18318.542036449195, 18448.907755461136, 18631.068446577887, 18686.43940681782, 13433.529826456028, 13645.658858528219, 14222.502212422516, 14350.784738228725, 14552.781708274173, 13929.651758706113, 14519.854801451851, 14577.562673119823, 14650.974431789673, 15315.310811013309], "value": 9340.154877123887, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 110.0, 108.0, 106.0, 123.0, 109.0, 102.0, 107.0, 108.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 124.0, 152.0, 181.0, 117.0, 145.0, 152.0, 117.0, 170.0, 127.0], "value": 143.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 168.0, 164.0, 162.0, 163.0, 168.0, 168.0, 164.0, 167.0, 163.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 78.0, 169.0, 82.0, 75.0, 75.0, 86.0, 100.0, 75.0], "value": 88.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 129.0, 79.0, 80.0, 78.0, 125.0, 80.0, 82.0, 140.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 114.0, 114.0, 114.0, 119.0, 114.0, 119.0, 115.0, 117.0], "value": 115.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 150.0, 150.0, 150.0, 150.0, 154.0, 155.0, 151.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 99.0, 94.0, 99.0, 94.0, 94.0, 94.0, 99.0, 94.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 55.0, 56.0, 63.0, 56.0, 65.0, 55.0, 61.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 59.0, 54.0, 55.0, 54.0, 56.0, 53.0, 57.0, 58.0], "value": 55.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 76.0, 79.0, 90.0, 77.0, 83.0, 79.0, 92.0, 88.0, 79.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 128.0, 125.0, 130.0, 136.0, 132.0, 134.0, 125.0, 136.0, 172.0], "value": 135.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 179.0, 188.0, 176.0, 171.0, 188.0, 173.0, 183.0, 180.0, 176.0], "value": 179.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 72.0, 71.0, 73.0, 72.0, 68.0, 67.0, 65.0, 65.0], "value": 69.1, "unit": "score"}]}]} 19:07:28 INFO - Return code: 0 19:07:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:07:28 INFO - # TBPL SUCCESS # 19:07:28 INFO - Running post-action listener: _package_coverage_data 19:07:28 INFO - Running post-action listener: _resource_record_post_action 19:07:28 INFO - [mozharness: 2017-08-11 02:07:28.743276Z] Finished run-tests step (success) 19:07:28 INFO - Running post-run listener: _resource_record_post_run 19:07:28 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 434176; Write bytes: 445280256; Read time: 216; Write time: 296000 19:07:28 INFO - TinderboxPrint: CPU usage
13.1% 19:07:28 INFO - TinderboxPrint: I/O read bytes / time
434,176 / 216 19:07:28 INFO - TinderboxPrint: I/O write bytes / time
445,280,256 / 296,000 19:07:28 INFO - TinderboxPrint: CPU idle
8,266.0 (86.8%) 19:07:28 INFO - TinderboxPrint: CPU user
1,203.3 (12.6%) 19:07:28 INFO - TinderboxPrint: Swap in / out
0 / 0 19:07:28 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 117751808; Read time: 0; Write time: 97832 19:07:28 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:07:28 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 430080; Write bytes: 326406144; Read time: 208; Write time: 198084 19:07:29 INFO - Running post-run listener: _upload_blobber_files 19:07:29 INFO - Blob upload gear active. 19:07:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:07:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:07:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:07:29 INFO - (blobuploader) - INFO - Open directory for files ... 19:07:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:07:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:07:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:07:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:07:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:07:30 INFO - (blobuploader) - INFO - Done attempting. 19:07:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:07:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:07:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:07:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:07:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:07:37 INFO - (blobuploader) - INFO - Done attempting. 19:07:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:07:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:07:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:07:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:07:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:07:38 INFO - (blobuploader) - INFO - Done attempting. 19:07:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:07:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:07:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:07:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:07:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:07:39 INFO - (blobuploader) - INFO - Done attempting. 19:07:39 INFO - (blobuploader) - INFO - Iteration through files over. 19:07:39 INFO - Return code: 0 19:07:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:07:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:07:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b510b577062909e13add39fed93398caf759ee779a28f3cdea2944135f1ef115cff1cf44f30dff2af86479f5308f40bf852bde932be13ee3c4a40104369e0c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5646803eb41c25c638d7526a6d1e33e133203f345e48dad573705b2d3ff437319c994fb63620d81597140b774bb5f28ca0c9f911f123a0bf9cbd0d77cf9f8930", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f31c3812c64f08d2bfb544b2a6012cec86dc1652da9410fbba4bf432fb058c326b9fe795e20de87d34209c6f03acb70fb3888a006060dfc8561a0dddf2ab5b06", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d79b6e17f067231f66f55eb72efe7a0e7da7586e0a61818e15eaefdf0c1a0c5cefb667e3998eb40da6abe65327921e1110e3b58acf2b8ca9b73788d997d6df1"} 19:07:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:07:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:07:39 INFO - Contents: 19:07:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b510b577062909e13add39fed93398caf759ee779a28f3cdea2944135f1ef115cff1cf44f30dff2af86479f5308f40bf852bde932be13ee3c4a40104369e0c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5646803eb41c25c638d7526a6d1e33e133203f345e48dad573705b2d3ff437319c994fb63620d81597140b774bb5f28ca0c9f911f123a0bf9cbd0d77cf9f8930", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f31c3812c64f08d2bfb544b2a6012cec86dc1652da9410fbba4bf432fb058c326b9fe795e20de87d34209c6f03acb70fb3888a006060dfc8561a0dddf2ab5b06", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d79b6e17f067231f66f55eb72efe7a0e7da7586e0a61818e15eaefdf0c1a0c5cefb667e3998eb40da6abe65327921e1110e3b58acf2b8ca9b73788d997d6df1"} 19:07:39 INFO - Running post-run listener: copy_logs_to_upload_dir 19:07:39 INFO - Copying logs to upload dir... 19:07:39 INFO - mkdir: /builds/slave/test/build/upload/logs 19:07:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.306738 ========= master_lag: 0.89 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-10 19:07:40.770008) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-10 19:07:40.774413) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b510b577062909e13add39fed93398caf759ee779a28f3cdea2944135f1ef115cff1cf44f30dff2af86479f5308f40bf852bde932be13ee3c4a40104369e0c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5646803eb41c25c638d7526a6d1e33e133203f345e48dad573705b2d3ff437319c994fb63620d81597140b774bb5f28ca0c9f911f123a0bf9cbd0d77cf9f8930", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f31c3812c64f08d2bfb544b2a6012cec86dc1652da9410fbba4bf432fb058c326b9fe795e20de87d34209c6f03acb70fb3888a006060dfc8561a0dddf2ab5b06", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d79b6e17f067231f66f55eb72efe7a0e7da7586e0a61818e15eaefdf0c1a0c5cefb667e3998eb40da6abe65327921e1110e3b58acf2b8ca9b73788d997d6df1"} build_url:https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011099 build_url: 'https://queue.taskcluster.net/v1/task/FQylf4SMTjqgA4sl_IbrWA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b510b577062909e13add39fed93398caf759ee779a28f3cdea2944135f1ef115cff1cf44f30dff2af86479f5308f40bf852bde932be13ee3c4a40104369e0c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5646803eb41c25c638d7526a6d1e33e133203f345e48dad573705b2d3ff437319c994fb63620d81597140b774bb5f28ca0c9f911f123a0bf9cbd0d77cf9f8930", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f31c3812c64f08d2bfb544b2a6012cec86dc1652da9410fbba4bf432fb058c326b9fe795e20de87d34209c6f03acb70fb3888a006060dfc8561a0dddf2ab5b06", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d79b6e17f067231f66f55eb72efe7a0e7da7586e0a61818e15eaefdf0c1a0c5cefb667e3998eb40da6abe65327921e1110e3b58acf2b8ca9b73788d997d6df1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-10 19:07:40.809061) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 19:07:40.809393) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1502414759.251401-1607335713 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 19:07:40.858915) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-10 19:07:40.861257) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-10 19:07:40.861545) ========= ========= Total master_lag: 1.03 =========