builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1481389564.0 results: success (0) revision: c51e7406d7b2e2246a1ece0d8989282ca752039f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-10 09:06:04.003860) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-10 09:06:04.004265) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-10 09:06:04.004527) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-10 09:06:04.038128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 09:06:04.038395) ========= 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=4300f881736b422476174874000001bc-1481375912.477573-410408989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-10 09:06:04-- 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% 25.8M=0s 2016-12-10 09:06:04 (25.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.091510 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 09:06:04.144738) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 09:06:04.145041) ========= 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=4300f881736b422476174874000001bc-1481375912.477573-410408989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021949 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 09:06:04.199402) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-10 09:06:04.200069) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c51e7406d7b2e2246a1ece0d8989282ca752039f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev c51e7406d7b2e2246a1ece0d8989282ca752039f --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=4300f881736b422476174874000001bc-1481375912.477573-410408989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-10 09:06:04,723 truncating revision to first 12 chars 2016-12-10 09:06:04,723 Setting DEBUG logging. 2016-12-10 09:06:04,723 attempt 1/10 2016-12-10 09:06:04,723 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c51e7406d7b2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-10 09:06:05,631 unpacking tar archive at: mozilla-central-c51e7406d7b2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.245106 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-10 09:06:05.460011) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-10 09:06:05.460384) ========= script_repo_revision: c51e7406d7b2e2246a1ece0d8989282ca752039f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-10 09:06:05.460778) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-10 09:06:05.461057) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-10 09:06:05.471545) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-12-10 09:06:05.471866) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=4300f881736b422476174874000001bc-1481375912.477573-410408989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:06:06 INFO - MultiFileLogger online at 20161210 09:06:06 in /builds/slave/test 09:06:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:06:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:06:06 INFO - {'append_to_log': False, 09:06:06 INFO - 'base_work_dir': '/builds/slave/test', 09:06:06 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:06:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:06:06 INFO - 'branch': 'Firefox-Non-PGO', 09:06:06 INFO - 'buildbot_json_path': 'buildprops.json', 09:06:06 INFO - 'config_files': ('talos/linux_config.py',), 09:06:06 INFO - 'default_actions': ('clobber', 09:06:06 INFO - 'read-buildbot-config', 09:06:06 INFO - 'download-and-extract', 09:06:06 INFO - 'populate-webroot', 09:06:06 INFO - 'create-virtualenv', 09:06:06 INFO - 'install', 09:06:06 INFO - 'run-tests'), 09:06:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:06:06 INFO - 'download_minidump_stackwalk': True, 09:06:06 INFO - 'download_symbols': 'ondemand', 09:06:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:06:06 INFO - 'tooltool.py': '/tools/tooltool.py', 09:06:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:06:06 INFO - '/tools/misc-python/virtualenv.py')}, 09:06:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:06:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:06:06 INFO - 'installer_path': 'installer.exe', 09:06:06 INFO - 'log_level': 'info', 09:06:06 INFO - 'log_name': 'talos', 09:06:06 INFO - 'log_to_console': True, 09:06:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:06:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:06:06 INFO - 'opt_config_files': (), 09:06:06 INFO - 'pip_index': False, 09:06:06 INFO - 'sps_profile': False, 09:06:06 INFO - 'sps_profile_interval': 0, 09:06:06 INFO - 'suite': 'dromaeojs', 09:06:06 INFO - 'system_bits': '32', 09:06:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:06:06 INFO - 'title': 'talos-linux64-ix-045', 09:06:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:06:06 INFO - 'use_talos_json': True, 09:06:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:06:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:06:06 INFO - 'work_dir': 'build'} 09:06:06 INFO - [mozharness: 2016-12-10 17:06:06.093742Z] Running clobber step. 09:06:06 INFO - Running pre-action listener: _resource_record_pre_action 09:06:06 INFO - Running main action method: clobber 09:06:06 INFO - rmtree: /builds/slave/test/build 09:06:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:06:06 INFO - Running post-action listener: _resource_record_post_action 09:06:06 INFO - [mozharness: 2016-12-10 17:06:06.554482Z] Finished clobber step (success) 09:06:06 INFO - [mozharness: 2016-12-10 17:06:06.554582Z] Running read-buildbot-config step. 09:06:06 INFO - Running pre-action listener: _resource_record_pre_action 09:06:06 INFO - Running main action method: read_buildbot_config 09:06:06 INFO - Using buildbot properties: 09:06:06 INFO - { 09:06:06 INFO - "project": "", 09:06:06 INFO - "product": "firefox", 09:06:06 INFO - "who": "philringnalda@gmail.com", 09:06:06 INFO - "installer_path": "public/build/target.tar.bz2", 09:06:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:06:06 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:06:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 09:06:06 INFO - "stage_platform": "linux64", 09:06:06 INFO - "basedir": "/builds/slave/test", 09:06:06 INFO - "buildnumber": 864, 09:06:06 INFO - "platform": "ubuntu64_hw", 09:06:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:06:06 INFO - "slavebuilddir": "test", 09:06:06 INFO - "taskId": "C96EY7c4RzG8lTxZisUp8w", 09:06:06 INFO - "branch": "mozilla-central", 09:06:06 INFO - "script_repo_revision": "production", 09:06:06 INFO - "revision": "c51e7406d7b2e2246a1ece0d8989282ca752039f", 09:06:06 INFO - "slavename": "talos-linux64-ix-045", 09:06:06 INFO - "repo_path": "mozilla-central" 09:06:06 INFO - } 09:06:06 INFO - Finding installer, test and symbols from parent task. 09:06:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C96EY7c4RzG8lTxZisUp8w'}, attempt #1 09:06:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C96EY7c4RzG8lTxZisUp8w'}, attempt #1 09:06:07 INFO - Task dependencies: JJuFAjinQx6isgb8jsmonQ 09:06:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ'}, attempt #1 09:06:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/target.tar.bz2 09:06:07 INFO - Set test_url: https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/test_packages.json 09:06:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/target.crashreporter-symbols.zip 09:06:07 INFO - Running post-action listener: _resource_record_post_action 09:06:07 INFO - [mozharness: 2016-12-10 17:06:07.952795Z] Finished read-buildbot-config step (success) 09:06:07 INFO - [mozharness: 2016-12-10 17:06:07.953008Z] Running download-and-extract step. 09:06:07 INFO - Running pre-action listener: _resource_record_pre_action 09:06:07 INFO - Running main action method: download_and_extract 09:06:07 INFO - mkdir: /builds/slave/test/build/tests 09:06:07 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:07 INFO - trying https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/target.test_packages.json 09:06:07 INFO - Downloading https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:06:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:06:08 INFO - Downloaded 896 bytes. 09:06:08 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:06:08 INFO - Using the following test package requirements: 09:06:08 INFO - {u'common': [u'target.common.tests.zip'], 09:06:08 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:06:08 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:06:08 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:06:08 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:06:08 INFO - u'mozbase': [u'target.common.tests.zip'], 09:06:08 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:06:08 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:06:08 INFO - u'web-platform': [u'target.common.tests.zip', 09:06:08 INFO - u'target.web-platform.tests.zip'], 09:06:08 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:06:08 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:06:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/target.common.tests.zip 09:06:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:06:08 INFO - Fetch https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/target.common.tests.zip into memory 09:06:10 INFO - Expected file size: 20223471 09:06:10 INFO - Obtained file size: 20223471 09:06:14 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:06:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/target.common.tests.zip 09:06:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:06:14 INFO - Fetch https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/target.common.tests.zip into memory 09:06:14 INFO - Expected file size: 20223471 09:06:14 INFO - Obtained file size: 20223471 09:06:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/target.talos.tests.zip 09:06:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:06:19 INFO - Fetch https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/target.talos.tests.zip into memory 09:06:21 INFO - Expected file size: 14409734 09:06:21 INFO - Obtained file size: 14409734 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 - trying https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/target.tar.bz2 09:06:21 INFO - Downloading https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:06:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:06:23 INFO - Downloaded 55636452 bytes. 09:06:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/target.tar.bz2 09:06:23 INFO - mkdir: /builds/slave/test/properties 09:06:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:06:23 INFO - Writing to file /builds/slave/test/properties/build_url 09:06:23 INFO - Contents: 09:06:23 INFO - build_url:https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/target.tar.bz2 09:06:23 INFO - Running post-action listener: _resource_record_post_action 09:06:23 INFO - Running post-action listener: set_extra_try_arguments 09:06:23 INFO - [mozharness: 2016-12-10 17:06:23.497164Z] Finished download-and-extract step (success) 09:06:23 INFO - [mozharness: 2016-12-10 17:06:23.497260Z] Running populate-webroot step. 09:06:23 INFO - Running pre-action listener: _resource_record_pre_action 09:06:23 INFO - Running main action method: populate_webroot 09:06:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:06:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:06:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:06:23 INFO - '--tppagecycles', 09:06:23 INFO - '7'], 09:06:23 INFO - 'tests': ['tsvgm']}}, 09:06:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:06:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:06:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:06:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:06:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:06:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:06:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:06:23 INFO - 'talos_options': ['--disable-e10s'], 09:06:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:06:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:06:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:06:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:06:23 INFO - 'talos_options': ['--disable-e10s'], 09:06:23 INFO - 'tests': ['damp', 'tps']}, 09:06:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:06:23 INFO - 'tests': ['damp', 'tps']}, 09:06:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:06:23 INFO - 'tests': ['dromaeo_dom']}, 09:06:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:06:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:06:23 INFO - 'tests': ['basic_compositor_video']}, 09:06:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:06:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:06:23 INFO - 'tests': ['a11yr', 09:06:23 INFO - 'ts_paint', 09:06:23 INFO - 'tpaint', 09:06:23 INFO - 'sessionrestore', 09:06:23 INFO - 'sessionrestore_no_auto_restore', 09:06:23 INFO - 'tabpaint']}, 09:06:23 INFO - 'other-e10s': {'tests': ['a11yr', 09:06:23 INFO - 'ts_paint', 09:06:23 INFO - 'tpaint', 09:06:23 INFO - 'sessionrestore', 09:06:23 INFO - 'sessionrestore_no_auto_restore', 09:06:23 INFO - 'tabpaint']}, 09:06:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:06:23 INFO - 'ts_paint', 09:06:23 INFO - 'tpaint', 09:06:23 INFO - 'sessionrestore', 09:06:23 INFO - 'sessionrestore_no_auto_restore', 09:06:23 INFO - 'tabpaint']}, 09:06:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:06:23 INFO - 'ts_paint', 09:06:23 INFO - 'tpaint', 09:06:23 INFO - 'sessionrestore', 09:06:23 INFO - 'sessionrestore_no_auto_restore', 09:06:23 INFO - 'tabpaint']}, 09:06:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:06:23 INFO - 'tests': ['a11yr', 09:06:23 INFO - 'ts_paint', 09:06:23 INFO - 'tpaint', 09:06:23 INFO - 'sessionrestore', 09:06:23 INFO - 'sessionrestore_no_auto_restore', 09:06:23 INFO - 'tabpaint']}, 09:06:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:06:23 INFO - 'tests': ['a11yr', 09:06:23 INFO - 'ts_paint', 09:06:23 INFO - 'tpaint', 09:06:23 INFO - 'sessionrestore', 09:06:23 INFO - 'sessionrestore_no_auto_restore', 09:06:23 INFO - 'tabpaint']}, 09:06:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:06:23 INFO - 'tests': ['tsvgx', 09:06:23 INFO - 'tsvgr_opacity', 09:06:23 INFO - 'tart', 09:06:23 INFO - 'tscrollx', 09:06:23 INFO - 'cart', 09:06:23 INFO - 'tsvg_static']}, 09:06:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:06:23 INFO - 'tsvgr_opacity', 09:06:23 INFO - 'tart', 09:06:23 INFO - 'tscrollx', 09:06:23 INFO - 'cart', 09:06:23 INFO - 'tsvg_static']}, 09:06:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:06:23 INFO - 'talos_options': ['--disable-e10s'], 09:06:23 INFO - 'tests': ['tp5o']}, 09:06:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:06:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:06:23 INFO - 'talos_options': ['--disable-e10s', 09:06:23 INFO - '--xperf_path', 09:06:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:06:23 INFO - 'tests': ['tp5n']}, 09:06:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:06:23 INFO - 'talos_options': ['--xperf_path', 09:06:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:06:23 INFO - 'tests': ['tp5n']}}, 09:06:23 INFO - 'talos.zip': {'path': '', 09:06:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:06:23 INFO - Running post-action listener: _resource_record_post_action 09:06:23 INFO - [mozharness: 2016-12-10 17:06:23.510324Z] Finished populate-webroot step (success) 09:06:23 INFO - [mozharness: 2016-12-10 17:06:23.510416Z] Running create-virtualenv step. 09:06:23 INFO - Running pre-action listener: _resource_record_pre_action 09:06:23 INFO - Running main action method: create_virtualenv 09:06:23 INFO - Creating virtualenv /builds/slave/test/build/venv 09:06:23 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:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:06:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:06:23 INFO - Using real prefix '/usr' 09:06:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:06:24 INFO - Installing distribute.............................................................................................................................................................................................done. 09:06:26 INFO - Installing pip.................done. 09:06:26 INFO - Return code: 0 09:06:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:06:26 INFO - Reading from file tmpfile_stdout 09:06:26 INFO - Output received: 09:06:26 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:26 INFO - Installing pip>=1.5 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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f07faca0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2455a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2683f20>, '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 0x25f0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f0f90>, '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': '4300f881736b422476174874000001bc-1481375912.477573-410408989', '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', 'pip>=1.5'] 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 pip>=1.5 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': '4300f881736b422476174874000001bc-1481375912.477573-410408989', 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): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:06:26 INFO - Cleaning up... 09:06:26 INFO - Return code: 0 09:06:26 INFO - Installing psutil>=3.1.1 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', '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 0x7f07faca0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2455a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2683f20>, '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 0x25f0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f0f90>, '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': '4300f881736b422476174874000001bc-1481375912.477573-410408989', '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', 'psutil>=3.1.1'] 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 psutil>=3.1.1 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': '4300f881736b422476174874000001bc-1481375912.477573-410408989', 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 - Downloading/unpacking psutil>=3.1.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:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:06:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:06:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:06:28 INFO - Installing collected packages: psutil 09:06:28 INFO - Running setup.py install for psutil 09:06:28 INFO - building 'psutil._psutil_linux' extension 09:06:28 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:29 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:29 INFO - building 'psutil._psutil_posix' extension 09:06:29 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:29 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:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:06:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:06:29 INFO - Successfully installed psutil 09:06:29 INFO - Cleaning up... 09:06:29 INFO - Return code: 0 09:06:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:06:29 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:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:29 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:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:29 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 0x7f07faca0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2455a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2683f20>, '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 0x25f0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f0f90>, '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': '4300f881736b422476174874000001bc-1481375912.477573-410408989', '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:29 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:29 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:29 INFO - Using env: {'DISPLAY': ':0', 09:06:29 INFO - 'HOME': '/home/cltbld', 09:06:29 INFO - 'LANG': 'en_US.UTF-8', 09:06:29 INFO - 'LANGUAGE': 'en_US:en', 09:06:29 INFO - 'LOGNAME': 'cltbld', 09:06:29 INFO - 'MAIL': '/var/mail/cltbld', 09:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:29 INFO - 'MOZ_NO_REMOTE': '1', 09:06:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:29 INFO - 'NO_EM_RESTART': '1', 09:06:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:29 INFO - 'PWD': '/builds/slave/test', 09:06:29 INFO - 'SHELL': '/bin/bash', 09:06:29 INFO - 'SHLVL': '1', 09:06:29 INFO - 'TERM': 'linux', 09:06:29 INFO - 'TMOUT': '86400', 09:06:29 INFO - 'USER': 'cltbld', 09:06:29 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481375912.477573-410408989', 09:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:29 INFO - '_': '/tools/buildbot/bin/python'} 09:06:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 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:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:06:31 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:31 INFO - Installing collected packages: mozsystemmonitor 09:06:31 INFO - Running setup.py install for mozsystemmonitor 09:06:31 INFO - Successfully installed mozsystemmonitor 09:06:31 INFO - Cleaning up... 09:06:31 INFO - Return code: 0 09:06:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:06:31 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:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:31 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:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:31 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 0x7f07faca0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2455a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2683f20>, '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 0x25f0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f0f90>, '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': '4300f881736b422476174874000001bc-1481375912.477573-410408989', '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:31 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:31 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:31 INFO - Using env: {'DISPLAY': ':0', 09:06:31 INFO - 'HOME': '/home/cltbld', 09:06:31 INFO - 'LANG': 'en_US.UTF-8', 09:06:31 INFO - 'LANGUAGE': 'en_US:en', 09:06:31 INFO - 'LOGNAME': 'cltbld', 09:06:31 INFO - 'MAIL': '/var/mail/cltbld', 09:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:31 INFO - 'MOZ_NO_REMOTE': '1', 09:06:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:31 INFO - 'NO_EM_RESTART': '1', 09:06:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:31 INFO - 'PWD': '/builds/slave/test', 09:06:31 INFO - 'SHELL': '/bin/bash', 09:06:31 INFO - 'SHLVL': '1', 09:06:31 INFO - 'TERM': 'linux', 09:06:31 INFO - 'TMOUT': '86400', 09:06:31 INFO - 'USER': 'cltbld', 09:06:31 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481375912.477573-410408989', 09:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:31 INFO - '_': '/tools/buildbot/bin/python'} 09:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:31 INFO - Downloading/unpacking jsonschema==2.5.1 09:06:31 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:31 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:31 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:31 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:31 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:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:06:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:06:33 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:33 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:33 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:33 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:33 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:33 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:34 INFO - Downloading functools32-3.2.3-2.tar.gz 09:06:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:06:34 INFO - warning: no files found matching '*.txt' 09:06:34 INFO - no previously-included directories found matching 'build' 09:06:34 INFO - no previously-included directories found matching 'dist' 09:06:34 INFO - no previously-included directories found matching '.git*' 09:06:34 INFO - Installing collected packages: jsonschema, functools32 09:06:34 INFO - Running setup.py install for functools32 09:06:34 INFO - warning: no files found matching '*.txt' 09:06:34 INFO - no previously-included directories found matching 'build' 09:06:34 INFO - no previously-included directories found matching 'dist' 09:06:34 INFO - no previously-included directories found matching '.git*' 09:06:34 INFO - Successfully installed jsonschema functools32 09:06:34 INFO - Cleaning up... 09:06:34 INFO - Return code: 0 09:06:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:06:34 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:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:34 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:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7f07faca0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2455a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2683f20>, '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 0x25f0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f0f90>, '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': '4300f881736b422476174874000001bc-1481375912.477573-410408989', '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:34 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:34 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:34 INFO - Using env: {'DISPLAY': ':0', 09:06:34 INFO - 'HOME': '/home/cltbld', 09:06:34 INFO - 'LANG': 'en_US.UTF-8', 09:06:34 INFO - 'LANGUAGE': 'en_US:en', 09:06:34 INFO - 'LOGNAME': 'cltbld', 09:06:34 INFO - 'MAIL': '/var/mail/cltbld', 09:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:34 INFO - 'MOZ_NO_REMOTE': '1', 09:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:34 INFO - 'NO_EM_RESTART': '1', 09:06:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:34 INFO - 'PWD': '/builds/slave/test', 09:06:34 INFO - 'SHELL': '/bin/bash', 09:06:34 INFO - 'SHLVL': '1', 09:06:34 INFO - 'TERM': 'linux', 09:06:34 INFO - 'TMOUT': '86400', 09:06:34 INFO - 'USER': 'cltbld', 09:06:34 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481375912.477573-410408989', 09:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:34 INFO - '_': '/tools/buildbot/bin/python'} 09:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:06:34 INFO - Cleaning up... 09:06:34 INFO - Return code: 0 09:06:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:06:34 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:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:34 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:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7f07faca0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2455a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2683f20>, '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 0x25f0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f0f90>, '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': '4300f881736b422476174874000001bc-1481375912.477573-410408989', '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:34 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:34 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:34 INFO - Using env: {'DISPLAY': ':0', 09:06:34 INFO - 'HOME': '/home/cltbld', 09:06:34 INFO - 'LANG': 'en_US.UTF-8', 09:06:34 INFO - 'LANGUAGE': 'en_US:en', 09:06:34 INFO - 'LOGNAME': 'cltbld', 09:06:34 INFO - 'MAIL': '/var/mail/cltbld', 09:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:34 INFO - 'MOZ_NO_REMOTE': '1', 09:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:34 INFO - 'NO_EM_RESTART': '1', 09:06:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:34 INFO - 'PWD': '/builds/slave/test', 09:06:34 INFO - 'SHELL': '/bin/bash', 09:06:34 INFO - 'SHLVL': '1', 09:06:34 INFO - 'TERM': 'linux', 09:06:34 INFO - 'TMOUT': '86400', 09:06:34 INFO - 'USER': 'cltbld', 09:06:34 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481375912.477573-410408989', 09:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:34 INFO - '_': '/tools/buildbot/bin/python'} 09:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:34 INFO - Downloading/unpacking blobuploader==1.2.4 09:06:34 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:34 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:34 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:34 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:34 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:34 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:36 INFO - Downloading blobuploader-1.2.4.tar.gz 09:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:06:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:06:36 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:36 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:36 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:36 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:36 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:36 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 - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:06:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:06:37 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:37 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 - 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:37 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:37 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:37 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 docopt-0.6.1.tar.gz 09:06:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:06:37 INFO - Installing collected packages: blobuploader, requests, docopt 09:06:37 INFO - Running setup.py install for blobuploader 09:06:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:06:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:06:37 INFO - Running setup.py install for requests 09:06:38 INFO - Running setup.py install for docopt 09:06:38 INFO - Successfully installed blobuploader requests docopt 09:06:38 INFO - Cleaning up... 09:06:38 INFO - Return code: 0 09:06:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:38 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:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:38 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:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:38 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', '--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 0x7f07faca0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2455a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2683f20>, '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 0x25f0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f0f90>, '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': '4300f881736b422476174874000001bc-1481375912.477573-410408989', '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', '--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:38 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: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': '4300f881736b422476174874000001bc-1481375912.477573-410408989', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:06:38 INFO - Running setup.py (path:/tmp/pip-jJVjlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:06:38 INFO - Running setup.py (path:/tmp/pip-V1FfhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:06:38 INFO - Running setup.py (path:/tmp/pip-L4posQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:06:38 INFO - Running setup.py (path:/tmp/pip-OmbI0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:06:38 INFO - Running setup.py (path:/tmp/pip-6HS3Y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:06:38 INFO - Running setup.py (path:/tmp/pip-RKZEZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:06:38 INFO - Running setup.py (path:/tmp/pip-SQPzON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:06:39 INFO - Running setup.py (path:/tmp/pip-Tc9RxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:06:39 INFO - Running setup.py (path:/tmp/pip-CZG96y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:06:39 INFO - Running setup.py (path:/tmp/pip-OmPKXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:06:39 INFO - Running setup.py (path:/tmp/pip-hykRGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:06:39 INFO - Running setup.py (path:/tmp/pip-VeV8vY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:06:39 INFO - Running setup.py (path:/tmp/pip-lnihPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:06:39 INFO - Running setup.py (path:/tmp/pip-lip5I4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:39 INFO - Running setup.py (path:/tmp/pip-WtAvqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:06:39 INFO - Running setup.py (path:/tmp/pip-YuHRwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:06:39 INFO - Running setup.py (path:/tmp/pip-wrYuMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:06:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:06:39 INFO - Running setup.py install for manifestparser 09:06:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:06:39 INFO - Running setup.py install for mozcrash 09:06:39 INFO - Running setup.py install for mozdebug 09:06:40 INFO - Running setup.py install for mozdevice 09:06:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:06:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:06:40 INFO - Running setup.py install for mozfile 09:06:40 INFO - Running setup.py install for mozhttpd 09:06:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:06:40 INFO - Running setup.py install for mozinfo 09:06:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:06:40 INFO - Running setup.py install for mozInstall 09:06:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:06:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:06:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:06:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:06:40 INFO - Running setup.py install for mozleak 09:06:40 INFO - Running setup.py install for mozlog 09:06:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:06:40 INFO - Running setup.py install for moznetwork 09:06:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:06:40 INFO - Running setup.py install for mozprocess 09:06:40 INFO - Running setup.py install for mozprofile 09:06:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:06:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:06:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:06:41 INFO - Running setup.py install for mozrunner 09:06:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:06:41 INFO - Running setup.py install for mozscreenshot 09:06:41 INFO - Running setup.py install for moztest 09:06:41 INFO - Running setup.py install for mozversion 09:06:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:06:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:06:41 INFO - Cleaning up... 09:06:41 INFO - Return code: 0 09:06:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:41 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:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:41 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:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:41 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 0x7f07faca0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2455a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2683f20>, '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 0x25f0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f0f90>, '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': '4300f881736b422476174874000001bc-1481375912.477573-410408989', '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:41 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:41 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:41 INFO - Using env: {'DISPLAY': ':0', 09:06:41 INFO - 'HOME': '/home/cltbld', 09:06:41 INFO - 'LANG': 'en_US.UTF-8', 09:06:41 INFO - 'LANGUAGE': 'en_US:en', 09:06:41 INFO - 'LOGNAME': 'cltbld', 09:06:41 INFO - 'MAIL': '/var/mail/cltbld', 09:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:41 INFO - 'MOZ_NO_REMOTE': '1', 09:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:41 INFO - 'NO_EM_RESTART': '1', 09:06:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:41 INFO - 'PWD': '/builds/slave/test', 09:06:41 INFO - 'SHELL': '/bin/bash', 09:06:41 INFO - 'SHLVL': '1', 09:06:41 INFO - 'TERM': 'linux', 09:06:41 INFO - 'TMOUT': '86400', 09:06:41 INFO - 'USER': 'cltbld', 09:06:41 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481375912.477573-410408989', 09:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:41 INFO - '_': '/tools/buildbot/bin/python'} 09:06:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:06:41 INFO - Running setup.py (path:/tmp/pip-39pO4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:06:41 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:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:06:41 INFO - Running setup.py (path:/tmp/pip-wgobst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:06:41 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:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:06:41 INFO - Running setup.py (path:/tmp/pip-RvIaTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:06:41 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:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:06:42 INFO - Running setup.py (path:/tmp/pip-xIUyWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:06:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:06:42 INFO - Running setup.py (path:/tmp/pip-EQhcmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:06:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:06:42 INFO - Running setup.py (path:/tmp/pip-ZBHrik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:06:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:06:42 INFO - Running setup.py (path:/tmp/pip-1f4oli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:06:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:06:42 INFO - Running setup.py (path:/tmp/pip-Dz01Nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:06:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:06:42 INFO - Running setup.py (path:/tmp/pip-nVOtJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:06:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:06:42 INFO - Running setup.py (path:/tmp/pip-7dak3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:06:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:06:42 INFO - Running setup.py (path:/tmp/pip-W11LJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:06:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:06:42 INFO - Running setup.py (path:/tmp/pip-TISocw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:06:42 INFO - Running setup.py (path:/tmp/pip-KCqPnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:06:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:06:42 INFO - Running setup.py (path:/tmp/pip-yh_uya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:06:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:42 INFO - Running setup.py (path:/tmp/pip-bYM3CM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:06:42 INFO - Running setup.py (path:/tmp/pip-YpL7vQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:06:42 INFO - Running setup.py (path:/tmp/pip-Git5Ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:06:43 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:43 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:43 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:43 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:43 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:43 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:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:06:43 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:43 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:43 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:43 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:43 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:43 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:44 INFO - Downloading blessings-1.6.tar.gz 09:06:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:06:45 INFO - Installing collected packages: blessings 09:06:45 INFO - Running setup.py install for blessings 09:06:45 INFO - Successfully installed blessings 09:06:45 INFO - Cleaning up... 09:06:45 INFO - Return code: 0 09:06:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:06:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:06:45 INFO - Reading from file tmpfile_stdout 09:06:45 INFO - Current package versions: 09:06:45 INFO - argparse == 1.2.1 09:06:45 INFO - blessings == 1.6 09:06:45 INFO - blobuploader == 1.2.4 09:06:45 INFO - docopt == 0.6.1 09:06:45 INFO - functools32 == 3.2.3-2 09:06:45 INFO - jsonschema == 2.5.1 09:06:45 INFO - manifestparser == 1.1 09:06:45 INFO - mozInstall == 1.12 09:06:45 INFO - mozcrash == 1.0 09:06:45 INFO - mozdebug == 0.1 09:06:45 INFO - mozdevice == 0.49 09:06:45 INFO - mozfile == 1.2 09:06:45 INFO - mozhttpd == 0.7 09:06:45 INFO - mozinfo == 0.9 09:06:45 INFO - mozleak == 0.1 09:06:45 INFO - mozlog == 3.4 09:06:45 INFO - moznetwork == 0.27 09:06:45 INFO - mozprocess == 0.23 09:06:45 INFO - mozprofile == 0.28 09:06:45 INFO - mozrunner == 6.13 09:06:45 INFO - mozscreenshot == 0.1 09:06:45 INFO - mozsystemmonitor == 0.3 09:06:45 INFO - moztest == 0.7 09:06:45 INFO - mozversion == 1.4 09:06:45 INFO - psutil == 3.1.1 09:06:45 INFO - requests == 1.2.3 09:06:45 INFO - wsgiref == 0.1.2 09:06:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:45 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:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:45 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:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:45 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 0x7f07faca0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2455a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2683f20>, '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 0x25f0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f0f90>, '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': '4300f881736b422476174874000001bc-1481375912.477573-410408989', '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:45 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:45 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:45 INFO - Using env: {'DISPLAY': ':0', 09:06:45 INFO - 'HOME': '/home/cltbld', 09:06:45 INFO - 'LANG': 'en_US.UTF-8', 09:06:45 INFO - 'LANGUAGE': 'en_US:en', 09:06:45 INFO - 'LOGNAME': 'cltbld', 09:06:45 INFO - 'MAIL': '/var/mail/cltbld', 09:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:45 INFO - 'MOZ_NO_REMOTE': '1', 09:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:45 INFO - 'NO_EM_RESTART': '1', 09:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:45 INFO - 'PWD': '/builds/slave/test', 09:06:45 INFO - 'SHELL': '/bin/bash', 09:06:45 INFO - 'SHLVL': '1', 09:06:45 INFO - 'TERM': 'linux', 09:06:45 INFO - 'TMOUT': '86400', 09:06:45 INFO - 'USER': 'cltbld', 09:06:45 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481375912.477573-410408989', 09:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:45 INFO - '_': '/tools/buildbot/bin/python'} 09:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:45 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:45 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:45 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:45 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:45 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:45 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:45 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:45 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:45 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:45 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:45 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:45 INFO - Cleaning up... 09:06:45 INFO - Return code: 0 09:06:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:06:45 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:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:45 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:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:45 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 0x7f07faca0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2455a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2683f20>, '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 0x25f0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f0f90>, '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': '4300f881736b422476174874000001bc-1481375912.477573-410408989', '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:45 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:45 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:45 INFO - Using env: {'DISPLAY': ':0', 09:06:45 INFO - 'HOME': '/home/cltbld', 09:06:45 INFO - 'LANG': 'en_US.UTF-8', 09:06:45 INFO - 'LANGUAGE': 'en_US:en', 09:06:45 INFO - 'LOGNAME': 'cltbld', 09:06:45 INFO - 'MAIL': '/var/mail/cltbld', 09:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:45 INFO - 'MOZ_NO_REMOTE': '1', 09:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:45 INFO - 'NO_EM_RESTART': '1', 09:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:45 INFO - 'PWD': '/builds/slave/test', 09:06:45 INFO - 'SHELL': '/bin/bash', 09:06:45 INFO - 'SHLVL': '1', 09:06:45 INFO - 'TERM': 'linux', 09:06:45 INFO - 'TMOUT': '86400', 09:06:45 INFO - 'USER': 'cltbld', 09:06:45 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481375912.477573-410408989', 09:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:45 INFO - '_': '/tools/buildbot/bin/python'} 09:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:06:45 INFO - Cleaning up... 09:06:45 INFO - Return code: 0 09:06:45 INFO - Running post-action listener: _resource_record_post_action 09:06:45 INFO - Running post-action listener: _start_resource_monitoring 09:06:45 INFO - Starting resource monitoring. 09:06:45 INFO - [mozharness: 2016-12-10 17:06:45.959738Z] Finished create-virtualenv step (success) 09:06:45 INFO - [mozharness: 2016-12-10 17:06:45.960193Z] Running install step. 09:06:45 INFO - Running pre-action listener: _resource_record_pre_action 09:06:45 INFO - Running main action method: install 09:06:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:06:46 INFO - Reading from file tmpfile_stdout 09:06:46 INFO - Detecting whether we're running mozinstall >=1.0... 09:06:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:06:46 INFO - Reading from file tmpfile_stdout 09:06:46 INFO - Output received: 09:06:46 INFO - Usage: mozinstall [options] installer 09:06:46 INFO - Options: 09:06:46 INFO - -h, --help show this help message and exit 09:06:46 INFO - -d DEST, --destination=DEST 09:06:46 INFO - Directory to install application into. [default: 09:06:46 INFO - "/builds/slave/test"] 09:06:46 INFO - --app=APP Application being installed. [default: firefox] 09:06:46 INFO - mkdir: /builds/slave/test/build/application 09:06:46 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:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:07:02 INFO - Reading from file tmpfile_stdout 09:07:02 INFO - Output received: 09:07:02 INFO - /builds/slave/test/build/application/firefox/firefox 09:07:02 INFO - Running post-action listener: _resource_record_post_action 09:07:02 INFO - [mozharness: 2016-12-10 17:07:02.305194Z] Finished install step (success) 09:07:02 INFO - [mozharness: 2016-12-10 17:07:02.305462Z] Running run-tests step. 09:07:02 INFO - Running pre-action listener: _resource_record_pre_action 09:07:02 INFO - Running main action method: run_tests 09:07:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:07:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:07:02 INFO - Python 2.7.3 09:07:02 INFO - Return code: 0 09:07:02 INFO - grabbing minidump binary from tooltool 09:07:02 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:07:02 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 0x2683f20>, '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 0x25f0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f0f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:07:02 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:07:02 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:07:02 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:07:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:07:02 INFO - Return code: 0 09:07:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:07:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:07:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:07:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:07:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:07:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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:07:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-045 --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:07:02 INFO - Using env: {'DISPLAY': ':0', 09:07:02 INFO - 'HOME': '/home/cltbld', 09:07:02 INFO - 'LANG': 'en_US.UTF-8', 09:07:02 INFO - 'LANGUAGE': 'en_US:en', 09:07:02 INFO - 'LOGNAME': 'cltbld', 09:07:02 INFO - 'MAIL': '/var/mail/cltbld', 09:07:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:07:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:02 INFO - 'MOZ_NO_REMOTE': '1', 09:07:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:02 INFO - 'NO_EM_RESTART': '1', 09:07:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:02 INFO - 'PWD': '/builds/slave/test', 09:07:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:07:02 INFO - 'SHELL': '/bin/bash', 09:07:02 INFO - 'SHLVL': '1', 09:07:02 INFO - 'TERM': 'linux', 09:07:02 INFO - 'TMOUT': '86400', 09:07:02 INFO - 'USER': 'cltbld', 09:07:02 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481375912.477573-410408989', 09:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:02 INFO - '_': '/tools/buildbot/bin/python'} 09:07:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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:07:02 INFO - mozversion application_buildid: 20161210162808 09:07:02 INFO - mozversion application_changeset: c51e7406d7b2e2246a1ece0d8989282ca752039f 09:07:02 INFO - mozversion application_display_name: Nightly 09:07:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:07:02 INFO - mozversion application_name: Firefox 09:07:02 INFO - mozversion application_remotingname: firefox 09:07:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:07:02 INFO - mozversion application_vendor: Mozilla 09:07:02 INFO - mozversion application_version: 53.0a1 09:07:02 INFO - mozversion platform_buildid: 20161210162808 09:07:02 INFO - mozversion platform_changeset: c51e7406d7b2e2246a1ece0d8989282ca752039f 09:07:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:07:02 INFO - mozversion platform_version: 53.0a1 09:07:02 INFO - using testdate: 1481389622 09:07:02 INFO - actual date: 1481389622 09:07:02 INFO - starting webserver on 'localhost:57308' 09:07:02 INFO - SUITE-START | Running 2 tests 09:07:02 INFO - TEST-START | dromaeo_css 09:07:02 INFO - operating with platform_type : linux_ 09:07:02 INFO - Initialising browser for dromaeo_css test... 09:07:02 INFO - TEST-INFO | started process 6893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUL3_GB/profile http://localhost:57308/getInfo.html) 09:07:07 INFO - PROCESS | 6893 | __metrics Screen width/height:1600/1200 09:07:07 INFO - PROCESS | 6893 | colorDepth:24 09:07:07 INFO - PROCESS | 6893 | Browser inner width/height: 1024/697 09:07:07 INFO - PROCESS | 6893 | __metrics 09:07:07 INFO - PROCESS | 6893 | 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:07 INFO - PROCESS | 6893 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:07:08 INFO - PROCESS | 6893 | console.error: PushService: 09:07:08 INFO - PROCESS | 6893 | stateChangeProcessEnqueue: Error transitioning state 09:07:08 INFO - PROCESS | 6893 | UnknownError 09:07:08 INFO - TEST-INFO | 6893: exit 0 09:07:08 INFO - Browser initialized. 09:07:08 INFO - Running cycle 1/1 for dromaeo_css test... 09:07:08 INFO - TEST-INFO | started process 6978 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUL3_GB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:21 INFO - PROCESS | 6978 | RSS: Main: 173658112 09:07:21 INFO - PROCESS | 6978 | 09:08:12 INFO - PROCESS | 6978 | 1481389692033 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:10:29 INFO - PROCESS | 6978 | Cycle 1(1): loaded http://localhost:57308/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57308/tests/dromaeo/cssquery-ext.html) 09:10:31 INFO - PROCESS | 6978 | RSS: Main: 289370112 09:10:31 INFO - PROCESS | 6978 | 09:13:33 INFO - PROCESS | 6978 | Cycle 1(1): loaded http://localhost:57308/tests/dromaeo/cssquery-ext.html (next: http://localhost:57308/tests/dromaeo/cssquery-jquery.html) 09:13:34 INFO - PROCESS | 6978 | RSS: Main: 291164160 09:13:34 INFO - PROCESS | 6978 | 09:16:36 INFO - PROCESS | 6978 | Cycle 1(1): loaded http://localhost:57308/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57308/tests/dromaeo/cssquery-mootools.html) 09:16:37 INFO - PROCESS | 6978 | RSS: Main: 248676352 09:16:37 INFO - PROCESS | 6978 | 09:19:39 INFO - PROCESS | 6978 | Cycle 1(1): loaded http://localhost:57308/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57308/tests/dromaeo/cssquery-prototype.html) 09:19:40 INFO - PROCESS | 6978 | RSS: Main: 226902016 09:19:40 INFO - PROCESS | 6978 | 09:22:43 INFO - PROCESS | 6978 | Cycle 1(1): loaded http://localhost:57308/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57308/tests/dromaeo/cssquery-yui.html) 09:22:44 INFO - PROCESS | 6978 | RSS: Main: 222867456 09:22:44 INFO - PROCESS | 6978 | 09:25:47 INFO - PROCESS | 6978 | Cycle 1(1): loaded http://localhost:57308/tests/dromaeo/cssquery-yui.html (next: http://localhost:57308/tests/dromaeo/cssquery-dojo.html) 09:25:47 INFO - PROCESS | 6978 | RSS: Main: 314089472 09:25:47 INFO - PROCESS | 6978 | 09:25:47 INFO - PROCESS | 6978 | __start_tp_report 09:25:47 INFO - PROCESS | 6978 | _x_x_mozilla_page_load 09:25:47 INFO - PROCESS | 6978 | _x_x_mozilla_page_load_details 09:25:47 INFO - PROCESS | 6978 | |i|pagename|runs| 09:25:47 INFO - PROCESS | 6978 | |0;dojo.html;2593.7406259374065;2643.6695413073367;2661.1617340537737;2672.973270267297;2683.5303821831176;4677.06458708258;4748.620110391169;4772.141014617372;4875.171220892448;4900.803967841287;4759.000609871922;4787.44944331402;4797.6401769867225;4847.951520484794;4886.438059623153;4377.037051848588;4412.514623391425;4414.779261036935;4421.977890110545;4497.640188784906;4408.691391602589;4495.415595972535;4505.752183629899;4544.068465964469;4544.681872268926;4476;4514;4521.457425108975;4539.160255352754;4561.247394179956;4326.9567304326865;4348.1086377292895;4363.127374525107;4412.426384569985;4417.249067658506;4376.190404775127;4388.210122178007;4418.845340413102;4432.312991486325;4478.149151661174;4822.7829747661435;4839.153148199051;4839.37088178538;4840.5159484051665;4849.466558678542;5015.523525265094;5174.249733788617;5193.246979187997;5194.584433245369;5245.86885327866;5034.270030845543;5102.132637451605;5120.743962801882;5120.84637460873;5162.070827251093;4775.42694876617;4779.856604301807;4780.95219047812;4786.018866132435;4793.400824896888;5202.401723801736;5266.605004624592;5267.078261304257;5268.420473747885;5274.024305503494;5014.348134742533;5034.018366418513;5050.671706339076;5052.974735126374;5073.061483625541;5175.637705360588;5192.532672059533;5197.376314842243;5201.401838788588;5206.947930520646;5156.278121063054;5159.58723302135;5161.922571161435;5162.483751624807;5164.948350516522;5067.41724701664;5070;5085.847424577269;5141.665791723526;5142.434332223453;4458.799354029076;4460.553944605514;4464.843730469483;4501.842435514741;4509.571590698878;3800.5819359870393;3812.3709587917683;3837.002379381381;3875.476810630585;3879.2047630235734;4381.18947994622;4392.626626736763;4393.0774537347515;4396.538363471789;4397.2085024695225;5115.028144652504;5126.384833819965;5137.357830271216;5146.716930568855;5153.768080436389;4392.582704643054;4402;4403.713758605744;4405.118976204772;4408.184485870124;4423.535528769497;4551.362809206714;4656.627469802408;4664.137134630037;4692.601128904013;4853.587445067209;4854.5873600744335;4882.2432522959;4883.609311255091;4906.8773280668265;5235.895282094413;5242.47575242488;5242.5281724644965;5244.396894357198;5292.735363231746;4678.087772884391;4719.669623126486;4846.612271018381;4850.320955066223;4852.708837469763;4973.850784476472;5049.747512624281;5088.847334579968;5089.160288552347;5091.287219789307;5207.843764687065;5220.686758794484;5225.451327610546;5226.45122262157;5229.372475302988;4938.950610493849;4953.578945789648;4956.8760780980765;4960.751962401938;5006.3992320921725;4972.825951091694;5016.824411145738;5024.547790698854;5031.52200540948;5079.517445842639;4768.189407800752;4831.347768051268;4834.444038935568;4891;4938.48145944685;5103.362079740033;5111.258867464123;5148.073346797612;5156.329677141947;5156.329677141947;4984.601231901367;4987.027529631687;4988.401391833003;4990.4011518618;5035.899282014412 09:25:47 INFO - PROCESS | 6978 | |1;ext.html;515.3892637224889;536.6538582614214;546.5272539253544;546.8496163555022;549.793827314757;27806.443871122567;37057.25885482292;38197.618023819756;38367.04082397941;42265;38921.80539097307;39395.40906886392;39396.80301598488;39465;39466.408003879966;7388.9261107388775;7560.206178351276;7564;7564.130125035636;7568.205338439468;7444;7650.234976502333;9390.62437502499;9602.135807777298;9632.133108020276;9952.054554817318;10015.69952901414;10028.197744180485;10033.498325083752;10035.94982025089;9750.171235444961;9831.8525222121;9857.507124643811;9858.16205622523;9860.802783944317;9782.951085244527;9852.901470985342;9859.802803943881;9862.950685246527;9866.556004979793;36065.45901811475;36349.818250908844;36383.636163638286;36422;36448.271034579426;2883.812552184101;2945.3225758075764;3009.337945651975;3079.6612372638992;3340.0146956647845;25540.74459255421;25841;26417.207483775517;27700.30749231265;28110.156695299174;3444.3111377724304;3470.288590838872;3528.7177025838128;3533.805640689761;3561.661642143992;243685;244288;245218;246163;246595.76702116555;44948.3257751134;45349.546504535196;45388;45434.772826136315;45483.77258113688;48425.5157448421;48622;48679.756601216766;48714.512854871;48727.756361217966;11470.942645286721;11856.644300670994;11865.169438139248;11872.168948173545;11883.524659013716;9049.909500905038;9265.583048762823;9774.266929980138;9851.901480985242;9859.457729824928;14560.781588276184;14810.519527910932;15145.394184232508;15540.922295388677;15669.764953525706;5996.430339117776;6000.189974353494;6143.447089761943;6209.9379006210265;6211.223597050369;745.3440971944653;851.8296340731879;933.3513208320288;935.9470595579972;982.4337654314792;25749.485010300064;27096.458070838868;27153.86423067872;27724.722752772213;27776.30559235995;933.4399360383716;937.803061357109;972.4311277902507;976.4922240434934;1031.5409642709074;13729.794053089212;14602.488912887999;14634.414623414945;14786.186759728103;14792.704145917021;372963;622176;640418;642932;643490;42416.57583424188;42531.7873410631;42885.785571071945;42949.78525107355;43151.784241078596;1139.2310190621297;1142.2118738070872;1167.8073117935614;1172.9472173752201;1177.4230626992883;24997.625035624846;25483;25837.612435813855;25964;26264;36263.637363626025;36968;36984.815075924445;36994.44508332431;37009.44485832768;332693;335073;335290;335828;336820;20468.590628187652;20875.164993400092;22614.773852261926;22614.886925565268;23051.308460746204;33953.15117121993;33989.49015764815;34108.65891341154;34426.31147377088;34877.65122348744;28798.280042999093;29092.56361154542;29313.120606381843;29626.703732963255;30215.697843022168;26565.33586660349;26802.463950720485;27203.319917002234;28078.01726939629;28091.43817123687;29425;29755.553666694585;29782.70217297799;29866.850665746533;39425;32485.675143248263;33732.32535349328;36153.27693446169;36796.81601591975;36912.81543592265;28024;28967.710322897343;29201.41597168087;29482.410351793274;29933.102006939826 09:25:47 INFO - PROCESS | 6978 | |2;jquery.html;350.1124649014745;367.66358781714735;372.9533808273966;373.3652790256564;394.2410859096239;12278.693032674188;12352.073594480416;13265.535706250283;16131.516054518353;16783.580410489714;16156.75764863525;16842.747358789627;16928.915355423236;17042.74435883463;17054.488365349058;4658.60401865841;5021.046001259749;5037.042961837239;5060.240963855433;5060.316857224265;3628.6915612172997;4951.777170027357;5048.368953880765;5052.6210534209895;5054.570361519275;3667.7982710950887;3787.715921305913;3793.753406028613;5790.652560846342;5879.412058794108;5898.852528686795;5911.674857882815;5912;5915.467607915287;5922.437368450033;4490.146872094324;4743.146233677937;4776.09254241693;4832.444268909086;4832.5409086137115;11805.114616403804;11947.701307467296;12424.75150496985;18976.335828245945;19466;1698.9745153822703;1856.4894653970266;2018.3743039657752;2321.988390058039;2376.417777644471;8472.27985621223;8511.787205319855;8616;8881.555922203865;8890.288776897833;1636.4681478519528;1674.6315810521667;1677.6309211973346;1692.0270844264596;1744.7819022622173;64071.35928640701;64611;64698.676506617165;66055;67094;9723.562439690231;9732.854007189897;10116.949415252877;10157.85106616951;10256.743581410525;13672;13672.863271367358;13676.316184190751;13680.521181758591;13696.383662735201;6780.796576102724;6842.315768423118;7034.366906978396;7111.324424179695;7144.749933752294;6520.510961677798;6566.9343306566325;6737.966310168418;6748.460123190133;6757.662116894136;4185.707000509996;4241.579071011184;4257.042165512797;4331.740095594275;4396.120775844844;1745.598512342143;1802.4953013156075;1804.9819501805077;1839.1080326041858;1852.6294741051843;793.0879488588055;815.3192084609418;816.8366326734676;887.5562218890555;908.0329449136648;15185.468508602145;15403.46087886941;15960.441384551485;16533.421330253623;17079;774.8256642255448;780.3718007004416;819.5205804604374;828.4656396624264;834.983300334002;9190.862137067948;9206.171444569887;9284.48935308551;9415.858762118574;9645.662401815904;347735;354500;359467.4053259486;359700;361014;69875.3012469879;70816.64591677008;70820.2917970824;71384.28615713776;73506;892.9374943753875;894.0478390513952;901.977450563728;912.4844462878452;913.1005959130251;14491.565253042425;14499;14743.705125897637;14974.850251497346;15317.846821531642;33356.833215833765;34339;34372;34492.82753586216;35609.46585801267;41777;46996;48400.51599484101;48743.75628121837;48917.510824891295;6976;7252;7330.5968171751065;7429.962850185714;7548.886766698394;10390.688279351632;10841.349519028883;10860.945695271474;11000.394978276272;11348.54605815758;9509.429434233969;9539.666111686058;9693.224542036762;9757.756056098655;10005.899941000496;9755.170810481188;9771.110978306522;10020.599176033169;10044.49777511107;10348.016938390841;9771.951140244253;9879.30844840883;10117.29178957466;10192.519853299229;10321.277510574188;7137.500374973702;7287.9635601823775;7327.74352897646;7351.70593176267;7411.740589079356;9369.531523423666;9381.577828997575;9445.622175113192;9538.95230523843;10157.847632285373 09:25:47 INFO - PROCESS | 6978 | |3;mootools.html;1253.0101220036172;1337.0974592150296;1359.6125104345263;1453.9491117810878;1693.5681401242673;6499.935000649992;7250.564966102038;7463.290987356199;7495.812604684872;7738.110117336508;7533.096028476577;7616.2764537369;7616.581088040156;7620.88568671469;7621.8475630487355;1869.728889311049;1937.6221636780833;2164.7943445372666;2207.128184367174;2208.149862303009;2152.2359562355373;2216.6674998750236;2218.5784700906856;2219.9778002220014;2223.8888055597154;2152.87082775034;2164.0261882153013;2178.041661668861;2178.673199020144;2186.5408264264443;2143.9249626263086;2169.1323470611724;2169.143188440557;2171.706819579352;2171.945701357479;2103.852730308879;2121.1091341636547;2124.691919671639;2125.3942626351572;2125.5005073807642;7417.888731668975;7560.130584982742;7571.318581327707;7589.165191828894;7599.734009309703;4335.3063509838275;4470.396496472967;4470.932936005963;4476.239039363316;4484.1928452878465;2763.737444942727;2915.3731947631363;2979.4041191761735;2987.4025194961096;2996.0412667946266;901.1034021148934;913.4108500017452;942.6559305853314;944.3436811416069;983.822911875862;10223.182145428347;10273.845892311696;10292.588296468133;10295.3822770634;10296.27926045177;3978.0651546886456;4176.853810116631;4227.302495088337;4281.636060934856;4285.228658841438;8700.651973920973;8729.694460693845;8729.825403491895;8730;8736.8689469658;4591.242444996605;4607.14767767964;4612;4655.02244528646;4662.603678687349;3659.908502287411;3740.139767853409;4174.833006679699;4236.724612900151;4242.087951090531;3524.788512689247;3552.769070010441;3648.2338708870902;3653.12325041988;3668.614795446493;1149.8275258711094;1174.3775798826637;1174.5536696055444;1203.3622180244483;1219.530480764912;845.2308399356679;866.7659731872485;872.3936863879669;873.0745409865563;880.0759202836996;5150.227465880148;5311.442298558673;5317.946820531745;5320.654157479751;5483.616146869681;397.3999261115736;401.5783427401217;410.86852207293975;416.8578096016892;417.607448997947;3573.8749143780365;3637.636236376341;3657.9451308230396;3675.6875665568728;3696.094456858087;8815.911840881508;9028.413153145024;9156.633734650673;9160.267178625827;9186.311026673025;9075.591598378089;9131.26949844011;9171.862422063674;9183.908160918305;9187.724368268962;7069.71721131149;7161.283871612901;7172.246914073947;7174.354308112295;7178.641067946582;5094.15946368845;5113.51421614946;5125.589952803842;5235.65968212065;5444.891102178013;8394.034686010942;8408.915910841059;8413.579321034047;8428.578571071545;8499.91500085016;8029.879551806845;8185.140560241089;8262.215089566482;8482.151784821468;8575.271101956403;6495.188101487314;6607.07500949877;6609.4712423007;6665.733370665119;6685.565438246498;7104.680289386886;7221.169565500035;7222.783316500513;7224.277572242734;7224.566526008456;6435.388638079375;6568.7372505101175;6591.439727623206;6621.635810030494;6730.226024007106;6418.935810641834;6461.547691661539;6471.06169605414;6535.248446428722;6539.4768418525455;5946.554008449297;6140.631562106288;6201.162843016135;6285.497160227263;6294.748210071546;4472.79872405736;4492.955070449254;4547.067851090585;4609.308603709336;4638.884027899329;4369.060651959844;4398.186335527937;4456.2647163219;4503.301988191835;4649.558291962394 09:25:47 INFO - PROCESS | 6978 | |4;prototype.html;339.2807248632897;344.5004743122472;346.61701790524484;347.42848015015284;350.253959067187;4515.7516336601475;4674.532546745324;4692.5072867348945;4742.549457801503;4751.9524804751945;4560.527367159414;4665.09030739006;4677.415323084614;4689.6482763792765;4692.41344831896;3741.4948981887437;3742.0644838790304;3748.9812550937345;3763.5295588051495;3774.226283611853;3580.4629305604108;3695.778253304797;3742.8315725792404;3758.7932663703486;3758.962410375889;3694.4827724118645;3782.81085945703;3790.241951609675;3797.8480860765535;3800.258949504848;3790.2419516096893;3799.7910114943666;3799.810009499514;3802.752821066622;3807.6382743639447;3418.5555877735737;3427.2631384252254;3430.8456119474686;3435.639257877912;3438.2951494943477;4495.685302028859;4613.76931153441;4623.144718227105;4645.931435769792;4679.8534359081905;4312.482502099737;4318.503372112216;4329.328954012101;4333.761643109628;4349.391085248068;4912.606991440676;4919.655624106314;4924;4930.580900623451;4936.259561065833;3524.718022558189;3650.8682308484454;3690.0959264979983;3704.7777133371815;3714.387126124186;5138.614603904722;5144.176931690949;5154.587632989352;5159.845204643867;5166.664166829144;3779.6976241900584;3783.754055986352;3783.97557306845;3787.791671458096;3800.4869342638945;3814.2180852925085;3833.1758671885677;3844.3464611016193;3850.845966161322;3852.152526444234;4159.625633692982;4285.271503844354;4287.249731297011;4298.484181898192;4312.439382880269;4949.232868905254;4966.180580204225;4967.180415231519;4978.5768209701855;4980.850574482772;1226.141700809437;1263.389178797041;1293.8964882809353;1300.4993077665167;1302.2837439408477;893.6648756716231;926.6293482607011;927.3369540778376;929.819129705284;933.3466573398513;4157.7089603727445;4167.812448439767;4170.812313445902;4173.874783756492;4180.561041090703;4861.642103579761;4925.20759015556;4949.529794669501;4963.57809586182;4975.4527002029745;4020.4119372847563;4118.238125946709;4159.646430053479;4180.742399104511;4242.830286788494;2582.4705935283223;2594.9351266218496;2631.2633661783516;2649.1919964410654;2657.8272412293527;4532.841350552715;4551.38556294896;4555;4589.541045895384;4596.977015114903;4806.7836947336755;4854.80580776765;4907.9263811042865;4952.90094198114;4980.825671101494;4456.77716114193;4511.62395469385;4515.209838278354;4517.977410112929;4560.794764235618;4836.564709176191;4845.836999120256;4852.344933434082;4856.1016212000895;4862.781174847211;4764.523547645208;4784.641151913551;4806.8077276909935;5020.548150666457;5084.3898732152375;4768.61851051922;4769.87740455494;4776.325257855612;4790.976045119752;4804.95195048059;3521.683048525645;3524.5946716127974;3530.3821831179953;3541.2563361694333;3544.0608238816217;4937.7531123444405;5104.417630534546;5111.042288979684;5136.30659860929;5150.665206761549;4996;5008.749562521933;5008.974955125347;5009.772605711624;5022.744313921519;4962.751862406937;4978.153713868579;4986.451490335988;4998.2502624606595;5008.924866127084;4750.239961606127;4868.634852386014;4887.193613053806;4892.706437613754;4919.278252611557;5005.299258103795;5007.924881126859;5014.598832093351;5017.799288028438;5038.951434382146;4865.9026819464125;4892.2661600760175;4892.559669629751;4905.558499735041;4913.729744863924 09:25:47 INFO - PROCESS | 6978 | |5;yui.html;588.6203398807771;597.527095709077;622.8349487385841;700.1283402164305;702.5573888450278;11663.183577149592;14975.251237438126;15668.216589170524;15672;15709.450169244064;15103;15269.541913742578;15298.770518442205;15306.69386612267;15315.617109572266;620.7113692133157;753.9547627142362;778.6651739751904;779.40765018586;780.9062912450514;629.9905501417483;755.8639444899916;775.414562005685;785.8546168958733;787.6455594982252;818.1899919080098;822.1778221778221;824.5794644731201;824.8061705499233;825.5830805443243;653.7287025884252;816.5590581086207;817.5666896544841;818.3003531980161;818.8607936650753;490.55359622743487;578.4967078641608;596.9343372229051;599.0235915457775;601.3715667127818;13693.657658558615;13704.588862334047;13750.587482375544;13754.449822007107;13761.449542018307;11605.709857253552;11719.882801171965;11948.28310301376;12138.211016283913;12431.440585173688;10769.515371808287;10829.620963266327;11020.393878336688;11092.55629774816;11593.884061159364;3656.8902932912056;3678.2275722098393;3728.3475391806323;3736.23407201523;3752.5365107608054;52937.47062529364;62197.37802621961;63001.68499157475;63081;66373;9646.324757267064;9984.450855202887;10219.489025548693;10292.330998485075;10377.273590848568;18604.16281267346;18606.627867442574;18613.7207941881;18620.44138675842;18627.441176764718;6776.966115169491;6855.177378714487;6880.552764070319;7111.146662400545;7128.679209435588;3566.1619519412916;3645;3646.890593282206;3650.762700424517;3767.6232376762655;2971.4799910015663;3047.8628461719277;3056.388722255513;3058.525928481089;3296.6868147525947;534.6845361236889;535.3388565122071;542.4683809866353;552.0614954577154;559.0970582509218;549.2886711708347;551.685678578368;590.3771521045338;615;630.3507387390995;7397.81505462357;7940.642671079815;8344.207300306462;8418.831623367498;8604.924384451944;469.7956388970809;563.9520640745583;576.3631187537794;593.3769541980903;602.5240060352272;3850.383938569815;3987.102901847119;4023.2154729827403;4043.534993475729;4094.467719196485;63242.991915767925;66258;68270.31729682739;70309.64845175741;70774.64612676903;58915.41084589185;59257.70371148203;59905.733002885834;60304.09543856846;63147.36852631507;53624;54725;55057.1741423879;55592;55742;7604.42966777505;8089.959550202211;8139.14538973423;8146.959265203873;8319.209675080858;38065.42901856419;38439.807800960814;38814.22371552497;39494.60505394909;39522.40716389199;50233.497665022885;52279.477205227464;52325;52752.47247527629;53326;9387.81224375495;9460.574274157541;9495.620175192915;9553.713388598353;9902.059304366074;10340.27618066728;10613.310134841211;10622.628208012682;10836.295640783324;10940.124790016938;9967.252456065678;10091.142252908585;10121.291509594257;10162.644307449204;10658.89341106579;10759.784804304027;10989.890101098887;11007;11470.483828227916;11787.882121178678;11348.375839328915;11423.828642570203;11680.591179308683;11809.881901180877;12197;9020.90979090227;9187.540622968958;9316.813663726824;9624.711258662252;9813.411195328303;9531.142197202285;9698.46658433793;9941.701748947544;10171.64399246023;10245.897541024495 09:25:47 INFO - PROCESS | 6978 | __end_tp_report 09:25:47 INFO - PROCESS | 6978 | __start_cc_report 09:25:47 INFO - PROCESS | 6978 | _x_x_mozilla_cycle_collect,1149 09:25:47 INFO - PROCESS | 6978 | __end_cc_report 09:25:47 INFO - PROCESS | 6978 | __startTimestamp1481390747659__endTimestamp 09:25:47 INFO - PROCESS | 6978 | 09:25:47 INFO - PROCESS | 6978 | ------- Summary: start ------- 09:25:47 INFO - PROCESS | 6978 | Number of tests: 6 09:25:47 INFO - PROCESS | 6978 | 09:25:47 INFO - PROCESS | 6978 | [#0] dojo.html Cycles:165 Average:4762.79 Median:4875.17 stddev:503.74 (10.3%) stddev-sans-first:475.68 09:25:47 INFO - PROCESS | 6978 | Values: 2593.7 2643.7 2661.2 2673.0 2683.5 4677.1 4748.6 4772.1 4875.2 4900.8 4759.0 4787.4 4797.6 4848.0 4886.4 4377.0 4412.5 4414.8 4422.0 4497.6 4408.7 4495.4 4505.8 4544.1 4544.7 4476.0 4514.0 4521.5 4539.2 4561.2 4327.0 4348.1 4363.1 4412.4 4417.2 4376.2 4388.2 4418.8 4432.3 4478.1 4822.8 4839.2 4839.4 4840.5 4849.5 5015.5 5174.2 5193.2 5194.6 5245.9 5034.3 5102.1 5120.7 5120.8 5162.1 4775.4 4779.9 4781.0 4786.0 4793.4 5202.4 5266.6 5267.1 5268.4 5274.0 5014.3 5034.0 5050.7 5053.0 5073.1 5175.6 5192.5 5197.4 5201.4 5206.9 5156.3 5159.6 5161.9 5162.5 5164.9 5067.4 5070.0 5085.8 5141.7 5142.4 4458.8 4460.6 4464.8 4501.8 4509.6 3800.6 3812.4 3837.0 3875.5 3879.2 4381.2 4392.6 4393.1 4396.5 4397.2 5115.0 5126.4 5137.4 5146.7 5153.8 4392.6 4402.0 4403.7 4405.1 4408.2 4423.5 4551.4 4656.6 4664.1 4692.6 4853.6 4854.6 4882.2 4883.6 4906.9 5235.9 5242.5 5242.5 5244.4 5292.7 4678.1 4719.7 4846.6 4850.3 4852.7 4973.9 5049.7 5088.8 5089.2 5091.3 5207.8 5220.7 5225.5 5226.5 5229.4 4939.0 4953.6 4956.9 4960.8 5006.4 4972.8 5016.8 5024.5 5031.5 5079.5 4768.2 4831.3 4834.4 4891.0 4938.5 5103.4 5111.3 5148.1 5156.3 5156.3 4984.6 4987.0 4988.4 4990.4 5035.9 09:25:47 INFO - PROCESS | 6978 | 09:25:47 INFO - PROCESS | 6978 | [#1] ext.html Cycles:180 Average:51455.16 Median:3547.73 stddev:112287.07 (3165.0%) stddev-sans-first:112536.93 09:25:47 INFO - PROCESS | 6978 | Values: 515.4 536.7 546.5 546.8 549.8 27806.4 37057.3 38197.6 38367.0 42265.0 38921.8 39395.4 39396.8 39465.0 39466.4 7388.9 7560.2 7564.0 7564.1 7568.2 7444.0 7650.2 9390.6 9602.1 9632.1 9952.1 10015.7 10028.2 10033.5 10035.9 9750.2 9831.9 9857.5 9858.2 9860.8 9783.0 9852.9 9859.8 9863.0 9866.6 36065.5 36349.8 36383.6 36422.0 36448.3 2883.8 2945.3 3009.3 3079.7 3340.0 25540.7 25841.0 26417.2 27700.3 28110.2 3444.3 3470.3 3528.7 3533.8 3561.7 243685.0 244288.0 245218.0 246163.0 246595.8 44948.3 45349.5 45388.0 45434.8 45483.8 48425.5 48622.0 48679.8 48714.5 48727.8 11470.9 11856.6 11865.2 11872.2 11883.5 9049.9 9265.6 9774.3 9851.9 9859.5 14560.8 14810.5 15145.4 15540.9 15669.8 5996.4 6000.2 6143.4 6209.9 6211.2 745.3 851.8 933.4 935.9 982.4 25749.5 27096.5 27153.9 27724.7 27776.3 933.4 937.8 972.4 976.5 1031.5 13729.8 14602.5 14634.4 14786.2 14792.7 372963.0 622176.0 640418.0 642932.0 643490.0 42416.6 42531.8 42885.8 42949.8 43151.8 1139.2 1142.2 1167.8 1172.9 1177.4 24997.6 25483.0 25837.6 25964.0 26264.0 36263.6 36968.0 36984.8 36994.4 37009.4 332693.0 335073.0 335290.0 335828.0 336820.0 20468.6 20875.2 22614.8 22614.9 23051.3 33953.2 33989.5 34108.7 34426.3 34877.7 28798.3 29092.6 29313.1 29626.7 30215.7 26565.3 26802.5 27203.3 28078.0 28091.4 29425.0 29755.6 29782.7 29866.9 39425.0 32485.7 33732.3 36153.3 36796.8 36912.8 28024.0 28967.7 29201.4 29482.4 29933.1 09:25:47 INFO - PROCESS | 6978 | 09:25:47 INFO - PROCESS | 6978 | [#2] jquery.html Cycles:180 Average:22474.32 Median:4804.27 stddev:58896.03 (1225.9%) stddev-sans-first:59037.82 09:25:47 INFO - PROCESS | 6978 | Values: 350.1 367.7 373.0 373.4 394.2 12278.7 12352.1 13265.5 16131.5 16783.6 16156.8 16842.7 16928.9 17042.7 17054.5 4658.6 5021.0 5037.0 5060.2 5060.3 3628.7 4951.8 5048.4 5052.6 5054.6 3667.8 3787.7 3793.8 5790.7 5879.4 5898.9 5911.7 5912.0 5915.5 5922.4 4490.1 4743.1 4776.1 4832.4 4832.5 11805.1 11947.7 12424.8 18976.3 19466.0 1699.0 1856.5 2018.4 2322.0 2376.4 8472.3 8511.8 8616.0 8881.6 8890.3 1636.5 1674.6 1677.6 1692.0 1744.8 64071.4 64611.0 64698.7 66055.0 67094.0 9723.6 9732.9 10116.9 10157.9 10256.7 13672.0 13672.9 13676.3 13680.5 13696.4 6780.8 6842.3 7034.4 7111.3 7144.7 6520.5 6566.9 6738.0 6748.5 6757.7 4185.7 4241.6 4257.0 4331.7 4396.1 1745.6 1802.5 1805.0 1839.1 1852.6 793.1 815.3 816.8 887.6 908.0 15185.5 15403.5 15960.4 16533.4 17079.0 774.8 780.4 819.5 828.5 835.0 9190.9 9206.2 9284.5 9415.9 9645.7 347735.0 354500.0 359467.4 359700.0 361014.0 69875.3 70816.6 70820.3 71384.3 73506.0 892.9 894.0 902.0 912.5 913.1 14491.6 14499.0 14743.7 14974.9 15317.8 33356.8 34339.0 34372.0 34492.8 35609.5 41777.0 46996.0 48400.5 48743.8 48917.5 6976.0 7252.0 7330.6 7430.0 7548.9 10390.7 10841.3 10860.9 11000.4 11348.5 9509.4 9539.7 9693.2 9757.8 10005.9 9755.2 9771.1 10020.6 10044.5 10348.0 9772.0 9879.3 10117.3 10192.5 10321.3 7137.5 7288.0 7327.7 7351.7 7411.7 9369.5 9381.6 9445.6 9539.0 10157.8 09:25:47 INFO - PROCESS | 6978 | 09:25:47 INFO - PROCESS | 6978 | [#3] mootools.html Cycles:180 Average:4977.03 Median:5103.84 stddev:2740.08 (53.7%) stddev-sans-first:2733.47 09:25:47 INFO - PROCESS | 6978 | Values: 1253.0 1337.1 1359.6 1453.9 1693.6 6499.9 7250.6 7463.3 7495.8 7738.1 7533.1 7616.3 7616.6 7620.9 7621.8 1869.7 1937.6 2164.8 2207.1 2208.1 2152.2 2216.7 2218.6 2220.0 2223.9 2152.9 2164.0 2178.0 2178.7 2186.5 2143.9 2169.1 2169.1 2171.7 2171.9 2103.9 2121.1 2124.7 2125.4 2125.5 7417.9 7560.1 7571.3 7589.2 7599.7 4335.3 4470.4 4470.9 4476.2 4484.2 2763.7 2915.4 2979.4 2987.4 2996.0 901.1 913.4 942.7 944.3 983.8 10223.2 10273.8 10292.6 10295.4 10296.3 3978.1 4176.9 4227.3 4281.6 4285.2 8700.7 8729.7 8729.8 8730.0 8736.9 4591.2 4607.1 4612.0 4655.0 4662.6 3659.9 3740.1 4174.8 4236.7 4242.1 3524.8 3552.8 3648.2 3653.1 3668.6 1149.8 1174.4 1174.6 1203.4 1219.5 845.2 866.8 872.4 873.1 880.1 5150.2 5311.4 5317.9 5320.7 5483.6 397.4 401.6 410.9 416.9 417.6 3573.9 3637.6 3657.9 3675.7 3696.1 8815.9 9028.4 9156.6 9160.3 9186.3 9075.6 9131.3 9171.9 9183.9 9187.7 7069.7 7161.3 7172.2 7174.4 7178.6 5094.2 5113.5 5125.6 5235.7 5444.9 8394.0 8408.9 8413.6 8428.6 8499.9 8029.9 8185.1 8262.2 8482.2 8575.3 6495.2 6607.1 6609.5 6665.7 6685.6 7104.7 7221.2 7222.8 7224.3 7224.6 6435.4 6568.7 6591.4 6621.6 6730.2 6418.9 6461.5 6471.1 6535.2 6539.5 5946.6 6140.6 6201.2 6285.5 6294.7 4472.8 4493.0 4547.1 4609.3 4638.9 4369.1 4398.2 4456.3 4503.3 4649.6 09:25:47 INFO - PROCESS | 6978 | 09:25:47 INFO - PROCESS | 6978 | [#4] prototype.html Cycles:180 Average:4101.31 Median:4575.17 stddev:1152.81 (25.2%) stddev-sans-first:1120.93 09:25:47 INFO - PROCESS | 6978 | Values: 339.3 344.5 346.6 347.4 350.3 4515.8 4674.5 4692.5 4742.5 4752.0 4560.5 4665.1 4677.4 4689.6 4692.4 3741.5 3742.1 3749.0 3763.5 3774.2 3580.5 3695.8 3742.8 3758.8 3759.0 3694.5 3782.8 3790.2 3797.8 3800.3 3790.2 3799.8 3799.8 3802.8 3807.6 3418.6 3427.3 3430.8 3435.6 3438.3 4495.7 4613.8 4623.1 4645.9 4679.9 4312.5 4318.5 4329.3 4333.8 4349.4 4912.6 4919.7 4924.0 4930.6 4936.3 3524.7 3650.9 3690.1 3704.8 3714.4 5138.6 5144.2 5154.6 5159.8 5166.7 3779.7 3783.8 3784.0 3787.8 3800.5 3814.2 3833.2 3844.3 3850.8 3852.2 4159.6 4285.3 4287.2 4298.5 4312.4 4949.2 4966.2 4967.2 4978.6 4980.9 1226.1 1263.4 1293.9 1300.5 1302.3 893.7 926.6 927.3 929.8 933.3 4157.7 4167.8 4170.8 4173.9 4180.6 4861.6 4925.2 4949.5 4963.6 4975.5 4020.4 4118.2 4159.6 4180.7 4242.8 2582.5 2594.9 2631.3 2649.2 2657.8 4532.8 4551.4 4555.0 4589.5 4597.0 4806.8 4854.8 4907.9 4952.9 4980.8 4456.8 4511.6 4515.2 4518.0 4560.8 4836.6 4845.8 4852.3 4856.1 4862.8 4764.5 4784.6 4806.8 5020.5 5084.4 4768.6 4769.9 4776.3 4791.0 4805.0 3521.7 3524.6 3530.4 3541.3 3544.1 4937.8 5104.4 5111.0 5136.3 5150.7 4996.0 5008.7 5009.0 5009.8 5022.7 4962.8 4978.2 4986.5 4998.3 5008.9 4750.2 4868.6 4887.2 4892.7 4919.3 5005.3 5007.9 5014.6 5017.8 5039.0 4865.9 4892.3 4892.6 4905.6 4913.7 09:25:47 INFO - PROCESS | 6978 | 09:25:47 INFO - PROCESS | 6978 | [#5] yui.html Cycles:180 Average:15203.27 Median:27633.73 stddev:19295.83 (69.8%) stddev-sans-first:19318.75 09:25:47 INFO - PROCESS | 6978 | Values: 588.6 597.5 622.8 700.1 702.6 11663.2 14975.3 15668.2 15672.0 15709.5 15103.0 15269.5 15298.8 15306.7 15315.6 620.7 754.0 778.7 779.4 780.9 630.0 755.9 775.4 785.9 787.6 818.2 822.2 824.6 824.8 825.6 653.7 816.6 817.6 818.3 818.9 490.6 578.5 596.9 599.0 601.4 13693.7 13704.6 13750.6 13754.4 13761.4 11605.7 11719.9 11948.3 12138.2 12431.4 10769.5 10829.6 11020.4 11092.6 11593.9 3656.9 3678.2 3728.3 3736.2 3752.5 52937.5 62197.4 63001.7 63081.0 66373.0 9646.3 9984.5 10219.5 10292.3 10377.3 18604.2 18606.6 18613.7 18620.4 18627.4 6777.0 6855.2 6880.6 7111.1 7128.7 3566.2 3645.0 3646.9 3650.8 3767.6 2971.5 3047.9 3056.4 3058.5 3296.7 534.7 535.3 542.5 552.1 559.1 549.3 551.7 590.4 615.0 630.4 7397.8 7940.6 8344.2 8418.8 8604.9 469.8 564.0 576.4 593.4 602.5 3850.4 3987.1 4023.2 4043.5 4094.5 63243.0 66258.0 68270.3 70309.6 70774.6 58915.4 59257.7 59905.7 60304.1 63147.4 53624.0 54725.0 55057.2 55592.0 55742.0 7604.4 8090.0 8139.1 8147.0 8319.2 38065.4 38439.8 38814.2 39494.6 39522.4 50233.5 52279.5 52325.0 52752.5 53326.0 9387.8 9460.6 9495.6 9553.7 9902.1 10340.3 10613.3 10622.6 10836.3 10940.1 9967.3 10091.1 10121.3 10162.6 10658.9 10759.8 10989.9 11007.0 11470.5 11787.9 11348.4 11423.8 11680.6 11809.9 12197.0 9020.9 9187.5 9316.8 9624.7 9813.4 9531.1 9698.5 9941.7 10171.6 10245.9 09:25:47 INFO - PROCESS | 6978 | -------- Summary: end -------- 09:25:47 INFO - PROCESS | 6978 | 09:25:48 INFO - TEST-INFO | 6978: exit 0 09:25:48 INFO - TEST-OK | dromaeo_css | took 1126075ms 09:25:48 INFO - TEST-START | kraken 09:25:48 INFO - operating with platform_type : linux_ 09:25:48 INFO - Initialising browser for kraken test... 09:25:48 INFO - TEST-INFO | started process 7285 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkUifz4/profile http://localhost:57308/getInfo.html) 09:25:53 INFO - PROCESS | 7285 | __metrics Screen width/height:1600/1200 09:25:53 INFO - PROCESS | 7285 | colorDepth:24 09:25:53 INFO - PROCESS | 7285 | Browser inner width/height: 1024/697 09:25:53 INFO - PROCESS | 7285 | __metrics 09:25:53 INFO - PROCESS | 7285 | 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:53 INFO - PROCESS | 7285 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:25:54 INFO - PROCESS | 7285 | console.error: PushService: 09:25:54 INFO - PROCESS | 7285 | stateChangeProcessEnqueue: Error transitioning state 09:25:54 INFO - PROCESS | 7285 | UnknownError 09:25:55 INFO - TEST-INFO | 7285: exit 0 09:25:55 INFO - Browser initialized. 09:25:55 INFO - Running cycle 1/1 for kraken test... 09:25:55 INFO - TEST-INFO | started process 7369 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkUifz4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:26:07 INFO - PROCESS | 7369 | RSS: Main: 173768704 09:26:07 INFO - PROCESS | 7369 | 09:26:10 INFO - PROCESS | 7369 | Cycle 1(1): loaded http://localhost:57308/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57308/tests/kraken/driver.html?testName=audio-beat-detection) 09:26:11 INFO - PROCESS | 7369 | RSS: Main: 239620096 09:26:11 INFO - PROCESS | 7369 | 09:26:14 INFO - PROCESS | 7369 | Cycle 1(1): loaded http://localhost:57308/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57308/tests/kraken/driver.html?testName=audio-dft) 09:26:14 INFO - PROCESS | 7369 | RSS: Main: 217788416 09:26:14 INFO - PROCESS | 7369 | 09:26:17 INFO - PROCESS | 7369 | Cycle 1(1): loaded http://localhost:57308/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57308/tests/kraken/driver.html?testName=audio-fft) 09:26:18 INFO - PROCESS | 7369 | RSS: Main: 300777472 09:26:18 INFO - PROCESS | 7369 | 09:26:20 INFO - PROCESS | 7369 | Cycle 1(1): loaded http://localhost:57308/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57308/tests/kraken/driver.html?testName=audio-oscillator) 09:26:21 INFO - PROCESS | 7369 | RSS: Main: 210219008 09:26:21 INFO - PROCESS | 7369 | 09:26:23 INFO - PROCESS | 7369 | Cycle 1(1): loaded http://localhost:57308/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57308/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:26:24 INFO - PROCESS | 7369 | RSS: Main: 214921216 09:26:24 INFO - PROCESS | 7369 | 09:26:27 INFO - PROCESS | 7369 | Cycle 1(1): loaded http://localhost:57308/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57308/tests/kraken/driver.html?testName=imaging-darkroom) 09:26:28 INFO - PROCESS | 7369 | RSS: Main: 253497344 09:26:28 INFO - PROCESS | 7369 | 09:26:31 INFO - PROCESS | 7369 | Cycle 1(1): loaded http://localhost:57308/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57308/tests/kraken/driver.html?testName=imaging-desaturate) 09:26:32 INFO - PROCESS | 7369 | RSS: Main: 248279040 09:26:32 INFO - PROCESS | 7369 | 09:26:35 INFO - PROCESS | 7369 | Cycle 1(1): loaded http://localhost:57308/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57308/tests/kraken/driver.html?testName=json-parse-financial) 09:26:35 INFO - PROCESS | 7369 | RSS: Main: 250425344 09:26:35 INFO - PROCESS | 7369 | 09:26:37 INFO - PROCESS | 7369 | Cycle 1(1): loaded http://localhost:57308/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57308/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:26:38 INFO - PROCESS | 7369 | RSS: Main: 213360640 09:26:38 INFO - PROCESS | 7369 | 09:26:39 INFO - PROCESS | 7369 | Cycle 1(1): loaded http://localhost:57308/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57308/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:26:40 INFO - PROCESS | 7369 | RSS: Main: 221069312 09:26:40 INFO - PROCESS | 7369 | 09:26:42 INFO - PROCESS | 7369 | Cycle 1(1): loaded http://localhost:57308/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57308/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:26:43 INFO - PROCESS | 7369 | RSS: Main: 229502976 09:26:43 INFO - PROCESS | 7369 | 09:26:46 INFO - PROCESS | 7369 | Cycle 1(1): loaded http://localhost:57308/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57308/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:26:47 INFO - PROCESS | 7369 | RSS: Main: 238817280 09:26:47 INFO - PROCESS | 7369 | 09:26:50 INFO - PROCESS | 7369 | Cycle 1(1): loaded http://localhost:57308/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57308/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:26:50 INFO - PROCESS | 7369 | RSS: Main: 234532864 09:26:50 INFO - PROCESS | 7369 | 09:26:52 INFO - PROCESS | 7369 | Cycle 1(1): loaded http://localhost:57308/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57308/tests/kraken/driver.html?testName=ai-astar) 09:26:52 INFO - PROCESS | 7369 | RSS: Main: 287719424 09:26:52 INFO - PROCESS | 7369 | 09:26:52 INFO - PROCESS | 7369 | __start_tp_report 09:26:52 INFO - PROCESS | 7369 | _x_x_mozilla_page_load 09:26:52 INFO - PROCESS | 7369 | _x_x_mozilla_page_load_details 09:26:52 INFO - PROCESS | 7369 | |i|pagename|runs| 09:26:52 INFO - PROCESS | 7369 | |0;ai-astar;108;116;116;117;115;114;113;115;115;114 09:26:52 INFO - PROCESS | 7369 | |1;audio-beat-detection;164;130;144;175;130;134;127;130;154;130 09:26:52 INFO - PROCESS | 7369 | |2;audio-dft;162;161;163;162;162;161;160;160;159;161 09:26:52 INFO - PROCESS | 7369 | |3;audio-fft;76;77;77;102;79;78;77;76;91;77 09:26:52 INFO - PROCESS | 7369 | |4;audio-oscillator;85;85;115;85;85;85;100;85;85;114 09:26:52 INFO - PROCESS | 7369 | |5;imaging-gaussian-blur;127;128;127;128;127;126;127;127;127;127 09:26:52 INFO - PROCESS | 7369 | |6;imaging-darkroom;148;147;147;147;148;147;146;147;146;147 09:26:52 INFO - PROCESS | 7369 | |7;imaging-desaturate;95;95;96;96;95;95;95;95;95;95 09:26:52 INFO - PROCESS | 7369 | |8;json-parse-financial;65;65;64;65;66;65;66;65;65;65 09:26:52 INFO - PROCESS | 7369 | |9;json-stringify-tinderbox;68;67;67;67;67;66;66;66;69;66 09:26:52 INFO - PROCESS | 7369 | |10;stanford-crypto-aes;86;85;91;86;84;84;84;85;89;84 09:26:52 INFO - PROCESS | 7369 | |11;stanford-crypto-ccm;155;140;148;151;151;152;143;138;191;141 09:26:52 INFO - PROCESS | 7369 | |12;stanford-crypto-pbkdf2;182;180;180;179;180;182;176;180;179;179 09:26:52 INFO - PROCESS | 7369 | |13;stanford-crypto-sha256-iterative;74;70;74;71;69;69;68;70;73;69 09:26:52 INFO - PROCESS | 7369 | __end_tp_report 09:26:52 INFO - PROCESS | 7369 | __start_cc_report 09:26:52 INFO - PROCESS | 7369 | _x_x_mozilla_cycle_collect,1948 09:26:52 INFO - PROCESS | 7369 | __end_cc_report 09:26:52 INFO - PROCESS | 7369 | __startTimestamp1481390812759__endTimestamp 09:26:52 INFO - PROCESS | 7369 | 09:26:52 INFO - PROCESS | 7369 | ------- Summary: start ------- 09:26:52 INFO - PROCESS | 7369 | Number of tests: 14 09:26:52 INFO - PROCESS | 7369 | 09:26:52 INFO - PROCESS | 7369 | [#0] ai-astar Cycles:10 Average:114.30 Median:115.00 stddev:2.50 (2.2%) stddev-sans-first:1.22 09:26:52 INFO - PROCESS | 7369 | Values: 108.0 116.0 116.0 117.0 115.0 114.0 113.0 115.0 115.0 114.0 09:26:52 INFO - PROCESS | 7369 | 09:26:52 INFO - PROCESS | 7369 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:139.00 stddev:16.95 (12.2%) stddev-sans-first:15.96 09:26:52 INFO - PROCESS | 7369 | Values: 164.0 130.0 144.0 175.0 130.0 134.0 127.0 130.0 154.0 130.0 09:26:52 INFO - PROCESS | 7369 | 09:26:52 INFO - PROCESS | 7369 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.20 (0.7%) stddev-sans-first:1.22 09:26:52 INFO - PROCESS | 7369 | Values: 162.0 161.0 163.0 162.0 162.0 161.0 160.0 160.0 159.0 161.0 09:26:52 INFO - PROCESS | 7369 | 09:26:52 INFO - PROCESS | 7369 | [#3] audio-fft Cycles:10 Average:81.00 Median:77.00 stddev:8.62 (11.2%) stddev-sans-first:8.95 09:26:52 INFO - PROCESS | 7369 | Values: 76.0 77.0 77.0 102.0 79.0 78.0 77.0 76.0 91.0 77.0 09:26:52 INFO - PROCESS | 7369 | 09:26:52 INFO - PROCESS | 7369 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:85.00 stddev:12.55 (14.8%) stddev-sans-first:13.03 09:26:52 INFO - PROCESS | 7369 | Values: 85.0 85.0 115.0 85.0 85.0 85.0 100.0 85.0 85.0 114.0 09:26:52 INFO - PROCESS | 7369 | 09:26:52 INFO - PROCESS | 7369 | [#5] imaging-gaussian-blur Cycles:10 Average:127.10 Median:127.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 09:26:52 INFO - PROCESS | 7369 | Values: 127.0 128.0 127.0 128.0 127.0 126.0 127.0 127.0 127.0 127.0 09:26:52 INFO - PROCESS | 7369 | 09:26:52 INFO - PROCESS | 7369 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 09:26:52 INFO - PROCESS | 7369 | Values: 148.0 147.0 147.0 147.0 148.0 147.0 146.0 147.0 146.0 147.0 09:26:52 INFO - PROCESS | 7369 | 09:26:52 INFO - PROCESS | 7369 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:26:52 INFO - PROCESS | 7369 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 09:26:52 INFO - PROCESS | 7369 | 09:26:52 INFO - PROCESS | 7369 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 09:26:52 INFO - PROCESS | 7369 | Values: 65.0 65.0 64.0 65.0 66.0 65.0 66.0 65.0 65.0 65.0 09:26:52 INFO - PROCESS | 7369 | 09:26:52 INFO - PROCESS | 7369 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:0.97 09:26:52 INFO - PROCESS | 7369 | Values: 68.0 67.0 67.0 67.0 67.0 66.0 66.0 66.0 69.0 66.0 09:26:52 INFO - PROCESS | 7369 | 09:26:52 INFO - PROCESS | 7369 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.50 stddev:2.39 (2.8%) stddev-sans-first:2.54 09:26:52 INFO - PROCESS | 7369 | Values: 86.0 85.0 91.0 86.0 84.0 84.0 84.0 85.0 89.0 84.0 09:26:52 INFO - PROCESS | 7369 | 09:26:52 INFO - PROCESS | 7369 | [#11] stanford-crypto-ccm Cycles:10 Average:151.00 Median:151.00 stddev:15.20 (10.1%) stddev-sans-first:16.06 09:26:52 INFO - PROCESS | 7369 | Values: 155.0 140.0 148.0 151.0 151.0 152.0 143.0 138.0 191.0 141.0 09:26:52 INFO - PROCESS | 7369 | 09:26:52 INFO - PROCESS | 7369 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.70 Median:180.00 stddev:1.70 (0.9%) stddev-sans-first:1.59 09:26:52 INFO - PROCESS | 7369 | Values: 182.0 180.0 180.0 179.0 180.0 182.0 176.0 180.0 179.0 179.0 09:26:52 INFO - PROCESS | 7369 | 09:26:52 INFO - PROCESS | 7369 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:70.50 stddev:2.21 (3.1%) stddev-sans-first:2.00 09:26:52 INFO - PROCESS | 7369 | Values: 74.0 70.0 74.0 71.0 69.0 69.0 68.0 70.0 73.0 69.0 09:26:52 INFO - PROCESS | 7369 | -------- Summary: end -------- 09:26:52 INFO - PROCESS | 7369 | 09:26:54 INFO - TEST-INFO | 7369: exit 0 09:26:54 INFO - TEST-OK | kraken | took 65540ms 09:26:54 INFO - SUITE-END | took 1191s 09:26:54 INFO - Completed test suite (00:19:51) 09:26:54 INFO - javascript benchmark 09:26:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2593.7406259374065, 2643.6695413073367, 2661.1617340537737, 2672.973270267297, 2683.5303821831176, 4677.06458708258, 4748.620110391169, 4772.141014617372, 4875.171220892448, 4900.803967841287, 4759.000609871922, 4787.44944331402, 4797.6401769867225, 4847.951520484794, 4886.438059623153, 4377.037051848588, 4412.514623391425, 4414.779261036935, 4421.977890110545, 4497.640188784906, 4408.691391602589, 4495.415595972535, 4505.752183629899, 4544.068465964469, 4544.681872268926, 4476.0, 4514.0, 4521.457425108975, 4539.160255352754, 4561.247394179956, 4326.9567304326865, 4348.1086377292895, 4363.127374525107, 4412.426384569985, 4417.249067658506, 4376.190404775127, 4388.210122178007, 4418.845340413102, 4432.312991486325, 4478.149151661174, 4822.7829747661435, 4839.153148199051, 4839.37088178538, 4840.5159484051665, 4849.466558678542, 5015.523525265094, 5174.249733788617, 5193.246979187997, 5194.584433245369, 5245.86885327866, 5034.270030845543, 5102.132637451605, 5120.743962801882, 5120.84637460873, 5162.070827251093, 4775.42694876617, 4779.856604301807, 4780.95219047812, 4786.018866132435, 4793.400824896888, 5202.401723801736, 5266.605004624592, 5267.078261304257, 5268.420473747885, 5274.024305503494, 5014.348134742533, 5034.018366418513, 5050.671706339076, 5052.974735126374, 5073.061483625541, 5175.637705360588, 5192.532672059533, 5197.376314842243, 5201.401838788588, 5206.947930520646, 5156.278121063054, 5159.58723302135, 5161.922571161435, 5162.483751624807, 5164.948350516522, 5067.41724701664, 5070.0, 5085.847424577269, 5141.665791723526, 5142.434332223453, 4458.799354029076, 4460.553944605514, 4464.843730469483, 4501.842435514741, 4509.571590698878, 3800.5819359870393, 3812.3709587917683, 3837.002379381381, 3875.476810630585, 3879.2047630235734, 4381.18947994622, 4392.626626736763, 4393.0774537347515, 4396.538363471789, 4397.2085024695225, 5115.028144652504, 5126.384833819965, 5137.357830271216, 5146.716930568855, 5153.768080436389, 4392.582704643054, 4402.0, 4403.713758605744, 4405.118976204772, 4408.184485870124, 4423.535528769497, 4551.362809206714, 4656.627469802408, 4664.137134630037, 4692.601128904013, 4853.587445067209, 4854.5873600744335, 4882.2432522959, 4883.609311255091, 4906.8773280668265, 5235.895282094413, 5242.47575242488, 5242.5281724644965, 5244.396894357198, 5292.735363231746, 4678.087772884391, 4719.669623126486, 4846.612271018381, 4850.320955066223, 4852.708837469763, 4973.850784476472, 5049.747512624281, 5088.847334579968, 5089.160288552347, 5091.287219789307, 5207.843764687065, 5220.686758794484, 5225.451327610546, 5226.45122262157, 5229.372475302988, 4938.950610493849, 4953.578945789648, 4956.8760780980765, 4960.751962401938, 5006.3992320921725, 4972.825951091694, 5016.824411145738, 5024.547790698854, 5031.52200540948, 5079.517445842639, 4768.189407800752, 4831.347768051268, 4834.444038935568, 4891.0, 4938.48145944685, 5103.362079740033, 5111.258867464123, 5148.073346797612, 5156.329677141947, 5156.329677141947, 4984.601231901367, 4987.027529631687, 4988.401391833003, 4990.4011518618, 5035.899282014412], "value": 4730.016209925515, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [515.3892637224889, 536.6538582614214, 546.5272539253544, 546.8496163555022, 549.793827314757, 27806.443871122567, 37057.25885482292, 38197.618023819756, 38367.04082397941, 42265.0, 38921.80539097307, 39395.40906886392, 39396.80301598488, 39465.0, 39466.408003879966, 7388.9261107388775, 7560.206178351276, 7564.0, 7564.130125035636, 7568.205338439468, 7444.0, 7650.234976502333, 9390.62437502499, 9602.135807777298, 9632.133108020276, 9952.054554817318, 10015.69952901414, 10028.197744180485, 10033.498325083752, 10035.94982025089, 9750.171235444961, 9831.8525222121, 9857.507124643811, 9858.16205622523, 9860.802783944317, 9782.951085244527, 9852.901470985342, 9859.802803943881, 9862.950685246527, 9866.556004979793, 36065.45901811475, 36349.818250908844, 36383.636163638286, 36422.0, 36448.271034579426, 2883.812552184101, 2945.3225758075764, 3009.337945651975, 3079.6612372638992, 3340.0146956647845, 25540.74459255421, 25841.0, 26417.207483775517, 27700.30749231265, 28110.156695299174, 3444.3111377724304, 3470.288590838872, 3528.7177025838128, 3533.805640689761, 3561.661642143992, 243685.0, 244288.0, 245218.0, 246163.0, 246595.76702116555, 44948.3257751134, 45349.546504535196, 45388.0, 45434.772826136315, 45483.77258113688, 48425.5157448421, 48622.0, 48679.756601216766, 48714.512854871, 48727.756361217966, 11470.942645286721, 11856.644300670994, 11865.169438139248, 11872.168948173545, 11883.524659013716, 9049.909500905038, 9265.583048762823, 9774.266929980138, 9851.901480985242, 9859.457729824928, 14560.781588276184, 14810.519527910932, 15145.394184232508, 15540.922295388677, 15669.764953525706, 5996.430339117776, 6000.189974353494, 6143.447089761943, 6209.9379006210265, 6211.223597050369, 745.3440971944653, 851.8296340731879, 933.3513208320288, 935.9470595579972, 982.4337654314792, 25749.485010300064, 27096.458070838868, 27153.86423067872, 27724.722752772213, 27776.30559235995, 933.4399360383716, 937.803061357109, 972.4311277902507, 976.4922240434934, 1031.5409642709074, 13729.794053089212, 14602.488912887999, 14634.414623414945, 14786.186759728103, 14792.704145917021, 372963.0, 622176.0, 640418.0, 642932.0, 643490.0, 42416.57583424188, 42531.7873410631, 42885.785571071945, 42949.78525107355, 43151.784241078596, 1139.2310190621297, 1142.2118738070872, 1167.8073117935614, 1172.9472173752201, 1177.4230626992883, 24997.625035624846, 25483.0, 25837.612435813855, 25964.0, 26264.0, 36263.637363626025, 36968.0, 36984.815075924445, 36994.44508332431, 37009.44485832768, 332693.0, 335073.0, 335290.0, 335828.0, 336820.0, 20468.590628187652, 20875.164993400092, 22614.773852261926, 22614.886925565268, 23051.308460746204, 33953.15117121993, 33989.49015764815, 34108.65891341154, 34426.31147377088, 34877.65122348744, 28798.280042999093, 29092.56361154542, 29313.120606381843, 29626.703732963255, 30215.697843022168, 26565.33586660349, 26802.463950720485, 27203.319917002234, 28078.01726939629, 28091.43817123687, 29425.0, 29755.553666694585, 29782.70217297799, 29866.850665746533, 39425.0, 32485.675143248263, 33732.32535349328, 36153.27693446169, 36796.81601591975, 36912.81543592265, 28024.0, 28967.710322897343, 29201.41597168087, 29482.410351793274, 29933.102006939826], "value": 16954.189809719443, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.1124649014745, 367.66358781714735, 372.9533808273966, 373.3652790256564, 394.2410859096239, 12278.693032674188, 12352.073594480416, 13265.535706250283, 16131.516054518353, 16783.580410489714, 16156.75764863525, 16842.747358789627, 16928.915355423236, 17042.74435883463, 17054.488365349058, 4658.60401865841, 5021.046001259749, 5037.042961837239, 5060.240963855433, 5060.316857224265, 3628.6915612172997, 4951.777170027357, 5048.368953880765, 5052.6210534209895, 5054.570361519275, 3667.7982710950887, 3787.715921305913, 3793.753406028613, 5790.652560846342, 5879.412058794108, 5898.852528686795, 5911.674857882815, 5912.0, 5915.467607915287, 5922.437368450033, 4490.146872094324, 4743.146233677937, 4776.09254241693, 4832.444268909086, 4832.5409086137115, 11805.114616403804, 11947.701307467296, 12424.75150496985, 18976.335828245945, 19466.0, 1698.9745153822703, 1856.4894653970266, 2018.3743039657752, 2321.988390058039, 2376.417777644471, 8472.27985621223, 8511.787205319855, 8616.0, 8881.555922203865, 8890.288776897833, 1636.4681478519528, 1674.6315810521667, 1677.6309211973346, 1692.0270844264596, 1744.7819022622173, 64071.35928640701, 64611.0, 64698.676506617165, 66055.0, 67094.0, 9723.562439690231, 9732.854007189897, 10116.949415252877, 10157.85106616951, 10256.743581410525, 13672.0, 13672.863271367358, 13676.316184190751, 13680.521181758591, 13696.383662735201, 6780.796576102724, 6842.315768423118, 7034.366906978396, 7111.324424179695, 7144.749933752294, 6520.510961677798, 6566.9343306566325, 6737.966310168418, 6748.460123190133, 6757.662116894136, 4185.707000509996, 4241.579071011184, 4257.042165512797, 4331.740095594275, 4396.120775844844, 1745.598512342143, 1802.4953013156075, 1804.9819501805077, 1839.1080326041858, 1852.6294741051843, 793.0879488588055, 815.3192084609418, 816.8366326734676, 887.5562218890555, 908.0329449136648, 15185.468508602145, 15403.46087886941, 15960.441384551485, 16533.421330253623, 17079.0, 774.8256642255448, 780.3718007004416, 819.5205804604374, 828.4656396624264, 834.983300334002, 9190.862137067948, 9206.171444569887, 9284.48935308551, 9415.858762118574, 9645.662401815904, 347735.0, 354500.0, 359467.4053259486, 359700.0, 361014.0, 69875.3012469879, 70816.64591677008, 70820.2917970824, 71384.28615713776, 73506.0, 892.9374943753875, 894.0478390513952, 901.977450563728, 912.4844462878452, 913.1005959130251, 14491.565253042425, 14499.0, 14743.705125897637, 14974.850251497346, 15317.846821531642, 33356.833215833765, 34339.0, 34372.0, 34492.82753586216, 35609.46585801267, 41777.0, 46996.0, 48400.51599484101, 48743.75628121837, 48917.510824891295, 6976.0, 7252.0, 7330.5968171751065, 7429.962850185714, 7548.886766698394, 10390.688279351632, 10841.349519028883, 10860.945695271474, 11000.394978276272, 11348.54605815758, 9509.429434233969, 9539.666111686058, 9693.224542036762, 9757.756056098655, 10005.899941000496, 9755.170810481188, 9771.110978306522, 10020.599176033169, 10044.49777511107, 10348.016938390841, 9771.951140244253, 9879.30844840883, 10117.29178957466, 10192.519853299229, 10321.277510574188, 7137.500374973702, 7287.9635601823775, 7327.74352897646, 7351.70593176267, 7411.740589079356, 9369.531523423666, 9381.577828997575, 9445.622175113192, 9538.95230523843, 10157.847632285373], "value": 7779.010396818414, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1253.0101220036172, 1337.0974592150296, 1359.6125104345263, 1453.9491117810878, 1693.5681401242673, 6499.935000649992, 7250.564966102038, 7463.290987356199, 7495.812604684872, 7738.110117336508, 7533.096028476577, 7616.2764537369, 7616.581088040156, 7620.88568671469, 7621.8475630487355, 1869.728889311049, 1937.6221636780833, 2164.7943445372666, 2207.128184367174, 2208.149862303009, 2152.2359562355373, 2216.6674998750236, 2218.5784700906856, 2219.9778002220014, 2223.8888055597154, 2152.87082775034, 2164.0261882153013, 2178.041661668861, 2178.673199020144, 2186.5408264264443, 2143.9249626263086, 2169.1323470611724, 2169.143188440557, 2171.706819579352, 2171.945701357479, 2103.852730308879, 2121.1091341636547, 2124.691919671639, 2125.3942626351572, 2125.5005073807642, 7417.888731668975, 7560.130584982742, 7571.318581327707, 7589.165191828894, 7599.734009309703, 4335.3063509838275, 4470.396496472967, 4470.932936005963, 4476.239039363316, 4484.1928452878465, 2763.737444942727, 2915.3731947631363, 2979.4041191761735, 2987.4025194961096, 2996.0412667946266, 901.1034021148934, 913.4108500017452, 942.6559305853314, 944.3436811416069, 983.822911875862, 10223.182145428347, 10273.845892311696, 10292.588296468133, 10295.3822770634, 10296.27926045177, 3978.0651546886456, 4176.853810116631, 4227.302495088337, 4281.636060934856, 4285.228658841438, 8700.651973920973, 8729.694460693845, 8729.825403491895, 8730.0, 8736.8689469658, 4591.242444996605, 4607.14767767964, 4612.0, 4655.02244528646, 4662.603678687349, 3659.908502287411, 3740.139767853409, 4174.833006679699, 4236.724612900151, 4242.087951090531, 3524.788512689247, 3552.769070010441, 3648.2338708870902, 3653.12325041988, 3668.614795446493, 1149.8275258711094, 1174.3775798826637, 1174.5536696055444, 1203.3622180244483, 1219.530480764912, 845.2308399356679, 866.7659731872485, 872.3936863879669, 873.0745409865563, 880.0759202836996, 5150.227465880148, 5311.442298558673, 5317.946820531745, 5320.654157479751, 5483.616146869681, 397.3999261115736, 401.5783427401217, 410.86852207293975, 416.8578096016892, 417.607448997947, 3573.8749143780365, 3637.636236376341, 3657.9451308230396, 3675.6875665568728, 3696.094456858087, 8815.911840881508, 9028.413153145024, 9156.633734650673, 9160.267178625827, 9186.311026673025, 9075.591598378089, 9131.26949844011, 9171.862422063674, 9183.908160918305, 9187.724368268962, 7069.71721131149, 7161.283871612901, 7172.246914073947, 7174.354308112295, 7178.641067946582, 5094.15946368845, 5113.51421614946, 5125.589952803842, 5235.65968212065, 5444.891102178013, 8394.034686010942, 8408.915910841059, 8413.579321034047, 8428.578571071545, 8499.91500085016, 8029.879551806845, 8185.140560241089, 8262.215089566482, 8482.151784821468, 8575.271101956403, 6495.188101487314, 6607.07500949877, 6609.4712423007, 6665.733370665119, 6685.565438246498, 7104.680289386886, 7221.169565500035, 7222.783316500513, 7224.277572242734, 7224.566526008456, 6435.388638079375, 6568.7372505101175, 6591.439727623206, 6621.635810030494, 6730.226024007106, 6418.935810641834, 6461.547691661539, 6471.06169605414, 6535.248446428722, 6539.4768418525455, 5946.554008449297, 6140.631562106288, 6201.162843016135, 6285.497160227263, 6294.748210071546, 4472.79872405736, 4492.955070449254, 4547.067851090585, 4609.308603709336, 4638.884027899329, 4369.060651959844, 4398.186335527937, 4456.2647163219, 4503.301988191835, 4649.558291962394], "value": 3975.051295089922, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.2807248632897, 344.5004743122472, 346.61701790524484, 347.42848015015284, 350.253959067187, 4515.7516336601475, 4674.532546745324, 4692.5072867348945, 4742.549457801503, 4751.9524804751945, 4560.527367159414, 4665.09030739006, 4677.415323084614, 4689.6482763792765, 4692.41344831896, 3741.4948981887437, 3742.0644838790304, 3748.9812550937345, 3763.5295588051495, 3774.226283611853, 3580.4629305604108, 3695.778253304797, 3742.8315725792404, 3758.7932663703486, 3758.962410375889, 3694.4827724118645, 3782.81085945703, 3790.241951609675, 3797.8480860765535, 3800.258949504848, 3790.2419516096893, 3799.7910114943666, 3799.810009499514, 3802.752821066622, 3807.6382743639447, 3418.5555877735737, 3427.2631384252254, 3430.8456119474686, 3435.639257877912, 3438.2951494943477, 4495.685302028859, 4613.76931153441, 4623.144718227105, 4645.931435769792, 4679.8534359081905, 4312.482502099737, 4318.503372112216, 4329.328954012101, 4333.761643109628, 4349.391085248068, 4912.606991440676, 4919.655624106314, 4924.0, 4930.580900623451, 4936.259561065833, 3524.718022558189, 3650.8682308484454, 3690.0959264979983, 3704.7777133371815, 3714.387126124186, 5138.614603904722, 5144.176931690949, 5154.587632989352, 5159.845204643867, 5166.664166829144, 3779.6976241900584, 3783.754055986352, 3783.97557306845, 3787.791671458096, 3800.4869342638945, 3814.2180852925085, 3833.1758671885677, 3844.3464611016193, 3850.845966161322, 3852.152526444234, 4159.625633692982, 4285.271503844354, 4287.249731297011, 4298.484181898192, 4312.439382880269, 4949.232868905254, 4966.180580204225, 4967.180415231519, 4978.5768209701855, 4980.850574482772, 1226.141700809437, 1263.389178797041, 1293.8964882809353, 1300.4993077665167, 1302.2837439408477, 893.6648756716231, 926.6293482607011, 927.3369540778376, 929.819129705284, 933.3466573398513, 4157.7089603727445, 4167.812448439767, 4170.812313445902, 4173.874783756492, 4180.561041090703, 4861.642103579761, 4925.20759015556, 4949.529794669501, 4963.57809586182, 4975.4527002029745, 4020.4119372847563, 4118.238125946709, 4159.646430053479, 4180.742399104511, 4242.830286788494, 2582.4705935283223, 2594.9351266218496, 2631.2633661783516, 2649.1919964410654, 2657.8272412293527, 4532.841350552715, 4551.38556294896, 4555.0, 4589.541045895384, 4596.977015114903, 4806.7836947336755, 4854.80580776765, 4907.9263811042865, 4952.90094198114, 4980.825671101494, 4456.77716114193, 4511.62395469385, 4515.209838278354, 4517.977410112929, 4560.794764235618, 4836.564709176191, 4845.836999120256, 4852.344933434082, 4856.1016212000895, 4862.781174847211, 4764.523547645208, 4784.641151913551, 4806.8077276909935, 5020.548150666457, 5084.3898732152375, 4768.61851051922, 4769.87740455494, 4776.325257855612, 4790.976045119752, 4804.95195048059, 3521.683048525645, 3524.5946716127974, 3530.3821831179953, 3541.2563361694333, 3544.0608238816217, 4937.7531123444405, 5104.417630534546, 5111.042288979684, 5136.30659860929, 5150.665206761549, 4996.0, 5008.749562521933, 5008.974955125347, 5009.772605711624, 5022.744313921519, 4962.751862406937, 4978.153713868579, 4986.451490335988, 4998.2502624606595, 5008.924866127084, 4750.239961606127, 4868.634852386014, 4887.193613053806, 4892.706437613754, 4919.278252611557, 5005.299258103795, 5007.924881126859, 5014.598832093351, 5017.799288028438, 5038.951434382146, 4865.9026819464125, 4892.2661600760175, 4892.559669629751, 4905.558499735041, 4913.729744863924], "value": 3753.341793196998, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.6203398807771, 597.527095709077, 622.8349487385841, 700.1283402164305, 702.5573888450278, 11663.183577149592, 14975.251237438126, 15668.216589170524, 15672.0, 15709.450169244064, 15103.0, 15269.541913742578, 15298.770518442205, 15306.69386612267, 15315.617109572266, 620.7113692133157, 753.9547627142362, 778.6651739751904, 779.40765018586, 780.9062912450514, 629.9905501417483, 755.8639444899916, 775.414562005685, 785.8546168958733, 787.6455594982252, 818.1899919080098, 822.1778221778221, 824.5794644731201, 824.8061705499233, 825.5830805443243, 653.7287025884252, 816.5590581086207, 817.5666896544841, 818.3003531980161, 818.8607936650753, 490.55359622743487, 578.4967078641608, 596.9343372229051, 599.0235915457775, 601.3715667127818, 13693.657658558615, 13704.588862334047, 13750.587482375544, 13754.449822007107, 13761.449542018307, 11605.709857253552, 11719.882801171965, 11948.28310301376, 12138.211016283913, 12431.440585173688, 10769.515371808287, 10829.620963266327, 11020.393878336688, 11092.55629774816, 11593.884061159364, 3656.8902932912056, 3678.2275722098393, 3728.3475391806323, 3736.23407201523, 3752.5365107608054, 52937.47062529364, 62197.37802621961, 63001.68499157475, 63081.0, 66373.0, 9646.324757267064, 9984.450855202887, 10219.489025548693, 10292.330998485075, 10377.273590848568, 18604.16281267346, 18606.627867442574, 18613.7207941881, 18620.44138675842, 18627.441176764718, 6776.966115169491, 6855.177378714487, 6880.552764070319, 7111.146662400545, 7128.679209435588, 3566.1619519412916, 3645.0, 3646.890593282206, 3650.762700424517, 3767.6232376762655, 2971.4799910015663, 3047.8628461719277, 3056.388722255513, 3058.525928481089, 3296.6868147525947, 534.6845361236889, 535.3388565122071, 542.4683809866353, 552.0614954577154, 559.0970582509218, 549.2886711708347, 551.685678578368, 590.3771521045338, 615.0, 630.3507387390995, 7397.81505462357, 7940.642671079815, 8344.207300306462, 8418.831623367498, 8604.924384451944, 469.7956388970809, 563.9520640745583, 576.3631187537794, 593.3769541980903, 602.5240060352272, 3850.383938569815, 3987.102901847119, 4023.2154729827403, 4043.534993475729, 4094.467719196485, 63242.991915767925, 66258.0, 68270.31729682739, 70309.64845175741, 70774.64612676903, 58915.41084589185, 59257.70371148203, 59905.733002885834, 60304.09543856846, 63147.36852631507, 53624.0, 54725.0, 55057.1741423879, 55592.0, 55742.0, 7604.42966777505, 8089.959550202211, 8139.14538973423, 8146.959265203873, 8319.209675080858, 38065.42901856419, 38439.807800960814, 38814.22371552497, 39494.60505394909, 39522.40716389199, 50233.497665022885, 52279.477205227464, 52325.0, 52752.47247527629, 53326.0, 9387.81224375495, 9460.574274157541, 9495.620175192915, 9553.713388598353, 9902.059304366074, 10340.27618066728, 10613.310134841211, 10622.628208012682, 10836.295640783324, 10940.124790016938, 9967.252456065678, 10091.142252908585, 10121.291509594257, 10162.644307449204, 10658.89341106579, 10759.784804304027, 10989.890101098887, 11007.0, 11470.483828227916, 11787.882121178678, 11348.375839328915, 11423.828642570203, 11680.591179308683, 11809.881901180877, 12197.0, 9020.90979090227, 9187.540622968958, 9316.813663726824, 9624.711258662252, 9813.411195328303, 9531.142197202285, 9698.46658433793, 9941.701748947544, 10171.64399246023, 10245.897541024495], "value": 6269.091580916482, "unit": "score"}], "name": "dromaeo_css", "value": 6227.9688163441415, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 116.0, 116.0, 117.0, 115.0, 114.0, 113.0, 115.0, 115.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 130.0, 144.0, 175.0, 130.0, 134.0, 127.0, 130.0, 154.0, 130.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 162.0, 162.0, 161.0, 160.0, 160.0, 159.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 102.0, 79.0, 78.0, 77.0, 76.0, 91.0, 77.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 115.0, 85.0, 85.0, 85.0, 100.0, 85.0, 85.0, 114.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 128.0, 127.0, 128.0, 127.0, 126.0, 127.0, 127.0, 127.0, 127.0], "value": 127.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 146.0, 147.0, 146.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0, 66.0, 69.0, 66.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 91.0, 86.0, 84.0, 84.0, 84.0, 85.0, 89.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 140.0, 148.0, 151.0, 151.0, 152.0, 143.0, 138.0, 191.0, 141.0], "value": 151.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 180.0, 180.0, 179.0, 180.0, 182.0, 176.0, 180.0, 179.0, 179.0], "value": 179.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 70.0, 74.0, 71.0, 69.0, 69.0, 68.0, 70.0, 73.0, 69.0], "value": 70.7, "unit": "score"}], "name": "kraken", "value": 1579.1000000000001, "alertThreshold": 2.0}]} 09:26:54 INFO - Return code: 0 09:26:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:26:54 INFO - # TBPL SUCCESS # 09:26:54 INFO - Running post-action listener: _resource_record_post_action 09:26:54 INFO - [mozharness: 2016-12-10 17:26:54.553471Z] Finished run-tests step (success) 09:26:54 INFO - Running post-run listener: _resource_record_post_run 09:26:54 INFO - Total resource usage - Wall time: 1208s; CPU: 13.0%; Read bytes: 8192; Write bytes: 389849088; Read time: 172; Write time: 259196 09:26:54 INFO - TinderboxPrint: CPU usage
13.1% 09:26:54 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 172 09:26:54 INFO - TinderboxPrint: I/O write bytes / time
389,849,088 / 259,196 09:26:54 INFO - TinderboxPrint: CPU idle
8,370.5 (86.8%) 09:26:54 INFO - TinderboxPrint: CPU user
1,216.8 (12.6%) 09:26:54 INFO - TinderboxPrint: Swap in / out
0 / 0 09:26:54 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99639296; Read time: 0; Write time: 99776 09:26:54 INFO - run-tests - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290209792; Read time: 164; Write time: 159420 09:26:55 INFO - Running post-run listener: _upload_blobber_files 09:26:55 INFO - Blob upload gear active. 09:26:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:26:55 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:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:26:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:26:55 INFO - (blobuploader) - INFO - Open directory for files ... 09:26:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:26:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:26:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:56 INFO - (blobuploader) - INFO - Done attempting. 09:26:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:26:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:26:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:59 INFO - (blobuploader) - INFO - Done attempting. 09:26:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:26:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:27:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:00 INFO - (blobuploader) - INFO - Done attempting. 09:27:00 INFO - (blobuploader) - INFO - Iteration through files over. 09:27:00 INFO - Return code: 0 09:27:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:27:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:27:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9670236251e924c7daf90c79d486a6f068d188c9714e889cf64e4720dfbd7c1b1df83b404405163dd28049407a2fae6144d3f133e556266d42cee048b85aec36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05d5596b45454af5532a8629ea5c2f09b75f8bf9f2740c39bd703572d71f7bde78b89a8cdcbceb6183d970991820b5a636e75a760b770e50c00085f1137b6e77", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b9a8aacd718a60d410f0452b0525cbbfc3be11dde0740258a46a1b004a9f0cf5fa63d237c51046091fb0abe30130d1790357845eacbba399e7799d8e8b8c399"} 09:27:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:27:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:27:00 INFO - Contents: 09:27:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9670236251e924c7daf90c79d486a6f068d188c9714e889cf64e4720dfbd7c1b1df83b404405163dd28049407a2fae6144d3f133e556266d42cee048b85aec36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05d5596b45454af5532a8629ea5c2f09b75f8bf9f2740c39bd703572d71f7bde78b89a8cdcbceb6183d970991820b5a636e75a760b770e50c00085f1137b6e77", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b9a8aacd718a60d410f0452b0525cbbfc3be11dde0740258a46a1b004a9f0cf5fa63d237c51046091fb0abe30130d1790357845eacbba399e7799d8e8b8c399"} 09:27:00 INFO - Running post-run listener: copy_logs_to_upload_dir 09:27:00 INFO - Copying logs to upload dir... 09:27:00 INFO - mkdir: /builds/slave/test/build/upload/logs 09:27:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.414396 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-12-10 09:26:59.903043) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-10 09:26:59.906310) ========= 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=4300f881736b422476174874000001bc-1481375912.477573-410408989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9670236251e924c7daf90c79d486a6f068d188c9714e889cf64e4720dfbd7c1b1df83b404405163dd28049407a2fae6144d3f133e556266d42cee048b85aec36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05d5596b45454af5532a8629ea5c2f09b75f8bf9f2740c39bd703572d71f7bde78b89a8cdcbceb6183d970991820b5a636e75a760b770e50c00085f1137b6e77", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b9a8aacd718a60d410f0452b0525cbbfc3be11dde0740258a46a1b004a9f0cf5fa63d237c51046091fb0abe30130d1790357845eacbba399e7799d8e8b8c399"} build_url:https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/JJuFAjinQx6isgb8jsmonQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9670236251e924c7daf90c79d486a6f068d188c9714e889cf64e4720dfbd7c1b1df83b404405163dd28049407a2fae6144d3f133e556266d42cee048b85aec36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05d5596b45454af5532a8629ea5c2f09b75f8bf9f2740c39bd703572d71f7bde78b89a8cdcbceb6183d970991820b5a636e75a760b770e50c00085f1137b6e77", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b9a8aacd718a60d410f0452b0525cbbfc3be11dde0740258a46a1b004a9f0cf5fa63d237c51046091fb0abe30130d1790357845eacbba399e7799d8e8b8c399"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-10 09:26:59.935025) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 09:26:59.935528) ========= 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=4300f881736b422476174874000001bc-1481375912.477573-410408989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 09:27:00.019035) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-10 09:27:00.019390) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-10 09:27:00.019711) ========= ========= Total master_lag: 0.18 =========