builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-082 starttime: 1489593946.3 results: success (0) revision: ce8120111f7f2902b3ac88ac35773d9957714a7a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 09:05:46.301551) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 09:05:46.302010) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 09:05:46.302453) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 09:05:46.316839) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 09:05:46.317168) ========= 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=51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-15 09:05:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.7M=0s 2017-03-15 09:05:46 (69.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.110490 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 09:05:46.441433) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 09:05:46.441743) ========= 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=51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016596 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 09:05:46.490937) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 09:05:46.491293) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ce8120111f7f2902b3ac88ac35773d9957714a7a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ce8120111f7f2902b3ac88ac35773d9957714a7a --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=51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-15 09:05:46,680 truncating revision to first 12 chars 2017-03-15 09:05:46,680 Setting DEBUG logging. 2017-03-15 09:05:46,680 attempt 1/10 2017-03-15 09:05:46,680 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ce8120111f7f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-15 09:05:46,971 unpacking tar archive at: mozilla-aurora-ce8120111f7f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.612594 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 09:05:47.116950) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 09:05:47.117305) ========= script_repo_revision: ce8120111f7f2902b3ac88ac35773d9957714a7a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 09:05:47.117663) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 09:05:47.117925) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 09:05:47.126242) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-03-15 09:05:47.126554) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:05:47 INFO - MultiFileLogger online at 20170315 09:05:47 in /builds/slave/test 09:05:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:05:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:05:47 INFO - {'append_to_log': False, 09:05:47 INFO - 'base_work_dir': '/builds/slave/test', 09:05:47 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:05:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:05:47 INFO - 'branch': 'Mozilla-Aurora', 09:05:47 INFO - 'buildbot_json_path': 'buildprops.json', 09:05:47 INFO - 'config_files': ('talos/linux_config.py',), 09:05:47 INFO - 'default_actions': ('clobber', 09:05:47 INFO - 'read-buildbot-config', 09:05:47 INFO - 'download-and-extract', 09:05:47 INFO - 'populate-webroot', 09:05:47 INFO - 'create-virtualenv', 09:05:47 INFO - 'install', 09:05:47 INFO - 'run-tests'), 09:05:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:05:47 INFO - 'download_minidump_stackwalk': True, 09:05:47 INFO - 'download_symbols': 'ondemand', 09:05:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:05:47 INFO - 'tooltool.py': '/tools/tooltool.py', 09:05:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:05:47 INFO - '/tools/misc-python/virtualenv.py')}, 09:05:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:05:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:05:47 INFO - 'gecko_profile': False, 09:05:47 INFO - 'gecko_profile_interval': 0, 09:05:47 INFO - 'installer_path': 'installer.exe', 09:05:47 INFO - 'log_level': 'info', 09:05:47 INFO - 'log_name': 'talos', 09:05:47 INFO - 'log_to_console': True, 09:05:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:05:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:05:47 INFO - 'opt_config_files': (), 09:05:47 INFO - 'pip_index': False, 09:05:47 INFO - 'suite': 'dromaeojs', 09:05:47 INFO - 'system_bits': '32', 09:05:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:05:47 INFO - 'title': 'talos-linux64-ix-082', 09:05:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:05:47 INFO - 'use_talos_json': True, 09:05:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:05:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:05:47 INFO - 'work_dir': 'build'} 09:05:47 INFO - [mozharness: 2017-03-15 16:05:47.414652Z] Running clobber step. 09:05:47 INFO - Running pre-action listener: _resource_record_pre_action 09:05:47 INFO - Running main action method: clobber 09:05:47 INFO - rmtree: /builds/slave/test/build 09:05:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:05:48 INFO - Running post-action listener: _resource_record_post_action 09:05:48 INFO - [mozharness: 2017-03-15 16:05:48.345416Z] Finished clobber step (success) 09:05:48 INFO - [mozharness: 2017-03-15 16:05:48.345514Z] Running read-buildbot-config step. 09:05:48 INFO - Running pre-action listener: _resource_record_pre_action 09:05:48 INFO - Running main action method: read_buildbot_config 09:05:48 INFO - Using buildbot properties: 09:05:48 INFO - { 09:05:48 INFO - "project": "", 09:05:48 INFO - "product": "firefox", 09:05:48 INFO - "who": "ffxbld@noreply.mozilla.org", 09:05:48 INFO - "installer_path": "public/build/target.tar.bz2", 09:05:48 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:05:48 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 09:05:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:05:48 INFO - "stage_platform": "linux64-pgo", 09:05:48 INFO - "basedir": "/builds/slave/test", 09:05:48 INFO - "buildnumber": 1100, 09:05:48 INFO - "platform": "ubuntu64_hw", 09:05:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:05:48 INFO - "slavebuilddir": "test", 09:05:48 INFO - "taskId": "LCI-JxrRS8qvxFSJ4LDXTg", 09:05:48 INFO - "branch": "mozilla-aurora", 09:05:48 INFO - "script_repo_revision": "production", 09:05:48 INFO - "revision": "ce8120111f7f2902b3ac88ac35773d9957714a7a", 09:05:48 INFO - "slavename": "talos-linux64-ix-082", 09:05:48 INFO - "repo_path": "releases/mozilla-aurora" 09:05:48 INFO - } 09:05:48 INFO - Finding installer, test and symbols from parent task. 09:05:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LCI-JxrRS8qvxFSJ4LDXTg'}, attempt #1 09:05:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LCI-JxrRS8qvxFSJ4LDXTg'}, attempt #1 09:05:49 INFO - Task dependencies: CaUtDTpISgyYcsahb3IoPg 09:05:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg'}, attempt #1 09:05:49 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/target.tar.bz2 09:05:49 INFO - Set test_url: https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/test_packages.json 09:05:49 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/target.crashreporter-symbols.zip 09:05:49 INFO - Running post-action listener: _resource_record_post_action 09:05:49 INFO - [mozharness: 2017-03-15 16:05:49.812977Z] Finished read-buildbot-config step (success) 09:05:49 INFO - [mozharness: 2017-03-15 16:05:49.813195Z] Running download-and-extract step. 09:05:49 INFO - Running pre-action listener: _resource_record_pre_action 09:05:49 INFO - Running main action method: download_and_extract 09:05:49 INFO - mkdir: /builds/slave/test/build/tests 09:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:05:49 INFO - trying https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/target.test_packages.json 09:05:49 INFO - Downloading https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:05:50 INFO - Downloaded 896 bytes. 09:05:50 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:05:50 INFO - Using the following test package requirements: 09:05:50 INFO - {u'common': [u'target.common.tests.zip'], 09:05:50 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:05:50 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:05:50 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:05:50 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:05:50 INFO - u'mozbase': [u'target.common.tests.zip'], 09:05:50 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:05:50 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:05:50 INFO - u'web-platform': [u'target.common.tests.zip', 09:05:50 INFO - u'target.web-platform.tests.zip'], 09:05:50 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:05:50 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:05:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/target.common.tests.zip 09:05:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:05:50 INFO - Fetch https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/target.common.tests.zip into memory 09:05:51 INFO - Expected file size: 59528760 09:05:51 INFO - Obtained file size: 59528760 09:06:01 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:06:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/target.common.tests.zip 09:06:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:06:01 INFO - Fetch https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/target.common.tests.zip into memory 09:06:02 INFO - Expected file size: 59528760 09:06:02 INFO - Obtained file size: 59528760 09:06:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/target.talos.tests.zip 09:06:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:06:13 INFO - Fetch https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/target.talos.tests.zip into memory 09:06:14 INFO - Expected file size: 14404424 09:06:14 INFO - Obtained file size: 14404424 09:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:06:14 INFO - trying https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/target.tar.bz2 09:06:14 INFO - Downloading https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:06:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:06:15 INFO - Downloaded 66692677 bytes. 09:06:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/target.tar.bz2 09:06:15 INFO - mkdir: /builds/slave/test/properties 09:06:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:06:15 INFO - Writing to file /builds/slave/test/properties/build_url 09:06:15 INFO - Contents: 09:06:15 INFO - build_url:https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/target.tar.bz2 09:06:15 INFO - Running post-action listener: _resource_record_post_action 09:06:15 INFO - Running post-action listener: set_extra_try_arguments 09:06:15 INFO - [mozharness: 2017-03-15 16:06:15.559795Z] Finished download-and-extract step (success) 09:06:15 INFO - [mozharness: 2017-03-15 16:06:15.559891Z] Running populate-webroot step. 09:06:15 INFO - Running pre-action listener: _resource_record_pre_action 09:06:15 INFO - Running main action method: populate_webroot 09:06:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:06:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:06:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:06:15 INFO - '--tppagecycles', 09:06:15 INFO - '7'], 09:06:15 INFO - 'tests': ['tsvgm']}}, 09:06:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:06:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:06:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:06:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:06:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:06:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:06:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:06:15 INFO - 'talos_options': ['--disable-e10s'], 09:06:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:06:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:06:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:06:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:06:15 INFO - 'talos_options': ['--disable-e10s'], 09:06:15 INFO - 'tests': ['damp', 'tps']}, 09:06:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:06:15 INFO - 'tests': ['damp', 'tps']}, 09:06:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:06:15 INFO - 'tests': ['dromaeo_dom']}, 09:06:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:06:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:06:15 INFO - 'tests': ['basic_compositor_video']}, 09:06:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:06:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:06:15 INFO - 'tests': ['a11yr', 09:06:15 INFO - 'ts_paint', 09:06:15 INFO - 'tpaint', 09:06:15 INFO - 'sessionrestore', 09:06:15 INFO - 'sessionrestore_no_auto_restore', 09:06:15 INFO - 'tabpaint']}, 09:06:15 INFO - 'other-e10s': {'tests': ['a11yr', 09:06:15 INFO - 'ts_paint', 09:06:15 INFO - 'tpaint', 09:06:15 INFO - 'sessionrestore', 09:06:15 INFO - 'sessionrestore_no_auto_restore', 09:06:15 INFO - 'tabpaint']}, 09:06:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:06:15 INFO - 'ts_paint', 09:06:15 INFO - 'tpaint', 09:06:15 INFO - 'sessionrestore', 09:06:15 INFO - 'sessionrestore_no_auto_restore', 09:06:15 INFO - 'tabpaint']}, 09:06:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:06:15 INFO - 'ts_paint', 09:06:15 INFO - 'tpaint', 09:06:15 INFO - 'sessionrestore', 09:06:15 INFO - 'sessionrestore_no_auto_restore', 09:06:15 INFO - 'tabpaint']}, 09:06:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:06:15 INFO - 'tests': ['a11yr', 09:06:15 INFO - 'ts_paint', 09:06:15 INFO - 'tpaint', 09:06:15 INFO - 'sessionrestore', 09:06:15 INFO - 'sessionrestore_no_auto_restore', 09:06:15 INFO - 'tabpaint']}, 09:06:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:06:15 INFO - 'tests': ['a11yr', 09:06:15 INFO - 'ts_paint', 09:06:15 INFO - 'tpaint', 09:06:15 INFO - 'sessionrestore', 09:06:15 INFO - 'sessionrestore_no_auto_restore', 09:06:15 INFO - 'tabpaint']}, 09:06:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:06:15 INFO - 'tests': ['tsvgx', 09:06:15 INFO - 'tsvgr_opacity', 09:06:15 INFO - 'tart', 09:06:15 INFO - 'tscrollx', 09:06:15 INFO - 'cart', 09:06:15 INFO - 'tsvg_static']}, 09:06:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:06:15 INFO - 'tsvgr_opacity', 09:06:15 INFO - 'tart', 09:06:15 INFO - 'tscrollx', 09:06:15 INFO - 'cart', 09:06:15 INFO - 'tsvg_static']}, 09:06:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:06:15 INFO - 'talos_options': ['--disable-e10s'], 09:06:15 INFO - 'tests': ['tp5o']}, 09:06:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:06:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:06:15 INFO - 'talos_options': ['--disable-e10s', 09:06:15 INFO - '--xperf_path', 09:06:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:06:15 INFO - 'tests': ['tp5n']}, 09:06:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:06:15 INFO - 'talos_options': ['--xperf_path', 09:06:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:06:15 INFO - 'tests': ['tp5n']}}, 09:06:15 INFO - 'talos.zip': {'path': '', 09:06:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:06:15 INFO - Running post-action listener: _resource_record_post_action 09:06:15 INFO - [mozharness: 2017-03-15 16:06:15.572944Z] Finished populate-webroot step (success) 09:06:15 INFO - [mozharness: 2017-03-15 16:06:15.573034Z] Running create-virtualenv step. 09:06:15 INFO - Running pre-action listener: _resource_record_pre_action 09:06:15 INFO - Running main action method: create_virtualenv 09:06:15 INFO - Creating virtualenv /builds/slave/test/build/venv 09:06:15 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 09:06:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:06:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:06:15 INFO - Using real prefix '/usr' 09:06:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:06:16 INFO - Installing distribute.............................................................................................................................................................................................done. 09:06:18 INFO - Installing pip.................done. 09:06:18 INFO - Return code: 0 09:06:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:06:18 INFO - Reading from file tmpfile_stdout 09:06:18 INFO - Output received: 09:06:18 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) 09:06:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:18 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0xf351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d0290>, '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 0x11d0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d1040>, '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': '51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679', '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 09:06:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:06:18 INFO - Using env: {'DISPLAY': ':0', 09:06:18 INFO - 'HOME': '/home/cltbld', 09:06:18 INFO - 'LANG': 'en_US.UTF-8', 09:06:18 INFO - 'LANGUAGE': 'en_US:en', 09:06:18 INFO - 'LOGNAME': 'cltbld', 09:06:18 INFO - 'MAIL': '/var/mail/cltbld', 09:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:18 INFO - 'MOZ_NO_REMOTE': '1', 09:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:18 INFO - 'NO_EM_RESTART': '1', 09:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:18 INFO - 'PWD': '/builds/slave/test', 09:06:18 INFO - 'SHELL': '/bin/bash', 09:06:18 INFO - 'SHLVL': '1', 09:06:18 INFO - 'TERM': 'linux', 09:06:18 INFO - 'TMOUT': '86400', 09:06:18 INFO - 'USER': 'cltbld', 09:06:18 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679', 09:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:18 INFO - '_': '/tools/buildbot/bin/python'} 09:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:18 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 09:06:18 INFO - Cleaning up... 09:06:18 INFO - Return code: 0 09:06:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:18 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0xf351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d0290>, '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 0x11d0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d1040>, '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': '51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679', '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 09:06:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:06:18 INFO - Using env: {'DISPLAY': ':0', 09:06:18 INFO - 'HOME': '/home/cltbld', 09:06:18 INFO - 'LANG': 'en_US.UTF-8', 09:06:18 INFO - 'LANGUAGE': 'en_US:en', 09:06:18 INFO - 'LOGNAME': 'cltbld', 09:06:18 INFO - 'MAIL': '/var/mail/cltbld', 09:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:18 INFO - 'MOZ_NO_REMOTE': '1', 09:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:18 INFO - 'NO_EM_RESTART': '1', 09:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:18 INFO - 'PWD': '/builds/slave/test', 09:06:18 INFO - 'SHELL': '/bin/bash', 09:06:18 INFO - 'SHLVL': '1', 09:06:18 INFO - 'TERM': 'linux', 09:06:18 INFO - 'TMOUT': '86400', 09:06:18 INFO - 'USER': 'cltbld', 09:06:18 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679', 09:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:18 INFO - '_': '/tools/buildbot/bin/python'} 09:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:18 INFO - Downloading/unpacking psutil>=3.1.1 09:06:18 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 09:06:18 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 09:06:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:18 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 09:06:18 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 09:06:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:06:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:06:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:06:20 INFO - Installing collected packages: psutil 09:06:20 INFO - Running setup.py install for psutil 09:06:21 INFO - building 'psutil._psutil_linux' extension 09:06:21 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 09:06:21 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 09:06:21 INFO - building 'psutil._psutil_posix' extension 09:06:21 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 09:06:21 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 09:06:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:06:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:06:21 INFO - Successfully installed psutil 09:06:21 INFO - Cleaning up... 09:06:21 INFO - Return code: 0 09:06:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0xf351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d0290>, '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 0x11d0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d1040>, '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': '51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679', '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 09:06:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:06:21 INFO - Using env: {'DISPLAY': ':0', 09:06:21 INFO - 'HOME': '/home/cltbld', 09:06:21 INFO - 'LANG': 'en_US.UTF-8', 09:06:21 INFO - 'LANGUAGE': 'en_US:en', 09:06:21 INFO - 'LOGNAME': 'cltbld', 09:06:21 INFO - 'MAIL': '/var/mail/cltbld', 09:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:21 INFO - 'MOZ_NO_REMOTE': '1', 09:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:21 INFO - 'NO_EM_RESTART': '1', 09:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:21 INFO - 'PWD': '/builds/slave/test', 09:06:21 INFO - 'SHELL': '/bin/bash', 09:06:21 INFO - 'SHLVL': '1', 09:06:21 INFO - 'TERM': 'linux', 09:06:21 INFO - 'TMOUT': '86400', 09:06:21 INFO - 'USER': 'cltbld', 09:06:21 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679', 09:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:21 INFO - '_': '/tools/buildbot/bin/python'} 09:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:06: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 09:06: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 09:06:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06: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 09:06: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 09:06:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:06:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:06:23 INFO - Installing collected packages: mozsystemmonitor 09:06:23 INFO - Running setup.py install for mozsystemmonitor 09:06:23 INFO - Successfully installed mozsystemmonitor 09:06:23 INFO - Cleaning up... 09:06:23 INFO - Return code: 0 09:06:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:24 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0xf351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d0290>, '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 0x11d0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d1040>, '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': '51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679', '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 09:06:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:06:24 INFO - Using env: {'DISPLAY': ':0', 09:06:24 INFO - 'HOME': '/home/cltbld', 09:06:24 INFO - 'LANG': 'en_US.UTF-8', 09:06:24 INFO - 'LANGUAGE': 'en_US:en', 09:06:24 INFO - 'LOGNAME': 'cltbld', 09:06:24 INFO - 'MAIL': '/var/mail/cltbld', 09:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:24 INFO - 'MOZ_NO_REMOTE': '1', 09:06:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:24 INFO - 'NO_EM_RESTART': '1', 09:06:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:24 INFO - 'PWD': '/builds/slave/test', 09:06:24 INFO - 'SHELL': '/bin/bash', 09:06:24 INFO - 'SHLVL': '1', 09:06:24 INFO - 'TERM': 'linux', 09:06:24 INFO - 'TMOUT': '86400', 09:06:24 INFO - 'USER': 'cltbld', 09:06:24 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679', 09:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:24 INFO - '_': '/tools/buildbot/bin/python'} 09:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:24 INFO - Downloading/unpacking jsonschema==2.5.1 09:06: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 09:06: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 09:06:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06: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 09:06: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 09:06:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:06:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:06:26 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 09:06:26 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 09:06:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:26 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 09:06:26 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 09:06:26 INFO - Downloading functools32-3.2.3-2.tar.gz 09:06:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:06:26 INFO - warning: no files found matching '*.txt' 09:06:26 INFO - no previously-included directories found matching 'build' 09:06:26 INFO - no previously-included directories found matching 'dist' 09:06:26 INFO - no previously-included directories found matching '.git*' 09:06:26 INFO - Installing collected packages: jsonschema, functools32 09:06:26 INFO - Running setup.py install for functools32 09:06:26 INFO - warning: no files found matching '*.txt' 09:06:26 INFO - no previously-included directories found matching 'build' 09:06:26 INFO - no previously-included directories found matching 'dist' 09:06:26 INFO - no previously-included directories found matching '.git*' 09:06:26 INFO - Successfully installed jsonschema functools32 09:06:26 INFO - Cleaning up... 09:06:26 INFO - Return code: 0 09:06:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:26 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0xf351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d0290>, '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 0x11d0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d1040>, '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': '51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679', '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 09:06:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:06:26 INFO - Using env: {'DISPLAY': ':0', 09:06:26 INFO - 'HOME': '/home/cltbld', 09:06:26 INFO - 'LANG': 'en_US.UTF-8', 09:06:26 INFO - 'LANGUAGE': 'en_US:en', 09:06:26 INFO - 'LOGNAME': 'cltbld', 09:06:26 INFO - 'MAIL': '/var/mail/cltbld', 09:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:26 INFO - 'MOZ_NO_REMOTE': '1', 09:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:26 INFO - 'NO_EM_RESTART': '1', 09:06:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:26 INFO - 'PWD': '/builds/slave/test', 09:06:26 INFO - 'SHELL': '/bin/bash', 09:06:26 INFO - 'SHLVL': '1', 09:06:26 INFO - 'TERM': 'linux', 09:06:26 INFO - 'TMOUT': '86400', 09:06:26 INFO - 'USER': 'cltbld', 09:06:26 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679', 09:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:26 INFO - '_': '/tools/buildbot/bin/python'} 09:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:06:26 INFO - Cleaning up... 09:06:26 INFO - Return code: 0 09:06:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:26 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0xf351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d0290>, '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 0x11d0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d1040>, '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': '51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679', '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 09:06:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:06:26 INFO - Using env: {'DISPLAY': ':0', 09:06:26 INFO - 'HOME': '/home/cltbld', 09:06:26 INFO - 'LANG': 'en_US.UTF-8', 09:06:26 INFO - 'LANGUAGE': 'en_US:en', 09:06:26 INFO - 'LOGNAME': 'cltbld', 09:06:26 INFO - 'MAIL': '/var/mail/cltbld', 09:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:26 INFO - 'MOZ_NO_REMOTE': '1', 09:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:26 INFO - 'NO_EM_RESTART': '1', 09:06:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:26 INFO - 'PWD': '/builds/slave/test', 09:06:26 INFO - 'SHELL': '/bin/bash', 09:06:26 INFO - 'SHLVL': '1', 09:06:26 INFO - 'TERM': 'linux', 09:06:26 INFO - 'TMOUT': '86400', 09:06:26 INFO - 'USER': 'cltbld', 09:06:26 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679', 09:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:26 INFO - '_': '/tools/buildbot/bin/python'} 09:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:27 INFO - Downloading/unpacking blobuploader==1.2.4 09:06:27 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 09:06:27 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 09:06:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:27 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 09:06:27 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 09:06:29 INFO - Downloading blobuploader-1.2.4.tar.gz 09:06:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:06:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:06:29 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 09:06:29 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 09:06:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:29 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 09:06:29 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 09:06:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:06:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:06:29 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 09:06:29 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 09:06:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:29 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 09:06:29 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 09:06:29 INFO - Downloading docopt-0.6.1.tar.gz 09:06:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:06:29 INFO - Installing collected packages: blobuploader, requests, docopt 09:06:29 INFO - Running setup.py install for blobuploader 09:06:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:06:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:06:30 INFO - Running setup.py install for requests 09:06:30 INFO - Running setup.py install for docopt 09:06:30 INFO - Successfully installed blobuploader requests docopt 09:06:30 INFO - Cleaning up... 09:06:30 INFO - Return code: 0 09:06:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:30 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0xf351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d0290>, '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 0x11d0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d1040>, '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': '51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679', '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 09:06:30 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:06:30 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:06:30 INFO - Using env: {'DISPLAY': ':0', 09:06:30 INFO - 'HOME': '/home/cltbld', 09:06:30 INFO - 'LANG': 'en_US.UTF-8', 09:06:30 INFO - 'LANGUAGE': 'en_US:en', 09:06:30 INFO - 'LOGNAME': 'cltbld', 09:06:30 INFO - 'MAIL': '/var/mail/cltbld', 09:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:30 INFO - 'MOZ_NO_REMOTE': '1', 09:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:30 INFO - 'NO_EM_RESTART': '1', 09:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:30 INFO - 'PWD': '/builds/slave/test', 09:06:30 INFO - 'SHELL': '/bin/bash', 09:06:30 INFO - 'SHLVL': '1', 09:06:30 INFO - 'TERM': 'linux', 09:06:30 INFO - 'TMOUT': '86400', 09:06:30 INFO - 'USER': 'cltbld', 09:06:30 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679', 09:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:30 INFO - '_': '/tools/buildbot/bin/python'} 09:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:06:30 INFO - Running setup.py (path:/tmp/pip-Mn4S_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:06:30 INFO - Running setup.py (path:/tmp/pip-LaEaV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:06:30 INFO - Running setup.py (path:/tmp/pip-BQ0c7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:06:30 INFO - Running setup.py (path:/tmp/pip-8f4XtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:06:31 INFO - Running setup.py (path:/tmp/pip-po5P2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:06:31 INFO - Running setup.py (path:/tmp/pip-URIqma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:06:31 INFO - Running setup.py (path:/tmp/pip-xlRJef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:06:31 INFO - Running setup.py (path:/tmp/pip-YFStWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:06:31 INFO - Running setup.py (path:/tmp/pip-rwlMHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:06:31 INFO - Running setup.py (path:/tmp/pip-7YbcAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:06:31 INFO - Running setup.py (path:/tmp/pip-HB4hko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:06:31 INFO - Running setup.py (path:/tmp/pip-P4HDiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:06:31 INFO - Running setup.py (path:/tmp/pip-1RLdL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:06:31 INFO - Running setup.py (path:/tmp/pip-5SEg47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:31 INFO - Running setup.py (path:/tmp/pip-WswCe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:06:31 INFO - Running setup.py (path:/tmp/pip-Toxynh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:06:31 INFO - Running setup.py (path:/tmp/pip-D3NVTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:06:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:06:31 INFO - Running setup.py install for manifestparser 09:06:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:06:32 INFO - Running setup.py install for mozcrash 09:06:32 INFO - Running setup.py install for mozdebug 09:06:32 INFO - Running setup.py install for mozdevice 09:06:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:06:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:06:32 INFO - Running setup.py install for mozfile 09:06:32 INFO - Running setup.py install for mozhttpd 09:06:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:06:32 INFO - Running setup.py install for mozinfo 09:06:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:06:32 INFO - Running setup.py install for mozInstall 09:06:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:06:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:06:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:06:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:06:32 INFO - Running setup.py install for mozleak 09:06:32 INFO - Running setup.py install for mozlog 09:06:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:06:33 INFO - Running setup.py install for moznetwork 09:06:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:06:33 INFO - Running setup.py install for mozprocess 09:06:33 INFO - Running setup.py install for mozprofile 09:06:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:06:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:06:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:06:33 INFO - Running setup.py install for mozrunner 09:06:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:06:33 INFO - Running setup.py install for mozscreenshot 09:06:33 INFO - Running setup.py install for moztest 09:06:33 INFO - Running setup.py install for mozversion 09:06:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:06:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:06:33 INFO - Cleaning up... 09:06:33 INFO - Return code: 0 09:06:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:06:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:33 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0xf351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d0290>, '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 0x11d0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d1040>, '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': '51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679', '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 09:06:33 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:06:33 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:06:33 INFO - Using env: {'DISPLAY': ':0', 09:06:33 INFO - 'HOME': '/home/cltbld', 09:06:33 INFO - 'LANG': 'en_US.UTF-8', 09:06:33 INFO - 'LANGUAGE': 'en_US:en', 09:06:33 INFO - 'LOGNAME': 'cltbld', 09:06:33 INFO - 'MAIL': '/var/mail/cltbld', 09:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:33 INFO - 'MOZ_NO_REMOTE': '1', 09:06:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:33 INFO - 'NO_EM_RESTART': '1', 09:06:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:33 INFO - 'PWD': '/builds/slave/test', 09:06:33 INFO - 'SHELL': '/bin/bash', 09:06:33 INFO - 'SHLVL': '1', 09:06:33 INFO - 'TERM': 'linux', 09:06:33 INFO - 'TMOUT': '86400', 09:06:33 INFO - 'USER': 'cltbld', 09:06:33 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679', 09:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:33 INFO - '_': '/tools/buildbot/bin/python'} 09:06:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:06:34 INFO - Running setup.py (path:/tmp/pip-Ao5URR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:06:34 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)) 09:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:06:34 INFO - Running setup.py (path:/tmp/pip-lwuyqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:06:34 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)) 09:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:06:34 INFO - Running setup.py (path:/tmp/pip-ywLxeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:06:34 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)) 09:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:06:34 INFO - Running setup.py (path:/tmp/pip-xJJz9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 09:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:06:34 INFO - Running setup.py (path:/tmp/pip-HXnIS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:06:34 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)) 09:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:06:34 INFO - Running setup.py (path:/tmp/pip-LdDiQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:06:34 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)) 09:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:06:34 INFO - Running setup.py (path:/tmp/pip-F73sHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 09:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:06:34 INFO - Running setup.py (path:/tmp/pip-JQEkjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 09:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:06:34 INFO - Running setup.py (path:/tmp/pip-zA29SV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:06:34 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)) 09:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:06:34 INFO - Running setup.py (path:/tmp/pip-mfVYn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 09:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:06:34 INFO - Running setup.py (path:/tmp/pip-0sEkqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:06:34 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)) 09:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:06:34 INFO - Running setup.py (path:/tmp/pip-CqkMFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:06:34 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)) 09:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:06:34 INFO - Running setup.py (path:/tmp/pip-VH0_JC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:06:34 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)) 09:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:06:34 INFO - Running setup.py (path:/tmp/pip-1U21wV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:06:35 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)) 09:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:35 INFO - Running setup.py (path:/tmp/pip-oh5esd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:35 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)) 09:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:06:35 INFO - Running setup.py (path:/tmp/pip-CdJZtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:06:35 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)) 09:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:06:35 INFO - Running setup.py (path:/tmp/pip-8cku56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:06:35 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)) 09:06:35 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)) 09:06:35 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)) 09:06:35 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)) 09:06:35 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:06:35 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:06:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:06:35 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 09:06:35 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 09:06:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:35 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 09:06:35 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 09:06:37 INFO - Downloading blessings-1.6.tar.gz 09:06:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:06:37 INFO - Installing collected packages: blessings 09:06:37 INFO - Running setup.py install for blessings 09:06:37 INFO - Successfully installed blessings 09:06:37 INFO - Cleaning up... 09:06:37 INFO - Return code: 0 09:06:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:06:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:06:37 INFO - Reading from file tmpfile_stdout 09:06:37 INFO - Current package versions: 09:06:37 INFO - argparse == 1.2.1 09:06:37 INFO - blessings == 1.6 09:06:37 INFO - blobuploader == 1.2.4 09:06:37 INFO - docopt == 0.6.1 09:06:37 INFO - functools32 == 3.2.3-2 09:06:37 INFO - jsonschema == 2.5.1 09:06:37 INFO - manifestparser == 1.1 09:06:37 INFO - mozInstall == 1.12 09:06:37 INFO - mozcrash == 1.0 09:06:37 INFO - mozdebug == 0.1 09:06:37 INFO - mozdevice == 0.49 09:06:37 INFO - mozfile == 1.2 09:06:37 INFO - mozhttpd == 0.7 09:06:37 INFO - mozinfo == 0.9 09:06:37 INFO - mozleak == 0.1 09:06:37 INFO - mozlog == 3.4 09:06:37 INFO - moznetwork == 0.27 09:06:37 INFO - mozprocess == 0.25 09:06:37 INFO - mozprofile == 0.28 09:06:37 INFO - mozrunner == 6.13 09:06:37 INFO - mozscreenshot == 0.1 09:06:37 INFO - mozsystemmonitor == 0.3 09:06:37 INFO - moztest == 0.8 09:06:37 INFO - mozversion == 1.4 09:06:37 INFO - psutil == 3.1.1 09:06:37 INFO - requests == 1.2.3 09:06:37 INFO - wsgiref == 0.1.2 09:06:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:37 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0xf351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d0290>, '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 0x11d0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d1040>, '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': '51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679', '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 09:06:37 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:06:37 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:06:37 INFO - Using env: {'DISPLAY': ':0', 09:06:37 INFO - 'HOME': '/home/cltbld', 09:06:37 INFO - 'LANG': 'en_US.UTF-8', 09:06:37 INFO - 'LANGUAGE': 'en_US:en', 09:06:37 INFO - 'LOGNAME': 'cltbld', 09:06:37 INFO - 'MAIL': '/var/mail/cltbld', 09:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:37 INFO - 'MOZ_NO_REMOTE': '1', 09:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:37 INFO - 'NO_EM_RESTART': '1', 09:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:37 INFO - 'PWD': '/builds/slave/test', 09:06:37 INFO - 'SHELL': '/bin/bash', 09:06:37 INFO - 'SHLVL': '1', 09:06:37 INFO - 'TERM': 'linux', 09:06:37 INFO - 'TMOUT': '86400', 09:06:37 INFO - 'USER': 'cltbld', 09:06:37 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679', 09:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:37 INFO - '_': '/tools/buildbot/bin/python'} 09:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:37 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)) 09:06:37 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)) 09:06:37 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)) 09:06:37 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)) 09:06:37 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)) 09:06:37 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)) 09:06:37 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)) 09:06:37 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)) 09:06:37 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)) 09:06:37 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)) 09:06:37 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)) 09:06:37 INFO - Cleaning up... 09:06:37 INFO - Return code: 0 09:06:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:38 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0xf351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d0290>, '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 0x11d0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d1040>, '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': '51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679', '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 09:06:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:06:38 INFO - Using env: {'DISPLAY': ':0', 09:06:38 INFO - 'HOME': '/home/cltbld', 09:06:38 INFO - 'LANG': 'en_US.UTF-8', 09:06:38 INFO - 'LANGUAGE': 'en_US:en', 09:06:38 INFO - 'LOGNAME': 'cltbld', 09:06:38 INFO - 'MAIL': '/var/mail/cltbld', 09:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:38 INFO - 'MOZ_NO_REMOTE': '1', 09:06:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:38 INFO - 'NO_EM_RESTART': '1', 09:06:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:38 INFO - 'PWD': '/builds/slave/test', 09:06:38 INFO - 'SHELL': '/bin/bash', 09:06:38 INFO - 'SHLVL': '1', 09:06:38 INFO - 'TERM': 'linux', 09:06:38 INFO - 'TMOUT': '86400', 09:06:38 INFO - 'USER': 'cltbld', 09:06:38 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679', 09:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:38 INFO - '_': '/tools/buildbot/bin/python'} 09:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:06:38 INFO - Cleaning up... 09:06:38 INFO - Return code: 0 09:06:38 INFO - Running post-action listener: _resource_record_post_action 09:06:38 INFO - Running post-action listener: _start_resource_monitoring 09:06:38 INFO - Starting resource monitoring. 09:06:38 INFO - [mozharness: 2017-03-15 16:06:38.265607Z] Finished create-virtualenv step (success) 09:06:38 INFO - [mozharness: 2017-03-15 16:06:38.266071Z] Running install step. 09:06:38 INFO - Running pre-action listener: _resource_record_pre_action 09:06:38 INFO - Running main action method: install 09:06:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:06:38 INFO - Reading from file tmpfile_stdout 09:06:38 INFO - Detecting whether we're running mozinstall >=1.0... 09:06:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:06:38 INFO - Reading from file tmpfile_stdout 09:06:38 INFO - Output received: 09:06:38 INFO - Usage: mozinstall [options] installer 09:06:38 INFO - Options: 09:06:38 INFO - -h, --help show this help message and exit 09:06:38 INFO - -d DEST, --destination=DEST 09:06:38 INFO - Directory to install application into. [default: 09:06:38 INFO - "/builds/slave/test"] 09:06:38 INFO - --app=APP Application being installed. [default: firefox] 09:06:38 INFO - mkdir: /builds/slave/test/build/application 09:06:38 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'] 09:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:06:55 INFO - Reading from file tmpfile_stdout 09:06:55 INFO - Output received: 09:06:55 INFO - /builds/slave/test/build/application/firefox/firefox 09:06:55 INFO - Running post-action listener: _resource_record_post_action 09:06:55 INFO - [mozharness: 2017-03-15 16:06:55.161293Z] Finished install step (success) 09:06:55 INFO - [mozharness: 2017-03-15 16:06:55.161567Z] Running run-tests step. 09:06:55 INFO - Running pre-action listener: _resource_record_pre_action 09:06:55 INFO - Running main action method: run_tests 09:06:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:06:55 INFO - Python 2.7.3 09:06:55 INFO - Return code: 0 09:06:55 INFO - grabbing minidump binary from tooltool 09:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:06:55 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 0x11d0290>, '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 0x11d0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d1040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:06:55 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 09:06:55 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 09:06:55 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 09:06:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:06:55 INFO - Return code: 0 09:06:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:06:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:06:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:06:55 INFO - ENV: RUST_BACKTRACE is now 1 09:06:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:06:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:06:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-082 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:06:55 INFO - Using env: {'DISPLAY': ':0', 09:06:55 INFO - 'HOME': '/home/cltbld', 09:06:55 INFO - 'LANG': 'en_US.UTF-8', 09:06:55 INFO - 'LANGUAGE': 'en_US:en', 09:06:55 INFO - 'LOGNAME': 'cltbld', 09:06:55 INFO - 'MAIL': '/var/mail/cltbld', 09:06:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:06:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:55 INFO - 'MOZ_NO_REMOTE': '1', 09:06:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:55 INFO - 'NO_EM_RESTART': '1', 09:06:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:55 INFO - 'PWD': '/builds/slave/test', 09:06:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:06:55 INFO - 'RUST_BACKTRACE': '1', 09:06:55 INFO - 'SHELL': '/bin/bash', 09:06:55 INFO - 'SHLVL': '1', 09:06:55 INFO - 'TERM': 'linux', 09:06:55 INFO - 'TMOUT': '86400', 09:06:55 INFO - 'USER': 'cltbld', 09:06:55 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679', 09:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:55 INFO - '_': '/tools/buildbot/bin/python'} 09:06:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:06:55 INFO - mozversion application_buildid: 20170315151350 09:06:55 INFO - mozversion application_changeset: ce8120111f7f2902b3ac88ac35773d9957714a7a 09:06:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:06:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:06:55 INFO - mozversion application_name: Firefox 09:06:55 INFO - mozversion application_remotingname: firefox-dev 09:06:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:06:55 INFO - mozversion application_vendor: Mozilla 09:06:55 INFO - mozversion application_version: 54.0a2 09:06:55 INFO - mozversion platform_buildid: 20170315151350 09:06:55 INFO - mozversion platform_changeset: ce8120111f7f2902b3ac88ac35773d9957714a7a 09:06:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:06:55 INFO - mozversion platform_version: 54.0a2 09:06:55 INFO - using testdate: 1489594015 09:06:55 INFO - actual date: 1489594015 09:06:55 INFO - starting webserver on 'localhost:56546' 09:06:55 INFO - SUITE-START | Running 2 tests 09:06:55 INFO - TEST-START | dromaeo_css 09:06:55 INFO - operating with platform_type : linux_ 09:06:55 INFO - Initialising browser for dromaeo_css test... 09:06:55 INFO - TEST-INFO | started process 30289 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR_fPFL/profile http://localhost:56546/getInfo.html) 09:06:59 INFO - PROCESS | 30289 | __metrics Screen width/height:1600/1200 09:06:59 INFO - PROCESS | 30289 | colorDepth:24 09:06:59 INFO - PROCESS | 30289 | Browser inner width/height: 1024/697 09:06:59 INFO - PROCESS | 30289 | __metrics 09:07:00 INFO - PROCESS | 30289 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:07:00 INFO - PROCESS | 30289 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:07:01 INFO - TEST-INFO | 30289: exit 0 09:07:01 INFO - Browser initialized. 09:07:01 INFO - Running cycle 1/1 for dromaeo_css test... 09:07:01 INFO - TEST-INFO | started process 30382 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR_fPFL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:13 INFO - PROCESS | 30382 | RSS: Main: 138469376 09:07:13 INFO - PROCESS | 30382 | 09:10:15 INFO - PROCESS | 30382 | Cycle 1(1): loaded http://localhost:56546/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56546/tests/dromaeo/cssquery-ext.html) 09:10:16 INFO - PROCESS | 30382 | RSS: Main: 243683328 09:10:16 INFO - PROCESS | 30382 | 09:12:03 INFO - PROCESS | 30382 | ************************* 09:12:03 INFO - PROCESS | 30382 | A coding exception was thrown and uncaught in a Task. 09:12:03 INFO - PROCESS | 30382 | 09:12:03 ERROR - PROCESS | 30382 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:12:03 INFO - PROCESS | 30382 | Full stack: 09:12:03 INFO - PROCESS | 30382 | ************************* 09:13:18 INFO - PROCESS | 30382 | Cycle 1(1): loaded http://localhost:56546/tests/dromaeo/cssquery-ext.html (next: http://localhost:56546/tests/dromaeo/cssquery-jquery.html) 09:13:19 INFO - PROCESS | 30382 | RSS: Main: 222593024 09:13:19 INFO - PROCESS | 30382 | 09:16:21 INFO - PROCESS | 30382 | Cycle 1(1): loaded http://localhost:56546/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56546/tests/dromaeo/cssquery-mootools.html) 09:16:22 INFO - PROCESS | 30382 | RSS: Main: 169484288 09:16:22 INFO - PROCESS | 30382 | 09:19:23 INFO - PROCESS | 30382 | Cycle 1(1): loaded http://localhost:56546/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56546/tests/dromaeo/cssquery-prototype.html) 09:19:24 INFO - PROCESS | 30382 | RSS: Main: 169222144 09:19:24 INFO - PROCESS | 30382 | 09:22:27 INFO - PROCESS | 30382 | Cycle 1(1): loaded http://localhost:56546/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56546/tests/dromaeo/cssquery-yui.html) 09:22:27 INFO - PROCESS | 30382 | RSS: Main: 174903296 09:22:27 INFO - PROCESS | 30382 | 09:25:30 INFO - PROCESS | 30382 | Cycle 1(1): loaded http://localhost:56546/tests/dromaeo/cssquery-yui.html (next: http://localhost:56546/tests/dromaeo/cssquery-dojo.html) 09:25:30 INFO - PROCESS | 30382 | RSS: Main: 267968512 09:25:30 INFO - PROCESS | 30382 | 09:25:30 INFO - PROCESS | 30382 | __start_tp_report 09:25:30 INFO - PROCESS | 30382 | _x_x_mozilla_page_load 09:25:30 INFO - PROCESS | 30382 | _x_x_mozilla_page_load_details 09:25:30 INFO - PROCESS | 30382 | |i|pagename|runs| 09:25:30 INFO - PROCESS | 30382 | |0;dojo.html;3393.507941348504;3416.6070901846297;3423.8801641942528;3426.9657303426957;3462.878799242027;5696.8860622787515;5761.510271626911;5774.56690748194;5792.362840087587;5796.159556864252;5739.913901291484;5831.504322132613;5840.474357307841;5843.444872737094;5851.502622277101;5247.973760131204;5280.117755875355;5305.681659100466;5342.759575819097;5356.3572371315495;5117.846464606049;5140.3060586820675;5356.035913535562;5367.677939323634;5369;5196.506331898482;5237.528622423981;5247.160454327309;5256.658317209388;5260.105782017047;5311.973440132794;5324.893502129975;5341.30563026806;5361.383440904307;5363.168708850135;5235.528802407802;5329.2006199070065;5334.546563542103;5338.279332290169;5341.65279256847;5542.667439953575;5606.6636001840025;5646.661200327952;5773.018586840247;5799.21710569072;6215.844603884894;6218.875622487571;6218.906716399258;6222.906656400158;6229.781957631507;6228.87542249157;6261.217347831521;6261.405166509175;6266.78066267683;6269.592476489013;5602.13166959122;5784.652920824764;5802.97098514509;5823.941760582382;5839.532837373;6181.7527298908435;6218.22272215973;6229.4393504584805;6347.650879201688;6350.206224221973;6111.964830093352;6114.823346783637;6116.1836049259855;6118.171816584309;6124.646118266257;6129.969350153221;6140.846478837975;6167.074938759222;6187.907181392283;6191.226096737908;5945.7621695132575;5974.2830860297045;6092.51259899207;6116.60242084272;6139.907901381483;5921.052631579013;5957.106434034843;6183.196184495987;6191.226096737908;6207.379262073847;4669.4630117536235;4678.929816052762;4679.415073115861;4686.695364801277;4721.976390118028;4217.578242175758;4228.78856057202;4240.660747140221;4246.660267178619;4258.808353624095;6025.66858822769;6029.336772954972;6029.366916473795;6032.758689652453;6033.155358249848;6008.279006519158;6042.214512113397;6124.991279909863;6134.7852825151795;6240.968795155995;6006.879862402728;6026.668533230627;6027.21646185993;6045.123457098696;6047.334793172748;5301;5301.390340110859;5308.708021058879;5308.787648494017;5312.681239125664;6142.201513803177;6199.845003874939;6518.217813862272;6521.413072823374;6522.673866306571;6110.498006581597;6120.355709577036;6193.194884664965;6228.968855155696;6233.75064997395;6502.089707441057;6516.055172000129;6520.347965203442;6526.738930442729;6528.575642583217;6073.210482637229;6132.63204207749;6132.908006379818;6133.26400831903;6141.539384546088;5977.820665380045;5998.400159983967;6134.467201660849;6142.0383852415835;6276.780312689034;6080.695965201634;6089.086637004308;6095;6100.908486372797;6116.021436570128;6016.42843929826;6069.2716873975405;6077.6353418795015;6083.8174854754425;6089.208402907594;5796.391378905323;5812.505936995402;5945;6024.337322894566;6055.061465472859;6109.894485367275;6114.905704492704;6115.118650813463;6119.173911522065;6121.056693971993;5742.770289188553;5755.683437410982;5958.821235362946;5968.880622387441;5977.282726072899 09:25:30 INFO - PROCESS | 30382 | |1;ext.html;776.8096816280013;829.4235506323106;848.6902280667555;894.9463032218064;909.3907082254889;30850.84574577127;43618.7819060905;44220.33669494956;44385.556144438546;44573;38832.22335553287;39186;42556.36165457513;42569.14861702772;42794.14411711764;7515.173330933593;9056.954715226431;9177.265818734519;9186.816263674722;9193.126652967958;7725.49784264021;10169.694909152737;10360.067593916547;10663.306885052485;10802.405867677275;10477.26659133861;10491.790164196711;10494.422806745626;10500.527476263549;10508.211884108723;10416.062554370104;10428.322159059713;10434.904335044863;10454.79090418195;10458.843117353284;10688.893111068945;10706.78586428267;10722.356658600509;10742.570297188104;10753.731156721065;41301;41704.79147604273;41976;42055.78972105151;42259;4037.1723796621623;4090.8159132839096;4099.323611604082;4214.536400995888;4255.702100852942;29683.851580741957;29706;30036.849815750782;30374.392512149632;30406.54390184149;4169;4265.1469706058915;4273.658107351404;4360.912781744379;4369.584889435499;243017;245206;245387;245466;246637;54893;55059;55120.44879551233;55172.72413637987;55228;56517;56519.71740141273;56687.71656141693;56697.16514174275;56731.43268567262;16412.343506259855;16471.25879335433;16471.6705665886;16504.092274924755;16521;12902.741945161231;13121.868781312256;14587;14622.195779232032;14675;12081.516739330504;12950.935245323713;13209.141405808592;13579.388927498287;13736.381862816197;5490;5518.806841760519;5525.723713814293;5561.944380556223;5583.3858275589655;991.9504024798875;999.7600575861741;1009.9646512372032;1013.8580598716186;1016.364772017489;28040.71959280381;28210;28225;28705.28236794097;28736;1081.853949716794;1098.9285696429865;1101.911847052234;1118.0831717991168;1126.1610100475198;16807.495775126765;17734.20196091153;18301.54246143857;18539;18558.257669693063;300929;352782;352932;353919;354421;56265.43734562684;63959.6802015987;65063.67468162629;70500;70713.64643176751;1539.4457995121747;1546.8453154684441;1561.4925149326514;1563.7028964496938;1567.6316065724545;31739.365212696077;32047;33468;33670;33671.3265734679;43834;43883.78058109689;44166.55833441753;44178.337324940796;44180;351420;353941;354530;354959;355168;36679;36851.26297473982;37151.442728358554;37403.94278314719;37466;37655.62344376521;43455.34816977811;46523.302150468444;47361.52638473571;47844.28233576429;37092.629073708915;37386.6261337394;37915.81042094772;38810;39461;37911.43132852954;37924.81037594794;37996.81001594974;39424.605753942094;39542.802285988386;40065.79967100263;40293.39559906662;40498.39252411157;40602.1879562413;40747.59252407438;31331.27677977642;33575.83212083924;33592;34167.145821354665;34316.48525272173;26312.736872631795;26376.868115659297;26404.339891502867;26405.471890561697;27250.182494525197 09:25:30 INFO - PROCESS | 30382 | |2;jquery.html;446.5712915601021;447.4697483482074;451.21939045451387;461.36792594146016;466.5754163711023;19890.900545497272;20881.582368352625;21354.786452135475;21481.355559333206;21991.780082199173;22071.77928220717;22192.334229973087;22214.444638884037;22276.108955641794;22823.42941426465;4939.974610409733;6798.830029249284;6968.094147760784;7025.086738723959;7034.753783617574;4137.089840235143;4347.913041739163;6745.3254674532645;6877.89683154753;7445.292697193785;7838.159301942036;7914;7919.722809701661;7919.8416031679335;7944.443888927777;7801.414893882953;7869.685212591489;7873.842523149534;7879.645415956295;7892.763217103496;7429.591372474511;7572.318491335751;7633.6564854581675;7642.235776422369;7644.426667999922;25342.619860702103;25367.492650146894;25532;25560.221302340415;25601.10396136145;3027.7729170312314;3083.645380781194;3122.8282444465544;3192.6807319267887;3216.131644456007;15741.212939352987;15935;16190.190490475547;16253.91873040639;16273.186340683036;2137.316058861165;2170.70695456113;2181.476445653032;2204.9448763780874;2217.8336624753206;117550;117602;117645;120662;121295.99999999911;18618.81381186198;18685.346012889484;18933.76930499513;18980.905095474434;19160.80839191618;32393.218372989242;32433.675663243066;32449;32512.18719531983;32595.83702081522;10463.738406539898;10490.216663167128;10609.628662996758;10645.73385665349;10902.945485272523;8817.338699597556;8853.29173666105;8920.553972301488;9128.26973842091;9131.634734610674;9224.262059035262;9638.90361096394;9685.273604479551;9685.951570242103;9840;2961.8370989595346;3610.2418492116426;3746.8576672917993;3754.8685795997008;4114.876553703393;934.9252059835197;953.0993211415284;965.9372140810825;974.3569244298728;979.8579206015088;19367.80632193688;20751.273705420237;20771.792282077287;20995.265165719127;21062.368128956157;957.2103015012642;968.5835090910836;977.6578197630914;980.1374790184734;983.3165949664914;10739.677809665722;11546.59586914454;11599.304041757521;11687.415629218505;11723.531058757724;693186;696781;698125;699290;703479;104668;113625.43187284176;115393.4230328843;115531.42234288943;116787.41606291915;1193.2482536002437;1202.3507306054632;1233.9259644421363;1235.234154823997;1243.2913239453426;17548.21033053541;18009.63980720352;18272.634547309244;18334.449966501026;18530.536736581693;51204.74397627988;51735.48264517307;52022.69943251449;52232;52326.215106772666;68834.96747548891;69692.65153674199;70156.64921675359;70697;71001.64499177677;11224.382658953837;11574.6527604172;11603.36181510025;11607.071434285068;11733.765324693288;7675.731349402968;11024.228304018641;11587.130965177477;11979.580714674945;12325.568605098779;10767.97704218098;11047.834282485608;11156;11211.103111750877;11406.48670809799;10610.89389106099;10637.521311540844;10744.086752626114;10750.301230419998;10821.404822734825;11051.950064743836;11173.622663058128;11226.494807733836;11425.542978281108;11439;11800.940995294968;11940;11952;12282.570110046105;12292.323922184009;10733.838992415276;10809.243352965532;11052.115830733683;11271.098312134845;11383.43082845871 09:25:30 INFO - PROCESS | 30382 | |3;mootools.html;1566.9686606267883;1577.4715470317442;1588.5234429671095;1598.2248609424435;1600.7118718630643;11213.159013074022;12017.699557511067;12018.519259229643;12036.458359373828;12041.397930103492;11175.720606984829;11356.091512678986;11431.599894003712;11435.199536032482;11642.476088576013;2484.428581426273;2550.591905295153;2554.910578129766;2555.2078855554837;2557.1177943609423;2418.407490164912;2476.715177754554;2477.355887469253;2484.3043947694673;2484.35406794233;2442.5725498037773;2458.2625212436287;2465.0386349323776;2467.2721547143547;2468.5062987402594;2360.811135109187;2362.373970897722;2388.235764555343;2389.689340385756;2390.940226494334;2306.1351993002622;2357.8821058946983;2370.0401337458356;2370.668106465096;2378.036895057487;11697.2981621103;11821.408929553489;11839.940800295943;11840.763184736257;11842.585509507126;5970.194023806817;6109;6117.051856962178;6119;6123.601965872204;3394.81555333998;3469.2367679110557;3475.7566970312087;3508.245727168671;3530.6822385985383;1375.848656647768;1380.3167432121063;1397.0988712280523;1440.819897512811;1483.6661751106024;16600;16875.746863797052;17524.211410486558;17616.647667046716;17688.557786055324;4905.092557876733;4922.483139270325;4971.005798840247;4984.90030199394;5065.11360511909;12994.740105197843;13041.673958150932;13046;13046.673833154247;13060.608181754562;6027.126066720301;6038.275406951194;6041.154238406539;6049.758009679652;6051.606645568024;5500;5576.330840299109;5610.831675049755;5643.971780141155;5654.491095801398;4081.6530594899173;4092.1201941582704;4133.607307305801;4150.667946564267;4154.376843473443;1040.1159014837328;1042.968710938673;1043.749500119981;1056.5456853553046;1058.6453538064834;1034.4930983818026;1055.6516349604613;1060.506864308085;1067.3489171605315;1072.4316112460408;6814.522983391115;7074.257202993715;7301.707931682779;7580.1661817200065;7735.729249476354;1007.3603261928728;1016.7254841192985;1039.6517166749072;1040.604570263295;1050.8528805967171;4664.696794708333;4682.274247491644;4695.718256904596;4711.552402521755;4734.076855013308;14117.576472705836;14646.121232725858;14649.633759155893;14660.56018319452;14663.633409164857;12987.155834870704;14197.929010354883;14366.712665746627;14428;14479.131252124906;8580.399372043898;8952.641894324284;9125.133112354315;10127.341722787995;10505.527251273865;6976.127984002;7088.64556772149;7104.822379440556;7120.715171393086;7223.927760722536;12404.937975310426;12454.501819927464;12703.42834572428;12887.420066097236;12889.8066529004;12589.24464532131;12663;12778.105532612999;13003.08978371505;13008.024398169986;9959.601615935282;10159.949200253952;10168.644097456554;10196.235282354002;10323.587056517656;11039.172062095215;11046.558137674403;11140.275882067965;11143.554257829595;11205.495752690986;8943.463392196489;9137.908620913706;9170.587323570322;9175.128362805523;9325.487098209664;8625.654973801229;8703.521306328214;8710.956445217733;8838.823223535364;9001.909980900107;7854.41091918097;7860.5676687782725;7889.13219545838;7935.1668074853615;7955.602219889098;5750.5496701980155;5841.678707671119;5925.822225333247;5931.525477961839;5957.463828255478;5689.345725241485;5745.339285982165;5786.875077533805;5790.94209057904;5813.76744930198 09:25:30 INFO - PROCESS | 30382 | |4;prototype.html;418.1511531590871;418.8910883170376;429.2573847244269;429.79155109771756;432.43995546365494;5205.531502164809;5212.504812042859;5218.5564227040695;5224.2686023956585;5262.4474430184755;4928.383952005999;5091.821786237482;5140.383154021522;5141.948580514194;5151.665141765792;4228.830846766125;4309.612134907858;4322.438083049199;4340.7395556266565;4391.451068616423;4330.501992270898;4350.521442641307;4378.715383500063;4380.189664912002;4407.118576284756;4392.934105988413;4400.823967041314;4421.734695918255;4429.424174857264;4431.778411079433;4186.420610378113;4328.4156638853665;4329.480462344507;4426.579474949875;4430.401895744066;4059.451973983504;4075.1442197138635;4095.365218391154;4104.199681062194;4127.28717582203;4977.850664480035;5040.16837221858;5041.72270525121;5045.924311135299;5065.39215294167;4891.804327826918;5017.197248440232;5024.899502009939;5025.924611130836;5039.798408063673;5320.388155362144;5328.20076988451;5370.288004557673;5405.216243644689;5420.4850539198715;4499.910001799978;4506.1663592235545;4529.207388706996;4549.818007279705;4561.452625684906;5467.6719396836315;5536.944630553683;5573.916391254134;5629.493345598875;5721.6853073080965;4571.582809329118;4650.255959046536;4666.300054991779;4701.3653156824075;4705;4681.789319480631;4721.409823772028;4741.193997020515;4757.690750101232;4776.09254241693;4761.738104404221;4951.133551628451;4971.477994810492;4980.551750342486;5002.699298182499;5291.618771552817;5323.574114070865;5351.625386222927;5361.571074314045;5379.515843574019;1607.3329568229053;1617.8058632963885;1618.8381161883954;1635;1642.6796774628833;1209.1475509765594;1272.5164437513686;1284.3642397013539;1286.3598911388056;1302.101549930545;5285.180796976475;5290.814821481306;5295.802242069575;5298.523132918056;5301.54936830366;5418.45815418455;5486.231927530149;5493.285872836505;5516.282883225155;5526.557875370041;5090.49095090488;5201.6878987260125;5233.685978841282;5252.684838909678;5264.6051546134195;2860.7711383089304;2879.5248783950833;2884.4856450363727;2886.870090845917;2904.3755592547705;5418.810341638024;5696.829095127153;5725.627834190765;5750.453706897838;5753.043965051903;5344.9732751336;5491.890162196733;5543.334799824047;5555.361133469622;5555.833325000256;5575.69333686643;5586.51957231334;5678.473079479592;5706.828795136153;5716.628419152742;5469.343678758574;5479.2602998594675;5483.698396588226;5487.451254874481;5517.2275881377445;5059.848204553869;5201.401838788588;5315.840524784263;5336.332958380202;5440.7551660174595;5708.915306091829;5730.341010783646;5749.568782341257;5754.856128596819;5793.391693872083;4377.409049778239;4485.977570112129;4521.909561808811;4526.705764125321;4530.433695788027;5354.892902141857;5488.7530061148145;5556.499915007668;5560.638558493685;5560.805371811967;5388.54197393226;5423.538999184956;5431.782728690808;5432;5485.17722341636;5182.792688292426;5190.636655434083;5287.550558202596;5363.950217585698;5381.865453363697;5276.39321478035;5285.445028271976;5374.543163830962;5416.729163541886;5435.211894275229;5302.8333766571295;5323.414424413234;5421.241026256248;5460.645058071213;5472.562195024469;5054.974725126351;5202.375714914235;5322.627416080837;5323.600729945347;5342.439043900335 09:25:30 INFO - PROCESS | 30382 | |5;yui.html;728.7558667846271;734.7905846833653;899.7075950316149;902.3142411767058;928.7585227840759;15106.320215590298;16529;17243.741343879836;17754.201060952255;17956.191971361288;16323.755143672854;16489.67020659586;16627.916860415713;16636.25136868841;16980.830191698078;888.7467071884498;906.7325139083953;908.0692290402325;910.1535571918114;910.4309806371018;878.3017501086651;901.6303315640589;909.9863502047475;910.8679241509977;911.0570559470949;955.0926619711302;957.9281553883486;958.018031517693;958.2046901072093;958.6357184269967;945.0832692288469;947.228009172529;947.6398968392001;947.8862536495631;948.0424770981358;697.5326531224092;698.5040621158984;699.2413231643673;699.3356311504041;699.8355386484172;15061.17163556004;15403.152826594533;15569.610759730984;16043.278052487665;16195.838041619669;14568.635784105376;14910.17994010329;14943.925280373529;15323.923380383027;15722.05667659944;12826.871731282661;12925;12961.675958101123;13257.668558286023;13292.468301268034;3926.2540117377607;3942.250972315251;3944.684425245973;4004.0390306326562;4054.614811592894;70089.29910700879;70347.64826175837;92039;94718;97694.51152744191;12403.503859845505;12632.305223212628;12634.115611907262;12665.746685066248;12855.678608034686;22609.53038052521;22814.65778013331;22970.08119675228;22996.540069198858;23135.843207839876;8631.093735157843;8648.26489748366;8677.305815534743;8868.467891926504;8892.033140858603;4902.460729319772;5004.449510553836;5098.260752190911;5259.395169555473;5305.65513241638;3659.2864391443945;3760.360738674432;3762.398016317376;3766.4915236443276;3768.3782175940664;619.9225096862892;626.8683576448997;628.5097623853402;638.2468686949352;642.5309524047472;737.4100719424439;832.8875601793801;837.6398148795954;854.6666799947901;871.7471933139445;10501.579936802442;10788.514516846604;10928.508217130247;10998.835017474745;12286.262824230575;681.4990981628499;682.8292926768308;682.8873235916018;730.4266151071383;896.2097588390045;4889.193283108319;5095.745212739348;5101.668391554537;5126.820561280412;5135.948640513622;63489;72758.63620681969;79893;83557;85632;71391.6430417855;72589.63705181546;75281;75899.62050189824;77115.61442192865;65688.34311656823;65906.67046664737;66009.66995164994;68410.9738353925;68583;9903.504824758877;10051.899481005097;10120.94939525327;10160.577519147177;10252.333598316085;46244.30633540567;46383;46444.0624437832;47041.764791175825;47226.76386618045;52971.205431917784;53074;54203.72898135484;54885.1767223484;56234.71882640561;13193.340332983504;13224.47102115943;13271.66820829487;13478.595642130751;13691.452341906212;14065.859341406864;14355.85644143587;14754.852451475348;14849.628759281104;15301.540953771404;13268.93365533166;14022.78965815534;14451.27743612794;14636.560903172922;14915.254237287874;13380.130291531019;13879.028468007142;13979.510717124851;14218.431262749787;14763.188024658746;13371.197728136343;13834.308284585932;14058;14639.560813175622;14640.04839685417;11152.832707509231;11272.718182045515;11543.19197656156;11803.645890623295;11925.940370298093;11597.942010289895;11686.415679215836;11692.532298707956;11830.408479575815;11927.105467090176 09:25:30 INFO - PROCESS | 30382 | __end_tp_report 09:25:30 INFO - PROCESS | 30382 | __start_cc_report 09:25:30 INFO - PROCESS | 30382 | _x_x_mozilla_cycle_collect,1110 09:25:30 INFO - PROCESS | 30382 | __end_cc_report 09:25:30 INFO - PROCESS | 30382 | __startTimestamp1489595130627__endTimestamp 09:25:30 INFO - PROCESS | 30382 | 09:25:30 INFO - PROCESS | 30382 | ------- Summary: start ------- 09:25:30 INFO - PROCESS | 30382 | Number of tests: 6 09:25:30 INFO - PROCESS | 30382 | 09:25:30 INFO - PROCESS | 30382 | [#0] dojo.html Cycles:165 Average:5754.36 Median:6024.34 stddev:643.95 (10.7%) stddev-sans-first:618.71 09:25:30 INFO - PROCESS | 30382 | Values: 3393.5 3416.6 3423.9 3427.0 3462.9 5696.9 5761.5 5774.6 5792.4 5796.2 5739.9 5831.5 5840.5 5843.4 5851.5 5248.0 5280.1 5305.7 5342.8 5356.4 5117.8 5140.3 5356.0 5367.7 5369.0 5196.5 5237.5 5247.2 5256.7 5260.1 5312.0 5324.9 5341.3 5361.4 5363.2 5235.5 5329.2 5334.5 5338.3 5341.7 5542.7 5606.7 5646.7 5773.0 5799.2 6215.8 6218.9 6218.9 6222.9 6229.8 6228.9 6261.2 6261.4 6266.8 6269.6 5602.1 5784.7 5803.0 5823.9 5839.5 6181.8 6218.2 6229.4 6347.7 6350.2 6112.0 6114.8 6116.2 6118.2 6124.6 6130.0 6140.8 6167.1 6187.9 6191.2 5945.8 5974.3 6092.5 6116.6 6139.9 5921.1 5957.1 6183.2 6191.2 6207.4 4669.5 4678.9 4679.4 4686.7 4722.0 4217.6 4228.8 4240.7 4246.7 4258.8 6025.7 6029.3 6029.4 6032.8 6033.2 6008.3 6042.2 6125.0 6134.8 6241.0 6006.9 6026.7 6027.2 6045.1 6047.3 5301.0 5301.4 5308.7 5308.8 5312.7 6142.2 6199.8 6518.2 6521.4 6522.7 6110.5 6120.4 6193.2 6229.0 6233.8 6502.1 6516.1 6520.3 6526.7 6528.6 6073.2 6132.6 6132.9 6133.3 6141.5 5977.8 5998.4 6134.5 6142.0 6276.8 6080.7 6089.1 6095.0 6100.9 6116.0 6016.4 6069.3 6077.6 6083.8 6089.2 5796.4 5812.5 5945.0 6024.3 6055.1 6109.9 6114.9 6115.1 6119.2 6121.1 5742.8 5755.7 5958.8 5968.9 5977.3 09:25:30 INFO - PROCESS | 30382 | 09:25:30 INFO - PROCESS | 30382 | [#1] ext.html Cycles:180 Average:49121.20 Median:354744.50 stddev:83304.67 (23.5%) stddev-sans-first:83459.27 09:25:30 INFO - PROCESS | 30382 | Values: 776.8 829.4 848.7 894.9 909.4 30850.8 43618.8 44220.3 44385.6 44573.0 38832.2 39186.0 42556.4 42569.1 42794.1 7515.2 9057.0 9177.3 9186.8 9193.1 7725.5 10169.7 10360.1 10663.3 10802.4 10477.3 10491.8 10494.4 10500.5 10508.2 10416.1 10428.3 10434.9 10454.8 10458.8 10688.9 10706.8 10722.4 10742.6 10753.7 41301.0 41704.8 41976.0 42055.8 42259.0 4037.2 4090.8 4099.3 4214.5 4255.7 29683.9 29706.0 30036.8 30374.4 30406.5 4169.0 4265.1 4273.7 4360.9 4369.6 243017.0 245206.0 245387.0 245466.0 246637.0 54893.0 55059.0 55120.4 55172.7 55228.0 56517.0 56519.7 56687.7 56697.2 56731.4 16412.3 16471.3 16471.7 16504.1 16521.0 12902.7 13121.9 14587.0 14622.2 14675.0 12081.5 12950.9 13209.1 13579.4 13736.4 5490.0 5518.8 5525.7 5561.9 5583.4 992.0 999.8 1010.0 1013.9 1016.4 28040.7 28210.0 28225.0 28705.3 28736.0 1081.9 1098.9 1101.9 1118.1 1126.2 16807.5 17734.2 18301.5 18539.0 18558.3 300929.0 352782.0 352932.0 353919.0 354421.0 56265.4 63959.7 65063.7 70500.0 70713.6 1539.4 1546.8 1561.5 1563.7 1567.6 31739.4 32047.0 33468.0 33670.0 33671.3 43834.0 43883.8 44166.6 44178.3 44180.0 351420.0 353941.0 354530.0 354959.0 355168.0 36679.0 36851.3 37151.4 37403.9 37466.0 37655.6 43455.3 46523.3 47361.5 47844.3 37092.6 37386.6 37915.8 38810.0 39461.0 37911.4 37924.8 37996.8 39424.6 39542.8 40065.8 40293.4 40498.4 40602.2 40747.6 31331.3 33575.8 33592.0 34167.1 34316.5 26312.7 26376.9 26404.3 26405.5 27250.2 09:25:30 INFO - PROCESS | 30382 | 09:25:30 INFO - PROCESS | 30382 | [#2] jquery.html Cycles:180 Average:38752.57 Median:22203.39 stddev:115017.61 (518.0%) stddev-sans-first:115304.30 09:25:30 INFO - PROCESS | 30382 | Values: 446.6 447.5 451.2 461.4 466.6 19890.9 20881.6 21354.8 21481.4 21991.8 22071.8 22192.3 22214.4 22276.1 22823.4 4940.0 6798.8 6968.1 7025.1 7034.8 4137.1 4347.9 6745.3 6877.9 7445.3 7838.2 7914.0 7919.7 7919.8 7944.4 7801.4 7869.7 7873.8 7879.6 7892.8 7429.6 7572.3 7633.7 7642.2 7644.4 25342.6 25367.5 25532.0 25560.2 25601.1 3027.8 3083.6 3122.8 3192.7 3216.1 15741.2 15935.0 16190.2 16253.9 16273.2 2137.3 2170.7 2181.5 2204.9 2217.8 117550.0 117602.0 117645.0 120662.0 121296.0 18618.8 18685.3 18933.8 18980.9 19160.8 32393.2 32433.7 32449.0 32512.2 32595.8 10463.7 10490.2 10609.6 10645.7 10902.9 8817.3 8853.3 8920.6 9128.3 9131.6 9224.3 9638.9 9685.3 9686.0 9840.0 2961.8 3610.2 3746.9 3754.9 4114.9 934.9 953.1 965.9 974.4 979.9 19367.8 20751.3 20771.8 20995.3 21062.4 957.2 968.6 977.7 980.1 983.3 10739.7 11546.6 11599.3 11687.4 11723.5 693186.0 696781.0 698125.0 699290.0 703479.0 104668.0 113625.4 115393.4 115531.4 116787.4 1193.2 1202.4 1233.9 1235.2 1243.3 17548.2 18009.6 18272.6 18334.4 18530.5 51204.7 51735.5 52022.7 52232.0 52326.2 68835.0 69692.7 70156.6 70697.0 71001.6 11224.4 11574.7 11603.4 11607.1 11733.8 7675.7 11024.2 11587.1 11979.6 12325.6 10768.0 11047.8 11156.0 11211.1 11406.5 10610.9 10637.5 10744.1 10750.3 10821.4 11052.0 11173.6 11226.5 11425.5 11439.0 11800.9 11940.0 11952.0 12282.6 12292.3 10733.8 10809.2 11052.1 11271.1 11383.4 09:25:30 INFO - PROCESS | 30382 | 09:25:30 INFO - PROCESS | 30382 | [#3] mootools.html Cycles:180 Average:7095.65 Median:2404.67 stddev:4519.77 (188.0%) stddev-sans-first:4513.36 09:25:30 INFO - PROCESS | 30382 | Values: 1567.0 1577.5 1588.5 1598.2 1600.7 11213.2 12017.7 12018.5 12036.5 12041.4 11175.7 11356.1 11431.6 11435.2 11642.5 2484.4 2550.6 2554.9 2555.2 2557.1 2418.4 2476.7 2477.4 2484.3 2484.4 2442.6 2458.3 2465.0 2467.3 2468.5 2360.8 2362.4 2388.2 2389.7 2390.9 2306.1 2357.9 2370.0 2370.7 2378.0 11697.3 11821.4 11839.9 11840.8 11842.6 5970.2 6109.0 6117.1 6119.0 6123.6 3394.8 3469.2 3475.8 3508.2 3530.7 1375.8 1380.3 1397.1 1440.8 1483.7 16600.0 16875.7 17524.2 17616.6 17688.6 4905.1 4922.5 4971.0 4984.9 5065.1 12994.7 13041.7 13046.0 13046.7 13060.6 6027.1 6038.3 6041.2 6049.8 6051.6 5500.0 5576.3 5610.8 5644.0 5654.5 4081.7 4092.1 4133.6 4150.7 4154.4 1040.1 1043.0 1043.7 1056.5 1058.6 1034.5 1055.7 1060.5 1067.3 1072.4 6814.5 7074.3 7301.7 7580.2 7735.7 1007.4 1016.7 1039.7 1040.6 1050.9 4664.7 4682.3 4695.7 4711.6 4734.1 14117.6 14646.1 14649.6 14660.6 14663.6 12987.2 14197.9 14366.7 14428.0 14479.1 8580.4 8952.6 9125.1 10127.3 10505.5 6976.1 7088.6 7104.8 7120.7 7223.9 12404.9 12454.5 12703.4 12887.4 12889.8 12589.2 12663.0 12778.1 13003.1 13008.0 9959.6 10159.9 10168.6 10196.2 10323.6 11039.2 11046.6 11140.3 11143.6 11205.5 8943.5 9137.9 9170.6 9175.1 9325.5 8625.7 8703.5 8711.0 8838.8 9001.9 7854.4 7860.6 7889.1 7935.2 7955.6 5750.5 5841.7 5925.8 5931.5 5957.5 5689.3 5745.3 5786.9 5790.9 5813.8 09:25:30 INFO - PROCESS | 30382 | 09:25:30 INFO - PROCESS | 30382 | [#4] prototype.html Cycles:180 Average:4701.94 Median:5201.54 stddev:1235.67 (23.8%) stddev-sans-first:1196.58 09:25:30 INFO - PROCESS | 30382 | Values: 418.2 418.9 429.3 429.8 432.4 5205.5 5212.5 5218.6 5224.3 5262.4 4928.4 5091.8 5140.4 5141.9 5151.7 4228.8 4309.6 4322.4 4340.7 4391.5 4330.5 4350.5 4378.7 4380.2 4407.1 4392.9 4400.8 4421.7 4429.4 4431.8 4186.4 4328.4 4329.5 4426.6 4430.4 4059.5 4075.1 4095.4 4104.2 4127.3 4977.9 5040.2 5041.7 5045.9 5065.4 4891.8 5017.2 5024.9 5025.9 5039.8 5320.4 5328.2 5370.3 5405.2 5420.5 4499.9 4506.2 4529.2 4549.8 4561.5 5467.7 5536.9 5573.9 5629.5 5721.7 4571.6 4650.3 4666.3 4701.4 4705.0 4681.8 4721.4 4741.2 4757.7 4776.1 4761.7 4951.1 4971.5 4980.6 5002.7 5291.6 5323.6 5351.6 5361.6 5379.5 1607.3 1617.8 1618.8 1635.0 1642.7 1209.1 1272.5 1284.4 1286.4 1302.1 5285.2 5290.8 5295.8 5298.5 5301.5 5418.5 5486.2 5493.3 5516.3 5526.6 5090.5 5201.7 5233.7 5252.7 5264.6 2860.8 2879.5 2884.5 2886.9 2904.4 5418.8 5696.8 5725.6 5750.5 5753.0 5345.0 5491.9 5543.3 5555.4 5555.8 5575.7 5586.5 5678.5 5706.8 5716.6 5469.3 5479.3 5483.7 5487.5 5517.2 5059.8 5201.4 5315.8 5336.3 5440.8 5708.9 5730.3 5749.6 5754.9 5793.4 4377.4 4486.0 4521.9 4526.7 4530.4 5354.9 5488.8 5556.5 5560.6 5560.8 5388.5 5423.5 5431.8 5432.0 5485.2 5182.8 5190.6 5287.6 5364.0 5381.9 5276.4 5285.4 5374.5 5416.7 5435.2 5302.8 5323.4 5421.2 5460.6 5472.6 5055.0 5202.4 5322.6 5323.6 5342.4 09:25:30 INFO - PROCESS | 30382 | 09:25:30 INFO - PROCESS | 30382 | [#5] yui.html Cycles:180 Average:18507.13 Median:46413.53 stddev:23484.17 (50.6%) stddev-sans-first:23512.10 09:25:30 INFO - PROCESS | 30382 | Values: 728.8 734.8 899.7 902.3 928.8 15106.3 16529.0 17243.7 17754.2 17956.2 16323.8 16489.7 16627.9 16636.3 16980.8 888.7 906.7 908.1 910.2 910.4 878.3 901.6 910.0 910.9 911.1 955.1 957.9 958.0 958.2 958.6 945.1 947.2 947.6 947.9 948.0 697.5 698.5 699.2 699.3 699.8 15061.2 15403.2 15569.6 16043.3 16195.8 14568.6 14910.2 14943.9 15323.9 15722.1 12826.9 12925.0 12961.7 13257.7 13292.5 3926.3 3942.3 3944.7 4004.0 4054.6 70089.3 70347.6 92039.0 94718.0 97694.5 12403.5 12632.3 12634.1 12665.7 12855.7 22609.5 22814.7 22970.1 22996.5 23135.8 8631.1 8648.3 8677.3 8868.5 8892.0 4902.5 5004.4 5098.3 5259.4 5305.7 3659.3 3760.4 3762.4 3766.5 3768.4 619.9 626.9 628.5 638.2 642.5 737.4 832.9 837.6 854.7 871.7 10501.6 10788.5 10928.5 10998.8 12286.3 681.5 682.8 682.9 730.4 896.2 4889.2 5095.7 5101.7 5126.8 5135.9 63489.0 72758.6 79893.0 83557.0 85632.0 71391.6 72589.6 75281.0 75899.6 77115.6 65688.3 65906.7 66009.7 68411.0 68583.0 9903.5 10051.9 10120.9 10160.6 10252.3 46244.3 46383.0 46444.1 47041.8 47226.8 52971.2 53074.0 54203.7 54885.2 56234.7 13193.3 13224.5 13271.7 13478.6 13691.5 14065.9 14355.9 14754.9 14849.6 15301.5 13268.9 14022.8 14451.3 14636.6 14915.3 13380.1 13879.0 13979.5 14218.4 14763.2 13371.2 13834.3 14058.0 14639.6 14640.0 11152.8 11272.7 11543.2 11803.6 11925.9 11597.9 11686.4 11692.5 11830.4 11927.1 09:25:30 INFO - PROCESS | 30382 | -------- Summary: end -------- 09:25:30 INFO - PROCESS | 30382 | 09:25:31 INFO - TEST-INFO | 30382: exit 0 09:25:31 INFO - TEST-OK | dromaeo_css | took 1116012ms 09:25:31 INFO - TEST-START | kraken 09:25:31 INFO - operating with platform_type : linux_ 09:25:31 INFO - Initialising browser for kraken test... 09:25:31 INFO - TEST-INFO | started process 30711 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLWWeSC/profile http://localhost:56546/getInfo.html) 09:25:35 INFO - PROCESS | 30711 | __metrics Screen width/height:1600/1200 09:25:35 INFO - PROCESS | 30711 | colorDepth:24 09:25:35 INFO - PROCESS | 30711 | Browser inner width/height: 1024/697 09:25:35 INFO - PROCESS | 30711 | __metrics 09:25:36 INFO - PROCESS | 30711 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:25:36 INFO - PROCESS | 30711 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:25:37 INFO - TEST-INFO | 30711: exit 0 09:25:37 INFO - Browser initialized. 09:25:37 INFO - Running cycle 1/1 for kraken test... 09:25:37 INFO - TEST-INFO | started process 30804 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLWWeSC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:48 INFO - PROCESS | 30804 | RSS: Main: 139096064 09:25:48 INFO - PROCESS | 30804 | 09:25:51 INFO - PROCESS | 30804 | Cycle 1(1): loaded http://localhost:56546/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56546/tests/kraken/driver.html?testName=audio-beat-detection) 09:25:52 INFO - PROCESS | 30804 | RSS: Main: 182386688 09:25:52 INFO - PROCESS | 30804 | 09:25:54 INFO - PROCESS | 30804 | Cycle 1(1): loaded http://localhost:56546/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56546/tests/kraken/driver.html?testName=audio-dft) 09:25:55 INFO - PROCESS | 30804 | RSS: Main: 174010368 09:25:55 INFO - PROCESS | 30804 | 09:25:58 INFO - PROCESS | 30804 | Cycle 1(1): loaded http://localhost:56546/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56546/tests/kraken/driver.html?testName=audio-fft) 09:25:58 INFO - PROCESS | 30804 | RSS: Main: 265932800 09:25:58 INFO - PROCESS | 30804 | 09:26:00 INFO - PROCESS | 30804 | Cycle 1(1): loaded http://localhost:56546/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56546/tests/kraken/driver.html?testName=audio-oscillator) 09:26:01 INFO - PROCESS | 30804 | RSS: Main: 171134976 09:26:01 INFO - PROCESS | 30804 | 09:26:03 INFO - PROCESS | 30804 | Cycle 1(1): loaded http://localhost:56546/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56546/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:26:04 INFO - PROCESS | 30804 | RSS: Main: 174206976 09:26:04 INFO - PROCESS | 30804 | 09:26:07 INFO - PROCESS | 30804 | Cycle 1(1): loaded http://localhost:56546/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56546/tests/kraken/driver.html?testName=imaging-darkroom) 09:26:07 INFO - PROCESS | 30804 | RSS: Main: 213229568 09:26:07 INFO - PROCESS | 30804 | 09:26:11 INFO - PROCESS | 30804 | Cycle 1(1): loaded http://localhost:56546/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56546/tests/kraken/driver.html?testName=imaging-desaturate) 09:26:11 INFO - PROCESS | 30804 | RSS: Main: 211492864 09:26:11 INFO - PROCESS | 30804 | 09:26:14 INFO - PROCESS | 30804 | Cycle 1(1): loaded http://localhost:56546/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56546/tests/kraken/driver.html?testName=json-parse-financial) 09:26:14 INFO - PROCESS | 30804 | RSS: Main: 209592320 09:26:14 INFO - PROCESS | 30804 | 09:26:16 INFO - PROCESS | 30804 | Cycle 1(1): loaded http://localhost:56546/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56546/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:26:17 INFO - PROCESS | 30804 | RSS: Main: 172355584 09:26:17 INFO - PROCESS | 30804 | 09:26:18 INFO - PROCESS | 30804 | Cycle 1(1): loaded http://localhost:56546/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56546/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:26:19 INFO - PROCESS | 30804 | RSS: Main: 178388992 09:26:19 INFO - PROCESS | 30804 | 09:26:21 INFO - PROCESS | 30804 | Cycle 1(1): loaded http://localhost:56546/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56546/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:26:22 INFO - PROCESS | 30804 | RSS: Main: 188510208 09:26:22 INFO - PROCESS | 30804 | 09:26:24 INFO - PROCESS | 30804 | Cycle 1(1): loaded http://localhost:56546/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56546/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:26:25 INFO - PROCESS | 30804 | RSS: Main: 198270976 09:26:25 INFO - PROCESS | 30804 | 09:26:28 INFO - PROCESS | 30804 | Cycle 1(1): loaded http://localhost:56546/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56546/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:26:28 INFO - PROCESS | 30804 | RSS: Main: 194310144 09:26:28 INFO - PROCESS | 30804 | 09:26:30 INFO - PROCESS | 30804 | Cycle 1(1): loaded http://localhost:56546/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56546/tests/kraken/driver.html?testName=ai-astar) 09:26:30 INFO - PROCESS | 30804 | RSS: Main: 244781056 09:26:30 INFO - PROCESS | 30804 | 09:26:30 INFO - PROCESS | 30804 | __start_tp_report 09:26:30 INFO - PROCESS | 30804 | _x_x_mozilla_page_load 09:26:30 INFO - PROCESS | 30804 | _x_x_mozilla_page_load_details 09:26:30 INFO - PROCESS | 30804 | |i|pagename|runs| 09:26:30 INFO - PROCESS | 30804 | |0;ai-astar;101;113;111;113;112;113;112;112;112;112 09:26:30 INFO - PROCESS | 30804 | |1;audio-beat-detection;141;116;116;165;117;122;116;116;137;116 09:26:30 INFO - PROCESS | 30804 | |2;audio-dft;161;160;161;160;161;162;161;161;161;160 09:26:30 INFO - PROCESS | 30804 | |3;audio-fft;74;74;75;114;76;75;75;76;92;75 09:26:30 INFO - PROCESS | 30804 | |4;audio-oscillator;81;81;99;82;82;82;92;81;81;98 09:26:30 INFO - PROCESS | 30804 | |5;imaging-gaussian-blur;113;114;113;113;113;113;113;112;113;113 09:26:30 INFO - PROCESS | 30804 | |6;imaging-darkroom;145;146;145;146;147;146;146;147;146;147 09:26:30 INFO - PROCESS | 30804 | |7;imaging-desaturate;94;94;94;94;94;94;93;94;94;94 09:26:30 INFO - PROCESS | 30804 | |8;json-parse-financial;57;54;55;54;54;55;54;55;54;54 09:26:30 INFO - PROCESS | 30804 | |9;json-stringify-tinderbox;52;53;54;52;52;52;53;53;53;53 09:26:30 INFO - PROCESS | 30804 | |10;stanford-crypto-aes;80;79;79;79;75;80;75;74;74;74 09:26:30 INFO - PROCESS | 30804 | |11;stanford-crypto-ccm;123;130;123;122;119;121;117;129;169;118 09:26:30 INFO - PROCESS | 30804 | |12;stanford-crypto-pbkdf2;166;163;162;160;169;165;165;167;164;165 09:26:30 INFO - PROCESS | 30804 | |13;stanford-crypto-sha256-iterative;63;60;60;62;59;64;59;60;59;59 09:26:30 INFO - PROCESS | 30804 | __end_tp_report 09:26:30 INFO - PROCESS | 30804 | __start_cc_report 09:26:30 INFO - PROCESS | 30804 | _x_x_mozilla_cycle_collect,1682 09:26:30 INFO - PROCESS | 30804 | __end_cc_report 09:26:30 INFO - PROCESS | 30804 | __startTimestamp1489595190468__endTimestamp 09:26:30 INFO - PROCESS | 30804 | 09:26:30 INFO - PROCESS | 30804 | ------- Summary: start ------- 09:26:30 INFO - PROCESS | 30804 | Number of tests: 14 09:26:30 INFO - PROCESS | 30804 | 09:26:30 INFO - PROCESS | 30804 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:3.60 (3.2%) stddev-sans-first:0.67 09:26:30 INFO - PROCESS | 30804 | Values: 101.0 113.0 111.0 113.0 112.0 113.0 112.0 112.0 112.0 112.0 09:26:30 INFO - PROCESS | 30804 | 09:26:30 INFO - PROCESS | 30804 | [#1] audio-beat-detection Cycles:10 Average:126.20 Median:119.50 stddev:16.54 (13.8%) stddev-sans-first:16.66 09:26:30 INFO - PROCESS | 30804 | Values: 141.0 116.0 116.0 165.0 117.0 122.0 116.0 116.0 137.0 116.0 09:26:30 INFO - PROCESS | 30804 | 09:26:30 INFO - PROCESS | 30804 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 09:26:30 INFO - PROCESS | 30804 | Values: 161.0 160.0 161.0 160.0 161.0 162.0 161.0 161.0 161.0 160.0 09:26:30 INFO - PROCESS | 30804 | 09:26:30 INFO - PROCESS | 30804 | [#3] audio-fft Cycles:10 Average:80.60 Median:75.00 stddev:12.91 (17.2%) stddev-sans-first:13.47 09:26:30 INFO - PROCESS | 30804 | Values: 74.0 74.0 75.0 114.0 76.0 75.0 75.0 76.0 92.0 75.0 09:26:30 INFO - PROCESS | 30804 | 09:26:30 INFO - PROCESS | 30804 | [#4] audio-oscillator Cycles:10 Average:85.90 Median:82.00 stddev:7.43 (9.1%) stddev-sans-first:7.67 09:26:30 INFO - PROCESS | 30804 | Values: 81.0 81.0 99.0 82.0 82.0 82.0 92.0 81.0 81.0 98.0 09:26:30 INFO - PROCESS | 30804 | 09:26:30 INFO - PROCESS | 30804 | [#5] imaging-gaussian-blur Cycles:10 Average:113.00 Median:113.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 09:26:30 INFO - PROCESS | 30804 | Values: 113.0 114.0 113.0 113.0 113.0 113.0 113.0 112.0 113.0 113.0 09:26:30 INFO - PROCESS | 30804 | 09:26:30 INFO - PROCESS | 30804 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 09:26:30 INFO - PROCESS | 30804 | Values: 145.0 146.0 145.0 146.0 147.0 146.0 146.0 147.0 146.0 147.0 09:26:30 INFO - PROCESS | 30804 | 09:26:30 INFO - PROCESS | 30804 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:26:30 INFO - PROCESS | 30804 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 09:26:30 INFO - PROCESS | 30804 | 09:26:30 INFO - PROCESS | 30804 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:0.97 (1.8%) stddev-sans-first:0.50 09:26:30 INFO - PROCESS | 30804 | Values: 57.0 54.0 55.0 54.0 54.0 55.0 54.0 55.0 54.0 54.0 09:26:30 INFO - PROCESS | 30804 | 09:26:30 INFO - PROCESS | 30804 | [#9] json-stringify-tinderbox Cycles:10 Average:52.70 Median:53.00 stddev:0.67 (1.3%) stddev-sans-first:0.67 09:26:30 INFO - PROCESS | 30804 | Values: 52.0 53.0 54.0 52.0 52.0 52.0 53.0 53.0 53.0 53.0 09:26:30 INFO - PROCESS | 30804 | 09:26:30 INFO - PROCESS | 30804 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:79.00 stddev:2.69 (3.4%) stddev-sans-first:2.60 09:26:30 INFO - PROCESS | 30804 | Values: 80.0 79.0 79.0 79.0 75.0 80.0 75.0 74.0 74.0 74.0 09:26:30 INFO - PROCESS | 30804 | 09:26:30 INFO - PROCESS | 30804 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:123.00 stddev:15.33 (12.5%) stddev-sans-first:16.19 09:26:30 INFO - PROCESS | 30804 | Values: 123.0 130.0 123.0 122.0 119.0 121.0 117.0 129.0 169.0 118.0 09:26:30 INFO - PROCESS | 30804 | 09:26:30 INFO - PROCESS | 30804 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:165.00 stddev:2.55 (1.5%) stddev-sans-first:2.65 09:26:30 INFO - PROCESS | 30804 | Values: 166.0 163.0 162.0 160.0 169.0 165.0 165.0 167.0 164.0 165.0 09:26:30 INFO - PROCESS | 30804 | 09:26:30 INFO - PROCESS | 30804 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.50 Median:60.00 stddev:1.84 (3.1%) stddev-sans-first:1.72 09:26:30 INFO - PROCESS | 30804 | Values: 63.0 60.0 60.0 62.0 59.0 64.0 59.0 60.0 59.0 59.0 09:26:30 INFO - PROCESS | 30804 | -------- Summary: end -------- 09:26:30 INFO - PROCESS | 30804 | 09:26:31 INFO - TEST-INFO | 30804: exit 0 09:26:31 INFO - TEST-OK | kraken | took 60061ms 09:26:31 INFO - SUITE-END | took 1176s 09:26:31 INFO - Completed test suite (00:19:36) 09:26:31 INFO - javascript benchmark 09:26:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7831.2041260609285, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3393.507941348504, 3416.6070901846297, 3423.8801641942528, 3426.9657303426957, 3462.878799242027, 5696.8860622787515, 5761.510271626911, 5774.56690748194, 5792.362840087587, 5796.159556864252, 5739.913901291484, 5831.504322132613, 5840.474357307841, 5843.444872737094, 5851.502622277101, 5247.973760131204, 5280.117755875355, 5305.681659100466, 5342.759575819097, 5356.3572371315495, 5117.846464606049, 5140.3060586820675, 5356.035913535562, 5367.677939323634, 5369.0, 5196.506331898482, 5237.528622423981, 5247.160454327309, 5256.658317209388, 5260.105782017047, 5311.973440132794, 5324.893502129975, 5341.30563026806, 5361.383440904307, 5363.168708850135, 5235.528802407802, 5329.2006199070065, 5334.546563542103, 5338.279332290169, 5341.65279256847, 5542.667439953575, 5606.6636001840025, 5646.661200327952, 5773.018586840247, 5799.21710569072, 6215.844603884894, 6218.875622487571, 6218.906716399258, 6222.906656400158, 6229.781957631507, 6228.87542249157, 6261.217347831521, 6261.405166509175, 6266.78066267683, 6269.592476489013, 5602.13166959122, 5784.652920824764, 5802.97098514509, 5823.941760582382, 5839.532837373, 6181.7527298908435, 6218.22272215973, 6229.4393504584805, 6347.650879201688, 6350.206224221973, 6111.964830093352, 6114.823346783637, 6116.1836049259855, 6118.171816584309, 6124.646118266257, 6129.969350153221, 6140.846478837975, 6167.074938759222, 6187.907181392283, 6191.226096737908, 5945.7621695132575, 5974.2830860297045, 6092.51259899207, 6116.60242084272, 6139.907901381483, 5921.052631579013, 5957.106434034843, 6183.196184495987, 6191.226096737908, 6207.379262073847, 4669.4630117536235, 4678.929816052762, 4679.415073115861, 4686.695364801277, 4721.976390118028, 4217.578242175758, 4228.78856057202, 4240.660747140221, 4246.660267178619, 4258.808353624095, 6025.66858822769, 6029.336772954972, 6029.366916473795, 6032.758689652453, 6033.155358249848, 6008.279006519158, 6042.214512113397, 6124.991279909863, 6134.7852825151795, 6240.968795155995, 6006.879862402728, 6026.668533230627, 6027.21646185993, 6045.123457098696, 6047.334793172748, 5301.0, 5301.390340110859, 5308.708021058879, 5308.787648494017, 5312.681239125664, 6142.201513803177, 6199.845003874939, 6518.217813862272, 6521.413072823374, 6522.673866306571, 6110.498006581597, 6120.355709577036, 6193.194884664965, 6228.968855155696, 6233.75064997395, 6502.089707441057, 6516.055172000129, 6520.347965203442, 6526.738930442729, 6528.575642583217, 6073.210482637229, 6132.63204207749, 6132.908006379818, 6133.26400831903, 6141.539384546088, 5977.820665380045, 5998.400159983967, 6134.467201660849, 6142.0383852415835, 6276.780312689034, 6080.695965201634, 6089.086637004308, 6095.0, 6100.908486372797, 6116.021436570128, 6016.42843929826, 6069.2716873975405, 6077.6353418795015, 6083.8174854754425, 6089.208402907594, 5796.391378905323, 5812.505936995402, 5945.0, 6024.337322894566, 6055.061465472859, 6109.894485367275, 6114.905704492704, 6115.118650813463, 6119.173911522065, 6121.056693971993, 5742.770289188553, 5755.683437410982, 5958.821235362946, 5968.880622387441, 5977.282726072899], "value": 5711.99644173423, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.8096816280013, 829.4235506323106, 848.6902280667555, 894.9463032218064, 909.3907082254889, 30850.84574577127, 43618.7819060905, 44220.33669494956, 44385.556144438546, 44573.0, 38832.22335553287, 39186.0, 42556.36165457513, 42569.14861702772, 42794.14411711764, 7515.173330933593, 9056.954715226431, 9177.265818734519, 9186.816263674722, 9193.126652967958, 7725.49784264021, 10169.694909152737, 10360.067593916547, 10663.306885052485, 10802.405867677275, 10477.26659133861, 10491.790164196711, 10494.422806745626, 10500.527476263549, 10508.211884108723, 10416.062554370104, 10428.322159059713, 10434.904335044863, 10454.79090418195, 10458.843117353284, 10688.893111068945, 10706.78586428267, 10722.356658600509, 10742.570297188104, 10753.731156721065, 41301.0, 41704.79147604273, 41976.0, 42055.78972105151, 42259.0, 4037.1723796621623, 4090.8159132839096, 4099.323611604082, 4214.536400995888, 4255.702100852942, 29683.851580741957, 29706.0, 30036.849815750782, 30374.392512149632, 30406.54390184149, 4169.0, 4265.1469706058915, 4273.658107351404, 4360.912781744379, 4369.584889435499, 243017.0, 245206.0, 245387.0, 245466.0, 246637.0, 54893.0, 55059.0, 55120.44879551233, 55172.72413637987, 55228.0, 56517.0, 56519.71740141273, 56687.71656141693, 56697.16514174275, 56731.43268567262, 16412.343506259855, 16471.25879335433, 16471.6705665886, 16504.092274924755, 16521.0, 12902.741945161231, 13121.868781312256, 14587.0, 14622.195779232032, 14675.0, 12081.516739330504, 12950.935245323713, 13209.141405808592, 13579.388927498287, 13736.381862816197, 5490.0, 5518.806841760519, 5525.723713814293, 5561.944380556223, 5583.3858275589655, 991.9504024798875, 999.7600575861741, 1009.9646512372032, 1013.8580598716186, 1016.364772017489, 28040.71959280381, 28210.0, 28225.0, 28705.28236794097, 28736.0, 1081.853949716794, 1098.9285696429865, 1101.911847052234, 1118.0831717991168, 1126.1610100475198, 16807.495775126765, 17734.20196091153, 18301.54246143857, 18539.0, 18558.257669693063, 300929.0, 352782.0, 352932.0, 353919.0, 354421.0, 56265.43734562684, 63959.6802015987, 65063.67468162629, 70500.0, 70713.64643176751, 1539.4457995121747, 1546.8453154684441, 1561.4925149326514, 1563.7028964496938, 1567.6316065724545, 31739.365212696077, 32047.0, 33468.0, 33670.0, 33671.3265734679, 43834.0, 43883.78058109689, 44166.55833441753, 44178.337324940796, 44180.0, 351420.0, 353941.0, 354530.0, 354959.0, 355168.0, 36679.0, 36851.26297473982, 37151.442728358554, 37403.94278314719, 37466.0, 37655.62344376521, 43455.34816977811, 46523.302150468444, 47361.52638473571, 47844.28233576429, 37092.629073708915, 37386.6261337394, 37915.81042094772, 38810.0, 39461.0, 37911.43132852954, 37924.81037594794, 37996.81001594974, 39424.605753942094, 39542.802285988386, 40065.79967100263, 40293.39559906662, 40498.39252411157, 40602.1879562413, 40747.59252407438, 31331.27677977642, 33575.83212083924, 33592.0, 34167.145821354665, 34316.48525272173, 26312.736872631795, 26376.868115659297, 26404.339891502867, 26405.471890561697, 27250.182494525197], "value": 19675.480185537708, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [446.5712915601021, 447.4697483482074, 451.21939045451387, 461.36792594146016, 466.5754163711023, 19890.900545497272, 20881.582368352625, 21354.786452135475, 21481.355559333206, 21991.780082199173, 22071.77928220717, 22192.334229973087, 22214.444638884037, 22276.108955641794, 22823.42941426465, 4939.974610409733, 6798.830029249284, 6968.094147760784, 7025.086738723959, 7034.753783617574, 4137.089840235143, 4347.913041739163, 6745.3254674532645, 6877.89683154753, 7445.292697193785, 7838.159301942036, 7914.0, 7919.722809701661, 7919.8416031679335, 7944.443888927777, 7801.414893882953, 7869.685212591489, 7873.842523149534, 7879.645415956295, 7892.763217103496, 7429.591372474511, 7572.318491335751, 7633.6564854581675, 7642.235776422369, 7644.426667999922, 25342.619860702103, 25367.492650146894, 25532.0, 25560.221302340415, 25601.10396136145, 3027.7729170312314, 3083.645380781194, 3122.8282444465544, 3192.6807319267887, 3216.131644456007, 15741.212939352987, 15935.0, 16190.190490475547, 16253.91873040639, 16273.186340683036, 2137.316058861165, 2170.70695456113, 2181.476445653032, 2204.9448763780874, 2217.8336624753206, 117550.0, 117602.0, 117645.0, 120662.0, 121295.99999999911, 18618.81381186198, 18685.346012889484, 18933.76930499513, 18980.905095474434, 19160.80839191618, 32393.218372989242, 32433.675663243066, 32449.0, 32512.18719531983, 32595.83702081522, 10463.738406539898, 10490.216663167128, 10609.628662996758, 10645.73385665349, 10902.945485272523, 8817.338699597556, 8853.29173666105, 8920.553972301488, 9128.26973842091, 9131.634734610674, 9224.262059035262, 9638.90361096394, 9685.273604479551, 9685.951570242103, 9840.0, 2961.8370989595346, 3610.2418492116426, 3746.8576672917993, 3754.8685795997008, 4114.876553703393, 934.9252059835197, 953.0993211415284, 965.9372140810825, 974.3569244298728, 979.8579206015088, 19367.80632193688, 20751.273705420237, 20771.792282077287, 20995.265165719127, 21062.368128956157, 957.2103015012642, 968.5835090910836, 977.6578197630914, 980.1374790184734, 983.3165949664914, 10739.677809665722, 11546.59586914454, 11599.304041757521, 11687.415629218505, 11723.531058757724, 693186.0, 696781.0, 698125.0, 699290.0, 703479.0, 104668.0, 113625.43187284176, 115393.4230328843, 115531.42234288943, 116787.41606291915, 1193.2482536002437, 1202.3507306054632, 1233.9259644421363, 1235.234154823997, 1243.2913239453426, 17548.21033053541, 18009.63980720352, 18272.634547309244, 18334.449966501026, 18530.536736581693, 51204.74397627988, 51735.48264517307, 52022.69943251449, 52232.0, 52326.215106772666, 68834.96747548891, 69692.65153674199, 70156.64921675359, 70697.0, 71001.64499177677, 11224.382658953837, 11574.6527604172, 11603.36181510025, 11607.071434285068, 11733.765324693288, 7675.731349402968, 11024.228304018641, 11587.130965177477, 11979.580714674945, 12325.568605098779, 10767.97704218098, 11047.834282485608, 11156.0, 11211.103111750877, 11406.48670809799, 10610.89389106099, 10637.521311540844, 10744.086752626114, 10750.301230419998, 10821.404822734825, 11051.950064743836, 11173.622663058128, 11226.494807733836, 11425.542978281108, 11439.0, 11800.940995294968, 11940.0, 11952.0, 12282.570110046105, 12292.323922184009, 10733.838992415276, 10809.243352965532, 11052.115830733683, 11271.098312134845, 11383.43082845871], "value": 11312.616042502197, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1566.9686606267883, 1577.4715470317442, 1588.5234429671095, 1598.2248609424435, 1600.7118718630643, 11213.159013074022, 12017.699557511067, 12018.519259229643, 12036.458359373828, 12041.397930103492, 11175.720606984829, 11356.091512678986, 11431.599894003712, 11435.199536032482, 11642.476088576013, 2484.428581426273, 2550.591905295153, 2554.910578129766, 2555.2078855554837, 2557.1177943609423, 2418.407490164912, 2476.715177754554, 2477.355887469253, 2484.3043947694673, 2484.35406794233, 2442.5725498037773, 2458.2625212436287, 2465.0386349323776, 2467.2721547143547, 2468.5062987402594, 2360.811135109187, 2362.373970897722, 2388.235764555343, 2389.689340385756, 2390.940226494334, 2306.1351993002622, 2357.8821058946983, 2370.0401337458356, 2370.668106465096, 2378.036895057487, 11697.2981621103, 11821.408929553489, 11839.940800295943, 11840.763184736257, 11842.585509507126, 5970.194023806817, 6109.0, 6117.051856962178, 6119.0, 6123.601965872204, 3394.81555333998, 3469.2367679110557, 3475.7566970312087, 3508.245727168671, 3530.6822385985383, 1375.848656647768, 1380.3167432121063, 1397.0988712280523, 1440.819897512811, 1483.6661751106024, 16600.0, 16875.746863797052, 17524.211410486558, 17616.647667046716, 17688.557786055324, 4905.092557876733, 4922.483139270325, 4971.005798840247, 4984.90030199394, 5065.11360511909, 12994.740105197843, 13041.673958150932, 13046.0, 13046.673833154247, 13060.608181754562, 6027.126066720301, 6038.275406951194, 6041.154238406539, 6049.758009679652, 6051.606645568024, 5500.0, 5576.330840299109, 5610.831675049755, 5643.971780141155, 5654.491095801398, 4081.6530594899173, 4092.1201941582704, 4133.607307305801, 4150.667946564267, 4154.376843473443, 1040.1159014837328, 1042.968710938673, 1043.749500119981, 1056.5456853553046, 1058.6453538064834, 1034.4930983818026, 1055.6516349604613, 1060.506864308085, 1067.3489171605315, 1072.4316112460408, 6814.522983391115, 7074.257202993715, 7301.707931682779, 7580.1661817200065, 7735.729249476354, 1007.3603261928728, 1016.7254841192985, 1039.6517166749072, 1040.604570263295, 1050.8528805967171, 4664.696794708333, 4682.274247491644, 4695.718256904596, 4711.552402521755, 4734.076855013308, 14117.576472705836, 14646.121232725858, 14649.633759155893, 14660.56018319452, 14663.633409164857, 12987.155834870704, 14197.929010354883, 14366.712665746627, 14428.0, 14479.131252124906, 8580.399372043898, 8952.641894324284, 9125.133112354315, 10127.341722787995, 10505.527251273865, 6976.127984002, 7088.64556772149, 7104.822379440556, 7120.715171393086, 7223.927760722536, 12404.937975310426, 12454.501819927464, 12703.42834572428, 12887.420066097236, 12889.8066529004, 12589.24464532131, 12663.0, 12778.105532612999, 13003.08978371505, 13008.024398169986, 9959.601615935282, 10159.949200253952, 10168.644097456554, 10196.235282354002, 10323.587056517656, 11039.172062095215, 11046.558137674403, 11140.275882067965, 11143.554257829595, 11205.495752690986, 8943.463392196489, 9137.908620913706, 9170.587323570322, 9175.128362805523, 9325.487098209664, 8625.654973801229, 8703.521306328214, 8710.956445217733, 8838.823223535364, 9001.909980900107, 7854.41091918097, 7860.5676687782725, 7889.13219545838, 7935.1668074853615, 7955.602219889098, 5750.5496701980155, 5841.678707671119, 5925.822225333247, 5931.525477961839, 5957.463828255478, 5689.345725241485, 5745.339285982165, 5786.875077533805, 5790.94209057904, 5813.76744930198], "value": 5390.917960136668, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.1511531590871, 418.8910883170376, 429.2573847244269, 429.79155109771756, 432.43995546365494, 5205.531502164809, 5212.504812042859, 5218.5564227040695, 5224.2686023956585, 5262.4474430184755, 4928.383952005999, 5091.821786237482, 5140.383154021522, 5141.948580514194, 5151.665141765792, 4228.830846766125, 4309.612134907858, 4322.438083049199, 4340.7395556266565, 4391.451068616423, 4330.501992270898, 4350.521442641307, 4378.715383500063, 4380.189664912002, 4407.118576284756, 4392.934105988413, 4400.823967041314, 4421.734695918255, 4429.424174857264, 4431.778411079433, 4186.420610378113, 4328.4156638853665, 4329.480462344507, 4426.579474949875, 4430.401895744066, 4059.451973983504, 4075.1442197138635, 4095.365218391154, 4104.199681062194, 4127.28717582203, 4977.850664480035, 5040.16837221858, 5041.72270525121, 5045.924311135299, 5065.39215294167, 4891.804327826918, 5017.197248440232, 5024.899502009939, 5025.924611130836, 5039.798408063673, 5320.388155362144, 5328.20076988451, 5370.288004557673, 5405.216243644689, 5420.4850539198715, 4499.910001799978, 4506.1663592235545, 4529.207388706996, 4549.818007279705, 4561.452625684906, 5467.6719396836315, 5536.944630553683, 5573.916391254134, 5629.493345598875, 5721.6853073080965, 4571.582809329118, 4650.255959046536, 4666.300054991779, 4701.3653156824075, 4705.0, 4681.789319480631, 4721.409823772028, 4741.193997020515, 4757.690750101232, 4776.09254241693, 4761.738104404221, 4951.133551628451, 4971.477994810492, 4980.551750342486, 5002.699298182499, 5291.618771552817, 5323.574114070865, 5351.625386222927, 5361.571074314045, 5379.515843574019, 1607.3329568229053, 1617.8058632963885, 1618.8381161883954, 1635.0, 1642.6796774628833, 1209.1475509765594, 1272.5164437513686, 1284.3642397013539, 1286.3598911388056, 1302.101549930545, 5285.180796976475, 5290.814821481306, 5295.802242069575, 5298.523132918056, 5301.54936830366, 5418.45815418455, 5486.231927530149, 5493.285872836505, 5516.282883225155, 5526.557875370041, 5090.49095090488, 5201.6878987260125, 5233.685978841282, 5252.684838909678, 5264.6051546134195, 2860.7711383089304, 2879.5248783950833, 2884.4856450363727, 2886.870090845917, 2904.3755592547705, 5418.810341638024, 5696.829095127153, 5725.627834190765, 5750.453706897838, 5753.043965051903, 5344.9732751336, 5491.890162196733, 5543.334799824047, 5555.361133469622, 5555.833325000256, 5575.69333686643, 5586.51957231334, 5678.473079479592, 5706.828795136153, 5716.628419152742, 5469.343678758574, 5479.2602998594675, 5483.698396588226, 5487.451254874481, 5517.2275881377445, 5059.848204553869, 5201.401838788588, 5315.840524784263, 5336.332958380202, 5440.7551660174595, 5708.915306091829, 5730.341010783646, 5749.568782341257, 5754.856128596819, 5793.391693872083, 4377.409049778239, 4485.977570112129, 4521.909561808811, 4526.705764125321, 4530.433695788027, 5354.892902141857, 5488.7530061148145, 5556.499915007668, 5560.638558493685, 5560.805371811967, 5388.54197393226, 5423.538999184956, 5431.782728690808, 5432.0, 5485.17722341636, 5182.792688292426, 5190.636655434083, 5287.550558202596, 5363.950217585698, 5381.865453363697, 5276.39321478035, 5285.445028271976, 5374.543163830962, 5416.729163541886, 5435.211894275229, 5302.8333766571295, 5323.414424413234, 5421.241026256248, 5460.645058071213, 5472.562195024469, 5054.974725126351, 5202.375714914235, 5322.627416080837, 5323.600729945347, 5342.439043900335], "value": 4347.470849199865, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.7558667846271, 734.7905846833653, 899.7075950316149, 902.3142411767058, 928.7585227840759, 15106.320215590298, 16529.0, 17243.741343879836, 17754.201060952255, 17956.191971361288, 16323.755143672854, 16489.67020659586, 16627.916860415713, 16636.25136868841, 16980.830191698078, 888.7467071884498, 906.7325139083953, 908.0692290402325, 910.1535571918114, 910.4309806371018, 878.3017501086651, 901.6303315640589, 909.9863502047475, 910.8679241509977, 911.0570559470949, 955.0926619711302, 957.9281553883486, 958.018031517693, 958.2046901072093, 958.6357184269967, 945.0832692288469, 947.228009172529, 947.6398968392001, 947.8862536495631, 948.0424770981358, 697.5326531224092, 698.5040621158984, 699.2413231643673, 699.3356311504041, 699.8355386484172, 15061.17163556004, 15403.152826594533, 15569.610759730984, 16043.278052487665, 16195.838041619669, 14568.635784105376, 14910.17994010329, 14943.925280373529, 15323.923380383027, 15722.05667659944, 12826.871731282661, 12925.0, 12961.675958101123, 13257.668558286023, 13292.468301268034, 3926.2540117377607, 3942.250972315251, 3944.684425245973, 4004.0390306326562, 4054.614811592894, 70089.29910700879, 70347.64826175837, 92039.0, 94718.0, 97694.51152744191, 12403.503859845505, 12632.305223212628, 12634.115611907262, 12665.746685066248, 12855.678608034686, 22609.53038052521, 22814.65778013331, 22970.08119675228, 22996.540069198858, 23135.843207839876, 8631.093735157843, 8648.26489748366, 8677.305815534743, 8868.467891926504, 8892.033140858603, 4902.460729319772, 5004.449510553836, 5098.260752190911, 5259.395169555473, 5305.65513241638, 3659.2864391443945, 3760.360738674432, 3762.398016317376, 3766.4915236443276, 3768.3782175940664, 619.9225096862892, 626.8683576448997, 628.5097623853402, 638.2468686949352, 642.5309524047472, 737.4100719424439, 832.8875601793801, 837.6398148795954, 854.6666799947901, 871.7471933139445, 10501.579936802442, 10788.514516846604, 10928.508217130247, 10998.835017474745, 12286.262824230575, 681.4990981628499, 682.8292926768308, 682.8873235916018, 730.4266151071383, 896.2097588390045, 4889.193283108319, 5095.745212739348, 5101.668391554537, 5126.820561280412, 5135.948640513622, 63489.0, 72758.63620681969, 79893.0, 83557.0, 85632.0, 71391.6430417855, 72589.63705181546, 75281.0, 75899.62050189824, 77115.61442192865, 65688.34311656823, 65906.67046664737, 66009.66995164994, 68410.9738353925, 68583.0, 9903.504824758877, 10051.899481005097, 10120.94939525327, 10160.577519147177, 10252.333598316085, 46244.30633540567, 46383.0, 46444.0624437832, 47041.764791175825, 47226.76386618045, 52971.205431917784, 53074.0, 54203.72898135484, 54885.1767223484, 56234.71882640561, 13193.340332983504, 13224.47102115943, 13271.66820829487, 13478.595642130751, 13691.452341906212, 14065.859341406864, 14355.85644143587, 14754.852451475348, 14849.628759281104, 15301.540953771404, 13268.93365533166, 14022.78965815534, 14451.27743612794, 14636.560903172922, 14915.254237287874, 13380.130291531019, 13879.028468007142, 13979.510717124851, 14218.431262749787, 14763.188024658746, 13371.197728136343, 13834.308284585932, 14058.0, 14639.560813175622, 14640.04839685417, 11152.832707509231, 11272.718182045515, 11543.19197656156, 11803.645890623295, 11925.940370298093, 11597.942010289895, 11686.415679215836, 11692.532298707956, 11830.408479575815, 11927.105467090176], "value": 7740.25450359465, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1454.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 111.0, 113.0, 112.0, 113.0, 112.0, 112.0, 112.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 116.0, 116.0, 165.0, 117.0, 122.0, 116.0, 116.0, 137.0, 116.0], "value": 126.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 161.0, 162.0, 161.0, 161.0, 161.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 114.0, 76.0, 75.0, 75.0, 76.0, 92.0, 75.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 99.0, 82.0, 82.0, 82.0, 92.0, 81.0, 81.0, 98.0], "value": 85.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 55.0, 54.0, 54.0, 55.0, 54.0, 55.0, 54.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 54.0, 52.0, 52.0, 52.0, 53.0, 53.0, 53.0, 53.0], "value": 52.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 75.0, 80.0, 75.0, 74.0, 74.0, 74.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 130.0, 123.0, 122.0, 119.0, 121.0, 117.0, 129.0, 169.0, 118.0], "value": 127.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 162.0, 160.0, 169.0, 165.0, 165.0, 167.0, 164.0, 165.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 60.0, 60.0, 62.0, 59.0, 64.0, 59.0, 60.0, 59.0, 59.0], "value": 60.5, "unit": "score"}]}]} 09:26:31 INFO - Return code: 0 09:26:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:26:31 ERROR - # TBPL SUCCESS # 09:26:31 INFO - Running post-action listener: _resource_record_post_action 09:26:31 INFO - [mozharness: 2017-03-15 16:26:31.811505Z] Finished run-tests step (success) 09:26:31 INFO - Running post-run listener: _resource_record_post_run 09:26:31 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 274432; Write bytes: 380268544; Read time: 144; Write time: 237604 09:26:31 INFO - TinderboxPrint: CPU usage
13.1% 09:26:31 INFO - TinderboxPrint: I/O read bytes / time
274,432 / 144 09:26:31 INFO - TinderboxPrint: I/O write bytes / time
380,268,544 / 237,604 09:26:31 INFO - TinderboxPrint: CPU idle
8,270.8 (86.9%) 09:26:31 INFO - TinderboxPrint: CPU user
1,204.2 (12.6%) 09:26:31 INFO - TinderboxPrint: Swap in / out
0 / 0 09:26:31 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 110247936; Read time: 44; Write time: 98548 09:26:31 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 270336; Write bytes: 254820352; Read time: 100; Write time: 130236 09:26:32 INFO - Running post-run listener: _upload_blobber_files 09:26:32 INFO - Blob upload gear active. 09:26:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:26:32 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 09:26:32 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:26:32 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:26:32 INFO - (blobuploader) - INFO - Open directory for files ... 09:26:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:26:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:26:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:33 INFO - (blobuploader) - INFO - Done attempting. 09:26:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:26:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:26:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:34 INFO - (blobuploader) - INFO - Done attempting. 09:26:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:26:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:26:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:37 INFO - (blobuploader) - INFO - Done attempting. 09:26:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:26:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:26:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:38 INFO - (blobuploader) - INFO - Done attempting. 09:26:38 INFO - (blobuploader) - INFO - Iteration through files over. 09:26:38 INFO - Return code: 0 09:26:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:26:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:26:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17c421831ab77aa937e804519ee97fbf3c61acb2eb5d11560b6425ad08501cc1aa5a871766fcca8c1af8a97510b48166724b265a0eb67441abce564e94412e3d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/29fcd0a3c77ea042a0842e60b59034855faf6381550bc47e670007520d33548f96a24a803350063f128db3e754cfbc3a88479777b3db9a639b1e4fdca2a0d8b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04481fc25a5776462c099c41591f76b5545f110c02f886da3b788fed8bf755c2b148c725b25a1acf74fbb2ec9d3e6d119d0cf6b747f0744dd77df51ea9471ba1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c0c2772510055c0ac9ca2fe26098bcff0bb21370003bbc58ab2ce206124b30f840bd65afdda5354994db810044e90ee240619a108f321dfddd4b9581dbd792cc"} 09:26:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:26:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:26:38 INFO - Contents: 09:26:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17c421831ab77aa937e804519ee97fbf3c61acb2eb5d11560b6425ad08501cc1aa5a871766fcca8c1af8a97510b48166724b265a0eb67441abce564e94412e3d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/29fcd0a3c77ea042a0842e60b59034855faf6381550bc47e670007520d33548f96a24a803350063f128db3e754cfbc3a88479777b3db9a639b1e4fdca2a0d8b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04481fc25a5776462c099c41591f76b5545f110c02f886da3b788fed8bf755c2b148c725b25a1acf74fbb2ec9d3e6d119d0cf6b747f0744dd77df51ea9471ba1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c0c2772510055c0ac9ca2fe26098bcff0bb21370003bbc58ab2ce206124b30f840bd65afdda5354994db810044e90ee240619a108f321dfddd4b9581dbd792cc"} 09:26:38 INFO - Running post-run listener: copy_logs_to_upload_dir 09:26:38 INFO - Copying logs to upload dir... 09:26:38 INFO - mkdir: /builds/slave/test/build/upload/logs 09:26:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.172884 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-03-15 09:26:38.306651) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 09:26:38.310449) ========= 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=51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17c421831ab77aa937e804519ee97fbf3c61acb2eb5d11560b6425ad08501cc1aa5a871766fcca8c1af8a97510b48166724b265a0eb67441abce564e94412e3d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/29fcd0a3c77ea042a0842e60b59034855faf6381550bc47e670007520d33548f96a24a803350063f128db3e754cfbc3a88479777b3db9a639b1e4fdca2a0d8b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04481fc25a5776462c099c41591f76b5545f110c02f886da3b788fed8bf755c2b148c725b25a1acf74fbb2ec9d3e6d119d0cf6b747f0744dd77df51ea9471ba1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c0c2772510055c0ac9ca2fe26098bcff0bb21370003bbc58ab2ce206124b30f840bd65afdda5354994db810044e90ee240619a108f321dfddd4b9581dbd792cc"} build_url:https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/CaUtDTpISgyYcsahb3IoPg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17c421831ab77aa937e804519ee97fbf3c61acb2eb5d11560b6425ad08501cc1aa5a871766fcca8c1af8a97510b48166724b265a0eb67441abce564e94412e3d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/29fcd0a3c77ea042a0842e60b59034855faf6381550bc47e670007520d33548f96a24a803350063f128db3e754cfbc3a88479777b3db9a639b1e4fdca2a0d8b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04481fc25a5776462c099c41591f76b5545f110c02f886da3b788fed8bf755c2b148c725b25a1acf74fbb2ec9d3e6d119d0cf6b747f0744dd77df51ea9471ba1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c0c2772510055c0ac9ca2fe26098bcff0bb21370003bbc58ab2ce206124b30f840bd65afdda5354994db810044e90ee240619a108f321dfddd4b9581dbd792cc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 09:26:38.337423) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 09:26:38.337956) ========= 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=51fc86400edbde9650d2781a000001d0-1489593945.619046-1454820679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 09:26:38.420139) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 09:26:38.420460) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 09:26:38.420767) ========= ========= Total master_lag: 0.16 =========