builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1472786631.16 results: success (0) buildid: 20160901190046 builduid: 09ea8af55366445eb1730c334cd5bece revision: d5f20820c80514476f596090292a5d77c4b41e3b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 20:23:51.164970) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 20:23:51.165540) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 20:23:51.165860) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 20:23:51.207869) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 20:23:51.208313) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-01 20:23:51-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-09-01 20:23:52 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.406748 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 20:23:51.630131) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 20:23:51.630506) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013835 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 20:23:51.681526) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 20:23:51.682014) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d5f20820c80514476f596090292a5d77c4b41e3b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d5f20820c80514476f596090292a5d77c4b41e3b --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=516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-01 20:23:52,184 truncating revision to first 12 chars 2016-09-01 20:23:52,184 Setting DEBUG logging. 2016-09-01 20:23:52,184 attempt 1/10 2016-09-01 20:23:52,184 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d5f20820c805?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 20:23:52,489 unpacking tar archive at: mozilla-central-d5f20820c805/testing/mozharness/ program finished with exit code 0 elapsedTime=0.705060 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 20:23:52.401596) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 20:23:52.402056) ========= script_repo_revision: d5f20820c80514476f596090292a5d77c4b41e3b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 20:23:52.402560) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 20:23:52.402888) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 20:23:52.413789) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-09-01 20:23:52.414254) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:23:53 INFO - MultiFileLogger online at 20160901 20:23:53 in /builds/slave/test 20:23:53 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 20:23:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:23:53 INFO - {'append_to_log': False, 20:23:53 INFO - 'base_work_dir': '/builds/slave/test', 20:23:53 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 20:23:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:23:53 INFO - 'branch': 'Firefox-Non-PGO', 20:23:53 INFO - 'buildbot_json_path': 'buildprops.json', 20:23:53 INFO - 'config_files': ('talos/linux_config.py',), 20:23:53 INFO - 'default_actions': ('clobber', 20:23:53 INFO - 'read-buildbot-config', 20:23:53 INFO - 'download-and-extract', 20:23:53 INFO - 'populate-webroot', 20:23:53 INFO - 'create-virtualenv', 20:23:53 INFO - 'install', 20:23:53 INFO - 'run-tests'), 20:23:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:23:53 INFO - 'download_minidump_stackwalk': True, 20:23:53 INFO - 'download_symbols': 'ondemand', 20:23:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:23:53 INFO - 'tooltool.py': '/tools/tooltool.py', 20:23:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:23:53 INFO - '/tools/misc-python/virtualenv.py')}, 20:23:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:23:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:23:53 INFO - 'installer_path': 'installer.exe', 20:23:53 INFO - 'log_level': 'info', 20:23:53 INFO - 'log_name': 'talos', 20:23:53 INFO - 'log_to_console': True, 20:23:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:23:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:23:53 INFO - 'opt_config_files': (), 20:23:53 INFO - 'pip_index': False, 20:23:53 INFO - 'sps_profile': False, 20:23:53 INFO - 'sps_profile_interval': 0, 20:23:53 INFO - 'suite': 'dromaeojs', 20:23:53 INFO - 'system_bits': '32', 20:23:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:23:53 INFO - 'title': 'talos-linux64-ix-061', 20:23:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:23:53 INFO - 'use_talos_json': True, 20:23:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:23:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:23:53 INFO - 'work_dir': 'build'} 20:23:53 INFO - [mozharness: 2016-09-02 03:23:53.015598Z] Running clobber step. 20:23:53 INFO - Running pre-action listener: _resource_record_pre_action 20:23:53 INFO - Running main action method: clobber 20:23:53 INFO - rmtree: /builds/slave/test/build 20:23:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:23:53 INFO - Running post-action listener: _resource_record_post_action 20:23:53 INFO - [mozharness: 2016-09-02 03:23:53.994259Z] Finished clobber step (success) 20:23:53 INFO - [mozharness: 2016-09-02 03:23:53.994360Z] Running read-buildbot-config step. 20:23:53 INFO - Running pre-action listener: _resource_record_pre_action 20:23:53 INFO - Running main action method: read_buildbot_config 20:23:53 INFO - Using buildbot properties: 20:23:53 INFO - { 20:23:53 INFO - "project": "", 20:23:53 INFO - "product": "firefox", 20:23:53 INFO - "script_repo_revision": "production", 20:23:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 20:23:53 INFO - "repository": "", 20:23:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 20:23:53 INFO - "buildid": "20160901190046", 20:23:53 INFO - "pgo_build": "False", 20:23:53 INFO - "basedir": "/builds/slave/test", 20:23:53 INFO - "buildnumber": 625, 20:23:53 INFO - "slavename": "talos-linux64-ix-061", 20:23:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:23:53 INFO - "platform": "ubuntu64_hw", 20:23:53 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 20:23:53 INFO - "branch": "mozilla-central", 20:23:53 INFO - "repo_path": "mozilla-central", 20:23:53 INFO - "revision": "d5f20820c80514476f596090292a5d77c4b41e3b", 20:23:53 INFO - "stage_platform": "linux64", 20:23:53 INFO - "builduid": "09ea8af55366445eb1730c334cd5bece", 20:23:53 INFO - "slavebuilddir": "test" 20:23:53 INFO - } 20:23:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/NnxGUL8-SvCaoxWogUKw1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 20:23:53 INFO - Running post-action listener: _resource_record_post_action 20:23:53 INFO - [mozharness: 2016-09-02 03:23:53.996814Z] Finished read-buildbot-config step (success) 20:23:53 INFO - [mozharness: 2016-09-02 03:23:53.996905Z] Running download-and-extract step. 20:23:53 INFO - Running pre-action listener: _resource_record_pre_action 20:23:53 INFO - Running main action method: download_and_extract 20:23:53 INFO - mkdir: /builds/slave/test/build/tests 20:23:53 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')]} 20:23:53 INFO - trying https://queue.taskcluster.net/v1/task/NnxGUL8-SvCaoxWogUKw1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:23:53 INFO - Downloading https://queue.taskcluster.net/v1/task/NnxGUL8-SvCaoxWogUKw1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:23:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NnxGUL8-SvCaoxWogUKw1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:23:54 INFO - Downloaded 1361 bytes. 20:23:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:23:54 INFO - Using the following test package requirements: 20:23:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:23:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:23:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:23:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:23:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:23:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:23:54 INFO - u'jsshell-linux-x86_64.zip'], 20:23:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:23:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:23:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:23:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:23:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:23:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:23:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:23:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:23:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:23:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:23:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:23:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:23:54 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')]} 20:23:54 INFO - trying https://queue.taskcluster.net/v1/task/NnxGUL8-SvCaoxWogUKw1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:23:54 INFO - Downloading https://queue.taskcluster.net/v1/task/NnxGUL8-SvCaoxWogUKw1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:23:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NnxGUL8-SvCaoxWogUKw1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:23:55 INFO - Downloaded 20334479 bytes. 20:23:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 20:23:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:23:59 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')]} 20:23:59 INFO - trying https://queue.taskcluster.net/v1/task/NnxGUL8-SvCaoxWogUKw1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:23:59 INFO - Downloading https://queue.taskcluster.net/v1/task/NnxGUL8-SvCaoxWogUKw1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:23:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NnxGUL8-SvCaoxWogUKw1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:24:00 INFO - Downloaded 20334479 bytes. 20:24:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 20:24:05 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')]} 20:24:05 INFO - trying https://queue.taskcluster.net/v1/task/NnxGUL8-SvCaoxWogUKw1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:24:05 INFO - Downloading https://queue.taskcluster.net/v1/task/NnxGUL8-SvCaoxWogUKw1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:24:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NnxGUL8-SvCaoxWogUKw1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:24:06 INFO - Downloaded 14413998 bytes. 20:24:06 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 20:24:06 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')]} 20:24:06 INFO - trying https://queue.taskcluster.net/v1/task/NnxGUL8-SvCaoxWogUKw1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:24:06 INFO - Downloading https://queue.taskcluster.net/v1/task/NnxGUL8-SvCaoxWogUKw1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:24:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NnxGUL8-SvCaoxWogUKw1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:24:07 INFO - Downloaded 55866045 bytes. 20:24:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NnxGUL8-SvCaoxWogUKw1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:24:07 INFO - mkdir: /builds/slave/test/properties 20:24:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:24:07 INFO - Writing to file /builds/slave/test/properties/build_url 20:24:07 INFO - Contents: 20:24:07 INFO - build_url:https://queue.taskcluster.net/v1/task/NnxGUL8-SvCaoxWogUKw1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:24:08 INFO - Running post-action listener: _resource_record_post_action 20:24:08 INFO - Running post-action listener: set_extra_try_arguments 20:24:08 INFO - [mozharness: 2016-09-02 03:24:08.296994Z] Finished download-and-extract step (success) 20:24:08 INFO - [mozharness: 2016-09-02 03:24:08.297265Z] Running populate-webroot step. 20:24:08 INFO - Running pre-action listener: _resource_record_pre_action 20:24:08 INFO - Running main action method: populate_webroot 20:24:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:24:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:24:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:24:08 INFO - '--tppagecycles', 20:24:08 INFO - '7'], 20:24:08 INFO - 'tests': ['tsvgm']}}, 20:24:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:24:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:24:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:24:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:24:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:24:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:24:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:08 INFO - 'talos_options': ['--disable-e10s'], 20:24:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:24:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:24:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:08 INFO - 'talos_options': ['--disable-e10s'], 20:24:08 INFO - 'tests': ['damp', 'tps']}, 20:24:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:08 INFO - 'tests': ['damp', 'tps']}, 20:24:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:24:08 INFO - 'tests': ['dromaeo_dom']}, 20:24:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:24:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:24:08 INFO - 'tests': ['basic_compositor_video']}, 20:24:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:24:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:24:08 INFO - 'tests': ['a11yr', 20:24:08 INFO - 'ts_paint', 20:24:08 INFO - 'tpaint', 20:24:08 INFO - 'sessionrestore', 20:24:08 INFO - 'sessionrestore_no_auto_restore', 20:24:08 INFO - 'tabpaint']}, 20:24:08 INFO - 'other-e10s': {'tests': ['a11yr', 20:24:08 INFO - 'ts_paint', 20:24:08 INFO - 'tpaint', 20:24:08 INFO - 'sessionrestore', 20:24:08 INFO - 'sessionrestore_no_auto_restore', 20:24:08 INFO - 'tabpaint']}, 20:24:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:24:08 INFO - 'ts_paint', 20:24:08 INFO - 'tpaint', 20:24:08 INFO - 'sessionrestore', 20:24:08 INFO - 'sessionrestore_no_auto_restore', 20:24:08 INFO - 'tabpaint']}, 20:24:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:24:08 INFO - 'ts_paint', 20:24:08 INFO - 'tpaint', 20:24:08 INFO - 'sessionrestore', 20:24:08 INFO - 'sessionrestore_no_auto_restore', 20:24:08 INFO - 'tabpaint']}, 20:24:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:24:08 INFO - 'tests': ['a11yr', 20:24:08 INFO - 'ts_paint', 20:24:08 INFO - 'tpaint', 20:24:08 INFO - 'sessionrestore', 20:24:08 INFO - 'sessionrestore_no_auto_restore', 20:24:08 INFO - 'tabpaint']}, 20:24:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:24:08 INFO - 'tests': ['a11yr', 20:24:08 INFO - 'ts_paint', 20:24:08 INFO - 'tpaint', 20:24:08 INFO - 'sessionrestore', 20:24:08 INFO - 'sessionrestore_no_auto_restore', 20:24:08 INFO - 'tabpaint']}, 20:24:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:24:08 INFO - 'tests': ['tsvgx', 20:24:08 INFO - 'tsvgr_opacity', 20:24:08 INFO - 'tart', 20:24:08 INFO - 'tscrollx', 20:24:08 INFO - 'cart']}, 20:24:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:24:08 INFO - 'tsvgr_opacity', 20:24:08 INFO - 'tart', 20:24:08 INFO - 'tscrollx', 20:24:08 INFO - 'cart']}, 20:24:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:08 INFO - 'talos_options': ['--disable-e10s'], 20:24:08 INFO - 'tests': ['tp5o']}, 20:24:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:08 INFO - 'tests': ['tp5o']}, 20:24:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:08 INFO - 'talos_options': ['--disable-e10s', 20:24:08 INFO - '--xperf_path', 20:24:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:24:08 INFO - 'tests': ['tp5n']}, 20:24:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:08 INFO - 'talos_options': ['--xperf_path', 20:24:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:24:08 INFO - 'tests': ['tp5n']}}, 20:24:08 INFO - 'talos.zip': {'path': '', 20:24:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:24:08 INFO - Running post-action listener: _resource_record_post_action 20:24:08 INFO - [mozharness: 2016-09-02 03:24:08.313124Z] Finished populate-webroot step (success) 20:24:08 INFO - [mozharness: 2016-09-02 03:24:08.313216Z] Running create-virtualenv step. 20:24:08 INFO - Running pre-action listener: _resource_record_pre_action 20:24:08 INFO - Running main action method: create_virtualenv 20:24:08 INFO - Creating virtualenv /builds/slave/test/build/venv 20:24:08 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 20:24:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:24:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:24:08 INFO - Using real prefix '/usr' 20:24:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:24:08 INFO - Installing distribute.............................................................................................................................................................................................done. 20:24:10 INFO - Installing pip.................done. 20:24:10 INFO - Return code: 0 20:24:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:24:10 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')]} 20:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:10 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')]} 20:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:10 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 0x7f57a0691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2137420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c5d20>, '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 0x21c6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c70b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580', '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 20:24:10 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 20:24:10 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 20:24:10 INFO - Using env: {'DISPLAY': ':0', 20:24:10 INFO - 'HOME': '/home/cltbld', 20:24:10 INFO - 'LANG': 'en_US.UTF-8', 20:24:10 INFO - 'LANGUAGE': 'en_US:en', 20:24:10 INFO - 'LOGNAME': 'cltbld', 20:24:10 INFO - 'MAIL': '/var/mail/cltbld', 20:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:10 INFO - 'MOZ_NO_REMOTE': '1', 20:24:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:24:10 INFO - 'NO_EM_RESTART': '1', 20:24:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:10 INFO - 'PWD': '/builds/slave/test', 20:24:10 INFO - 'SHELL': '/bin/bash', 20:24:10 INFO - 'SHLVL': '1', 20:24:10 INFO - 'TERM': 'linux', 20:24:10 INFO - 'TMOUT': '86400', 20:24:10 INFO - 'USER': 'cltbld', 20:24:10 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580', 20:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:10 INFO - '_': '/tools/buildbot/bin/python'} 20:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:11 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 20:24:11 INFO - Cleaning up... 20:24:11 INFO - Return code: 0 20:24:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:24:11 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')]} 20:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:11 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')]} 20:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:11 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 0x7f57a0691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2137420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c5d20>, '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 0x21c6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c70b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580', '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 20:24:11 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 20:24:11 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 20:24:11 INFO - Using env: {'DISPLAY': ':0', 20:24:11 INFO - 'HOME': '/home/cltbld', 20:24:11 INFO - 'LANG': 'en_US.UTF-8', 20:24:11 INFO - 'LANGUAGE': 'en_US:en', 20:24:11 INFO - 'LOGNAME': 'cltbld', 20:24:11 INFO - 'MAIL': '/var/mail/cltbld', 20:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:11 INFO - 'MOZ_NO_REMOTE': '1', 20:24:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:24:11 INFO - 'NO_EM_RESTART': '1', 20:24:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:11 INFO - 'PWD': '/builds/slave/test', 20:24:11 INFO - 'SHELL': '/bin/bash', 20:24:11 INFO - 'SHLVL': '1', 20:24:11 INFO - 'TERM': 'linux', 20:24:11 INFO - 'TMOUT': '86400', 20:24:11 INFO - 'USER': 'cltbld', 20:24:11 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580', 20:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:11 INFO - '_': '/tools/buildbot/bin/python'} 20:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:11 INFO - Downloading/unpacking psutil>=3.1.1 20:24:11 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 20:24:11 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 20:24:11 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 20:24:11 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 20:24:11 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 20:24:11 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 20:24:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:24:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:24:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:24:13 INFO - Installing collected packages: psutil 20:24:13 INFO - Running setup.py install for psutil 20:24:13 INFO - building 'psutil._psutil_linux' extension 20:24:13 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 20:24:13 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 20:24:13 INFO - building 'psutil._psutil_posix' extension 20:24:13 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 20:24:13 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 20:24:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:24:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:24:13 INFO - Successfully installed psutil 20:24:13 INFO - Cleaning up... 20:24:13 INFO - Return code: 0 20:24:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:24:13 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')]} 20:24:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:13 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')]} 20:24:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:13 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 0x7f57a0691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2137420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c5d20>, '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 0x21c6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c70b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580', '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 20:24:13 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 20:24:13 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 20:24:13 INFO - Using env: {'DISPLAY': ':0', 20:24:13 INFO - 'HOME': '/home/cltbld', 20:24:13 INFO - 'LANG': 'en_US.UTF-8', 20:24:13 INFO - 'LANGUAGE': 'en_US:en', 20:24:13 INFO - 'LOGNAME': 'cltbld', 20:24:13 INFO - 'MAIL': '/var/mail/cltbld', 20:24:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:13 INFO - 'MOZ_NO_REMOTE': '1', 20:24:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:24:13 INFO - 'NO_EM_RESTART': '1', 20:24:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:24:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:13 INFO - 'PWD': '/builds/slave/test', 20:24:13 INFO - 'SHELL': '/bin/bash', 20:24:13 INFO - 'SHLVL': '1', 20:24:13 INFO - 'TERM': 'linux', 20:24:13 INFO - 'TMOUT': '86400', 20:24:13 INFO - 'USER': 'cltbld', 20:24:13 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580', 20:24:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:13 INFO - '_': '/tools/buildbot/bin/python'} 20:24:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:24:14 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 20:24:14 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 20:24:14 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 20:24:14 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 20:24:14 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 20:24:14 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 20:24:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:24:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:24:16 INFO - Installing collected packages: mozsystemmonitor 20:24:16 INFO - Running setup.py install for mozsystemmonitor 20:24:16 INFO - Successfully installed mozsystemmonitor 20:24:16 INFO - Cleaning up... 20:24:16 INFO - Return code: 0 20:24:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:24:16 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')]} 20:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:16 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')]} 20:24:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:16 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 0x7f57a0691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2137420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c5d20>, '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 0x21c6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c70b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580', '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 20:24:16 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 20:24:16 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 20:24:16 INFO - Using env: {'DISPLAY': ':0', 20:24:16 INFO - 'HOME': '/home/cltbld', 20:24:16 INFO - 'LANG': 'en_US.UTF-8', 20:24:16 INFO - 'LANGUAGE': 'en_US:en', 20:24:16 INFO - 'LOGNAME': 'cltbld', 20:24:16 INFO - 'MAIL': '/var/mail/cltbld', 20:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:16 INFO - 'MOZ_NO_REMOTE': '1', 20:24:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:24:16 INFO - 'NO_EM_RESTART': '1', 20:24:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:16 INFO - 'PWD': '/builds/slave/test', 20:24:16 INFO - 'SHELL': '/bin/bash', 20:24:16 INFO - 'SHLVL': '1', 20:24:16 INFO - 'TERM': 'linux', 20:24:16 INFO - 'TMOUT': '86400', 20:24:16 INFO - 'USER': 'cltbld', 20:24:16 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580', 20:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:16 INFO - '_': '/tools/buildbot/bin/python'} 20:24:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:16 INFO - Downloading/unpacking jsonschema==2.5.1 20:24:16 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 20:24:16 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 20:24:16 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 20:24:16 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 20:24:16 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 20:24:16 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 20:24:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:24:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:18 INFO - Downloading functools32-3.2.3-2.tar.gz 20:24:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:24:18 INFO - warning: no files found matching '*.txt' 20:24:18 INFO - no previously-included directories found matching 'build' 20:24:18 INFO - no previously-included directories found matching 'dist' 20:24:18 INFO - no previously-included directories found matching '.git*' 20:24:18 INFO - Installing collected packages: jsonschema, functools32 20:24:18 INFO - Running setup.py install for functools32 20:24:18 INFO - warning: no files found matching '*.txt' 20:24:18 INFO - no previously-included directories found matching 'build' 20:24:18 INFO - no previously-included directories found matching 'dist' 20:24:18 INFO - no previously-included directories found matching '.git*' 20:24:18 INFO - Successfully installed jsonschema functools32 20:24:18 INFO - Cleaning up... 20:24:18 INFO - Return code: 0 20:24:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f57a0691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2137420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c5d20>, '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 0x21c6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c70b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580', '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 20:24:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:24:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:24:18 INFO - Using env: {'DISPLAY': ':0', 20:24:18 INFO - 'HOME': '/home/cltbld', 20:24:18 INFO - 'LANG': 'en_US.UTF-8', 20:24:18 INFO - 'LANGUAGE': 'en_US:en', 20:24:18 INFO - 'LOGNAME': 'cltbld', 20:24:18 INFO - 'MAIL': '/var/mail/cltbld', 20:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:18 INFO - 'MOZ_NO_REMOTE': '1', 20:24:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:24:18 INFO - 'NO_EM_RESTART': '1', 20:24:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:18 INFO - 'PWD': '/builds/slave/test', 20:24:18 INFO - 'SHELL': '/bin/bash', 20:24:18 INFO - 'SHLVL': '1', 20:24:18 INFO - 'TERM': 'linux', 20:24:18 INFO - 'TMOUT': '86400', 20:24:18 INFO - 'USER': 'cltbld', 20:24:18 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580', 20:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:18 INFO - '_': '/tools/buildbot/bin/python'} 20:24:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:24:18 INFO - Cleaning up... 20:24:18 INFO - Return code: 0 20:24:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f57a0691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2137420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c5d20>, '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 0x21c6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c70b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580', '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 20:24:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:24:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:24:18 INFO - Using env: {'DISPLAY': ':0', 20:24:18 INFO - 'HOME': '/home/cltbld', 20:24:18 INFO - 'LANG': 'en_US.UTF-8', 20:24:18 INFO - 'LANGUAGE': 'en_US:en', 20:24:18 INFO - 'LOGNAME': 'cltbld', 20:24:18 INFO - 'MAIL': '/var/mail/cltbld', 20:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:18 INFO - 'MOZ_NO_REMOTE': '1', 20:24:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:24:18 INFO - 'NO_EM_RESTART': '1', 20:24:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:18 INFO - 'PWD': '/builds/slave/test', 20:24:18 INFO - 'SHELL': '/bin/bash', 20:24:18 INFO - 'SHLVL': '1', 20:24:18 INFO - 'TERM': 'linux', 20:24:18 INFO - 'TMOUT': '86400', 20:24:18 INFO - 'USER': 'cltbld', 20:24:18 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580', 20:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:18 INFO - '_': '/tools/buildbot/bin/python'} 20:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:19 INFO - Downloading/unpacking blobuploader==1.2.4 20:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:19 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 20:24:19 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 20:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:21 INFO - Downloading blobuploader-1.2.4.tar.gz 20:24:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:24:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:24:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:21 INFO - Downloading docopt-0.6.1.tar.gz 20:24:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:24:21 INFO - Installing collected packages: blobuploader, requests, docopt 20:24:21 INFO - Running setup.py install for blobuploader 20:24:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:24:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:24:21 INFO - Running setup.py install for requests 20:24:22 INFO - Running setup.py install for docopt 20:24:22 INFO - Successfully installed blobuploader requests docopt 20:24:22 INFO - Cleaning up... 20:24:22 INFO - Return code: 0 20:24:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:24:22 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')]} 20:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:22 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')]} 20:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:22 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 0x7f57a0691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2137420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c5d20>, '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 0x21c6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c70b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580', '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 20:24:22 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 20:24:22 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 20:24:22 INFO - Using env: {'DISPLAY': ':0', 20:24:22 INFO - 'HOME': '/home/cltbld', 20:24:22 INFO - 'LANG': 'en_US.UTF-8', 20:24:22 INFO - 'LANGUAGE': 'en_US:en', 20:24:22 INFO - 'LOGNAME': 'cltbld', 20:24:22 INFO - 'MAIL': '/var/mail/cltbld', 20:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:22 INFO - 'MOZ_NO_REMOTE': '1', 20:24:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:24:22 INFO - 'NO_EM_RESTART': '1', 20:24:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:22 INFO - 'PWD': '/builds/slave/test', 20:24:22 INFO - 'SHELL': '/bin/bash', 20:24:22 INFO - 'SHLVL': '1', 20:24:22 INFO - 'TERM': 'linux', 20:24:22 INFO - 'TMOUT': '86400', 20:24:22 INFO - 'USER': 'cltbld', 20:24:22 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580', 20:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:22 INFO - '_': '/tools/buildbot/bin/python'} 20:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:24:22 INFO - Running setup.py (path:/tmp/pip-C46dpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:24:22 INFO - Running setup.py (path:/tmp/pip-Qdi65t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:24:22 INFO - Running setup.py (path:/tmp/pip-b0L384-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:24:22 INFO - Running setup.py (path:/tmp/pip-q35caX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:24:22 INFO - Running setup.py (path:/tmp/pip-dXURRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:24:23 INFO - Running setup.py (path:/tmp/pip-hDQRN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:24:23 INFO - Running setup.py (path:/tmp/pip-fl5aPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:24:23 INFO - Running setup.py (path:/tmp/pip-ZfyXzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:24:23 INFO - Running setup.py (path:/tmp/pip-7UpSUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:24:23 INFO - Running setup.py (path:/tmp/pip-8OGnwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:24:23 INFO - Running setup.py (path:/tmp/pip-Vv4zcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:24:23 INFO - Running setup.py (path:/tmp/pip-Ao7yiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:24:23 INFO - Running setup.py (path:/tmp/pip-5v3sP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:24:23 INFO - Running setup.py (path:/tmp/pip-K_3mu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:24:23 INFO - Running setup.py (path:/tmp/pip-gY9zxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:24:23 INFO - Running setup.py (path:/tmp/pip-lRBlxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:24:23 INFO - Running setup.py (path:/tmp/pip-hOVQos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:24:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:24:23 INFO - Running setup.py install for manifestparser 20:24:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:24:23 INFO - Running setup.py install for mozcrash 20:24:24 INFO - Running setup.py install for mozdebug 20:24:24 INFO - Running setup.py install for mozdevice 20:24:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:24:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:24:24 INFO - Running setup.py install for mozfile 20:24:24 INFO - Running setup.py install for mozhttpd 20:24:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:24:24 INFO - Running setup.py install for mozinfo 20:24:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:24:24 INFO - Running setup.py install for mozInstall 20:24:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:24:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:24:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:24:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:24:24 INFO - Running setup.py install for mozleak 20:24:24 INFO - Running setup.py install for mozlog 20:24:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:24:24 INFO - Running setup.py install for moznetwork 20:24:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:24:25 INFO - Running setup.py install for mozprocess 20:24:25 INFO - Running setup.py install for mozprofile 20:24:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:24:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:24:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:24:25 INFO - Running setup.py install for mozrunner 20:24:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:24:25 INFO - Running setup.py install for mozscreenshot 20:24:25 INFO - Running setup.py install for moztest 20:24:25 INFO - Running setup.py install for mozversion 20:24:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:24:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:24:25 INFO - Cleaning up... 20:24:25 INFO - Return code: 0 20:24:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:24:25 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')]} 20:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:25 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')]} 20:24:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:25 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 0x7f57a0691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2137420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c5d20>, '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 0x21c6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c70b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580', '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 20:24:25 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 20:24:25 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 20:24:25 INFO - Using env: {'DISPLAY': ':0', 20:24:25 INFO - 'HOME': '/home/cltbld', 20:24:25 INFO - 'LANG': 'en_US.UTF-8', 20:24:25 INFO - 'LANGUAGE': 'en_US:en', 20:24:25 INFO - 'LOGNAME': 'cltbld', 20:24:25 INFO - 'MAIL': '/var/mail/cltbld', 20:24:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:25 INFO - 'MOZ_NO_REMOTE': '1', 20:24:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:24:25 INFO - 'NO_EM_RESTART': '1', 20:24:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:24:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:25 INFO - 'PWD': '/builds/slave/test', 20:24:25 INFO - 'SHELL': '/bin/bash', 20:24:25 INFO - 'SHLVL': '1', 20:24:25 INFO - 'TERM': 'linux', 20:24:25 INFO - 'TMOUT': '86400', 20:24:25 INFO - 'USER': 'cltbld', 20:24:25 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580', 20:24:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:25 INFO - '_': '/tools/buildbot/bin/python'} 20:24:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:24:25 INFO - Running setup.py (path:/tmp/pip-C4nsIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:24:25 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)) 20:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:24:25 INFO - Running setup.py (path:/tmp/pip-48xQdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 20:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:24:26 INFO - Running setup.py (path:/tmp/pip-caluJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:24:26 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)) 20:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:24:26 INFO - Running setup.py (path:/tmp/pip-Wg_cR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 20:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:24:26 INFO - Running setup.py (path:/tmp/pip-k9orS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:24:26 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)) 20:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:24:26 INFO - Running setup.py (path:/tmp/pip-XHN0Ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:24:26 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)) 20:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:24:26 INFO - Running setup.py (path:/tmp/pip-sLRNFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:24:26 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)) 20:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:24:26 INFO - Running setup.py (path:/tmp/pip-4LwdFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:24:26 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)) 20:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:24:26 INFO - Running setup.py (path:/tmp/pip-p0C5M5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:24:26 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)) 20:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:24:26 INFO - Running setup.py (path:/tmp/pip-rvBctk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 20:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:24:26 INFO - Running setup.py (path:/tmp/pip-GUUKza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:24:26 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)) 20:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:24:26 INFO - Running setup.py (path:/tmp/pip-gS8hPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:24:26 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)) 20:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:24:26 INFO - Running setup.py (path:/tmp/pip-QpmF1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:24:26 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)) 20:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:24:26 INFO - Running setup.py (path:/tmp/pip-rwIcSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 20:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:24:26 INFO - Running setup.py (path:/tmp/pip-cFnNLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:24:26 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)) 20:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:24:26 INFO - Running setup.py (path:/tmp/pip-0eQFiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:24:27 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)) 20:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:24:27 INFO - Running setup.py (path:/tmp/pip-ZbW6X9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:24:27 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)) 20:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:24:27 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)) 20:24:27 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:24:27 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:24:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:29 INFO - Downloading blessings-1.6.tar.gz 20:24:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:24:29 INFO - Installing collected packages: blessings 20:24:29 INFO - Running setup.py install for blessings 20:24:29 INFO - Successfully installed blessings 20:24:29 INFO - Cleaning up... 20:24:29 INFO - Return code: 0 20:24:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:24:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:24:29 INFO - Reading from file tmpfile_stdout 20:24:29 INFO - Current package versions: 20:24:29 INFO - argparse == 1.2.1 20:24:29 INFO - blessings == 1.6 20:24:29 INFO - blobuploader == 1.2.4 20:24:29 INFO - docopt == 0.6.1 20:24:29 INFO - functools32 == 3.2.3-2 20:24:29 INFO - jsonschema == 2.5.1 20:24:29 INFO - manifestparser == 1.1 20:24:29 INFO - mozInstall == 1.12 20:24:29 INFO - mozcrash == 0.17 20:24:29 INFO - mozdebug == 0.1 20:24:29 INFO - mozdevice == 0.48 20:24:29 INFO - mozfile == 1.2 20:24:29 INFO - mozhttpd == 0.7 20:24:29 INFO - mozinfo == 0.9 20:24:29 INFO - mozleak == 0.1 20:24:29 INFO - mozlog == 3.3 20:24:29 INFO - moznetwork == 0.27 20:24:29 INFO - mozprocess == 0.23 20:24:29 INFO - mozprofile == 0.28 20:24:29 INFO - mozrunner == 6.12 20:24:29 INFO - mozscreenshot == 0.1 20:24:29 INFO - mozsystemmonitor == 0.3 20:24:29 INFO - moztest == 0.7 20:24:29 INFO - mozversion == 1.4 20:24:29 INFO - psutil == 3.1.1 20:24:29 INFO - requests == 1.2.3 20:24:29 INFO - wsgiref == 0.1.2 20:24:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:24: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')]} 20:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24: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')]} 20:24:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:29 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 0x7f57a0691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2137420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c5d20>, '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 0x21c6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c70b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580', '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 20:24:29 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 20:24:29 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 20:24:29 INFO - Using env: {'DISPLAY': ':0', 20:24:29 INFO - 'HOME': '/home/cltbld', 20:24:29 INFO - 'LANG': 'en_US.UTF-8', 20:24:29 INFO - 'LANGUAGE': 'en_US:en', 20:24:29 INFO - 'LOGNAME': 'cltbld', 20:24:29 INFO - 'MAIL': '/var/mail/cltbld', 20:24:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:29 INFO - 'MOZ_NO_REMOTE': '1', 20:24:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:24:29 INFO - 'NO_EM_RESTART': '1', 20:24:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:24:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:29 INFO - 'PWD': '/builds/slave/test', 20:24:29 INFO - 'SHELL': '/bin/bash', 20:24:29 INFO - 'SHLVL': '1', 20:24:29 INFO - 'TERM': 'linux', 20:24:29 INFO - 'TMOUT': '86400', 20:24:29 INFO - 'USER': 'cltbld', 20:24:29 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580', 20:24:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:29 INFO - '_': '/tools/buildbot/bin/python'} 20:24:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:29 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)) 20:24:29 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)) 20:24:29 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)) 20:24:29 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)) 20:24:29 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)) 20:24:29 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)) 20:24:29 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)) 20:24:29 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)) 20:24:29 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)) 20:24:29 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)) 20:24:29 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)) 20:24:29 INFO - Cleaning up... 20:24:29 INFO - Return code: 0 20:24:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:24: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')]} 20:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24: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')]} 20:24:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f57a0691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2137420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c5d20>, '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 0x21c6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c70b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580', '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 20:24: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', 'jsonschema'] in /builds/slave/test/build 20:24: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 jsonschema 20:24:29 INFO - Using env: {'DISPLAY': ':0', 20:24:29 INFO - 'HOME': '/home/cltbld', 20:24:29 INFO - 'LANG': 'en_US.UTF-8', 20:24:29 INFO - 'LANGUAGE': 'en_US:en', 20:24:29 INFO - 'LOGNAME': 'cltbld', 20:24:29 INFO - 'MAIL': '/var/mail/cltbld', 20:24:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:29 INFO - 'MOZ_NO_REMOTE': '1', 20:24:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:24:29 INFO - 'NO_EM_RESTART': '1', 20:24:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:24:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:29 INFO - 'PWD': '/builds/slave/test', 20:24:29 INFO - 'SHELL': '/bin/bash', 20:24:29 INFO - 'SHLVL': '1', 20:24:29 INFO - 'TERM': 'linux', 20:24:29 INFO - 'TMOUT': '86400', 20:24:29 INFO - 'USER': 'cltbld', 20:24:29 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580', 20:24:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:29 INFO - '_': '/tools/buildbot/bin/python'} 20:24:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:24:29 INFO - Cleaning up... 20:24:29 INFO - Return code: 0 20:24:29 INFO - Running post-action listener: _resource_record_post_action 20:24:29 INFO - Running post-action listener: _start_resource_monitoring 20:24:29 INFO - Starting resource monitoring. 20:24:29 INFO - [mozharness: 2016-09-02 03:24:29.964487Z] Finished create-virtualenv step (success) 20:24:29 INFO - [mozharness: 2016-09-02 03:24:29.964956Z] Running install step. 20:24:29 INFO - Running pre-action listener: _resource_record_pre_action 20:24:29 INFO - Running main action method: install 20:24:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:24:30 INFO - Reading from file tmpfile_stdout 20:24:30 INFO - Detecting whether we're running mozinstall >=1.0... 20:24:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:24:30 INFO - Reading from file tmpfile_stdout 20:24:30 INFO - Output received: 20:24:30 INFO - Usage: mozinstall [options] installer 20:24:30 INFO - Options: 20:24:30 INFO - -h, --help show this help message and exit 20:24:30 INFO - -d DEST, --destination=DEST 20:24:30 INFO - Directory to install application into. [default: 20:24:30 INFO - "/builds/slave/test"] 20:24:30 INFO - --app=APP Application being installed. [default: firefox] 20:24:30 INFO - mkdir: /builds/slave/test/build/application 20:24:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:24:47 INFO - Reading from file tmpfile_stdout 20:24:47 INFO - Output received: 20:24:47 INFO - /builds/slave/test/build/application/firefox/firefox 20:24:47 INFO - Running post-action listener: _resource_record_post_action 20:24:47 INFO - [mozharness: 2016-09-02 03:24:47.049020Z] Finished install step (success) 20:24:47 INFO - [mozharness: 2016-09-02 03:24:47.049346Z] Running run-tests step. 20:24:47 INFO - Running pre-action listener: _resource_record_pre_action 20:24:47 INFO - Running main action method: run_tests 20:24:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:24:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:24:47 INFO - Python 2.7.3 20:24:47 INFO - Return code: 0 20:24:47 INFO - grabbing minidump binary from tooltool 20:24:47 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')]} 20:24:47 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 0x21c5d20>, '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 0x21c6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c70b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:24:47 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 20:24:47 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 20:24:47 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 20:24:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:24:47 INFO - Return code: 0 20:24:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:24:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:24:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:24:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:24:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:24:47 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/NnxGUL8-SvCaoxWogUKw1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 20:24:47 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/NnxGUL8-SvCaoxWogUKw1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 20:24:47 INFO - Using env: {'DISPLAY': ':0', 20:24:47 INFO - 'HOME': '/home/cltbld', 20:24:47 INFO - 'LANG': 'en_US.UTF-8', 20:24:47 INFO - 'LANGUAGE': 'en_US:en', 20:24:47 INFO - 'LOGNAME': 'cltbld', 20:24:47 INFO - 'MAIL': '/var/mail/cltbld', 20:24:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:24:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:47 INFO - 'MOZ_NO_REMOTE': '1', 20:24:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:24:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:24:47 INFO - 'NO_EM_RESTART': '1', 20:24:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:47 INFO - 'PWD': '/builds/slave/test', 20:24:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:24:47 INFO - 'SHELL': '/bin/bash', 20:24:47 INFO - 'SHLVL': '1', 20:24:47 INFO - 'TERM': 'linux', 20:24:47 INFO - 'TMOUT': '86400', 20:24:47 INFO - 'USER': 'cltbld', 20:24:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580', 20:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:47 INFO - '_': '/tools/buildbot/bin/python'} 20:24:47 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/NnxGUL8-SvCaoxWogUKw1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 20:24:47 INFO - mozversion application_buildid: 20160901190046 20:24:47 INFO - mozversion application_changeset: d5f20820c80514476f596090292a5d77c4b41e3b 20:24:47 INFO - mozversion application_display_name: Nightly 20:24:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:24:47 INFO - mozversion application_name: Firefox 20:24:47 INFO - mozversion application_remotingname: firefox 20:24:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:24:47 INFO - mozversion application_vendor: Mozilla 20:24:47 INFO - mozversion application_version: 51.0a1 20:24:47 INFO - mozversion platform_buildid: 20160901190046 20:24:47 INFO - mozversion platform_changeset: d5f20820c80514476f596090292a5d77c4b41e3b 20:24:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:24:47 INFO - mozversion platform_version: 51.0a1 20:24:47 INFO - using testdate: 1472786687 20:24:47 INFO - actual date: 1472786687 20:24:47 INFO - starting webserver on 'localhost:40747' 20:24:47 INFO - SUITE-START | Running 2 tests 20:24:47 INFO - TEST-START | dromaeo_css 20:24:47 INFO - operating with platform_type : linux_ 20:24:47 INFO - Initialising browser for dromaeo_css test... 20:24:47 INFO - TEST-INFO | started process 1115 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyXcmwI/profile http://localhost:40747/getInfo.html) 20:24:52 INFO - PROCESS | 1115 | __metrics Screen width/height:1600/1200 20:24:52 INFO - PROCESS | 1115 | colorDepth:24 20:24:52 INFO - PROCESS | 1115 | Browser inner width/height: 1024/697 20:24:52 INFO - PROCESS | 1115 | __metrics 20:24:52 INFO - PROCESS | 1115 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:24:52 INFO - PROCESS | 1115 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:24:53 INFO - PROCESS | 1115 | console.error: PushService: 20:24:53 INFO - PROCESS | 1115 | stateChangeProcessEnqueue: Error transitioning state 20:24:53 INFO - PROCESS | 1115 | UnknownError 20:24:53 INFO - TEST-INFO | 1115: exit 0 20:24:53 INFO - Browser initialized. 20:24:53 INFO - Running cycle 1/1 for dromaeo_css test... 20:24:53 INFO - TEST-INFO | started process 1266 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyXcmwI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:25:06 INFO - PROCESS | 1266 | RSS: Main: 181043200 20:25:06 INFO - PROCESS | 1266 | 20:25:57 INFO - PROCESS | 1266 | 1472786757310 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] 20:28:11 INFO - PROCESS | 1266 | Cycle 1(1): loaded http://localhost:40747/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40747/tests/dromaeo/cssquery-ext.html) 20:28:12 INFO - PROCESS | 1266 | RSS: Main: 269340672 20:28:12 INFO - PROCESS | 1266 | 20:31:15 INFO - PROCESS | 1266 | Cycle 1(1): loaded http://localhost:40747/tests/dromaeo/cssquery-ext.html (next: http://localhost:40747/tests/dromaeo/cssquery-jquery.html) 20:31:15 INFO - PROCESS | 1266 | RSS: Main: 270090240 20:31:15 INFO - PROCESS | 1266 | 20:34:17 INFO - PROCESS | 1266 | Cycle 1(1): loaded http://localhost:40747/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40747/tests/dromaeo/cssquery-mootools.html) 20:34:18 INFO - PROCESS | 1266 | RSS: Main: 217882624 20:34:18 INFO - PROCESS | 1266 | 20:37:20 INFO - PROCESS | 1266 | Cycle 1(1): loaded http://localhost:40747/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40747/tests/dromaeo/cssquery-prototype.html) 20:37:21 INFO - PROCESS | 1266 | RSS: Main: 232255488 20:37:21 INFO - PROCESS | 1266 | 20:40:24 INFO - PROCESS | 1266 | Cycle 1(1): loaded http://localhost:40747/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40747/tests/dromaeo/cssquery-yui.html) 20:40:25 INFO - PROCESS | 1266 | RSS: Main: 219385856 20:40:25 INFO - PROCESS | 1266 | 20:43:28 INFO - PROCESS | 1266 | Cycle 1(1): loaded http://localhost:40747/tests/dromaeo/cssquery-yui.html (next: http://localhost:40747/tests/dromaeo/cssquery-dojo.html) 20:43:28 INFO - PROCESS | 1266 | RSS: Main: 313851904 20:43:28 INFO - PROCESS | 1266 | 20:43:28 INFO - PROCESS | 1266 | __start_tp_report 20:43:28 INFO - PROCESS | 1266 | _x_x_mozilla_page_load 20:43:28 INFO - PROCESS | 1266 | _x_x_mozilla_page_load_details 20:43:28 INFO - PROCESS | 1266 | |i|pagename|runs| 20:43:28 INFO - PROCESS | 1266 | |0;dojo.html;2635.499255141523;2643.814932954693;2650.204938518444;2693.94612107758;2704.8512331821753;4689.413823272091;4768.54698803614;4786.210275304575;4875.512448755123;4925.5813255873245;4767.070421267854;4787.80848766049;4794.736289504076;4835.1296766582;4847.684900481458;4338.240807858612;4368.410264614284;4414.205443020255;4476.910461790779;4550.931736023946;4459.665525085616;4480.910381792362;4503.954960450403;4522.773861306938;4541.296099104644;4285.507166675841;4359.455068116486;4369.016971181491;4375.671824613167;4382.276924307485;4414.823407063714;4417.094495628388;4470.910581788378;4489.1021795641;4499.595036446735;4432.645388368923;4443.911121777579;4452.933206001912;4454.77726113693;4504.864854054384;4677.087967846237;4891.975540122312;4898.853034408973;4900.044491324194;4909.582685471739;5154.304168937183;5195.402528709209;5208.6093542984045;5231.60762942777;5236.21456781482;5236.97878913612;5259.579233661298;5260.736963151827;5265.052290587692;5359.866003349908;4669.136209801198;4830.734309612934;4898.951010489885;4920.335754673145;4924.72913989734;5293.470652934753;5302.469753024744;5324.254604355393;5368.1679339702405;5389.757460914268;5087.535240330346;5088.465711100355;5092.439831618519;5102.387713474407;5155.123628983007;4966.056449274626;4999.825006124768;5169.508896654812;5173.534381905646;5186.455422180692;4971.925421118686;5005.874853128701;5014.122528557488;5067.341245638044;5076.670016448919;4977.925331120036;4984.37695288089;4986.127427700138;4996.575291100225;5048.485454363677;4218.557051509547;4228.91542169161;4239.40648309237;4259.829606815692;4294.828206871753;3814.7138964577766;3828.8277027533827;3897.5517815451017;3931.4889064422014;3957.0305275207756;4456.331550267421;4470.530594287553;4482.641388688897;4486.3494793254795;4541.795619197144;5042.420121686053;5203.713795741271;5217.713025783542;5223.947760522422;5227.18978558324;4330.480342358937;4364.956350436455;4390.714603550759;4427.579379958899;4437.489688685778;4583.472900616405;4592.782912528182;4593.793279302439;4651.511591282867;4654.557817007379;4864.537868902448;4896.094222568836;4898.21628539432;4903.092927808296;4964.67729597575;5071.670341427795;5135.204043373283;5213.713245771519;5218.8956220876125;5264.210368444611;4880.877978050577;4885.706857588556;4893.951060489349;4908.460069392436;4952.356193694796;5145.305383773143;5150.072986862401;5152.845414637567;5155.587552995827;5156.716380599103;4970.428400733817;5004.374453193351;5013.222950442687;5081.314022606901;5169.172932330809;5067.594592432522;5100.744962751922;5107.821226257063;5109.9744501277255;5170;5089.567386772166;5091.71995540234;5107.463716309734;5108.750632271171;5170.1727723565555;4830.372051633406;4929.211326187936;4999.45006049327;5003.624728145331;5062.114130027304;5090.847274581768;5144.536991670768;5153.175491921274;5199.2980947573105;5208.5312321891215;4984.177610694195;5013.699178049329;5018.5232402921665;5037.496250374933;5092.796288148581 20:43:28 INFO - PROCESS | 1266 | |1;ext.html;571.7627184718342;580.727058282607;586.891425086359;587.9323877754059;589.6579983609507;27667.44665106699;38525.422118668204;40066.399004014966;40090.398644020366;44095.3385699214;40995;41401.378979315334;41452.37821432681;41464.17071658565;41495.37756933641;7143.642817859086;7676.117246516652;7824.491408058458;7827.099883513383;7827.608619569027;9500.477473738942;9758.512074396287;9780.755481112958;10136.645217417356;10146.463384153962;10016.54925528353;10098.091171794536;10099.646512372068;10104.89895101047;10119.342242754234;9852.507374631276;9855.950720246425;9905.75235619108;9908.10827025564;9912.256580756437;9803.362781419184;9861.950690246575;9864.161546268575;9872.851907221397;9879.703608891745;38909;39190;39213.41179882275;39234;39235.41146882799;2857.6999415061327;2862.5706144078554;3035.180501264646;3043.345680678665;3129.8904538341076;28366.432671346665;28492.287692807637;28535.57196642052;28808.135755927357;29248.561271580944;3310.8675652974093;3331.900042998714;3334.866605335784;3359.6976272135626;3414.846331915045;182420;183097;183729;184176;184231;31313.373732525222;50394.244086338;50726.49273507291;50778.49221507811;50799.23801142986;31913.840430797696;33417.16457088592;33494.8325258377;33500.162495937795;33543.49684754731;13170.275634840176;13266.27035513056;13283.867161328457;13297.135686180367;13302.201867887765;9542.61829526825;10881.129509639368;11138.27601205919;11172.776544469065;11264.718382040515;7664.770056898302;7766.456348055694;7767.883481747778;7770.689172433039;7803.648835802403;3000.189948713835;3058.2201538607515;3094.535819627029;3112.128603990886;3118.5830980989463;847.169773621854;874.7506960516222;918.4443411735937;948.7912659214961;993.1409330928694;27354.316142096606;27579.862100689366;28030.719692803217;28285.71714282872;28383.29041773972;938.9671361502293;956.4978386347224;969.6121551379364;976.1458723616835;1001.4692213127055;14525.709485810436;14902.403903843724;14990.550283491513;15265.847341526665;15332.15673137988;393220;463112;466155;470056;668452;49388.50611493839;49930.50625443728;50045.24932126021;50059.49940500621;50064.749676251384;1052.7157667429751;1194.4326444938586;1199.3883119608888;1226.0620625221713;1244.7448273103992;26224.606630900933;28554.316088942294;28872.133835984954;28937.13188604345;29019.274518137216;40432;41129.177416452105;41179.58820411757;41203.175936481704;41334.79332603438;279123;280357;280740;282786;282933;24263.636045458978;24714.876425617756;31249.375012499167;35549.644503554635;37319.44020839744;41411.55059572901;41816.790916045225;41916.371254430596;42165.367519486615;42527;34873.30253394969;35192;35215.82392088023;35474.290514190085;35882.4617630741;35160.29679406449;35245.64754352424;35880.15617891551;35901.1024724384;36003.27993440169;35008.29983400369;35145.64854351526;35375.29249415049;35493.82253088718;35590.64409355873;30438;32333.51499727459;32668.83665581657;32712.672873271913;32771.18072048218;24624.6306305402;25342.746572534037;25366.239012829643;25394.873025635494;25711.228663140137 20:43:28 INFO - PROCESS | 1266 | |2;jquery.html;343.2876780680089;361.88600590813894;364.7082334132694;369.1306972080749;380.8191109223118;12286.262824230542;15741.527754167379;15819.129947852864;16029.198540073008;16838.663226735458;16040.86360822064;16119.758203626925;17110.486685399428;17258;17546.122693865287;5016.673916195454;5245.8950820983555;5269.525742683158;5515.751791169407;5557.944420555783;3383.3909896218793;5496.7526461309335;5524.06090964537;5532.972335138319;5534.640248383842;5209.32278803755;5476.17857321401;5514.91727624086;5570.498655121039;5574.080276754331;5405.108157154064;5554.19488666183;5555.611107222496;5566.163166155199;5566.248556444869;5426.782928682887;5428.538574221196;5429.588307040198;5431.891362172774;5432.782688692448;12257.080718946114;14991;19725.9013704932;20182.19271229149;20269.898650506802;1714.588498760301;1768.5755418699418;1815.4009176971567;1827.0773259503999;1874.5407375193029;8761;9045.276377889753;9077.409968352036;9546.093121153479;9561.904380956172;1423.5373503611265;1503.2333509909915;1538.6691861249774;1560.0405750463497;1566.0681894272889;71805;73489.63255183744;74229.25770742277;74754;77042;8394.202550757669;8833;8938;9013.864792028126;10069.015837160652;11709.355985420712;11871.0503159747;11876.168668193144;11892.881071189177;11900.047996160287;6889.655517224119;7046.084009078787;7093.32613401726;7158.677859496335;7177.3899218567;6893.4140598048725;6894.9655251724425;6967.8606427871155;7083.574985500886;7117.501774875709;3675.246574452284;3684.778913265213;3758.4362345647824;3764.0778009387877;3804.1060350817534;1765.2409463930376;1794.7846258448808;1825.2607693884;1850.2321536562176;1852.8702990790516;852.5737131434283;875.5490922175085;904.1004200820095;912.2519533982071;928.2342067793962;16280.75578866318;17107.74338384925;17364.65270694579;17507.29970801154;17936.461906142835;816.7713040348712;849.4987957105337;857.2199298638209;861.4788053227707;884.566562384427;9217.815643687089;9771.462569558742;9812.607495700093;9820.263480239011;9977.501124943723;386417;393447;393539;396908;400622;77387.22612773912;78276;78571;78646.21353786503;78764;872.9180903545091;884.1114679746813;901.396064636695;904.7466709321401;905.714699869539;15088.094714317176;15272.312745926238;15742;15814.288357023732;15907.522774316789;37499.81250093841;37644.435333469475;38149.23701526009;38647.2270554593;38714.22571548497;50336;50911;51098;51146.232806507185;51339;5107.978404319077;7059.082319298458;7188.532745371744;7209.0628218331285;7321.377682897013;7846.333061689592;9265.861012084959;9495;9738.220942324455;10379;8415.747527574182;8708.69519566812;9033.954830225806;9299.209567186865;9405.106514881076;9134.817303653757;9284.535773211448;9405.106514881076;9406.717798466058;9459.601180577525;9255.67605133817;9303.813923721624;9304.581293841658;9340.626374944926;9820.901790982;7137.785866424016;9832.655857044969;9943.403395796275;10099.7475063124;10518.368897866152;8846.778830529289;9080.40977336471;9596.76008099803;9624.807503850025;10277.280590358603 20:43:28 INFO - PROCESS | 1266 | |3;mootools.html;1198.3588780002701;1340.2859210099543;1400.7268582626389;1467.2883651429056;1696.7200411932024;7534.095908490982;7932.048154221494;7962.283394494494;8137.471064380811;8141.06377766557;7994.96002519988;8105.473144245635;8117.715879944203;8118.309943654796;8119.634616442259;2232.1852523828766;2256.7404748453973;2259.4577301447616;2260.163739416418;2261.276391554703;2203.449137715571;2250.909963601454;2259.0624890670433;2264.377296243538;2264.9320520384413;2169.511859831533;2192.0464597899886;2205.933821985343;2206.459417442729;2221.455743342883;2147.066026278558;2150.3763908466526;2157.5684863027377;2168.6963825064504;2171.1532502324108;2136.529963408048;2143.431990522513;2145.0668959002883;2147.1518750093783;2147.4953385954286;7863.13505514393;8093.312068474187;8120.390970677223;8160.9591952040455;8160.9591952040455;4321.178975994582;4409.338599210112;4428.535003824584;4433.046894917576;4448.466184057901;2715.904943326994;2854.87153078112;2898.521743912252;2901.912942611725;2923.1668974342424;947.9905200947971;959.4195511715451;973.5910917414632;975.4586204656413;978.9216862651042;10873.075788557982;10957.671269861838;10966.287191332618;10985.176111791647;10990.890091099067;3947.1908258806875;3960.0495880988356;4102.835886564564;4154.667626589866;4187.790610469464;8528.914710852936;8596.484210947363;8599.183077607617;8604.139586041345;8610.526421046778;4446.688731788744;4457.955420445819;4458.331250312414;4460;4460.933086003713;3490.7556471046782;3931.8820435386983;4012.879613611596;4042.656374208166;4133.586641335843;3418.1796368871787;3459.356805517359;3581.048328660886;3603.4955106285142;3617.439296908983;1041.7760181561;1047.8480620310165;1079.5519859258477;1080.4597701149426;1088.2871719024051;693.5595896605691;694.2224708326706;730.6127752291294;744.9702011919462;760.581680075956;4952.826651067196;4968.428630707443;5253.082624841905;5264.05247055526;5355.3841308249275;387.18883938150094;394.43398722832825;394.7966797099496;396;396.5736832904581;3426.2119712466274;3486.2156014896445;3521.6302288259876;3564.8395822188063;3614.0964758810296;9417.48203848795;9904.950475247577;9924.702258932244;9925.801483970281;9929.453880036523;9813.656522021694;9846.064623860722;9883.406995580288;9884.357516761387;9898.406095634286;7500.099988001475;7565.6217189140325;7584;7585.886211706828;7587;4971.925421118758;5064.164412871834;5121.8719532012;5180.9740951295;5354.54486368663;9147.77130571741;9175.174234318943;9180.403273787182;9214.44713317203;9280.489573073546;8619.569021548772;8944.239739622206;8947.463152210888;9210.078992100736;9351.812963740824;5805.303363596396;5989.8203053908455;5993.460588546877;6692.163479565054;6863.176418829573;7064.646767661494;7364;7602.1257555381835;7688.038995125609;7782.805429864072;6648.5346025777735;6768.323167683192;6794.660266986532;6822.897656535057;6957.199922009034;6637.734490620321;6751.257361690112;6877.552959057645;6955.095837541087;6982.406495447944;5867.9413205869105;6105.175801266772;6139.8465038372615;6139.938600613937;6143.1706719592285;4474.37358769779;4503.639708823221;4506.076254367781;4544.7045942013665;4574.634029277717;4669.463011753556;4699.4830568636735;4761.142994261067;4768.237082066853;4822.276658501253 20:43:28 INFO - PROCESS | 1266 | |4;prototype.html;292.653205950948;295.9985200073999;302.3529646556368;303.29483949816677;303.88604273397476;4679.391679081723;4847.442544107429;4852.393450818648;4880.365552478177;4900.064474532562;4634.675572709912;4743.739094349818;4781.211100168477;4790.353302304188;4801.783919723612;3765.491658626078;3771.208046310278;3776.3580191367396;3782.1490164712995;3808.466814645938;3567.30437564675;3653.5250417445695;3796.5444146702434;3827.483289755889;3845.38473844185;3714.1271801126713;3742.4760533525327;3743.7753734775865;3759.4360845873202;3767.5478942526797;3749.9625003749884;3750.9437358439645;3765.134019175605;3771.377722675755;3785.1483416231404;3332.450145725952;3340.732741380684;3342.944089385035;3350.614679311886;3351.8994430167136;4599.678022538424;4661.114388266218;4686.95313046872;4705.929411058837;4708.317293992386;4307;4318.632916202127;4334.609885110355;4350.651947844165;4354.216241076605;5017.620154457553;5032.597392208614;5039.47085556015;5040.445550989388;5055.620828437882;3590.7486475946694;3609.693176080036;3655.926881462356;3670.1558641512333;3676.16191904048;5242.292290540767;5245.921311180336;5249.921251181236;5252.1596544552685;5313.9734301328635;3710.8867339797953;3724.255148970217;3740.5224936150066;3743.326201283795;3744.307303148926;3786;3807.58116607173;3812.4281357796553;3814.6376094271;3821.3503704370323;4197.433346498184;4297.484301883794;4306.375575541591;4320.891977700583;4366.497852746975;5055.393352797688;5061.746912654353;5067.87330316745;5074.594032477393;5075.796968121308;1255.2217625072512;1286.899700755859;1309.2340980526499;1310.6919873829643;1333.4932725564224;873.5806812729925;879;904.6381447420953;912.115248209236;913.2283220678516;4411;4417.249067658506;4421.977890110593;4435.3125265583885;4447.844325448594;5096.719680417538;5120.590352771769;5121.641485096007;5127.3847138343635;5131.204663277198;4395.53846846083;4395.955880515576;4407.47110346754;4409.33859921008;4420.226460369422;2307.4462129088897;2431.3921519620094;2431.829771915984;2438.6707794447875;2440.986990399;4324.610785029299;4336.241157797373;4353.608175264241;4356;4360.302351623725;4650.302454631832;4654.9518211986615;4665.440147182292;4666.556677115668;4673.626109911199;4030.118465297268;4322.913541729148;4325.502567204811;4339.522652508222;4371.23503386906;4514.571115743999;4545.499995000613;4553.590176884097;4585.082983403399;4602.4937256902385;4470.173017991682;4500.954990450054;4519.638428925744;4548.158590660738;4561.840335588238;4337.1976184405985;4339.63113135387;4589.311603259538;4958.801572985476;5002.974985125051;3703.2778608172225;3710.4805327254744;3715.5912849587066;3742.476053352478;3755.9061023474633;5001.774920128676;5246.501582349671;5267.577754006474;5285.471452854684;5331.3602367714575;4887.87780305481;4933.235348520985;4973.52751488608;5009.298698182331;5080.872978175427;4943.3573635427165;5013.849584512471;5048.343715316985;5058.4688607697135;5080.822171223989;4771.618270538279;4921.680090794087;4951.331570237971;4978.377702787152;4990.500949905126;5088.771005304696;5102.642815002914;5114.539691427789;5116.641835071509;5122.385313762373;4964.478729733326;4973.925391119208;4975.701457912537;4978.47725988766;4994.875128121826 20:43:28 INFO - PROCESS | 1266 | |5;yui.html;617.7004152985801;619.744131361843;644.7388807532951;693.4591019005178;703.6587255181237;11043.72390690233;12786.232826030433;12833.67915802103;12887.162334448254;13012;12773.680657983556;12855.55005574805;12878.80681789774;12894.871051289485;12912.289824059673;610.255488304268;746.9029026226583;767.4627760567626;768.2010708862776;770.6532060572765;737.1927739125649;772.0850791811692;773.4740376543948;779.2129948751744;784.3293983643988;809.9635516401776;812.1513018895268;812.3420029775871;812.4353574265888;813.0771574263194;630.8328293002359;803.9115697273295;805.9361642631699;806.3710305961359;806.3911746631256;566.1733868551919;579.8869220502004;580.8751118509498;585.3882692586258;586.0681516388962;11643.592474263445;11647.301161930227;11669.649910502698;11673.94163029188;11681.649550513499;9612.375195612332;10145.594176232942;10240.180785537139;10657.253992220547;10735.141188704885;11482.540698372055;11672.708182295426;11858.46636901333;12041.157119001673;12274.938625306817;4037;4038.0106873815807;4078.8572399966156;4205.8527951521855;4213.431186789775;67410;67913.32086679169;68287.65856170688;68421;69039;10112.443815590066;10199.215137350933;10270.147154938433;10513.264071515074;10542.47287635615;19007.61984760297;19018.42944711661;19030.61938761245;19100.33148839784;19130.330438434587;6570.77002304917;6615.768448104293;6621.370969757865;6670.599764014175;6769.627670478072;3399.5070714746225;3489.249811290534;3491.5635545556806;3554.306910152495;3562.1628917204434;2698.190542837141;2807.185916084313;2808.7893407994075;2812.2828678686806;2815.211740712604;481.3838286992655;482.9251466022772;484.7818481683186;487.9121758083508;489.64256093052273;432.6560384494335;448.8967537466401;501.9409046911015;511.57028096399205;537.2210295072083;6826.180858297036;6988;7229.610766828159;7267.527610705287;7525.473216874766;485.58239913674214;501.50852164878626;504.39220739009403;541.3233458177278;557.3701717059697;3284.540164376989;3301.4717645176656;3489.3195826814035;3557.768745031565;3612.5303710517464;55929.720351397984;81195.18804811995;93208;94738;100154.4992275034;49326.50673493291;66192;68792;84193.15806841975;86029.56985215034;63585.36414635794;63864.68067659632;64332.67833660802;72606.63696681483;76152;7556.131044929683;8116.513009219466;8118.254575266346;8187.26314631686;8351;43641.78179109084;45082.3237651442;45232.32151517796;45535.54464455313;45908.540914591766;35180.82409588038;35879.641203588675;36386.63613363938;55612;58255.70872145782;11113;11237.60668376603;11355.716107097389;11787.823182652439;12755.93622031884;12173.2696038238;12386.690332741753;12631.242125472501;14192.716145676823;14309.069910455786;10820.5130769114;11373.14701397382;11467.4266286687;11522.193446458667;11722.120840936794;10919.290246133976;11600;11826.940865295619;11834.171607987359;11835.70410739704;10470.790584188122;10830.566777328819;11174.441277935908;11819.172657913863;12040.096992725405;9647.324687271823;10192.847107293248;10582.523786429476;10597.311174773615;10738.355698658106;9257.861132083159;9270.907290927003;9386.202172815387;9475.241980641395;9815 20:43:28 INFO - PROCESS | 1266 | __end_tp_report 20:43:28 INFO - PROCESS | 1266 | __start_cc_report 20:43:28 INFO - PROCESS | 1266 | _x_x_mozilla_cycle_collect,908 20:43:28 INFO - PROCESS | 1266 | __end_cc_report 20:43:28 INFO - PROCESS | 1266 | __startTimestamp1472787808678__endTimestamp 20:43:28 INFO - PROCESS | 1266 | 20:43:28 INFO - PROCESS | 1266 | ------- Summary: start ------- 20:43:28 INFO - PROCESS | 1266 | Number of tests: 6 20:43:28 INFO - PROCESS | 1266 | 20:43:28 INFO - PROCESS | 1266 | [#0] dojo.html Cycles:165 Average:4776.17 Median:4924.73 stddev:511.51 (10.4%) stddev-sans-first:484.73 20:43:28 INFO - PROCESS | 1266 | Values: 2635.5 2643.8 2650.2 2693.9 2704.9 4689.4 4768.5 4786.2 4875.5 4925.6 4767.1 4787.8 4794.7 4835.1 4847.7 4338.2 4368.4 4414.2 4476.9 4550.9 4459.7 4480.9 4504.0 4522.8 4541.3 4285.5 4359.5 4369.0 4375.7 4382.3 4414.8 4417.1 4470.9 4489.1 4499.6 4432.6 4443.9 4452.9 4454.8 4504.9 4677.1 4892.0 4898.9 4900.0 4909.6 5154.3 5195.4 5208.6 5231.6 5236.2 5237.0 5259.6 5260.7 5265.1 5359.9 4669.1 4830.7 4899.0 4920.3 4924.7 5293.5 5302.5 5324.3 5368.2 5389.8 5087.5 5088.5 5092.4 5102.4 5155.1 4966.1 4999.8 5169.5 5173.5 5186.5 4971.9 5005.9 5014.1 5067.3 5076.7 4977.9 4984.4 4986.1 4996.6 5048.5 4218.6 4228.9 4239.4 4259.8 4294.8 3814.7 3828.8 3897.6 3931.5 3957.0 4456.3 4470.5 4482.6 4486.3 4541.8 5042.4 5203.7 5217.7 5223.9 5227.2 4330.5 4365.0 4390.7 4427.6 4437.5 4583.5 4592.8 4593.8 4651.5 4654.6 4864.5 4896.1 4898.2 4903.1 4964.7 5071.7 5135.2 5213.7 5218.9 5264.2 4880.9 4885.7 4894.0 4908.5 4952.4 5145.3 5150.1 5152.8 5155.6 5156.7 4970.4 5004.4 5013.2 5081.3 5169.2 5067.6 5100.7 5107.8 5110.0 5170.0 5089.6 5091.7 5107.5 5108.8 5170.2 4830.4 4929.2 4999.5 5003.6 5062.1 5090.8 5144.5 5153.2 5199.3 5208.5 4984.2 5013.7 5018.5 5037.5 5092.8 20:43:28 INFO - PROCESS | 1266 | 20:43:28 INFO - PROCESS | 1266 | [#1] ext.html Cycles:180 Average:46527.30 Median:35176.15 stddev:92987.17 (264.3%) stddev-sans-first:93184.00 20:43:28 INFO - PROCESS | 1266 | Values: 571.8 580.7 586.9 587.9 589.7 27667.4 38525.4 40066.4 40090.4 44095.3 40995.0 41401.4 41452.4 41464.2 41495.4 7143.6 7676.1 7824.5 7827.1 7827.6 9500.5 9758.5 9780.8 10136.6 10146.5 10016.5 10098.1 10099.6 10104.9 10119.3 9852.5 9856.0 9905.8 9908.1 9912.3 9803.4 9862.0 9864.2 9872.9 9879.7 38909.0 39190.0 39213.4 39234.0 39235.4 2857.7 2862.6 3035.2 3043.3 3129.9 28366.4 28492.3 28535.6 28808.1 29248.6 3310.9 3331.9 3334.9 3359.7 3414.8 182420.0 183097.0 183729.0 184176.0 184231.0 31313.4 50394.2 50726.5 50778.5 50799.2 31913.8 33417.2 33494.8 33500.2 33543.5 13170.3 13266.3 13283.9 13297.1 13302.2 9542.6 10881.1 11138.3 11172.8 11264.7 7664.8 7766.5 7767.9 7770.7 7803.6 3000.2 3058.2 3094.5 3112.1 3118.6 847.2 874.8 918.4 948.8 993.1 27354.3 27579.9 28030.7 28285.7 28383.3 939.0 956.5 969.6 976.1 1001.5 14525.7 14902.4 14990.6 15265.8 15332.2 393220.0 463112.0 466155.0 470056.0 668452.0 49388.5 49930.5 50045.2 50059.5 50064.7 1052.7 1194.4 1199.4 1226.1 1244.7 26224.6 28554.3 28872.1 28937.1 29019.3 40432.0 41129.2 41179.6 41203.2 41334.8 279123.0 280357.0 280740.0 282786.0 282933.0 24263.6 24714.9 31249.4 35549.6 37319.4 41411.6 41816.8 41916.4 42165.4 42527.0 34873.3 35192.0 35215.8 35474.3 35882.5 35160.3 35245.6 35880.2 35901.1 36003.3 35008.3 35145.6 35375.3 35493.8 35590.6 30438.0 32333.5 32668.8 32712.7 32771.2 24624.6 25342.7 25366.2 25394.9 25711.2 20:43:28 INFO - PROCESS | 1266 | 20:43:28 INFO - PROCESS | 1266 | [#2] jquery.html Cycles:180 Average:24271.09 Median:5519.91 stddev:65272.34 (1182.5%) stddev-sans-first:65430.72 20:43:28 INFO - PROCESS | 1266 | Values: 343.3 361.9 364.7 369.1 380.8 12286.3 15741.5 15819.1 16029.2 16838.7 16040.9 16119.8 17110.5 17258.0 17546.1 5016.7 5245.9 5269.5 5515.8 5557.9 3383.4 5496.8 5524.1 5533.0 5534.6 5209.3 5476.2 5514.9 5570.5 5574.1 5405.1 5554.2 5555.6 5566.2 5566.2 5426.8 5428.5 5429.6 5431.9 5432.8 12257.1 14991.0 19725.9 20182.2 20269.9 1714.6 1768.6 1815.4 1827.1 1874.5 8761.0 9045.3 9077.4 9546.1 9561.9 1423.5 1503.2 1538.7 1560.0 1566.1 71805.0 73489.6 74229.3 74754.0 77042.0 8394.2 8833.0 8938.0 9013.9 10069.0 11709.4 11871.1 11876.2 11892.9 11900.0 6889.7 7046.1 7093.3 7158.7 7177.4 6893.4 6895.0 6967.9 7083.6 7117.5 3675.2 3684.8 3758.4 3764.1 3804.1 1765.2 1794.8 1825.3 1850.2 1852.9 852.6 875.5 904.1 912.3 928.2 16280.8 17107.7 17364.7 17507.3 17936.5 816.8 849.5 857.2 861.5 884.6 9217.8 9771.5 9812.6 9820.3 9977.5 386417.0 393447.0 393539.0 396908.0 400622.0 77387.2 78276.0 78571.0 78646.2 78764.0 872.9 884.1 901.4 904.7 905.7 15088.1 15272.3 15742.0 15814.3 15907.5 37499.8 37644.4 38149.2 38647.2 38714.2 50336.0 50911.0 51098.0 51146.2 51339.0 5108.0 7059.1 7188.5 7209.1 7321.4 7846.3 9265.9 9495.0 9738.2 10379.0 8415.7 8708.7 9034.0 9299.2 9405.1 9134.8 9284.5 9405.1 9406.7 9459.6 9255.7 9303.8 9304.6 9340.6 9820.9 7137.8 9832.7 9943.4 10099.7 10518.4 8846.8 9080.4 9596.8 9624.8 10277.3 20:43:28 INFO - PROCESS | 1266 | 20:43:28 INFO - PROCESS | 1266 | [#3] mootools.html Cycles:180 Average:5125.63 Median:4960.63 stddev:2962.04 (59.7%) stddev-sans-first:2955.64 20:43:28 INFO - PROCESS | 1266 | Values: 1198.4 1340.3 1400.7 1467.3 1696.7 7534.1 7932.0 7962.3 8137.5 8141.1 7995.0 8105.5 8117.7 8118.3 8119.6 2232.2 2256.7 2259.5 2260.2 2261.3 2203.4 2250.9 2259.1 2264.4 2264.9 2169.5 2192.0 2205.9 2206.5 2221.5 2147.1 2150.4 2157.6 2168.7 2171.2 2136.5 2143.4 2145.1 2147.2 2147.5 7863.1 8093.3 8120.4 8161.0 8161.0 4321.2 4409.3 4428.5 4433.0 4448.5 2715.9 2854.9 2898.5 2901.9 2923.2 948.0 959.4 973.6 975.5 978.9 10873.1 10957.7 10966.3 10985.2 10990.9 3947.2 3960.0 4102.8 4154.7 4187.8 8528.9 8596.5 8599.2 8604.1 8610.5 4446.7 4458.0 4458.3 4460.0 4460.9 3490.8 3931.9 4012.9 4042.7 4133.6 3418.2 3459.4 3581.0 3603.5 3617.4 1041.8 1047.8 1079.6 1080.5 1088.3 693.6 694.2 730.6 745.0 760.6 4952.8 4968.4 5253.1 5264.1 5355.4 387.2 394.4 394.8 396.0 396.6 3426.2 3486.2 3521.6 3564.8 3614.1 9417.5 9905.0 9924.7 9925.8 9929.5 9813.7 9846.1 9883.4 9884.4 9898.4 7500.1 7565.6 7584.0 7585.9 7587.0 4971.9 5064.2 5121.9 5181.0 5354.5 9147.8 9175.2 9180.4 9214.4 9280.5 8619.6 8944.2 8947.5 9210.1 9351.8 5805.3 5989.8 5993.5 6692.2 6863.2 7064.6 7364.0 7602.1 7688.0 7782.8 6648.5 6768.3 6794.7 6822.9 6957.2 6637.7 6751.3 6877.6 6955.1 6982.4 5867.9 6105.2 6139.8 6139.9 6143.2 4474.4 4503.6 4506.1 4544.7 4574.6 4669.5 4699.5 4761.1 4768.2 4822.3 20:43:28 INFO - PROCESS | 1266 | 20:43:28 INFO - PROCESS | 1266 | [#4] prototype.html Cycles:180 Average:4101.14 Median:4441.58 stddev:1174.97 (26.5%) stddev-sans-first:1142.96 20:43:28 INFO - PROCESS | 1266 | Values: 292.7 296.0 302.4 303.3 303.9 4679.4 4847.4 4852.4 4880.4 4900.1 4634.7 4743.7 4781.2 4790.4 4801.8 3765.5 3771.2 3776.4 3782.1 3808.5 3567.3 3653.5 3796.5 3827.5 3845.4 3714.1 3742.5 3743.8 3759.4 3767.5 3750.0 3750.9 3765.1 3771.4 3785.1 3332.5 3340.7 3342.9 3350.6 3351.9 4599.7 4661.1 4687.0 4705.9 4708.3 4307.0 4318.6 4334.6 4350.7 4354.2 5017.6 5032.6 5039.5 5040.4 5055.6 3590.7 3609.7 3655.9 3670.2 3676.2 5242.3 5245.9 5249.9 5252.2 5314.0 3710.9 3724.3 3740.5 3743.3 3744.3 3786.0 3807.6 3812.4 3814.6 3821.4 4197.4 4297.5 4306.4 4320.9 4366.5 5055.4 5061.7 5067.9 5074.6 5075.8 1255.2 1286.9 1309.2 1310.7 1333.5 873.6 879.0 904.6 912.1 913.2 4411.0 4417.2 4422.0 4435.3 4447.8 5096.7 5120.6 5121.6 5127.4 5131.2 4395.5 4396.0 4407.5 4409.3 4420.2 2307.4 2431.4 2431.8 2438.7 2441.0 4324.6 4336.2 4353.6 4356.0 4360.3 4650.3 4655.0 4665.4 4666.6 4673.6 4030.1 4322.9 4325.5 4339.5 4371.2 4514.6 4545.5 4553.6 4585.1 4602.5 4470.2 4501.0 4519.6 4548.2 4561.8 4337.2 4339.6 4589.3 4958.8 5003.0 3703.3 3710.5 3715.6 3742.5 3755.9 5001.8 5246.5 5267.6 5285.5 5331.4 4887.9 4933.2 4973.5 5009.3 5080.9 4943.4 5013.8 5048.3 5058.5 5080.8 4771.6 4921.7 4951.3 4978.4 4990.5 5088.8 5102.6 5114.5 5116.6 5122.4 4964.5 4973.9 4975.7 4978.5 4994.9 20:43:28 INFO - PROCESS | 1266 | 20:43:28 INFO - PROCESS | 1266 | [#5] yui.html Cycles:180 Average:16404.50 Median:45157.32 stddev:22860.04 (50.6%) stddev-sans-first:22893.44 20:43:28 INFO - PROCESS | 1266 | Values: 617.7 619.7 644.7 693.5 703.7 11043.7 12786.2 12833.7 12887.2 13012.0 12773.7 12855.6 12878.8 12894.9 12912.3 610.3 746.9 767.5 768.2 770.7 737.2 772.1 773.5 779.2 784.3 810.0 812.2 812.3 812.4 813.1 630.8 803.9 805.9 806.4 806.4 566.2 579.9 580.9 585.4 586.1 11643.6 11647.3 11669.6 11673.9 11681.6 9612.4 10145.6 10240.2 10657.3 10735.1 11482.5 11672.7 11858.5 12041.2 12274.9 4037.0 4038.0 4078.9 4205.9 4213.4 67410.0 67913.3 68287.7 68421.0 69039.0 10112.4 10199.2 10270.1 10513.3 10542.5 19007.6 19018.4 19030.6 19100.3 19130.3 6570.8 6615.8 6621.4 6670.6 6769.6 3399.5 3489.2 3491.6 3554.3 3562.2 2698.2 2807.2 2808.8 2812.3 2815.2 481.4 482.9 484.8 487.9 489.6 432.7 448.9 501.9 511.6 537.2 6826.2 6988.0 7229.6 7267.5 7525.5 485.6 501.5 504.4 541.3 557.4 3284.5 3301.5 3489.3 3557.8 3612.5 55929.7 81195.2 93208.0 94738.0 100154.5 49326.5 66192.0 68792.0 84193.2 86029.6 63585.4 63864.7 64332.7 72606.6 76152.0 7556.1 8116.5 8118.3 8187.3 8351.0 43641.8 45082.3 45232.3 45535.5 45908.5 35180.8 35879.6 36386.6 55612.0 58255.7 11113.0 11237.6 11355.7 11787.8 12755.9 12173.3 12386.7 12631.2 14192.7 14309.1 10820.5 11373.1 11467.4 11522.2 11722.1 10919.3 11600.0 11826.9 11834.2 11835.7 10470.8 10830.6 11174.4 11819.2 12040.1 9647.3 10192.8 10582.5 10597.3 10738.4 9257.9 9270.9 9386.2 9475.2 9815.0 20:43:28 INFO - PROCESS | 1266 | -------- Summary: end -------- 20:43:28 INFO - PROCESS | 1266 | 20:43:29 INFO - TEST-INFO | 1266: exit 0 20:43:29 INFO - TEST-OK | dromaeo_css | took 1122315ms 20:43:29 INFO - TEST-START | kraken 20:43:29 INFO - operating with platform_type : linux_ 20:43:29 INFO - Initialising browser for kraken test... 20:43:29 INFO - TEST-INFO | started process 1571 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi9CfU7/profile http://localhost:40747/getInfo.html) 20:43:34 INFO - PROCESS | 1571 | __metrics Screen width/height:1600/1200 20:43:34 INFO - PROCESS | 1571 | colorDepth:24 20:43:34 INFO - PROCESS | 1571 | Browser inner width/height: 1024/697 20:43:34 INFO - PROCESS | 1571 | __metrics 20:43:35 INFO - PROCESS | 1571 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:43:35 INFO - PROCESS | 1571 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:43:35 INFO - PROCESS | 1571 | console.error: PushService: 20:43:35 INFO - PROCESS | 1571 | stateChangeProcessEnqueue: Error transitioning state 20:43:35 INFO - PROCESS | 1571 | UnknownError 20:43:36 INFO - TEST-INFO | 1571: exit 0 20:43:36 INFO - Browser initialized. 20:43:36 INFO - Running cycle 1/1 for kraken test... 20:43:36 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi9CfU7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:43:48 INFO - PROCESS | 1653 | RSS: Main: 180711424 20:43:48 INFO - PROCESS | 1653 | 20:43:51 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:40747/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40747/tests/kraken/driver.html?testName=audio-beat-detection) 20:43:52 INFO - PROCESS | 1653 | RSS: Main: 234967040 20:43:52 INFO - PROCESS | 1653 | 20:43:55 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:40747/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40747/tests/kraken/driver.html?testName=audio-dft) 20:43:55 INFO - PROCESS | 1653 | RSS: Main: 222990336 20:43:55 INFO - PROCESS | 1653 | 20:43:58 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:40747/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40747/tests/kraken/driver.html?testName=audio-fft) 20:43:59 INFO - PROCESS | 1653 | RSS: Main: 302051328 20:43:59 INFO - PROCESS | 1653 | 20:44:01 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:40747/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40747/tests/kraken/driver.html?testName=audio-oscillator) 20:44:02 INFO - PROCESS | 1653 | RSS: Main: 212267008 20:44:02 INFO - PROCESS | 1653 | 20:44:04 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:40747/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40747/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:44:05 INFO - PROCESS | 1653 | RSS: Main: 214962176 20:44:05 INFO - PROCESS | 1653 | 20:44:08 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:40747/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40747/tests/kraken/driver.html?testName=imaging-darkroom) 20:44:08 INFO - PROCESS | 1653 | RSS: Main: 253784064 20:44:08 INFO - PROCESS | 1653 | 20:44:12 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:40747/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40747/tests/kraken/driver.html?testName=imaging-desaturate) 20:44:13 INFO - PROCESS | 1653 | RSS: Main: 247382016 20:44:13 INFO - PROCESS | 1653 | 20:44:15 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:40747/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40747/tests/kraken/driver.html?testName=json-parse-financial) 20:44:16 INFO - PROCESS | 1653 | RSS: Main: 251035648 20:44:16 INFO - PROCESS | 1653 | 20:44:18 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:40747/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40747/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:44:18 INFO - PROCESS | 1653 | RSS: Main: 214511616 20:44:18 INFO - PROCESS | 1653 | 20:44:20 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:40747/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40747/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:44:21 INFO - PROCESS | 1653 | RSS: Main: 221618176 20:44:21 INFO - PROCESS | 1653 | 20:44:23 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:40747/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40747/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:44:24 INFO - PROCESS | 1653 | RSS: Main: 222605312 20:44:24 INFO - PROCESS | 1653 | 20:44:27 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:40747/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:44:27 INFO - PROCESS | 1653 | RSS: Main: 223752192 20:44:27 INFO - PROCESS | 1653 | 20:44:30 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:40747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:44:31 INFO - PROCESS | 1653 | RSS: Main: 221458432 20:44:31 INFO - PROCESS | 1653 | 20:44:33 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:40747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40747/tests/kraken/driver.html?testName=ai-astar) 20:44:33 INFO - PROCESS | 1653 | RSS: Main: 272089088 20:44:33 INFO - PROCESS | 1653 | 20:44:33 INFO - PROCESS | 1653 | __start_tp_report 20:44:33 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 20:44:33 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 20:44:33 INFO - PROCESS | 1653 | |i|pagename|runs| 20:44:33 INFO - PROCESS | 1653 | |0;ai-astar;115;116;121;114;115;115;117;113;114;130 20:44:33 INFO - PROCESS | 1653 | |1;audio-beat-detection;150;122;150;187;130;154;160;123;205;128 20:44:33 INFO - PROCESS | 1653 | |2;audio-dft;161;161;164;161;162;161;163;161;161;162 20:44:33 INFO - PROCESS | 1653 | |3;audio-fft;77;81;77;177;77;79;75;77;161;76 20:44:33 INFO - PROCESS | 1653 | |4;audio-oscillator;84;83;135;84;84;83;148;84;84;140 20:44:33 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;117;116;116;117;119;116;116;117;117;117 20:44:33 INFO - PROCESS | 1653 | |6;imaging-darkroom;147;147;147;146;148;146;148;146;147;147 20:44:33 INFO - PROCESS | 1653 | |7;imaging-desaturate;95;95;96;95;96;97;96;96;97;95 20:44:33 INFO - PROCESS | 1653 | |8;json-parse-financial;66;66;69;69;68;68;69;68;68;68 20:44:33 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;65;66;64;65;66;66;65;69;66;66 20:44:33 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;84;82;83;82;83;87;95;83;84;83 20:44:33 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;154;144;132;142;135;136;133;133;176;136 20:44:33 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;180;178;179;177;180;185;186;177;176;178 20:44:33 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;72;73;70;70;73;70;69;70;69;69 20:44:33 INFO - PROCESS | 1653 | __end_tp_report 20:44:33 INFO - PROCESS | 1653 | __start_cc_report 20:44:33 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,2010 20:44:33 INFO - PROCESS | 1653 | __end_cc_report 20:44:33 INFO - PROCESS | 1653 | __startTimestamp1472787873526__endTimestamp 20:44:33 INFO - PROCESS | 1653 | 20:44:33 INFO - PROCESS | 1653 | ------- Summary: start ------- 20:44:33 INFO - PROCESS | 1653 | Number of tests: 14 20:44:33 INFO - PROCESS | 1653 | 20:44:33 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:117.00 Median:115.50 stddev:5.08 (4.4%) stddev-sans-first:5.33 20:44:33 INFO - PROCESS | 1653 | Values: 115.0 116.0 121.0 114.0 115.0 115.0 117.0 113.0 114.0 130.0 20:44:33 INFO - PROCESS | 1653 | 20:44:33 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:152.00 stddev:27.69 (18.2%) stddev-sans-first:29.36 20:44:33 INFO - PROCESS | 1653 | Values: 150.0 122.0 150.0 187.0 130.0 154.0 160.0 123.0 205.0 128.0 20:44:33 INFO - PROCESS | 1653 | 20:44:33 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.50 stddev:1.06 (0.7%) stddev-sans-first:1.09 20:44:33 INFO - PROCESS | 1653 | Values: 161.0 161.0 164.0 161.0 162.0 161.0 163.0 161.0 161.0 162.0 20:44:33 INFO - PROCESS | 1653 | 20:44:33 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:95.70 Median:77.00 stddev:38.85 (50.5%) stddev-sans-first:40.61 20:44:33 INFO - PROCESS | 1653 | Values: 77.0 81.0 77.0 177.0 77.0 79.0 75.0 77.0 161.0 76.0 20:44:33 INFO - PROCESS | 1653 | 20:44:33 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:100.90 Median:84.00 stddev:27.85 (33.2%) stddev-sans-first:28.86 20:44:33 INFO - PROCESS | 1653 | Values: 84.0 83.0 135.0 84.0 84.0 83.0 148.0 84.0 84.0 140.0 20:44:33 INFO - PROCESS | 1653 | 20:44:33 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 20:44:33 INFO - PROCESS | 1653 | Values: 117.0 116.0 116.0 117.0 119.0 116.0 116.0 117.0 117.0 117.0 20:44:33 INFO - PROCESS | 1653 | 20:44:33 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 20:44:33 INFO - PROCESS | 1653 | Values: 147.0 147.0 147.0 146.0 148.0 146.0 148.0 146.0 147.0 147.0 20:44:33 INFO - PROCESS | 1653 | 20:44:33 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 20:44:33 INFO - PROCESS | 1653 | Values: 95.0 95.0 96.0 95.0 96.0 97.0 96.0 96.0 97.0 95.0 20:44:33 INFO - PROCESS | 1653 | 20:44:33 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:67.90 Median:68.00 stddev:1.10 (1.6%) stddev-sans-first:0.93 20:44:33 INFO - PROCESS | 1653 | Values: 66.0 66.0 69.0 69.0 68.0 68.0 69.0 68.0 68.0 68.0 20:44:33 INFO - PROCESS | 1653 | 20:44:33 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:1.32 (2.0%) stddev-sans-first:1.36 20:44:33 INFO - PROCESS | 1653 | Values: 65.0 66.0 64.0 65.0 66.0 66.0 65.0 69.0 66.0 66.0 20:44:33 INFO - PROCESS | 1653 | 20:44:33 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:83.50 stddev:3.92 (4.7%) stddev-sans-first:4.15 20:44:33 INFO - PROCESS | 1653 | Values: 84.0 82.0 83.0 82.0 83.0 87.0 95.0 83.0 84.0 83.0 20:44:33 INFO - PROCESS | 1653 | 20:44:33 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:142.10 Median:139.00 stddev:13.69 (9.8%) stddev-sans-first:13.83 20:44:33 INFO - PROCESS | 1653 | Values: 154.0 144.0 132.0 142.0 135.0 136.0 133.0 133.0 176.0 136.0 20:44:33 INFO - PROCESS | 1653 | 20:44:33 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.60 Median:179.50 stddev:3.37 (1.9%) stddev-sans-first:3.57 20:44:33 INFO - PROCESS | 1653 | Values: 180.0 178.0 179.0 177.0 180.0 185.0 186.0 177.0 176.0 178.0 20:44:33 INFO - PROCESS | 1653 | 20:44:33 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:70.00 stddev:1.58 (2.3%) stddev-sans-first:1.58 20:44:33 INFO - PROCESS | 1653 | Values: 72.0 73.0 70.0 70.0 73.0 70.0 69.0 70.0 69.0 69.0 20:44:33 INFO - PROCESS | 1653 | -------- Summary: end -------- 20:44:33 INFO - PROCESS | 1653 | 20:44:34 INFO - TEST-INFO | 1653: exit 0 20:44:34 INFO - TEST-OK | kraken | took 65268ms 20:44:34 INFO - SUITE-END | took 1187s 20:44:35 INFO - Completed test suite (00:19:47) 20:44:35 INFO - javascript benchmark 20:44:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2635.499255141523, 2643.814932954693, 2650.204938518444, 2693.94612107758, 2704.8512331821753, 4689.413823272091, 4768.54698803614, 4786.210275304575, 4875.512448755123, 4925.5813255873245, 4767.070421267854, 4787.80848766049, 4794.736289504076, 4835.1296766582, 4847.684900481458, 4338.240807858612, 4368.410264614284, 4414.205443020255, 4476.910461790779, 4550.931736023946, 4459.665525085616, 4480.910381792362, 4503.954960450403, 4522.773861306938, 4541.296099104644, 4285.507166675841, 4359.455068116486, 4369.016971181491, 4375.671824613167, 4382.276924307485, 4414.823407063714, 4417.094495628388, 4470.910581788378, 4489.1021795641, 4499.595036446735, 4432.645388368923, 4443.911121777579, 4452.933206001912, 4454.77726113693, 4504.864854054384, 4677.087967846237, 4891.975540122312, 4898.853034408973, 4900.044491324194, 4909.582685471739, 5154.304168937183, 5195.402528709209, 5208.6093542984045, 5231.60762942777, 5236.21456781482, 5236.97878913612, 5259.579233661298, 5260.736963151827, 5265.052290587692, 5359.866003349908, 4669.136209801198, 4830.734309612934, 4898.951010489885, 4920.335754673145, 4924.72913989734, 5293.470652934753, 5302.469753024744, 5324.254604355393, 5368.1679339702405, 5389.757460914268, 5087.535240330346, 5088.465711100355, 5092.439831618519, 5102.387713474407, 5155.123628983007, 4966.056449274626, 4999.825006124768, 5169.508896654812, 5173.534381905646, 5186.455422180692, 4971.925421118686, 5005.874853128701, 5014.122528557488, 5067.341245638044, 5076.670016448919, 4977.925331120036, 4984.37695288089, 4986.127427700138, 4996.575291100225, 5048.485454363677, 4218.557051509547, 4228.91542169161, 4239.40648309237, 4259.829606815692, 4294.828206871753, 3814.7138964577766, 3828.8277027533827, 3897.5517815451017, 3931.4889064422014, 3957.0305275207756, 4456.331550267421, 4470.530594287553, 4482.641388688897, 4486.3494793254795, 4541.795619197144, 5042.420121686053, 5203.713795741271, 5217.713025783542, 5223.947760522422, 5227.18978558324, 4330.480342358937, 4364.956350436455, 4390.714603550759, 4427.579379958899, 4437.489688685778, 4583.472900616405, 4592.782912528182, 4593.793279302439, 4651.511591282867, 4654.557817007379, 4864.537868902448, 4896.094222568836, 4898.21628539432, 4903.092927808296, 4964.67729597575, 5071.670341427795, 5135.204043373283, 5213.713245771519, 5218.8956220876125, 5264.210368444611, 4880.877978050577, 4885.706857588556, 4893.951060489349, 4908.460069392436, 4952.356193694796, 5145.305383773143, 5150.072986862401, 5152.845414637567, 5155.587552995827, 5156.716380599103, 4970.428400733817, 5004.374453193351, 5013.222950442687, 5081.314022606901, 5169.172932330809, 5067.594592432522, 5100.744962751922, 5107.821226257063, 5109.9744501277255, 5170.0, 5089.567386772166, 5091.71995540234, 5107.463716309734, 5108.750632271171, 5170.1727723565555, 4830.372051633406, 4929.211326187936, 4999.45006049327, 5003.624728145331, 5062.114130027304, 5090.847274581768, 5144.536991670768, 5153.175491921274, 5199.2980947573105, 5208.5312321891215, 4984.177610694195, 5013.699178049329, 5018.5232402921665, 5037.496250374933, 5092.796288148581], "value": 4742.806482108839, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.7627184718342, 580.727058282607, 586.891425086359, 587.9323877754059, 589.6579983609507, 27667.44665106699, 38525.422118668204, 40066.399004014966, 40090.398644020366, 44095.3385699214, 40995.0, 41401.378979315334, 41452.37821432681, 41464.17071658565, 41495.37756933641, 7143.642817859086, 7676.117246516652, 7824.491408058458, 7827.099883513383, 7827.608619569027, 9500.477473738942, 9758.512074396287, 9780.755481112958, 10136.645217417356, 10146.463384153962, 10016.54925528353, 10098.091171794536, 10099.646512372068, 10104.89895101047, 10119.342242754234, 9852.507374631276, 9855.950720246425, 9905.75235619108, 9908.10827025564, 9912.256580756437, 9803.362781419184, 9861.950690246575, 9864.161546268575, 9872.851907221397, 9879.703608891745, 38909.0, 39190.0, 39213.41179882275, 39234.0, 39235.41146882799, 2857.6999415061327, 2862.5706144078554, 3035.180501264646, 3043.345680678665, 3129.8904538341076, 28366.432671346665, 28492.287692807637, 28535.57196642052, 28808.135755927357, 29248.561271580944, 3310.8675652974093, 3331.900042998714, 3334.866605335784, 3359.6976272135626, 3414.846331915045, 182420.0, 183097.0, 183729.0, 184176.0, 184231.0, 31313.373732525222, 50394.244086338, 50726.49273507291, 50778.49221507811, 50799.23801142986, 31913.840430797696, 33417.16457088592, 33494.8325258377, 33500.162495937795, 33543.49684754731, 13170.275634840176, 13266.27035513056, 13283.867161328457, 13297.135686180367, 13302.201867887765, 9542.61829526825, 10881.129509639368, 11138.27601205919, 11172.776544469065, 11264.718382040515, 7664.770056898302, 7766.456348055694, 7767.883481747778, 7770.689172433039, 7803.648835802403, 3000.189948713835, 3058.2201538607515, 3094.535819627029, 3112.128603990886, 3118.5830980989463, 847.169773621854, 874.7506960516222, 918.4443411735937, 948.7912659214961, 993.1409330928694, 27354.316142096606, 27579.862100689366, 28030.719692803217, 28285.71714282872, 28383.29041773972, 938.9671361502293, 956.4978386347224, 969.6121551379364, 976.1458723616835, 1001.4692213127055, 14525.709485810436, 14902.403903843724, 14990.550283491513, 15265.847341526665, 15332.15673137988, 393220.0, 463112.0, 466155.0, 470056.0, 668452.0, 49388.50611493839, 49930.50625443728, 50045.24932126021, 50059.49940500621, 50064.749676251384, 1052.7157667429751, 1194.4326444938586, 1199.3883119608888, 1226.0620625221713, 1244.7448273103992, 26224.606630900933, 28554.316088942294, 28872.133835984954, 28937.13188604345, 29019.274518137216, 40432.0, 41129.177416452105, 41179.58820411757, 41203.175936481704, 41334.79332603438, 279123.0, 280357.0, 280740.0, 282786.0, 282933.0, 24263.636045458978, 24714.876425617756, 31249.375012499167, 35549.644503554635, 37319.44020839744, 41411.55059572901, 41816.790916045225, 41916.371254430596, 42165.367519486615, 42527.0, 34873.30253394969, 35192.0, 35215.82392088023, 35474.290514190085, 35882.4617630741, 35160.29679406449, 35245.64754352424, 35880.15617891551, 35901.1024724384, 36003.27993440169, 35008.29983400369, 35145.64854351526, 35375.29249415049, 35493.82253088718, 35590.64409355873, 30438.0, 32333.51499727459, 32668.83665581657, 32712.672873271913, 32771.18072048218, 24624.6306305402, 25342.746572534037, 25366.239012829643, 25394.873025635494, 25711.228663140137], "value": 16778.82845335825, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.2876780680089, 361.88600590813894, 364.7082334132694, 369.1306972080749, 380.8191109223118, 12286.262824230542, 15741.527754167379, 15819.129947852864, 16029.198540073008, 16838.663226735458, 16040.86360822064, 16119.758203626925, 17110.486685399428, 17258.0, 17546.122693865287, 5016.673916195454, 5245.8950820983555, 5269.525742683158, 5515.751791169407, 5557.944420555783, 3383.3909896218793, 5496.7526461309335, 5524.06090964537, 5532.972335138319, 5534.640248383842, 5209.32278803755, 5476.17857321401, 5514.91727624086, 5570.498655121039, 5574.080276754331, 5405.108157154064, 5554.19488666183, 5555.611107222496, 5566.163166155199, 5566.248556444869, 5426.782928682887, 5428.538574221196, 5429.588307040198, 5431.891362172774, 5432.782688692448, 12257.080718946114, 14991.0, 19725.9013704932, 20182.19271229149, 20269.898650506802, 1714.588498760301, 1768.5755418699418, 1815.4009176971567, 1827.0773259503999, 1874.5407375193029, 8761.0, 9045.276377889753, 9077.409968352036, 9546.093121153479, 9561.904380956172, 1423.5373503611265, 1503.2333509909915, 1538.6691861249774, 1560.0405750463497, 1566.0681894272889, 71805.0, 73489.63255183744, 74229.25770742277, 74754.0, 77042.0, 8394.202550757669, 8833.0, 8938.0, 9013.864792028126, 10069.015837160652, 11709.355985420712, 11871.0503159747, 11876.168668193144, 11892.881071189177, 11900.047996160287, 6889.655517224119, 7046.084009078787, 7093.32613401726, 7158.677859496335, 7177.3899218567, 6893.4140598048725, 6894.9655251724425, 6967.8606427871155, 7083.574985500886, 7117.501774875709, 3675.246574452284, 3684.778913265213, 3758.4362345647824, 3764.0778009387877, 3804.1060350817534, 1765.2409463930376, 1794.7846258448808, 1825.2607693884, 1850.2321536562176, 1852.8702990790516, 852.5737131434283, 875.5490922175085, 904.1004200820095, 912.2519533982071, 928.2342067793962, 16280.75578866318, 17107.74338384925, 17364.65270694579, 17507.29970801154, 17936.461906142835, 816.7713040348712, 849.4987957105337, 857.2199298638209, 861.4788053227707, 884.566562384427, 9217.815643687089, 9771.462569558742, 9812.607495700093, 9820.263480239011, 9977.501124943723, 386417.0, 393447.0, 393539.0, 396908.0, 400622.0, 77387.22612773912, 78276.0, 78571.0, 78646.21353786503, 78764.0, 872.9180903545091, 884.1114679746813, 901.396064636695, 904.7466709321401, 905.714699869539, 15088.094714317176, 15272.312745926238, 15742.0, 15814.288357023732, 15907.522774316789, 37499.81250093841, 37644.435333469475, 38149.23701526009, 38647.2270554593, 38714.22571548497, 50336.0, 50911.0, 51098.0, 51146.232806507185, 51339.0, 5107.978404319077, 7059.082319298458, 7188.532745371744, 7209.0628218331285, 7321.377682897013, 7846.333061689592, 9265.861012084959, 9495.0, 9738.220942324455, 10379.0, 8415.747527574182, 8708.69519566812, 9033.954830225806, 9299.209567186865, 9405.106514881076, 9134.817303653757, 9284.535773211448, 9405.106514881076, 9406.717798466058, 9459.601180577525, 9255.67605133817, 9303.813923721624, 9304.581293841658, 9340.626374944926, 9820.901790982, 7137.785866424016, 9832.655857044969, 9943.403395796275, 10099.7475063124, 10518.368897866152, 8846.778830529289, 9080.40977336471, 9596.76008099803, 9624.807503850025, 10277.280590358603], "value": 7931.261023674809, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1198.3588780002701, 1340.2859210099543, 1400.7268582626389, 1467.2883651429056, 1696.7200411932024, 7534.095908490982, 7932.048154221494, 7962.283394494494, 8137.471064380811, 8141.06377766557, 7994.96002519988, 8105.473144245635, 8117.715879944203, 8118.309943654796, 8119.634616442259, 2232.1852523828766, 2256.7404748453973, 2259.4577301447616, 2260.163739416418, 2261.276391554703, 2203.449137715571, 2250.909963601454, 2259.0624890670433, 2264.377296243538, 2264.9320520384413, 2169.511859831533, 2192.0464597899886, 2205.933821985343, 2206.459417442729, 2221.455743342883, 2147.066026278558, 2150.3763908466526, 2157.5684863027377, 2168.6963825064504, 2171.1532502324108, 2136.529963408048, 2143.431990522513, 2145.0668959002883, 2147.1518750093783, 2147.4953385954286, 7863.13505514393, 8093.312068474187, 8120.390970677223, 8160.9591952040455, 8160.9591952040455, 4321.178975994582, 4409.338599210112, 4428.535003824584, 4433.046894917576, 4448.466184057901, 2715.904943326994, 2854.87153078112, 2898.521743912252, 2901.912942611725, 2923.1668974342424, 947.9905200947971, 959.4195511715451, 973.5910917414632, 975.4586204656413, 978.9216862651042, 10873.075788557982, 10957.671269861838, 10966.287191332618, 10985.176111791647, 10990.890091099067, 3947.1908258806875, 3960.0495880988356, 4102.835886564564, 4154.667626589866, 4187.790610469464, 8528.914710852936, 8596.484210947363, 8599.183077607617, 8604.139586041345, 8610.526421046778, 4446.688731788744, 4457.955420445819, 4458.331250312414, 4460.0, 4460.933086003713, 3490.7556471046782, 3931.8820435386983, 4012.879613611596, 4042.656374208166, 4133.586641335843, 3418.1796368871787, 3459.356805517359, 3581.048328660886, 3603.4955106285142, 3617.439296908983, 1041.7760181561, 1047.8480620310165, 1079.5519859258477, 1080.4597701149426, 1088.2871719024051, 693.5595896605691, 694.2224708326706, 730.6127752291294, 744.9702011919462, 760.581680075956, 4952.826651067196, 4968.428630707443, 5253.082624841905, 5264.05247055526, 5355.3841308249275, 387.18883938150094, 394.43398722832825, 394.7966797099496, 396.0, 396.5736832904581, 3426.2119712466274, 3486.2156014896445, 3521.6302288259876, 3564.8395822188063, 3614.0964758810296, 9417.48203848795, 9904.950475247577, 9924.702258932244, 9925.801483970281, 9929.453880036523, 9813.656522021694, 9846.064623860722, 9883.406995580288, 9884.357516761387, 9898.406095634286, 7500.099988001475, 7565.6217189140325, 7584.0, 7585.886211706828, 7587.0, 4971.925421118758, 5064.164412871834, 5121.8719532012, 5180.9740951295, 5354.54486368663, 9147.77130571741, 9175.174234318943, 9180.403273787182, 9214.44713317203, 9280.489573073546, 8619.569021548772, 8944.239739622206, 8947.463152210888, 9210.078992100736, 9351.812963740824, 5805.303363596396, 5989.8203053908455, 5993.460588546877, 6692.163479565054, 6863.176418829573, 7064.646767661494, 7364.0, 7602.1257555381835, 7688.038995125609, 7782.805429864072, 6648.5346025777735, 6768.323167683192, 6794.660266986532, 6822.897656535057, 6957.199922009034, 6637.734490620321, 6751.257361690112, 6877.552959057645, 6955.095837541087, 6982.406495447944, 5867.9413205869105, 6105.175801266772, 6139.8465038372615, 6139.938600613937, 6143.1706719592285, 4474.37358769779, 4503.639708823221, 4506.076254367781, 4544.7045942013665, 4574.634029277717, 4669.463011753556, 4699.4830568636735, 4761.142994261067, 4768.237082066853, 4822.276658501253], "value": 4015.665271856889, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.653205950948, 295.9985200073999, 302.3529646556368, 303.29483949816677, 303.88604273397476, 4679.391679081723, 4847.442544107429, 4852.393450818648, 4880.365552478177, 4900.064474532562, 4634.675572709912, 4743.739094349818, 4781.211100168477, 4790.353302304188, 4801.783919723612, 3765.491658626078, 3771.208046310278, 3776.3580191367396, 3782.1490164712995, 3808.466814645938, 3567.30437564675, 3653.5250417445695, 3796.5444146702434, 3827.483289755889, 3845.38473844185, 3714.1271801126713, 3742.4760533525327, 3743.7753734775865, 3759.4360845873202, 3767.5478942526797, 3749.9625003749884, 3750.9437358439645, 3765.134019175605, 3771.377722675755, 3785.1483416231404, 3332.450145725952, 3340.732741380684, 3342.944089385035, 3350.614679311886, 3351.8994430167136, 4599.678022538424, 4661.114388266218, 4686.95313046872, 4705.929411058837, 4708.317293992386, 4307.0, 4318.632916202127, 4334.609885110355, 4350.651947844165, 4354.216241076605, 5017.620154457553, 5032.597392208614, 5039.47085556015, 5040.445550989388, 5055.620828437882, 3590.7486475946694, 3609.693176080036, 3655.926881462356, 3670.1558641512333, 3676.16191904048, 5242.292290540767, 5245.921311180336, 5249.921251181236, 5252.1596544552685, 5313.9734301328635, 3710.8867339797953, 3724.255148970217, 3740.5224936150066, 3743.326201283795, 3744.307303148926, 3786.0, 3807.58116607173, 3812.4281357796553, 3814.6376094271, 3821.3503704370323, 4197.433346498184, 4297.484301883794, 4306.375575541591, 4320.891977700583, 4366.497852746975, 5055.393352797688, 5061.746912654353, 5067.87330316745, 5074.594032477393, 5075.796968121308, 1255.2217625072512, 1286.899700755859, 1309.2340980526499, 1310.6919873829643, 1333.4932725564224, 873.5806812729925, 879.0, 904.6381447420953, 912.115248209236, 913.2283220678516, 4411.0, 4417.249067658506, 4421.977890110593, 4435.3125265583885, 4447.844325448594, 5096.719680417538, 5120.590352771769, 5121.641485096007, 5127.3847138343635, 5131.204663277198, 4395.53846846083, 4395.955880515576, 4407.47110346754, 4409.33859921008, 4420.226460369422, 2307.4462129088897, 2431.3921519620094, 2431.829771915984, 2438.6707794447875, 2440.986990399, 4324.610785029299, 4336.241157797373, 4353.608175264241, 4356.0, 4360.302351623725, 4650.302454631832, 4654.9518211986615, 4665.440147182292, 4666.556677115668, 4673.626109911199, 4030.118465297268, 4322.913541729148, 4325.502567204811, 4339.522652508222, 4371.23503386906, 4514.571115743999, 4545.499995000613, 4553.590176884097, 4585.082983403399, 4602.4937256902385, 4470.173017991682, 4500.954990450054, 4519.638428925744, 4548.158590660738, 4561.840335588238, 4337.1976184405985, 4339.63113135387, 4589.311603259538, 4958.801572985476, 5002.974985125051, 3703.2778608172225, 3710.4805327254744, 3715.5912849587066, 3742.476053352478, 3755.9061023474633, 5001.774920128676, 5246.501582349671, 5267.577754006474, 5285.471452854684, 5331.3602367714575, 4887.87780305481, 4933.235348520985, 4973.52751488608, 5009.298698182331, 5080.872978175427, 4943.3573635427165, 5013.849584512471, 5048.343715316985, 5058.4688607697135, 5080.822171223989, 4771.618270538279, 4921.680090794087, 4951.331570237971, 4978.377702787152, 4990.500949905126, 5088.771005304696, 5102.642815002914, 5114.539691427789, 5116.641835071509, 5122.385313762373, 4964.478729733326, 4973.925391119208, 4975.701457912537, 4978.47725988766, 4994.875128121826], "value": 3733.475997469456, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.7004152985801, 619.744131361843, 644.7388807532951, 693.4591019005178, 703.6587255181237, 11043.72390690233, 12786.232826030433, 12833.67915802103, 12887.162334448254, 13012.0, 12773.680657983556, 12855.55005574805, 12878.80681789774, 12894.871051289485, 12912.289824059673, 610.255488304268, 746.9029026226583, 767.4627760567626, 768.2010708862776, 770.6532060572765, 737.1927739125649, 772.0850791811692, 773.4740376543948, 779.2129948751744, 784.3293983643988, 809.9635516401776, 812.1513018895268, 812.3420029775871, 812.4353574265888, 813.0771574263194, 630.8328293002359, 803.9115697273295, 805.9361642631699, 806.3710305961359, 806.3911746631256, 566.1733868551919, 579.8869220502004, 580.8751118509498, 585.3882692586258, 586.0681516388962, 11643.592474263445, 11647.301161930227, 11669.649910502698, 11673.94163029188, 11681.649550513499, 9612.375195612332, 10145.594176232942, 10240.180785537139, 10657.253992220547, 10735.141188704885, 11482.540698372055, 11672.708182295426, 11858.46636901333, 12041.157119001673, 12274.938625306817, 4037.0, 4038.0106873815807, 4078.8572399966156, 4205.8527951521855, 4213.431186789775, 67410.0, 67913.32086679169, 68287.65856170688, 68421.0, 69039.0, 10112.443815590066, 10199.215137350933, 10270.147154938433, 10513.264071515074, 10542.47287635615, 19007.61984760297, 19018.42944711661, 19030.61938761245, 19100.33148839784, 19130.330438434587, 6570.77002304917, 6615.768448104293, 6621.370969757865, 6670.599764014175, 6769.627670478072, 3399.5070714746225, 3489.249811290534, 3491.5635545556806, 3554.306910152495, 3562.1628917204434, 2698.190542837141, 2807.185916084313, 2808.7893407994075, 2812.2828678686806, 2815.211740712604, 481.3838286992655, 482.9251466022772, 484.7818481683186, 487.9121758083508, 489.64256093052273, 432.6560384494335, 448.8967537466401, 501.9409046911015, 511.57028096399205, 537.2210295072083, 6826.180858297036, 6988.0, 7229.610766828159, 7267.527610705287, 7525.473216874766, 485.58239913674214, 501.50852164878626, 504.39220739009403, 541.3233458177278, 557.3701717059697, 3284.540164376989, 3301.4717645176656, 3489.3195826814035, 3557.768745031565, 3612.5303710517464, 55929.720351397984, 81195.18804811995, 93208.0, 94738.0, 100154.4992275034, 49326.50673493291, 66192.0, 68792.0, 84193.15806841975, 86029.56985215034, 63585.36414635794, 63864.68067659632, 64332.67833660802, 72606.63696681483, 76152.0, 7556.131044929683, 8116.513009219466, 8118.254575266346, 8187.26314631686, 8351.0, 43641.78179109084, 45082.3237651442, 45232.32151517796, 45535.54464455313, 45908.540914591766, 35180.82409588038, 35879.641203588675, 36386.63613363938, 55612.0, 58255.70872145782, 11113.0, 11237.60668376603, 11355.716107097389, 11787.823182652439, 12755.93622031884, 12173.2696038238, 12386.690332741753, 12631.242125472501, 14192.716145676823, 14309.069910455786, 10820.5130769114, 11373.14701397382, 11467.4266286687, 11522.193446458667, 11722.120840936794, 10919.290246133976, 11600.0, 11826.940865295619, 11834.171607987359, 11835.70410739704, 10470.790584188122, 10830.566777328819, 11174.441277935908, 11819.172657913863, 12040.096992725405, 9647.324687271823, 10192.847107293248, 10582.523786429476, 10597.311174773615, 10738.355698658106, 9257.861132083159, 9270.907290927003, 9386.202172815387, 9475.241980641395, 9815.0], "value": 6267.257900923585, "unit": "score"}], "name": "dromaeo_css", "value": 6244.860422116342, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 121.0, 114.0, 115.0, 115.0, 117.0, 113.0, 114.0, 130.0], "value": 117.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 122.0, 150.0, 187.0, 130.0, 154.0, 160.0, 123.0, 205.0, 128.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 164.0, 161.0, 162.0, 161.0, 163.0, 161.0, 161.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 77.0, 177.0, 77.0, 79.0, 75.0, 77.0, 161.0, 76.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 135.0, 84.0, 84.0, 83.0, 148.0, 84.0, 84.0, 140.0], "value": 100.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 119.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 148.0, 146.0, 148.0, 146.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0, 97.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 69.0, 69.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0], "value": 67.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 65.0, 66.0, 66.0, 65.0, 69.0, 66.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 83.0, 82.0, 83.0, 87.0, 95.0, 83.0, 84.0, 83.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 144.0, 132.0, 142.0, 135.0, 136.0, 133.0, 133.0, 176.0, 136.0], "value": 142.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 178.0, 179.0, 177.0, 180.0, 185.0, 186.0, 177.0, 176.0, 178.0], "value": 179.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 70.0, 70.0, 73.0, 70.0, 69.0, 70.0, 69.0, 69.0], "value": 70.5, "unit": "score"}], "name": "kraken", "value": 1596.1999999999996, "alertThreshold": 2.0}]} 20:44:35 INFO - Return code: 0 20:44:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:44:35 INFO - # TBPL SUCCESS # 20:44:35 INFO - Running post-action listener: _resource_record_post_action 20:44:35 INFO - [mozharness: 2016-09-02 03:44:35.351112Z] Finished run-tests step (success) 20:44:35 INFO - Running post-run listener: _resource_record_post_run 20:44:35 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 421449728; Read time: 12; Write time: 332900 20:44:35 INFO - TinderboxPrint: CPU usage
13.1% 20:44:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:44:35 INFO - TinderboxPrint: I/O write bytes / time
421,449,728 / 332,900 20:44:35 INFO - TinderboxPrint: CPU idle
8,357.2 (86.9%) 20:44:35 INFO - TinderboxPrint: CPU user
1,206.3 (12.5%) 20:44:35 INFO - TinderboxPrint: Swap in / out
0 / 0 20:44:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 131215360; Read time: 0; Write time: 105552 20:44:35 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 289796096; Read time: 0; Write time: 227204 20:44:35 INFO - Running post-run listener: _upload_blobber_files 20:44:35 INFO - Blob upload gear active. 20:44:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:44:35 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 20:44:35 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'] 20:44:35 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 20:44:36 INFO - (blobuploader) - INFO - Open directory for files ... 20:44:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:44:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:44:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:44:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:44:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:44:37 INFO - (blobuploader) - INFO - Done attempting. 20:44:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:44:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:44:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:44:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:44:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:44:42 INFO - (blobuploader) - INFO - Done attempting. 20:44:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:44:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:44:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:44:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:44:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:44:43 INFO - (blobuploader) - INFO - Done attempting. 20:44:43 INFO - (blobuploader) - INFO - Iteration through files over. 20:44:43 INFO - Return code: 0 20:44:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:44:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:44:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8abe3a5411e38909338ef9a35ea38a4417671f6f6ae899e8dd3979b924fe86785d123cbef17187362e4457445d48ee2d5fb27e67d1f124aee21684d75fd60cf1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ceb540232792c38a17316451ba21d5a9579d51964e78ccd3fd5347e1c24f21f575446efeb13fe9979a65385d462a1ef8fac248bcbc384202b2d4ea899b99d663", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73f7709450050fe05cefcb6236a05560487af2e562b3c5520ee6242fa7d1dbeb34c6efbc16fd0e31a7021d92e32defee61113a3c1813c0c87a7e86abde056e02"} 20:44:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:44:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:44:43 INFO - Contents: 20:44:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8abe3a5411e38909338ef9a35ea38a4417671f6f6ae899e8dd3979b924fe86785d123cbef17187362e4457445d48ee2d5fb27e67d1f124aee21684d75fd60cf1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ceb540232792c38a17316451ba21d5a9579d51964e78ccd3fd5347e1c24f21f575446efeb13fe9979a65385d462a1ef8fac248bcbc384202b2d4ea899b99d663", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73f7709450050fe05cefcb6236a05560487af2e562b3c5520ee6242fa7d1dbeb34c6efbc16fd0e31a7021d92e32defee61113a3c1813c0c87a7e86abde056e02"} 20:44:43 INFO - Running post-run listener: copy_logs_to_upload_dir 20:44:43 INFO - Copying logs to upload dir... 20:44:43 INFO - mkdir: /builds/slave/test/build/upload/logs 20:44:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.621451 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-09-01 20:44:43.055076) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 20:44:43.062504) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580 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/8abe3a5411e38909338ef9a35ea38a4417671f6f6ae899e8dd3979b924fe86785d123cbef17187362e4457445d48ee2d5fb27e67d1f124aee21684d75fd60cf1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ceb540232792c38a17316451ba21d5a9579d51964e78ccd3fd5347e1c24f21f575446efeb13fe9979a65385d462a1ef8fac248bcbc384202b2d4ea899b99d663", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73f7709450050fe05cefcb6236a05560487af2e562b3c5520ee6242fa7d1dbeb34c6efbc16fd0e31a7021d92e32defee61113a3c1813c0c87a7e86abde056e02"} build_url:https://queue.taskcluster.net/v1/task/NnxGUL8-SvCaoxWogUKw1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/NnxGUL8-SvCaoxWogUKw1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8abe3a5411e38909338ef9a35ea38a4417671f6f6ae899e8dd3979b924fe86785d123cbef17187362e4457445d48ee2d5fb27e67d1f124aee21684d75fd60cf1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ceb540232792c38a17316451ba21d5a9579d51964e78ccd3fd5347e1c24f21f575446efeb13fe9979a65385d462a1ef8fac248bcbc384202b2d4ea899b99d663", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73f7709450050fe05cefcb6236a05560487af2e562b3c5520ee6242fa7d1dbeb34c6efbc16fd0e31a7021d92e32defee61113a3c1813c0c87a7e86abde056e02"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 20:44:43.090480) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 20:44:43.090828) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1472784676.112005-2093079580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 20:44:43.140961) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 20:44:43.144351) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 20:44:43.144709) ========= ========= Total master_lag: 0.15 =========