builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-024 starttime: 1472252450.86 results: success (0) buildid: 20160826150433 builduid: 207d0873ac034aee94fa7b64a0857880 revision: ad6a5176633bfda73f33af647741394c2964416b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 16:00:50.865468) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 16:00:50.865939) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 16:00:50.866253) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 16:00:50.913428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 16:00:50.913834) ========= 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=41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-26 16:00: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% 219M=0s 2016-08-26 16:00:51 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092420 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 16:00:51.021966) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 16:00:51.022306) ========= 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=41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023198 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 16:00:51.073548) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-26 16:00:51.073906) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ad6a5176633bfda73f33af647741394c2964416b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ad6a5176633bfda73f33af647741394c2964416b --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=41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-26 16:00:51,417 truncating revision to first 12 chars 2016-08-26 16:00:51,417 Setting DEBUG logging. 2016-08-26 16:00:51,418 attempt 1/10 2016-08-26 16:00:51,418 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ad6a5176633b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-26 16:00:52,461 unpacking tar archive at: fx-team-ad6a5176633b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.378106 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-26 16:00:52.468035) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 16:00:52.468353) ========= script_repo_revision: ad6a5176633bfda73f33af647741394c2964416b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 16:00:52.469299) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 16:00:52.469764) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 16:00:52.481653) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-26 16:00:52.482250) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:00:52 INFO - MultiFileLogger online at 20160826 16:00:52 in /builds/slave/test 16:00:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:00:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:00:52 INFO - {'append_to_log': False, 16:00:52 INFO - 'base_work_dir': '/builds/slave/test', 16:00:52 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:00:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:00:52 INFO - 'branch': 'Fx-Team-Non-PGO', 16:00:52 INFO - 'buildbot_json_path': 'buildprops.json', 16:00:52 INFO - 'config_files': ('talos/linux_config.py',), 16:00:52 INFO - 'default_actions': ('clobber', 16:00:52 INFO - 'read-buildbot-config', 16:00:52 INFO - 'download-and-extract', 16:00:52 INFO - 'populate-webroot', 16:00:52 INFO - 'create-virtualenv', 16:00:52 INFO - 'install', 16:00:52 INFO - 'run-tests'), 16:00:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:00:52 INFO - 'download_minidump_stackwalk': True, 16:00:52 INFO - 'download_symbols': 'ondemand', 16:00:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:00:52 INFO - 'tooltool.py': '/tools/tooltool.py', 16:00:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:00:52 INFO - '/tools/misc-python/virtualenv.py')}, 16:00:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:00:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:00:52 INFO - 'installer_path': 'installer.exe', 16:00:52 INFO - 'log_level': 'info', 16:00:52 INFO - 'log_name': 'talos', 16:00:52 INFO - 'log_to_console': True, 16:00:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:00:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:00:52 INFO - 'opt_config_files': (), 16:00:52 INFO - 'pip_index': False, 16:00:52 INFO - 'sps_profile': False, 16:00:52 INFO - 'sps_profile_interval': 0, 16:00:52 INFO - 'suite': 'dromaeojs', 16:00:52 INFO - 'system_bits': '32', 16:00:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:00:52 INFO - 'title': 'talos-linux64-ix-024', 16:00:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:00:52 INFO - 'use_talos_json': True, 16:00:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:00:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:00:52 INFO - 'work_dir': 'build'} 16:00:52 INFO - [mozharness: 2016-08-26 23:00:52.911566Z] Running clobber step. 16:00:52 INFO - Running pre-action listener: _resource_record_pre_action 16:00:52 INFO - Running main action method: clobber 16:00:52 INFO - rmtree: /builds/slave/test/build 16:00:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:00:53 INFO - Running post-action listener: _resource_record_post_action 16:00:53 INFO - [mozharness: 2016-08-26 23:00:53.885279Z] Finished clobber step (success) 16:00:53 INFO - [mozharness: 2016-08-26 23:00:53.885383Z] Running read-buildbot-config step. 16:00:53 INFO - Running pre-action listener: _resource_record_pre_action 16:00:53 INFO - Running main action method: read_buildbot_config 16:00:53 INFO - Using buildbot properties: 16:00:53 INFO - { 16:00:53 INFO - "project": "", 16:00:53 INFO - "product": "firefox", 16:00:53 INFO - "script_repo_revision": "production", 16:00:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:00:53 INFO - "repository": "", 16:00:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:00:53 INFO - "buildid": "20160826150433", 16:00:53 INFO - "pgo_build": "False", 16:00:53 INFO - "basedir": "/builds/slave/test", 16:00:53 INFO - "buildnumber": 1889, 16:00:53 INFO - "slavename": "talos-linux64-ix-024", 16:00:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:00:53 INFO - "platform": "ubuntu64_hw", 16:00:53 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:00:53 INFO - "branch": "fx-team", 16:00:53 INFO - "repo_path": "integration/fx-team", 16:00:53 INFO - "revision": "ad6a5176633bfda73f33af647741394c2964416b", 16:00:53 INFO - "stage_platform": "linux64", 16:00:53 INFO - "builduid": "207d0873ac034aee94fa7b64a0857880", 16:00:53 INFO - "slavebuilddir": "test" 16:00:53 INFO - } 16:00:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/SH17ujm4T2OiIlPCM_2jnA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:00:53 INFO - Running post-action listener: _resource_record_post_action 16:00:53 INFO - [mozharness: 2016-08-26 23:00:53.888326Z] Finished read-buildbot-config step (success) 16:00:53 INFO - [mozharness: 2016-08-26 23:00:53.888416Z] Running download-and-extract step. 16:00:53 INFO - Running pre-action listener: _resource_record_pre_action 16:00:53 INFO - Running main action method: download_and_extract 16:00:53 INFO - mkdir: /builds/slave/test/build/tests 16:00: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')]} 16:00:53 INFO - trying https://queue.taskcluster.net/v1/task/SH17ujm4T2OiIlPCM_2jnA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:00:53 INFO - Downloading https://queue.taskcluster.net/v1/task/SH17ujm4T2OiIlPCM_2jnA/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 16:00:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SH17ujm4T2OiIlPCM_2jnA/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 16:00:54 INFO - Downloaded 1361 bytes. 16:00:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:00:54 INFO - Using the following test package requirements: 16:00:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:00:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:00:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:00:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:00:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:00:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:00:54 INFO - u'jsshell-linux-x86_64.zip'], 16:00:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:00:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:00:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:00:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:00:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:00:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:00:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:00:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:00:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:00:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:00:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:00:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:00: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')]} 16:00:54 INFO - trying https://queue.taskcluster.net/v1/task/SH17ujm4T2OiIlPCM_2jnA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:00:54 INFO - Downloading https://queue.taskcluster.net/v1/task/SH17ujm4T2OiIlPCM_2jnA/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 16:00:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SH17ujm4T2OiIlPCM_2jnA/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 16:00:55 INFO - Downloaded 20303367 bytes. 16:00: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 16:00: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 16:00: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')]} 16:00:59 INFO - trying https://queue.taskcluster.net/v1/task/SH17ujm4T2OiIlPCM_2jnA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:00:59 INFO - Downloading https://queue.taskcluster.net/v1/task/SH17ujm4T2OiIlPCM_2jnA/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 16:00:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SH17ujm4T2OiIlPCM_2jnA/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 16:01:00 INFO - Downloaded 20303367 bytes. 16:01: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 16:01:04 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')]} 16:01:04 INFO - trying https://queue.taskcluster.net/v1/task/SH17ujm4T2OiIlPCM_2jnA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:01:04 INFO - Downloading https://queue.taskcluster.net/v1/task/SH17ujm4T2OiIlPCM_2jnA/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 16:01:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SH17ujm4T2OiIlPCM_2jnA/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 16:01:07 INFO - Downloaded 14413998 bytes. 16:01:07 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 16:01:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:07 INFO - trying https://queue.taskcluster.net/v1/task/SH17ujm4T2OiIlPCM_2jnA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:01:07 INFO - Downloading https://queue.taskcluster.net/v1/task/SH17ujm4T2OiIlPCM_2jnA/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 16:01:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SH17ujm4T2OiIlPCM_2jnA/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 16:01:09 INFO - Downloaded 55858674 bytes. 16:01:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SH17ujm4T2OiIlPCM_2jnA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:01:09 INFO - mkdir: /builds/slave/test/properties 16:01:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:01:09 INFO - Writing to file /builds/slave/test/properties/build_url 16:01:09 INFO - Contents: 16:01:09 INFO - build_url:https://queue.taskcluster.net/v1/task/SH17ujm4T2OiIlPCM_2jnA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:01:09 INFO - Running post-action listener: _resource_record_post_action 16:01:09 INFO - Running post-action listener: set_extra_try_arguments 16:01:09 INFO - [mozharness: 2016-08-26 23:01:09.985979Z] Finished download-and-extract step (success) 16:01:09 INFO - [mozharness: 2016-08-26 23:01:09.986208Z] Running populate-webroot step. 16:01:09 INFO - Running pre-action listener: _resource_record_pre_action 16:01:09 INFO - Running main action method: populate_webroot 16:01:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:01:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:01:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:01:09 INFO - '--tppagecycles', 16:01:10 INFO - '7'], 16:01:10 INFO - 'tests': ['tsvgm']}}, 16:01:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:01:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:01:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:01:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:01:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:01:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:01:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:10 INFO - 'talos_options': ['--disable-e10s'], 16:01:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:01:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:01:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:10 INFO - 'talos_options': ['--disable-e10s'], 16:01:10 INFO - 'tests': ['damp', 'tps']}, 16:01:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:10 INFO - 'tests': ['damp', 'tps']}, 16:01:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:01:10 INFO - 'tests': ['dromaeo_dom']}, 16:01:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:01:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:01:10 INFO - 'tests': ['basic_compositor_video']}, 16:01:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:01:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:01:10 INFO - 'tests': ['a11yr', 16:01:10 INFO - 'ts_paint', 16:01:10 INFO - 'tpaint', 16:01:10 INFO - 'sessionrestore', 16:01:10 INFO - 'sessionrestore_no_auto_restore', 16:01:10 INFO - 'tabpaint']}, 16:01:10 INFO - 'other-e10s': {'tests': ['a11yr', 16:01:10 INFO - 'ts_paint', 16:01:10 INFO - 'tpaint', 16:01:10 INFO - 'sessionrestore', 16:01:10 INFO - 'sessionrestore_no_auto_restore', 16:01:10 INFO - 'tabpaint']}, 16:01:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:01:10 INFO - 'ts_paint', 16:01:10 INFO - 'tpaint', 16:01:10 INFO - 'sessionrestore', 16:01:10 INFO - 'sessionrestore_no_auto_restore', 16:01:10 INFO - 'tabpaint']}, 16:01:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:01:10 INFO - 'ts_paint', 16:01:10 INFO - 'tpaint', 16:01:10 INFO - 'sessionrestore', 16:01:10 INFO - 'sessionrestore_no_auto_restore', 16:01:10 INFO - 'tabpaint']}, 16:01:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:01:10 INFO - 'tests': ['a11yr', 16:01:10 INFO - 'ts_paint', 16:01:10 INFO - 'tpaint', 16:01:10 INFO - 'sessionrestore', 16:01:10 INFO - 'sessionrestore_no_auto_restore', 16:01:10 INFO - 'tabpaint']}, 16:01:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:01:10 INFO - 'tests': ['a11yr', 16:01:10 INFO - 'ts_paint', 16:01:10 INFO - 'tpaint', 16:01:10 INFO - 'sessionrestore', 16:01:10 INFO - 'sessionrestore_no_auto_restore', 16:01:10 INFO - 'tabpaint']}, 16:01:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:01:10 INFO - 'tests': ['tsvgx', 16:01:10 INFO - 'tsvgr_opacity', 16:01:10 INFO - 'tart', 16:01:10 INFO - 'tscrollx', 16:01:10 INFO - 'cart']}, 16:01:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:01:10 INFO - 'tsvgr_opacity', 16:01:10 INFO - 'tart', 16:01:10 INFO - 'tscrollx', 16:01:10 INFO - 'cart']}, 16:01:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:10 INFO - 'talos_options': ['--disable-e10s'], 16:01:10 INFO - 'tests': ['tp5o']}, 16:01:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:10 INFO - 'tests': ['tp5o']}, 16:01:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:10 INFO - 'talos_options': ['--disable-e10s', 16:01:10 INFO - '--xperf_path', 16:01:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:01:10 INFO - 'tests': ['tp5n']}, 16:01:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:10 INFO - 'talos_options': ['--xperf_path', 16:01:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:01:10 INFO - 'tests': ['tp5n']}}, 16:01:10 INFO - 'talos.zip': {'path': '', 16:01:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:01:10 INFO - Running post-action listener: _resource_record_post_action 16:01:10 INFO - [mozharness: 2016-08-26 23:01:10.006698Z] Finished populate-webroot step (success) 16:01:10 INFO - [mozharness: 2016-08-26 23:01:10.006788Z] Running create-virtualenv step. 16:01:10 INFO - Running pre-action listener: _resource_record_pre_action 16:01:10 INFO - Running main action method: create_virtualenv 16:01:10 INFO - Creating virtualenv /builds/slave/test/build/venv 16:01:10 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 16:01:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:01:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:01:10 INFO - Using real prefix '/usr' 16:01:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:01:10 INFO - Installing distribute.............................................................................................................................................................................................done. 16:01:12 INFO - Installing pip.................done. 16:01:12 INFO - Return code: 0 16:01:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:01:12 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')]} 16:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:12 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')]} 16:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:12 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 0x7f143a9d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf96420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d20>, '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 0x1025c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10260b0>, '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': '41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266', '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 16:01:12 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 16:01:12 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 16:01:12 INFO - Using env: {'DISPLAY': ':0', 16:01:12 INFO - 'HOME': '/home/cltbld', 16:01:12 INFO - 'LANG': 'en_US.UTF-8', 16:01:12 INFO - 'LANGUAGE': 'en_US:en', 16:01:12 INFO - 'LOGNAME': 'cltbld', 16:01:12 INFO - 'MAIL': '/var/mail/cltbld', 16:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:12 INFO - 'MOZ_NO_REMOTE': '1', 16:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:12 INFO - 'NO_EM_RESTART': '1', 16:01:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:12 INFO - 'PWD': '/builds/slave/test', 16:01:12 INFO - 'SHELL': '/bin/bash', 16:01:12 INFO - 'SHLVL': '1', 16:01:12 INFO - 'TERM': 'linux', 16:01:12 INFO - 'TMOUT': '86400', 16:01:12 INFO - 'USER': 'cltbld', 16:01:12 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266', 16:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:12 INFO - '_': '/tools/buildbot/bin/python'} 16:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:12 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 16:01:12 INFO - Cleaning up... 16:01:12 INFO - Return code: 0 16:01:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:01:12 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')]} 16:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:12 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')]} 16:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:12 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 0x7f143a9d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf96420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d20>, '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 0x1025c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10260b0>, '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': '41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266', '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 16:01:12 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 16:01:12 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 16:01:12 INFO - Using env: {'DISPLAY': ':0', 16:01:12 INFO - 'HOME': '/home/cltbld', 16:01:12 INFO - 'LANG': 'en_US.UTF-8', 16:01:12 INFO - 'LANGUAGE': 'en_US:en', 16:01:12 INFO - 'LOGNAME': 'cltbld', 16:01:12 INFO - 'MAIL': '/var/mail/cltbld', 16:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:12 INFO - 'MOZ_NO_REMOTE': '1', 16:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:12 INFO - 'NO_EM_RESTART': '1', 16:01:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:12 INFO - 'PWD': '/builds/slave/test', 16:01:12 INFO - 'SHELL': '/bin/bash', 16:01:12 INFO - 'SHLVL': '1', 16:01:12 INFO - 'TERM': 'linux', 16:01:12 INFO - 'TMOUT': '86400', 16:01:12 INFO - 'USER': 'cltbld', 16:01:12 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266', 16:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:12 INFO - '_': '/tools/buildbot/bin/python'} 16:01:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:13 INFO - Downloading/unpacking psutil>=3.1.1 16:01:13 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 16:01:13 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 16:01:13 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 16:01:13 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 16:01:13 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 16:01:13 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 16:01:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:01:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:01:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:01:14 INFO - Installing collected packages: psutil 16:01:14 INFO - Running setup.py install for psutil 16:01:15 INFO - building 'psutil._psutil_linux' extension 16:01:15 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 16:01:15 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 16:01:15 INFO - building 'psutil._psutil_posix' extension 16:01:15 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 16:01:15 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 16:01:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:01:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:01:15 INFO - Successfully installed psutil 16:01:15 INFO - Cleaning up... 16:01:15 INFO - Return code: 0 16:01:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:01:15 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')]} 16:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:15 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')]} 16:01:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:15 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 0x7f143a9d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf96420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d20>, '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 0x1025c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10260b0>, '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': '41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266', '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 16:01:15 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 16:01:15 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 16:01:15 INFO - Using env: {'DISPLAY': ':0', 16:01:15 INFO - 'HOME': '/home/cltbld', 16:01:15 INFO - 'LANG': 'en_US.UTF-8', 16:01:15 INFO - 'LANGUAGE': 'en_US:en', 16:01:15 INFO - 'LOGNAME': 'cltbld', 16:01:15 INFO - 'MAIL': '/var/mail/cltbld', 16:01:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:15 INFO - 'MOZ_NO_REMOTE': '1', 16:01:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:15 INFO - 'NO_EM_RESTART': '1', 16:01:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:15 INFO - 'PWD': '/builds/slave/test', 16:01:15 INFO - 'SHELL': '/bin/bash', 16:01:15 INFO - 'SHLVL': '1', 16:01:15 INFO - 'TERM': 'linux', 16:01:15 INFO - 'TMOUT': '86400', 16:01:15 INFO - 'USER': 'cltbld', 16:01:15 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266', 16:01:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:15 INFO - '_': '/tools/buildbot/bin/python'} 16:01:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:01:15 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 16:01:15 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 16:01:15 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 16:01:15 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 16:01:15 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 16:01:15 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 16:01:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:01:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:01:17 INFO - Installing collected packages: mozsystemmonitor 16:01:17 INFO - Running setup.py install for mozsystemmonitor 16:01:17 INFO - Successfully installed mozsystemmonitor 16:01:17 INFO - Cleaning up... 16:01:17 INFO - Return code: 0 16:01:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:01:17 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')]} 16:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:17 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')]} 16:01:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7f143a9d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf96420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d20>, '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 0x1025c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10260b0>, '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': '41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266', '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 16:01:17 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 16:01:17 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 16:01:17 INFO - Using env: {'DISPLAY': ':0', 16:01:17 INFO - 'HOME': '/home/cltbld', 16:01:17 INFO - 'LANG': 'en_US.UTF-8', 16:01:17 INFO - 'LANGUAGE': 'en_US:en', 16:01:17 INFO - 'LOGNAME': 'cltbld', 16:01:17 INFO - 'MAIL': '/var/mail/cltbld', 16:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:17 INFO - 'MOZ_NO_REMOTE': '1', 16:01:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:17 INFO - 'NO_EM_RESTART': '1', 16:01:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:17 INFO - 'PWD': '/builds/slave/test', 16:01:17 INFO - 'SHELL': '/bin/bash', 16:01:17 INFO - 'SHLVL': '1', 16:01:17 INFO - 'TERM': 'linux', 16:01:17 INFO - 'TMOUT': '86400', 16:01:17 INFO - 'USER': 'cltbld', 16:01:17 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266', 16:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:17 INFO - '_': '/tools/buildbot/bin/python'} 16:01:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:18 INFO - Downloading/unpacking jsonschema==2.5.1 16:01: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 16:01: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 16:01: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 16:01: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 16:01: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 16:01: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 16:01:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:01:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:01: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 16:01: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 16:01: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 16:01: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 16:01: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 16:01: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 16:01:20 INFO - Downloading functools32-3.2.3-2.tar.gz 16:01:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:01:20 INFO - warning: no files found matching '*.txt' 16:01:20 INFO - no previously-included directories found matching 'build' 16:01:20 INFO - no previously-included directories found matching 'dist' 16:01:20 INFO - no previously-included directories found matching '.git*' 16:01:20 INFO - Installing collected packages: jsonschema, functools32 16:01:20 INFO - Running setup.py install for functools32 16:01:20 INFO - warning: no files found matching '*.txt' 16:01:20 INFO - no previously-included directories found matching 'build' 16:01:20 INFO - no previously-included directories found matching 'dist' 16:01:20 INFO - no previously-included directories found matching '.git*' 16:01:20 INFO - Successfully installed jsonschema functools32 16:01:20 INFO - Cleaning up... 16:01:20 INFO - Return code: 0 16:01:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:01:20 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')]} 16:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:20 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')]} 16:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:20 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 0x7f143a9d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf96420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d20>, '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 0x1025c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10260b0>, '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': '41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266', '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 16:01:20 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 16:01:20 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 16:01:20 INFO - Using env: {'DISPLAY': ':0', 16:01:20 INFO - 'HOME': '/home/cltbld', 16:01:20 INFO - 'LANG': 'en_US.UTF-8', 16:01:20 INFO - 'LANGUAGE': 'en_US:en', 16:01:20 INFO - 'LOGNAME': 'cltbld', 16:01:20 INFO - 'MAIL': '/var/mail/cltbld', 16:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:20 INFO - 'MOZ_NO_REMOTE': '1', 16:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:20 INFO - 'NO_EM_RESTART': '1', 16:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:20 INFO - 'PWD': '/builds/slave/test', 16:01:20 INFO - 'SHELL': '/bin/bash', 16:01:20 INFO - 'SHLVL': '1', 16:01:20 INFO - 'TERM': 'linux', 16:01:20 INFO - 'TMOUT': '86400', 16:01:20 INFO - 'USER': 'cltbld', 16:01:20 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266', 16:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:20 INFO - '_': '/tools/buildbot/bin/python'} 16:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:01:20 INFO - Cleaning up... 16:01:20 INFO - Return code: 0 16:01:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:01:20 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')]} 16:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:20 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')]} 16:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:20 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 0x7f143a9d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf96420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d20>, '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 0x1025c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10260b0>, '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': '41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266', '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 16:01:20 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 16:01:20 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 16:01:20 INFO - Using env: {'DISPLAY': ':0', 16:01:20 INFO - 'HOME': '/home/cltbld', 16:01:20 INFO - 'LANG': 'en_US.UTF-8', 16:01:20 INFO - 'LANGUAGE': 'en_US:en', 16:01:20 INFO - 'LOGNAME': 'cltbld', 16:01:20 INFO - 'MAIL': '/var/mail/cltbld', 16:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:20 INFO - 'MOZ_NO_REMOTE': '1', 16:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:20 INFO - 'NO_EM_RESTART': '1', 16:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:20 INFO - 'PWD': '/builds/slave/test', 16:01:20 INFO - 'SHELL': '/bin/bash', 16:01:20 INFO - 'SHLVL': '1', 16:01:20 INFO - 'TERM': 'linux', 16:01:20 INFO - 'TMOUT': '86400', 16:01:20 INFO - 'USER': 'cltbld', 16:01:20 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266', 16:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:20 INFO - '_': '/tools/buildbot/bin/python'} 16:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:20 INFO - Downloading/unpacking blobuploader==1.2.4 16:01:20 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 16:01:20 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 16:01:20 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 16:01:20 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 16:01:20 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 16:01:20 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 16:01:22 INFO - Downloading blobuploader-1.2.4.tar.gz 16:01:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:01:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:01:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:22 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 16:01:22 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 16:01:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:01:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:23 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 16:01:23 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 16:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:23 INFO - Downloading docopt-0.6.1.tar.gz 16:01:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:01:23 INFO - Installing collected packages: blobuploader, requests, docopt 16:01:23 INFO - Running setup.py install for blobuploader 16:01:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:01:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:01:23 INFO - Running setup.py install for requests 16:01:24 INFO - Running setup.py install for docopt 16:01:24 INFO - Successfully installed blobuploader requests docopt 16:01:24 INFO - Cleaning up... 16:01:24 INFO - Return code: 0 16:01:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:01:24 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')]} 16:01:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:24 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')]} 16:01:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:24 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 0x7f143a9d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf96420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d20>, '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 0x1025c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10260b0>, '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': '41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266', '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 16:01:24 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 16:01:24 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 16:01:24 INFO - Using env: {'DISPLAY': ':0', 16:01:24 INFO - 'HOME': '/home/cltbld', 16:01:24 INFO - 'LANG': 'en_US.UTF-8', 16:01:24 INFO - 'LANGUAGE': 'en_US:en', 16:01:24 INFO - 'LOGNAME': 'cltbld', 16:01:24 INFO - 'MAIL': '/var/mail/cltbld', 16:01:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:24 INFO - 'MOZ_NO_REMOTE': '1', 16:01:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:24 INFO - 'NO_EM_RESTART': '1', 16:01:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:24 INFO - 'PWD': '/builds/slave/test', 16:01:24 INFO - 'SHELL': '/bin/bash', 16:01:24 INFO - 'SHLVL': '1', 16:01:24 INFO - 'TERM': 'linux', 16:01:24 INFO - 'TMOUT': '86400', 16:01:24 INFO - 'USER': 'cltbld', 16:01:24 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266', 16:01:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:24 INFO - '_': '/tools/buildbot/bin/python'} 16:01:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:01:24 INFO - Running setup.py (path:/tmp/pip-SQfrgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:01:24 INFO - Running setup.py (path:/tmp/pip-khmh0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:01:24 INFO - Running setup.py (path:/tmp/pip-xhACqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:01:24 INFO - Running setup.py (path:/tmp/pip-dbmejJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:01:24 INFO - Running setup.py (path:/tmp/pip-1xa4nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:01:24 INFO - Running setup.py (path:/tmp/pip-oRLkvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:01:24 INFO - Running setup.py (path:/tmp/pip-Q1vvUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:01:24 INFO - Running setup.py (path:/tmp/pip-WTpCtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:01:24 INFO - Running setup.py (path:/tmp/pip-V4Ji_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:01:25 INFO - Running setup.py (path:/tmp/pip-UCPcx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:01:25 INFO - Running setup.py (path:/tmp/pip-ZFnEml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:01:25 INFO - Running setup.py (path:/tmp/pip-_02sdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:01:25 INFO - Running setup.py (path:/tmp/pip-RwyZFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:01:25 INFO - Running setup.py (path:/tmp/pip-haTtu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:25 INFO - Running setup.py (path:/tmp/pip-ta7bLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:01:25 INFO - Running setup.py (path:/tmp/pip-FskIYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:01:25 INFO - Running setup.py (path:/tmp/pip-5Z8FXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:01:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:01:25 INFO - Running setup.py install for manifestparser 16:01:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:01:25 INFO - Running setup.py install for mozcrash 16:01:25 INFO - Running setup.py install for mozdebug 16:01:25 INFO - Running setup.py install for mozdevice 16:01:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:01:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:01:26 INFO - Running setup.py install for mozfile 16:01:26 INFO - Running setup.py install for mozhttpd 16:01:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:01:26 INFO - Running setup.py install for mozinfo 16:01:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:01:26 INFO - Running setup.py install for mozInstall 16:01:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:01:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:01:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:01:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:01:26 INFO - Running setup.py install for mozleak 16:01:26 INFO - Running setup.py install for mozlog 16:01:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:01:26 INFO - Running setup.py install for moznetwork 16:01:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:01:26 INFO - Running setup.py install for mozprocess 16:01:26 INFO - Running setup.py install for mozprofile 16:01:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:01:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:01:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:01:26 INFO - Running setup.py install for mozrunner 16:01:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:01:27 INFO - Running setup.py install for mozscreenshot 16:01:27 INFO - Running setup.py install for moztest 16:01:27 INFO - Running setup.py install for mozversion 16:01:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:01:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:01:27 INFO - Cleaning up... 16:01:27 INFO - Return code: 0 16:01:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:01:27 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')]} 16:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:27 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')]} 16:01:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:27 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 0x7f143a9d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf96420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d20>, '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 0x1025c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10260b0>, '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': '41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266', '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 16:01:27 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 16:01:27 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 16:01:27 INFO - Using env: {'DISPLAY': ':0', 16:01:27 INFO - 'HOME': '/home/cltbld', 16:01:27 INFO - 'LANG': 'en_US.UTF-8', 16:01:27 INFO - 'LANGUAGE': 'en_US:en', 16:01:27 INFO - 'LOGNAME': 'cltbld', 16:01:27 INFO - 'MAIL': '/var/mail/cltbld', 16:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:27 INFO - 'MOZ_NO_REMOTE': '1', 16:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:27 INFO - 'NO_EM_RESTART': '1', 16:01:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:27 INFO - 'PWD': '/builds/slave/test', 16:01:27 INFO - 'SHELL': '/bin/bash', 16:01:27 INFO - 'SHLVL': '1', 16:01:27 INFO - 'TERM': 'linux', 16:01:27 INFO - 'TMOUT': '86400', 16:01:27 INFO - 'USER': 'cltbld', 16:01:27 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266', 16:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:27 INFO - '_': '/tools/buildbot/bin/python'} 16:01:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:01:27 INFO - Running setup.py (path:/tmp/pip-8ZKwHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:01:27 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)) 16:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:01:27 INFO - Running setup.py (path:/tmp/pip-fAYrCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:01:27 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)) 16:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:01:27 INFO - Running setup.py (path:/tmp/pip-7fg8jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:01:27 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)) 16:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:01:27 INFO - Running setup.py (path:/tmp/pip-NMkpCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:01:27 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)) 16:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:01:27 INFO - Running setup.py (path:/tmp/pip-Mr9dLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:01:27 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)) 16:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:01:27 INFO - Running setup.py (path:/tmp/pip-hta_uT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:01:28 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)) 16:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:01:28 INFO - Running setup.py (path:/tmp/pip-NrEhad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:01:28 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)) 16:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:01:28 INFO - Running setup.py (path:/tmp/pip-IOvaI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:01:28 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)) 16:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:01:28 INFO - Running setup.py (path:/tmp/pip-lmKe3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:01:28 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)) 16:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:01:28 INFO - Running setup.py (path:/tmp/pip-LFpKJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:01:28 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)) 16:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:01:28 INFO - Running setup.py (path:/tmp/pip-JYSlil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:01:28 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)) 16:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:01:28 INFO - Running setup.py (path:/tmp/pip-8W1PN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:01:28 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)) 16:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:01:28 INFO - Running setup.py (path:/tmp/pip-q5oHZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:01:28 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)) 16:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:01:28 INFO - Running setup.py (path:/tmp/pip-h3e0Wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:01:28 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)) 16:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:28 INFO - Running setup.py (path:/tmp/pip-Bz2uNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:28 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)) 16:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:01:28 INFO - Running setup.py (path:/tmp/pip-Kk2CZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:01:28 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)) 16:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:01:28 INFO - Running setup.py (path:/tmp/pip-GzExJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:01:28 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)) 16:01:28 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)) 16:01:28 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)) 16:01:28 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)) 16:01:28 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)) 16:01:28 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)) 16:01:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:01:28 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 16:01:28 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 16:01:28 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 16:01:28 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 16:01:28 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 16:01:28 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 16:01:30 INFO - Downloading blessings-1.6.tar.gz 16:01:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:01:30 INFO - Installing collected packages: blessings 16:01:30 INFO - Running setup.py install for blessings 16:01:30 INFO - Successfully installed blessings 16:01:30 INFO - Cleaning up... 16:01:30 INFO - Return code: 0 16:01:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:01:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:01:31 INFO - Reading from file tmpfile_stdout 16:01:31 INFO - Current package versions: 16:01:31 INFO - argparse == 1.2.1 16:01:31 INFO - blessings == 1.6 16:01:31 INFO - blobuploader == 1.2.4 16:01:31 INFO - docopt == 0.6.1 16:01:31 INFO - functools32 == 3.2.3-2 16:01:31 INFO - jsonschema == 2.5.1 16:01:31 INFO - manifestparser == 1.1 16:01:31 INFO - mozInstall == 1.12 16:01:31 INFO - mozcrash == 0.17 16:01:31 INFO - mozdebug == 0.1 16:01:31 INFO - mozdevice == 0.48 16:01:31 INFO - mozfile == 1.2 16:01:31 INFO - mozhttpd == 0.7 16:01:31 INFO - mozinfo == 0.9 16:01:31 INFO - mozleak == 0.1 16:01:31 INFO - mozlog == 3.3 16:01:31 INFO - moznetwork == 0.27 16:01:31 INFO - mozprocess == 0.23 16:01:31 INFO - mozprofile == 0.28 16:01:31 INFO - mozrunner == 6.12 16:01:31 INFO - mozscreenshot == 0.1 16:01:31 INFO - mozsystemmonitor == 0.3 16:01:31 INFO - moztest == 0.7 16:01:31 INFO - mozversion == 1.4 16:01:31 INFO - psutil == 3.1.1 16:01:31 INFO - requests == 1.2.3 16:01:31 INFO - wsgiref == 0.1.2 16:01:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:01:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7f143a9d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf96420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d20>, '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 0x1025c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10260b0>, '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': '41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266', '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 16:01:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 16:01:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.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 16:01:31 INFO - Using env: {'DISPLAY': ':0', 16:01:31 INFO - 'HOME': '/home/cltbld', 16:01:31 INFO - 'LANG': 'en_US.UTF-8', 16:01:31 INFO - 'LANGUAGE': 'en_US:en', 16:01:31 INFO - 'LOGNAME': 'cltbld', 16:01:31 INFO - 'MAIL': '/var/mail/cltbld', 16:01:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:31 INFO - 'MOZ_NO_REMOTE': '1', 16:01:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:31 INFO - 'NO_EM_RESTART': '1', 16:01:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:31 INFO - 'PWD': '/builds/slave/test', 16:01:31 INFO - 'SHELL': '/bin/bash', 16:01:31 INFO - 'SHLVL': '1', 16:01:31 INFO - 'TERM': 'linux', 16:01:31 INFO - 'TMOUT': '86400', 16:01:31 INFO - 'USER': 'cltbld', 16:01:31 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266', 16:01:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:31 INFO - '_': '/tools/buildbot/bin/python'} 16:01:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:31 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)) 16:01:31 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)) 16:01:31 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)) 16:01:31 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)) 16:01:31 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)) 16:01:31 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)) 16:01:31 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)) 16:01:31 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)) 16:01:31 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)) 16:01:31 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)) 16:01:31 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)) 16:01:31 INFO - Cleaning up... 16:01:31 INFO - Return code: 0 16:01:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:01:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f143a9d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf96420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d20>, '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 0x1025c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10260b0>, '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': '41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266', '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 16:01:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:01:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:01:31 INFO - Using env: {'DISPLAY': ':0', 16:01:31 INFO - 'HOME': '/home/cltbld', 16:01:31 INFO - 'LANG': 'en_US.UTF-8', 16:01:31 INFO - 'LANGUAGE': 'en_US:en', 16:01:31 INFO - 'LOGNAME': 'cltbld', 16:01:31 INFO - 'MAIL': '/var/mail/cltbld', 16:01:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:31 INFO - 'MOZ_NO_REMOTE': '1', 16:01:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:31 INFO - 'NO_EM_RESTART': '1', 16:01:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:31 INFO - 'PWD': '/builds/slave/test', 16:01:31 INFO - 'SHELL': '/bin/bash', 16:01:31 INFO - 'SHLVL': '1', 16:01:31 INFO - 'TERM': 'linux', 16:01:31 INFO - 'TMOUT': '86400', 16:01:31 INFO - 'USER': 'cltbld', 16:01:31 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266', 16:01:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:31 INFO - '_': '/tools/buildbot/bin/python'} 16:01:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:01:31 INFO - Cleaning up... 16:01:31 INFO - Return code: 0 16:01:31 INFO - Running post-action listener: _resource_record_post_action 16:01:31 INFO - Running post-action listener: _start_resource_monitoring 16:01:31 INFO - Starting resource monitoring. 16:01:31 INFO - [mozharness: 2016-08-26 23:01:31.706628Z] Finished create-virtualenv step (success) 16:01:31 INFO - [mozharness: 2016-08-26 23:01:31.707084Z] Running install step. 16:01:31 INFO - Running pre-action listener: _resource_record_pre_action 16:01:31 INFO - Running main action method: install 16:01:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:01:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:01:31 INFO - Reading from file tmpfile_stdout 16:01:31 INFO - Detecting whether we're running mozinstall >=1.0... 16:01:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:01:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:01:31 INFO - Reading from file tmpfile_stdout 16:01:31 INFO - Output received: 16:01:31 INFO - Usage: mozinstall [options] installer 16:01:31 INFO - Options: 16:01:31 INFO - -h, --help show this help message and exit 16:01:31 INFO - -d DEST, --destination=DEST 16:01:31 INFO - Directory to install application into. [default: 16:01:31 INFO - "/builds/slave/test"] 16:01:31 INFO - --app=APP Application being installed. [default: firefox] 16:01:31 INFO - mkdir: /builds/slave/test/build/application 16:01:31 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'] 16:01:31 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 16:01:48 INFO - Reading from file tmpfile_stdout 16:01:48 INFO - Output received: 16:01:48 INFO - /builds/slave/test/build/application/firefox/firefox 16:01:48 INFO - Running post-action listener: _resource_record_post_action 16:01:48 INFO - [mozharness: 2016-08-26 23:01:48.155300Z] Finished install step (success) 16:01:48 INFO - [mozharness: 2016-08-26 23:01:48.155582Z] Running run-tests step. 16:01:48 INFO - Running pre-action listener: _resource_record_pre_action 16:01:48 INFO - Running main action method: run_tests 16:01:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:01:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:01:48 INFO - Python 2.7.3 16:01:48 INFO - Return code: 0 16:01:48 INFO - grabbing minidump binary from tooltool 16:01:48 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')]} 16:01:48 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 0x1024d20>, '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 0x1025c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10260b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:01:48 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 16:01:48 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 16:01:48 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 16:01:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:01:48 INFO - Return code: 0 16:01:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:01:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:01:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:01:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:01:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:01:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SH17ujm4T2OiIlPCM_2jnA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 16:01:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SH17ujm4T2OiIlPCM_2jnA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 16:01:48 INFO - Using env: {'DISPLAY': ':0', 16:01:48 INFO - 'HOME': '/home/cltbld', 16:01:48 INFO - 'LANG': 'en_US.UTF-8', 16:01:48 INFO - 'LANGUAGE': 'en_US:en', 16:01:48 INFO - 'LOGNAME': 'cltbld', 16:01:48 INFO - 'MAIL': '/var/mail/cltbld', 16:01:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:01:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:48 INFO - 'MOZ_NO_REMOTE': '1', 16:01:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:48 INFO - 'NO_EM_RESTART': '1', 16:01:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:48 INFO - 'PWD': '/builds/slave/test', 16:01:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:01:48 INFO - 'SHELL': '/bin/bash', 16:01:48 INFO - 'SHLVL': '1', 16:01:48 INFO - 'TERM': 'linux', 16:01:48 INFO - 'TMOUT': '86400', 16:01:48 INFO - 'USER': 'cltbld', 16:01:48 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266', 16:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:48 INFO - '_': '/tools/buildbot/bin/python'} 16:01:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SH17ujm4T2OiIlPCM_2jnA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 16:01:48 INFO - mozversion application_buildid: 20160826150433 16:01:48 INFO - mozversion application_changeset: ad6a5176633bfda73f33af647741394c2964416b 16:01:48 INFO - mozversion application_display_name: Nightly 16:01:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:01:48 INFO - mozversion application_name: Firefox 16:01:48 INFO - mozversion application_remotingname: firefox 16:01:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:01:48 INFO - mozversion application_vendor: Mozilla 16:01:48 INFO - mozversion application_version: 51.0a1 16:01:48 INFO - mozversion platform_buildid: 20160826150433 16:01:48 INFO - mozversion platform_changeset: ad6a5176633bfda73f33af647741394c2964416b 16:01:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:01:48 INFO - mozversion platform_version: 51.0a1 16:01:48 INFO - using testdate: 1472252508 16:01:48 INFO - actual date: 1472252508 16:01:48 INFO - starting webserver on 'localhost:34857' 16:01:48 INFO - SUITE-START | Running 2 tests 16:01:48 INFO - TEST-START | dromaeo_css 16:01:48 INFO - operating with platform_type : linux_ 16:01:48 INFO - Initialising browser for dromaeo_css test... 16:01:48 INFO - TEST-INFO | started process 9447 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBsZ4tY/profile http://localhost:34857/getInfo.html) 16:01:52 INFO - PROCESS | 9447 | __metrics Screen width/height:1600/1200 16:01:52 INFO - PROCESS | 9447 | colorDepth:24 16:01:52 INFO - PROCESS | 9447 | Browser inner width/height: 1024/697 16:01:52 INFO - PROCESS | 9447 | __metrics 16:01:53 INFO - PROCESS | 9447 | 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" 16:01:53 INFO - PROCESS | 9447 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:01:54 INFO - PROCESS | 9447 | console.error: PushService: 16:01:54 INFO - PROCESS | 9447 | stateChangeProcessEnqueue: Error transitioning state 16:01:54 INFO - PROCESS | 9447 | UnknownError 16:01:54 INFO - TEST-INFO | 9447: exit 0 16:01:54 INFO - Browser initialized. 16:01:54 INFO - Running cycle 1/1 for dromaeo_css test... 16:01:54 INFO - TEST-INFO | started process 9530 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBsZ4tY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:02:07 INFO - PROCESS | 9530 | RSS: Main: 180953088 16:02:07 INFO - PROCESS | 9530 | 16:02:58 INFO - PROCESS | 9530 | 1472252578808 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] 16:05:11 INFO - PROCESS | 9530 | Cycle 1(1): loaded http://localhost:34857/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34857/tests/dromaeo/cssquery-ext.html) 16:05:12 INFO - PROCESS | 9530 | RSS: Main: 270696448 16:05:12 INFO - PROCESS | 9530 | 16:08:14 INFO - PROCESS | 9530 | Cycle 1(1): loaded http://localhost:34857/tests/dromaeo/cssquery-ext.html (next: http://localhost:34857/tests/dromaeo/cssquery-jquery.html) 16:08:15 INFO - PROCESS | 9530 | RSS: Main: 280436736 16:08:15 INFO - PROCESS | 9530 | 16:11:17 INFO - PROCESS | 9530 | Cycle 1(1): loaded http://localhost:34857/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34857/tests/dromaeo/cssquery-mootools.html) 16:11:18 INFO - PROCESS | 9530 | RSS: Main: 217067520 16:11:18 INFO - PROCESS | 9530 | 16:14:20 INFO - PROCESS | 9530 | Cycle 1(1): loaded http://localhost:34857/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34857/tests/dromaeo/cssquery-prototype.html) 16:14:21 INFO - PROCESS | 9530 | RSS: Main: 217653248 16:14:21 INFO - PROCESS | 9530 | 16:17:24 INFO - PROCESS | 9530 | Cycle 1(1): loaded http://localhost:34857/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34857/tests/dromaeo/cssquery-yui.html) 16:17:25 INFO - PROCESS | 9530 | RSS: Main: 217251840 16:17:25 INFO - PROCESS | 9530 | 16:20:28 INFO - PROCESS | 9530 | Cycle 1(1): loaded http://localhost:34857/tests/dromaeo/cssquery-yui.html (next: http://localhost:34857/tests/dromaeo/cssquery-dojo.html) 16:20:28 INFO - PROCESS | 9530 | RSS: Main: 308719616 16:20:28 INFO - PROCESS | 9530 | 16:20:28 INFO - PROCESS | 9530 | __start_tp_report 16:20:28 INFO - PROCESS | 9530 | _x_x_mozilla_page_load 16:20:28 INFO - PROCESS | 9530 | _x_x_mozilla_page_load_details 16:20:28 INFO - PROCESS | 9530 | |i|pagename|runs| 16:20:28 INFO - PROCESS | 9530 | |0;dojo.html;2563.397601563632;2581.6385706001174;2588.559944809382;2604.986975065124;2606.3353844769576;4498.190325741365;4583.839565615204;4682.625389968803;4719.4336679598455;4801.159797035518;4653.767311634413;4699.67102302839;4733.857984260478;4750.548697873705;4756.690815097025;4247.405363249148;4270.530241673413;4314.633256173213;4373.978130109361;4510.143072816154;4410.647148228134;4438.245498265286;4462.754548499831;4469.284914413694;4487.932681009787;4218.2196293685765;4245.426867372927;4255.702100852942;4294;4359.280718681413;4329.567043295677;4378.321360189176;4395.780210989437;4398.3622374755805;4405.449318835145;4244.0663054128045;4246.660267178619;4247.426597409341;4299.441072660534;4352.151330490556;4631.0506346198945;4688.695234809727;4689.366935463703;4691.296305554194;4759.524047595248;4878.463369029404;5005.199168133081;5016.122178618727;5062.569681577071;5073.416557095944;5094.31226784383;5098.770555325019;5101.158308879068;5102.617303702237;5107.948920510785;4701.529847015339;4749.4063242094735;4750.643701722384;4755.524447555217;4809.302651115569;4995;5179.948200517946;5234.26720259164;5249.790008399697;5328.49379308965;5004.174311238605;5036.093503169392;5037.596992240612;5038.84883453497;5041.773120209599;5123.666961647481;5126.846194614093;5136.4606716295;5138.254953031864;5180.300659411007;4806.615470762401;4914.827981020647;4920.065187614342;4970.502949705001;5042.142835717937;4943.3573635427165;4950.455449900508;4951.034548263126;4955.72743499111;5008.824691135866;4258.957410425918;4265.274903266452;4272.764997925144;4281.01536646573;4326.610605045561;3659.3596120678776;3685.4840322354894;3694.464302676097;3709.1283548366114;3768.7361884668358;4298.785060747013;4317.762523061199;4319.157764235943;4364.4980827204645;4369.453818272716;5016.724080175625;5026;5030.410984876855;5030.899382012412;5082.313887625197;4213.0099426634715;4302.935455968163;4324.805383757738;4368.803403846835;4378.824847006148;4582.656300777455;4599.264117741145;4606.009707912748;4647.95352046482;4664.230401983703;4829.758512074382;4841.806327746851;4841.951580484291;4843.297721830385;4903.509649035068;4897.46127925935;4991.15150424436;5061.746912654279;5076.873078172927;5137.306463627512;4810.59109975642;4823.56587907076;4827.662063655511;4866.29438731389;4886.144924638103;5003.074431230234;5036.6726162799305;5037.294778730908;5040.193569029085;5042.39491261051;4830.637702172281;4871.732054737024;4878.414590249193;5060.569851562511;5199.74001299941;4967.205247160437;5019.974900125622;5022.924656130234;5082.186850103965;5086.694798312114;5004.124278251365;5013.924791128209;5014.0974624567925;5019.347484826949;5084.059449001947;4723.929141062956;4924.458309585871;4930.211166213388;4941.876453088702;5002.474740152232;5020.146575082318;5031.371078615173;5038.269450929668;5089.160288552347;5092.134337162617;4917.164082106122;4919.803207871645;4920.507949205051;4932.8026878925875;4999.975000124976 16:20:28 INFO - PROCESS | 9530 | |1;ext.html;533.7704786941614;545.8144230961475;551.7985935133678;551.9337679478463;567.9634666733211;37418.43872341914;39244.626438074636;39287.41068883962;43296.134077318435;43340;39733.8013309933;40136;40207.19585608294;40218.798906005504;40223.39664905021;7186.461015423864;7722.498037627564;7775.727849525268;7801.258880406353;7856.567888766115;9741.90258097417;10022.899771002307;10027.64903228387;10368;10377.429241391721;9723.562439690231;9766;9766.511674416286;9768.316217864753;9779.070988256104;9978.850317245211;10007.14939230159;10027.147692446151;10032.046955539248;10036.14692751117;9805.068518490732;9874.802503949953;9876.061774131518;9878.259130565164;9881.604735810559;38279.425808612614;38451.8077409614;38514.4594216231;38547.22905541902;38611.61388386136;3000.3699223162944;3086.9691303086906;3097.829619370934;3156.0847354267235;3176.2218256527067;28268.85865570659;28466.573001404788;28882.27794305138;28927.132186034243;30065.248368790737;3279;3386.407378708716;3412.6246112927556;3421.674940880612;3462.97150738486;254356;254768;256072;256353;258504;50928.23607645888;51005;51009.744951275745;51028.489715102376;51260.487395126314;32112.35775284481;33042.17394565107;33186;34718;34721.65278347184;14168.574942751733;14237.216953067473;14237.715245695235;14262.3581938813;14276.57170284893;10142.188624910137;11374.488148033359;11527.654170374903;11560.595379161858;11595.942020289845;17677.292908283784;17691.203895824463;17738;17775.200115994812;17782.91108544449;6603.740761174866;6622.9006564901565;6718.798436046926;6917.792466226021;6947.895781563179;777.6772639354605;874.5845723281391;896.8968568614692;899.0515006668028;950.5627411390699;26610.866945665533;27050;27104.593431098154;27525.724742752718;27656.446871062468;906.6917248135666;924.930630202724;935.2751617496494;947.8815148106487;1035.7307100153864;13670.087764378268;14424.855751442561;14485.855141448661;14692.191929443983;14840.777388339184;385939;389583;390063;390798;391032;46151.38470153596;46512.3023154653;47019.52980470152;47175.76412117918;47178.29232561514;1061.6337363609696;1125.6454216921807;1135.7444574970566;1151.8790526994544;1184.9644510664693;26941;28142.859285703442;28993.42013159767;29285.560716589694;29404.55893161647;40759.592404076764;41505;41595.37606935959;41612.58387416208;41626.167476649694;281928;284374;284788;285988;286589;24528;25549.616755748306;25795.613065804402;26610.33474163084;26675.866620666773;39922.201555969295;40011;40667.593324067566;41087.794561027;41486.377704335064;33740.49389259212;34607.30785384228;34756.65243347534;34836.303273933874;34913.12717182091;34050.65949340574;34089.48865766966;34158.31683366369;34378.077863380895;34551.30897381988;34395.31209375848;34799.826000869834;35133.297334053685;35269.64730352664;35442.46836297406;29836.70163298426;31265.958241047752;32019.35961280808;32033.359332812746;34568.82715586406;24748.628770568816;24797.25608231756;24889.751102488743;25116.24651260465;25351.72029530581 16:20:28 INFO - PROCESS | 9530 | |2;jquery.html;332.9644804657513;346.3246668995458;360.421523454855;364.9616790237025;381.5821675265583;12295.200811947228;16839.579010524743;17191.570210744736;17480.125993700327;18504.537386565342;16261;16776.83223167768;17061.658766824658;17349.39277125301;17477;4904.313396124546;4988.102141614508;5060.190369540875;5100.77046532905;5100.948990510103;3677.5219221501166;5001.14980453322;5097.515736005073;5589.692566908819;5935.73289201987;5929.466348028676;5951.791687290945;5964.075568286922;5964.761409543613;5966.403359664042;5938.910916336258;6719.563228390163;7071.611061391622;7086.539374940612;7198.460115491359;6690.565113267622;6795.252522222551;6864.759733409357;6930.584164950119;6944.409725173316;23273.301800946;23463.296101116994;23852.045918163254;23944.16195433169;23970.520589588286;1950.3271371376852;2147.409462397853;2241.865488070721;2319.153508969231;2595.1176599955916;13595.864041359559;14159.929200353932;14548.272586370638;15243.847561524464;15386.384544618202;1861.9627607447776;1878.6806242938733;1893.1575448925234;1895.8198971097725;1921;82672;83764.99999999939;84346.57826710888;84628;84650;16324.510264692079;16378.508644740677;16398.83601163997;16436.75344869828;16469.91765041191;29003.709962900524;29018.486487567294;29070.7092929068;29079.273018174714;29254.853725731235;8699.217070463688;8736.388452808369;9056.230220431336;9095.36332456735;9144.131307525775;7257.201707812136;7277.417806575461;7329.963350183215;7479.214682458263;7495.925040749523;8060.556669383241;8327.541985190872;8413.284870785928;8574.528400937883;8604.913950860537;2992.5361568956846;3066.9846650766603;3247.184558144171;3282.8522716477814;3297.3734990351754;770.5761830992932;835.3275613131487;839.5256679975917;867.7223288547605;922.0908035149115;16239.269232884548;16627.916860415862;17149.399771008204;17213.913930430517;17677.11614419274;820.6430202861774;821.4783612406166;826.0541679776622;847.0809172048273;879.1867522541623;8935.821283574292;9583.281253905845;9661.372010819274;9664.130228279488;9674.322797404115;137359;303632.4818375894;383721;384995;386205;49083;64115;81042;81126;81606.18393816105;872.1757938747949;887.8268737596106;899.9370044096981;905.8188362327561;905.8233644439402;15467.922660386626;15634.687306253583;16234.350625975301;16309;16516;37082.629173707915;37541.2491750158;37824.81087594655;38257.23485530218;38266.6173338263;47014.76492617515;48726.756366217945;48841;49605.751971239915;54597.727011366274;7480.129967508123;7678.5392876427595;7706.306432421109;7883.763487095396;7929.207079292025;9915.900840991499;11739.178257521891;11831.17181797266;11935.403229838299;12114.75770484603;10137.543810528692;10254.436006019441;10273.845892311472;10362.637307694496;10887.618933337295;4587;5714.971425142848;9651.662191823252;10029.890733872231;10375.256083545755;9932.304738668225;9989.750256243651;10075.143612792996;10222;10675;7605;7784.299413052852;7836.09884863248;7884.566348850868;8032.558209298545;9243.39917905334;9600.75998100053;9999.450030248407;10096.444695541815;10604.310719803188 16:20:28 INFO - PROCESS | 9530 | |3;mootools.html;1346.2326473909873;1371.8490965993742;1443.870051695348;1659.0543390267553;1689.1216567384968;7302.853942921139;7895.052593688751;7897.131315555292;7905.446618736691;7910.090339610946;6639.601623902558;7304.160021597518;7487.51331163474;7538.057742782153;7726.96136519318;2135.3380452059832;2184.803367696915;2203.6914831923546;2205.184081889695;2206.172685243034;2138.1981756841183;2169.663702126173;2219.001449347792;2220.888955552224;2222.2333295013277;2148.581026699794;2148.8603240789375;2149.924752633658;2153.246363772683;2203.4271089516683;2122.7877212278804;2123.7132987046707;2126.5640543688505;2128.1274677382276;2128.2019242783954;2084.8436367272516;2154.6229409853213;2157.331227319536;2163.8268938484885;2164.177612507253;7732.342750866183;7823.100343460461;7857.882131768028;7859.292663660298;7862.135165131831;4380.18966491197;4442.577955094261;4496.415465989433;4497.168023915586;4542.205114105019;2914.213162446149;2944.764418846487;3039.361734035833;3057.3579548294883;3062.5099984002677;906.5104843384564;946.7349142240183;957.0381766324799;973.634886917406;979.745266230778;10560.94719526405;10569.63006294776;10591.470426478645;10613.681589552403;10697.144228461782;3926.9018274543364;4032.2338755636333;4219.156168766259;4244.808983595745;4275.508316543575;9036.096390360912;9036.141566551167;9040.502772347583;9042.412243204171;9042.63829446828;4566.269396896547;4568.908621827612;4569.314602809539;4574.039451715111;4580;3643.854245830137;4020.276350256982;4124.13393187428;4172.833086676499;4176.749395036308;3520.2959408118477;3552.236269202134;3661.377565813818;3697.1681371691157;3714.4428335749312;1163.976720465603;1168.1239070696977;1169.7660467906453;1182.255179237075;1190.4940400329824;745.9589722565311;810.7121971700079;811.1037303779357;841.3353450773942;855.7561095087871;5041.621878359065;5117.744112794346;5146.485351464824;5159.767810448464;5219.739013049332;390.33058305006483;412.0091180710396;412.0933945320248;414.5792021098587;416.02649799469384;3473.9652603474146;3501.8074005929407;3502.2820321833965;3564.946525802115;3668.926621467556;9064.50145242018;9478.146966773023;9502.097300756555;9503.334766566273;9510;9391.859122113174;9402.764930876647;9440.669576564924;9442.244620430349;9454.905450945402;6461.967690161519;6693.564918280296;6771.4582833373215;6892.310768923167;6893.069435626227;5211.114110601283;5219.4780521947505;5264.78940842362;5321.680699158062;5555.527780138734;8499.277561407349;8610.698625548326;8696.21734043939;8779.692710755093;8848.292136629183;8586.484810911365;8635.56822158877;8667.4366166199;8814.86777698348;8815.162559557088;5942.970285148546;6091.573589848668;6138.570300078952;6690.364415380531;6801.1158549388265;7387.556746595222;7461.477696561188;7463.925360746323;7464.178940316452;7465.738699145504;6590.340965903371;6618.139641846529;6628.403443690091;6648.301928297653;6812.386885180357;6204.968975155095;6295.401936815995;6336.651484168231;6433.774817881352;6492.026196070438;5938.396632909176;6042.8791424170395;6043.36544662804;6049.274087109575;6049.637021778707;4294.8067336970535;4374.234508960855;4405.823767049282;4439.556044395664;4447.888802779957;4209.810558524812;4360.934585981149;4376.649868010488;4380.9780951095045;4381.101874115862 16:20:28 INFO - PROCESS | 9530 | |4;prototype.html;284.42120285219585;284.6342449951812;289.7001603340542;291.2732731834074;292.2343460134448;4902.5097490250955;4930.728809915453;4945.777440015199;4950.603951683861;4960.255961605761;4784.736839473828;4794.472608013116;4869.9269510957365;4882.316475693406;4893.7797799099035;3588.7129029677694;3644.9271014579695;3738.5700644425833;3759.9624003760023;3785.734998550103;3763.9247215055684;3764.8352197486556;3765.3222419964395;3777.9799454147364;3791.4265579784355;3717.8103007037757;3730.3844865597143;3736.4021756518964;3743.307488114694;3752.9061773455746;3555.288942211555;3623.4927110204594;3735.570409402926;3749.7750134991716;3768.9811550942345;3319.751018673609;3325.983370083158;3329.866805327784;3333.8166400847945;3348.79907205566;4728.787204575802;4732.384789977315;4739.73931433771;4752.168370535177;4754.904901901978;4190.748555086705;4272.807723652443;4304.7632380219075;4316.3741257517795;4328.935065974013;5034.421041580228;5045.84862454127;5047.949520504784;5051.6716413433005;5066.974665126688;3623.6376362363817;3629.9455508167134;3644.469322884395;3646.268022689201;3659.0852286928266;5135.332406787131;5268.683878967274;5288.312519372495;5288.709120998344;5295.258663787073;3677.8528858845348;3709.499217605589;3711.31340701971;3714.4242642390473;3730.291244663505;3738.7382883197915;3744.8127593620757;3758.492603498493;3765.2657731742047;3780.6030366811638;4236.809343579546;4255.468066491689;4275.48694156697;4282.143571285756;4295.506016808107;4823.27650852375;4983.227599722049;4997;5023.2214006829;5032.874178145576;1289.7420515896858;1304.6673098359859;1305.7203940138718;1306.9479069349075;1309.3322405573226;802.9638666260032;835.6907944060737;836.3016880904513;836.3768992100923;841.8737189421513;4349.695521313478;4417.293233082755;4450.132224216311;4458.977705111453;4473.792076139489;5194.92207616886;5208.088584497697;5208.374995000624;5210.869728256748;5238.030964271622;4424.446944131983;4445.644078556072;4455.576720211575;4460.24175890093;4470.815233962938;2594.6237795519546;2735.275152084699;2765.3224959884556;2776.6112744215825;2777.666679998413;4954.603631709455;4969.552740253323;4977.32806071183;4978.800847966113;4983.6760610560195;5233.450487698813;5289.18017707256;5372.167314066326;5392.811251606175;5392.973035134799;4915.655904086751;4953.207486802166;4965.106280869478;4967.3542439482635;4970.304157417964;5235.397929238034;5245.669000184834;5246.97376513115;5248.772005216841;5251.789928402974;4893.363862697826;5144.845654630367;5154.175331947021;5165.225216217447;5168.896622067613;4976.377952755905;4980.676256043491;4982.551570358685;4983.177775666974;4987.077390682735;3637.890863274106;3654.3422184007136;3657.725670574771;3665.5967843537724;3677.5954644989565;5059.671121377099;5221.190715439113;5288.5985213917575;5296.602754793329;5297.5232229099565;5082.932584157368;5093.210552364241;5099.464556221544;5109.74451277442;5111.670965548909;5088.236764485357;5094.681919726441;5103.923441148311;5123.462036486116;5127;4776.904461910673;5007.774650140679;5021.799128034838;5027.371578552681;5043.596512278936;4904.803807847647;4997.475265097112;5107.693538387709;5143.537081662668;5165;4973.353464049796;4973.950260497349;4977.253411988231;4984.302197692254;4996 16:20:28 INFO - PROCESS | 9530 | |5;yui.html;605.0863196573174;610.2524407600689;655.6754406568749;685.4208194076007;714.1323292199976;12551.435185416656;13143.47426102957;13641.93179034106;13650.249236292;13727.107737997023;14098.929505352484;14242.572722818306;14253;14257.35841887115;14258.215798131125;740.0453415094522;761.9771406857803;764.8929149918988;765.4832987733286;765.6516285090298;598.3926314790491;715.506300652548;753.6759193546773;755.391909512842;763.5609524523394;795.9602019899011;797.5095316380442;798.1300382582983;798.2655956519986;798.2935102434359;779.5907148746896;785.0736131364987;785.5483097219122;785.5522352259214;791.4578513718093;459.79079518818855;542.4169018305298;569.5699746691222;570.7517230004961;572.3275151696739;12322.75354492914;12332;12356.938215308866;12704.237745735192;12729;11678.416079196091;12168.513259469699;12331.93834030833;12403.317817520032;12540.498380064786;9362.110599493037;9570;11614.245074070159;11636.592719254786;11824.822627660593;4104.302268614343;4158;4237.322028475429;4286.335617979218;4380.233459144669;53013.46986530124;54817.72591137059;54883.72558137224;60715.392846071416;61515.38484615141;9488.478133702574;10423.739406514898;10526.73683157912;10541.84187237192;10861.891381086247;18755.90622046881;19983.300584479475;20009.399718008484;20011.399658010283;20053.298134565513;7020.630976959444;7101.325374089453;7104.857902841914;7106.538075025107;7306.232845551141;3749.9625003750157;3823.598522155189;3833.6933045356304;3859.2281543691374;3965.7422267552515;2857.6856545779947;2952.4537960477383;2955.06915321673;2983.6270466191727;2991.641003079644;498.8179314550163;501.6112512802607;512.0680361741595;514.5780460022745;521.6504941689077;479.20452049598197;511.8541215753492;521.942586315505;594.5808205215313;601.6841158391879;7539.954507980939;7888.290053895177;8089.110197878229;8109.351251899834;8229.25936665703;544.4827413956757;588.1706793421256;593.6289818863211;594.8156071617813;597.7220592424457;3596.4245720684567;3769.6230376962635;3956.802159891994;3970.980145099256;4103.8974025649;71727;99884;102590.48704756428;103395;106365;88080.5595972016;89608.55195723979;89770.55114724385;91579.54210228907;92669.53665231765;64129;74524.25475745174;74924.25075749173;74933.25066749372;75240.24759752442;7555.16893141743;7590.392768578611;7797;7800.492967957065;7918.960405197937;43612.78193609012;44332.33501497415;44438.55561444473;44800.327995079446;45206.77396612996;56387.43612563822;56965;62464;63499.682501587195;65707;9575.425474471554;9897.901020989986;9988.400695958266;10186.643467478603;10258.794824103625;11073.944630276797;11098.2786118902;11319.717007074889;11383.089352851917;11660.242084264495;10556.788864222826;10565.788684226118;10579.418132002813;11132;12211;10324.638637647646;11152.498137583665;11182.944085279521;11282.266652667551;12764.744705106032;11115.666530004113;11183.608573700207;11552.59565915189;11981.122702434177;12367;9332.30007749435;9538.427694338361;10104;10122.949385253027;10937.12502999774;8898.55507224649;9808.558614862206;9921.900780992386;9934.751631209278;9942.900570994198 16:20:28 INFO - PROCESS | 9530 | __end_tp_report 16:20:28 INFO - PROCESS | 9530 | __start_cc_report 16:20:28 INFO - PROCESS | 9530 | _x_x_mozilla_cycle_collect,1042 16:20:28 INFO - PROCESS | 9530 | __end_cc_report 16:20:28 INFO - PROCESS | 9530 | __startTimestamp1472253628423__endTimestamp 16:20:28 INFO - PROCESS | 9530 | 16:20:28 INFO - PROCESS | 9530 | ------- Summary: start ------- 16:20:28 INFO - PROCESS | 9530 | Number of tests: 6 16:20:28 INFO - PROCESS | 9530 | 16:20:28 INFO - PROCESS | 9530 | [#0] dojo.html Cycles:165 Average:4681.62 Median:4841.81 stddev:508.51 (10.5%) stddev-sans-first:482.15 16:20:28 INFO - PROCESS | 9530 | Values: 2563.4 2581.6 2588.6 2605.0 2606.3 4498.2 4583.8 4682.6 4719.4 4801.2 4653.8 4699.7 4733.9 4750.5 4756.7 4247.4 4270.5 4314.6 4374.0 4510.1 4410.6 4438.2 4462.8 4469.3 4487.9 4218.2 4245.4 4255.7 4294.0 4359.3 4329.6 4378.3 4395.8 4398.4 4405.4 4244.1 4246.7 4247.4 4299.4 4352.2 4631.1 4688.7 4689.4 4691.3 4759.5 4878.5 5005.2 5016.1 5062.6 5073.4 5094.3 5098.8 5101.2 5102.6 5107.9 4701.5 4749.4 4750.6 4755.5 4809.3 4995.0 5179.9 5234.3 5249.8 5328.5 5004.2 5036.1 5037.6 5038.8 5041.8 5123.7 5126.8 5136.5 5138.3 5180.3 4806.6 4914.8 4920.1 4970.5 5042.1 4943.4 4950.5 4951.0 4955.7 5008.8 4259.0 4265.3 4272.8 4281.0 4326.6 3659.4 3685.5 3694.5 3709.1 3768.7 4298.8 4317.8 4319.2 4364.5 4369.5 5016.7 5026.0 5030.4 5030.9 5082.3 4213.0 4302.9 4324.8 4368.8 4378.8 4582.7 4599.3 4606.0 4648.0 4664.2 4829.8 4841.8 4842.0 4843.3 4903.5 4897.5 4991.2 5061.7 5076.9 5137.3 4810.6 4823.6 4827.7 4866.3 4886.1 5003.1 5036.7 5037.3 5040.2 5042.4 4830.6 4871.7 4878.4 5060.6 5199.7 4967.2 5020.0 5022.9 5082.2 5086.7 5004.1 5013.9 5014.1 5019.3 5084.1 4723.9 4924.5 4930.2 4941.9 5002.5 5020.1 5031.4 5038.3 5089.2 5092.1 4917.2 4919.8 4920.5 4932.8 5000.0 16:20:28 INFO - PROCESS | 9530 | 16:20:28 INFO - PROCESS | 9530 | [#1] ext.html Cycles:180 Average:45996.10 Median:34473.31 stddev:82871.21 (240.4%) stddev-sans-first:83033.39 16:20:28 INFO - PROCESS | 9530 | Values: 533.8 545.8 551.8 551.9 568.0 37418.4 39244.6 39287.4 43296.1 43340.0 39733.8 40136.0 40207.2 40218.8 40223.4 7186.5 7722.5 7775.7 7801.3 7856.6 9741.9 10022.9 10027.6 10368.0 10377.4 9723.6 9766.0 9766.5 9768.3 9779.1 9978.9 10007.1 10027.1 10032.0 10036.1 9805.1 9874.8 9876.1 9878.3 9881.6 38279.4 38451.8 38514.5 38547.2 38611.6 3000.4 3087.0 3097.8 3156.1 3176.2 28268.9 28466.6 28882.3 28927.1 30065.2 3279.0 3386.4 3412.6 3421.7 3463.0 254356.0 254768.0 256072.0 256353.0 258504.0 50928.2 51005.0 51009.7 51028.5 51260.5 32112.4 33042.2 33186.0 34718.0 34721.7 14168.6 14237.2 14237.7 14262.4 14276.6 10142.2 11374.5 11527.7 11560.6 11595.9 17677.3 17691.2 17738.0 17775.2 17782.9 6603.7 6622.9 6718.8 6917.8 6947.9 777.7 874.6 896.9 899.1 950.6 26610.9 27050.0 27104.6 27525.7 27656.4 906.7 924.9 935.3 947.9 1035.7 13670.1 14424.9 14485.9 14692.2 14840.8 385939.0 389583.0 390063.0 390798.0 391032.0 46151.4 46512.3 47019.5 47175.8 47178.3 1061.6 1125.6 1135.7 1151.9 1185.0 26941.0 28142.9 28993.4 29285.6 29404.6 40759.6 41505.0 41595.4 41612.6 41626.2 281928.0 284374.0 284788.0 285988.0 286589.0 24528.0 25549.6 25795.6 26610.3 26675.9 39922.2 40011.0 40667.6 41087.8 41486.4 33740.5 34607.3 34756.7 34836.3 34913.1 34050.7 34089.5 34158.3 34378.1 34551.3 34395.3 34799.8 35133.3 35269.6 35442.5 29836.7 31266.0 32019.4 32033.4 34568.8 24748.6 24797.3 24889.8 25116.2 25351.7 16:20:28 INFO - PROCESS | 9530 | 16:20:28 INFO - PROCESS | 9530 | [#2] jquery.html Cycles:180 Average:23670.99 Median:26872.66 stddev:55765.78 (207.5%) stddev-sans-first:55894.69 16:20:28 INFO - PROCESS | 9530 | Values: 333.0 346.3 360.4 365.0 381.6 12295.2 16839.6 17191.6 17480.1 18504.5 16261.0 16776.8 17061.7 17349.4 17477.0 4904.3 4988.1 5060.2 5100.8 5100.9 3677.5 5001.1 5097.5 5589.7 5935.7 5929.5 5951.8 5964.1 5964.8 5966.4 5938.9 6719.6 7071.6 7086.5 7198.5 6690.6 6795.3 6864.8 6930.6 6944.4 23273.3 23463.3 23852.0 23944.2 23970.5 1950.3 2147.4 2241.9 2319.2 2595.1 13595.9 14159.9 14548.3 15243.8 15386.4 1862.0 1878.7 1893.2 1895.8 1921.0 82672.0 83765.0 84346.6 84628.0 84650.0 16324.5 16378.5 16398.8 16436.8 16469.9 29003.7 29018.5 29070.7 29079.3 29254.9 8699.2 8736.4 9056.2 9095.4 9144.1 7257.2 7277.4 7330.0 7479.2 7495.9 8060.6 8327.5 8413.3 8574.5 8604.9 2992.5 3067.0 3247.2 3282.9 3297.4 770.6 835.3 839.5 867.7 922.1 16239.3 16627.9 17149.4 17213.9 17677.1 820.6 821.5 826.1 847.1 879.2 8935.8 9583.3 9661.4 9664.1 9674.3 137359.0 303632.5 383721.0 384995.0 386205.0 49083.0 64115.0 81042.0 81126.0 81606.2 872.2 887.8 899.9 905.8 905.8 15467.9 15634.7 16234.4 16309.0 16516.0 37082.6 37541.2 37824.8 38257.2 38266.6 47014.8 48726.8 48841.0 49605.8 54597.7 7480.1 7678.5 7706.3 7883.8 7929.2 9915.9 11739.2 11831.2 11935.4 12114.8 10137.5 10254.4 10273.8 10362.6 10887.6 4587.0 5715.0 9651.7 10029.9 10375.3 9932.3 9989.8 10075.1 10222.0 10675.0 7605.0 7784.3 7836.1 7884.6 8032.6 9243.4 9600.8 9999.5 10096.4 10604.3 16:20:28 INFO - PROCESS | 9530 | 16:20:28 INFO - PROCESS | 9530 | [#3] mootools.html Cycles:180 Average:5017.23 Median:5079.68 stddev:2823.87 (55.6%) stddev-sans-first:2818.32 16:20:28 INFO - PROCESS | 9530 | Values: 1346.2 1371.8 1443.9 1659.1 1689.1 7302.9 7895.1 7897.1 7905.4 7910.1 6639.6 7304.2 7487.5 7538.1 7727.0 2135.3 2184.8 2203.7 2205.2 2206.2 2138.2 2169.7 2219.0 2220.9 2222.2 2148.6 2148.9 2149.9 2153.2 2203.4 2122.8 2123.7 2126.6 2128.1 2128.2 2084.8 2154.6 2157.3 2163.8 2164.2 7732.3 7823.1 7857.9 7859.3 7862.1 4380.2 4442.6 4496.4 4497.2 4542.2 2914.2 2944.8 3039.4 3057.4 3062.5 906.5 946.7 957.0 973.6 979.7 10560.9 10569.6 10591.5 10613.7 10697.1 3926.9 4032.2 4219.2 4244.8 4275.5 9036.1 9036.1 9040.5 9042.4 9042.6 4566.3 4568.9 4569.3 4574.0 4580.0 3643.9 4020.3 4124.1 4172.8 4176.7 3520.3 3552.2 3661.4 3697.2 3714.4 1164.0 1168.1 1169.8 1182.3 1190.5 746.0 810.7 811.1 841.3 855.8 5041.6 5117.7 5146.5 5159.8 5219.7 390.3 412.0 412.1 414.6 416.0 3474.0 3501.8 3502.3 3564.9 3668.9 9064.5 9478.1 9502.1 9503.3 9510.0 9391.9 9402.8 9440.7 9442.2 9454.9 6462.0 6693.6 6771.5 6892.3 6893.1 5211.1 5219.5 5264.8 5321.7 5555.5 8499.3 8610.7 8696.2 8779.7 8848.3 8586.5 8635.6 8667.4 8814.9 8815.2 5943.0 6091.6 6138.6 6690.4 6801.1 7387.6 7461.5 7463.9 7464.2 7465.7 6590.3 6618.1 6628.4 6648.3 6812.4 6205.0 6295.4 6336.7 6433.8 6492.0 5938.4 6042.9 6043.4 6049.3 6049.6 4294.8 4374.2 4405.8 4439.6 4447.9 4209.8 4360.9 4376.6 4381.0 4381.1 16:20:28 INFO - PROCESS | 9530 | 16:20:28 INFO - PROCESS | 9530 | [#4] prototype.html Cycles:180 Average:4212.52 Median:4887.84 stddev:1233.37 (25.2%) stddev-sans-first:1201.08 16:20:28 INFO - PROCESS | 9530 | Values: 284.4 284.6 289.7 291.3 292.2 4902.5 4930.7 4945.8 4950.6 4960.3 4784.7 4794.5 4869.9 4882.3 4893.8 3588.7 3644.9 3738.6 3760.0 3785.7 3763.9 3764.8 3765.3 3778.0 3791.4 3717.8 3730.4 3736.4 3743.3 3752.9 3555.3 3623.5 3735.6 3749.8 3769.0 3319.8 3326.0 3329.9 3333.8 3348.8 4728.8 4732.4 4739.7 4752.2 4754.9 4190.7 4272.8 4304.8 4316.4 4328.9 5034.4 5045.8 5047.9 5051.7 5067.0 3623.6 3629.9 3644.5 3646.3 3659.1 5135.3 5268.7 5288.3 5288.7 5295.3 3677.9 3709.5 3711.3 3714.4 3730.3 3738.7 3744.8 3758.5 3765.3 3780.6 4236.8 4255.5 4275.5 4282.1 4295.5 4823.3 4983.2 4997.0 5023.2 5032.9 1289.7 1304.7 1305.7 1306.9 1309.3 803.0 835.7 836.3 836.4 841.9 4349.7 4417.3 4450.1 4459.0 4473.8 5194.9 5208.1 5208.4 5210.9 5238.0 4424.4 4445.6 4455.6 4460.2 4470.8 2594.6 2735.3 2765.3 2776.6 2777.7 4954.6 4969.6 4977.3 4978.8 4983.7 5233.5 5289.2 5372.2 5392.8 5393.0 4915.7 4953.2 4965.1 4967.4 4970.3 5235.4 5245.7 5247.0 5248.8 5251.8 4893.4 5144.8 5154.2 5165.2 5168.9 4976.4 4980.7 4982.6 4983.2 4987.1 3637.9 3654.3 3657.7 3665.6 3677.6 5059.7 5221.2 5288.6 5296.6 5297.5 5082.9 5093.2 5099.5 5109.7 5111.7 5088.2 5094.7 5103.9 5123.5 5127.0 4776.9 5007.8 5021.8 5027.4 5043.6 4904.8 4997.5 5107.7 5143.5 5165.0 4973.4 4974.0 4977.3 4984.3 4996.0 16:20:28 INFO - PROCESS | 9530 | 16:20:28 INFO - PROCESS | 9530 | [#5] yui.html Cycles:180 Average:17616.27 Median:513.32 stddev:25430.91 (4954.2%) stddev-sans-first:25470.17 16:20:28 INFO - PROCESS | 9530 | Values: 605.1 610.3 655.7 685.4 714.1 12551.4 13143.5 13641.9 13650.2 13727.1 14098.9 14242.6 14253.0 14257.4 14258.2 740.0 762.0 764.9 765.5 765.7 598.4 715.5 753.7 755.4 763.6 796.0 797.5 798.1 798.3 798.3 779.6 785.1 785.5 785.6 791.5 459.8 542.4 569.6 570.8 572.3 12322.8 12332.0 12356.9 12704.2 12729.0 11678.4 12168.5 12331.9 12403.3 12540.5 9362.1 9570.0 11614.2 11636.6 11824.8 4104.3 4158.0 4237.3 4286.3 4380.2 53013.5 54817.7 54883.7 60715.4 61515.4 9488.5 10423.7 10526.7 10541.8 10861.9 18755.9 19983.3 20009.4 20011.4 20053.3 7020.6 7101.3 7104.9 7106.5 7306.2 3750.0 3823.6 3833.7 3859.2 3965.7 2857.7 2952.5 2955.1 2983.6 2991.6 498.8 501.6 512.1 514.6 521.7 479.2 511.9 521.9 594.6 601.7 7540.0 7888.3 8089.1 8109.4 8229.3 544.5 588.2 593.6 594.8 597.7 3596.4 3769.6 3956.8 3971.0 4103.9 71727.0 99884.0 102590.5 103395.0 106365.0 88080.6 89608.6 89770.6 91579.5 92669.5 64129.0 74524.3 74924.3 74933.3 75240.2 7555.2 7590.4 7797.0 7800.5 7919.0 43612.8 44332.3 44438.6 44800.3 45206.8 56387.4 56965.0 62464.0 63499.7 65707.0 9575.4 9897.9 9988.4 10186.6 10258.8 11073.9 11098.3 11319.7 11383.1 11660.2 10556.8 10565.8 10579.4 11132.0 12211.0 10324.6 11152.5 11182.9 11282.3 12764.7 11115.7 11183.6 11552.6 11981.1 12367.0 9332.3 9538.4 10104.0 10122.9 10937.1 8898.6 9808.6 9921.9 9934.8 9942.9 16:20:28 INFO - PROCESS | 9530 | -------- Summary: end -------- 16:20:28 INFO - PROCESS | 9530 | 16:20:29 INFO - TEST-INFO | 9530: exit 0 16:20:29 INFO - TEST-OK | dromaeo_css | took 1120912ms 16:20:29 INFO - TEST-START | kraken 16:20:29 INFO - operating with platform_type : linux_ 16:20:29 INFO - Initialising browser for kraken test... 16:20:29 INFO - TEST-INFO | started process 9833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp269f_G/profile http://localhost:34857/getInfo.html) 16:20:33 INFO - PROCESS | 9833 | __metrics Screen width/height:1600/1200 16:20:33 INFO - PROCESS | 9833 | colorDepth:24 16:20:33 INFO - PROCESS | 9833 | Browser inner width/height: 1024/697 16:20:33 INFO - PROCESS | 9833 | __metrics 16:20:34 INFO - PROCESS | 9833 | 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" 16:20:34 INFO - PROCESS | 9833 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:20:34 INFO - PROCESS | 9833 | console.error: PushService: 16:20:34 INFO - PROCESS | 9833 | stateChangeProcessEnqueue: Error transitioning state 16:20:34 INFO - PROCESS | 9833 | UnknownError 16:20:35 INFO - TEST-INFO | 9833: exit 0 16:20:35 INFO - Browser initialized. 16:20:35 INFO - Running cycle 1/1 for kraken test... 16:20:35 INFO - TEST-INFO | started process 9918 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp269f_G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:20:47 INFO - PROCESS | 9918 | RSS: Main: 180543488 16:20:47 INFO - PROCESS | 9918 | 16:20:50 INFO - PROCESS | 9918 | Cycle 1(1): loaded http://localhost:34857/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34857/tests/kraken/driver.html?testName=audio-beat-detection) 16:20:51 INFO - PROCESS | 9918 | RSS: Main: 233684992 16:20:51 INFO - PROCESS | 9918 | 16:20:54 INFO - PROCESS | 9918 | Cycle 1(1): loaded http://localhost:34857/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34857/tests/kraken/driver.html?testName=audio-dft) 16:20:54 INFO - PROCESS | 9918 | RSS: Main: 224890880 16:20:54 INFO - PROCESS | 9918 | 16:20:58 INFO - PROCESS | 9918 | Cycle 1(1): loaded http://localhost:34857/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34857/tests/kraken/driver.html?testName=audio-fft) 16:20:58 INFO - PROCESS | 9918 | RSS: Main: 303460352 16:20:58 INFO - PROCESS | 9918 | 16:21:00 INFO - PROCESS | 9918 | Cycle 1(1): loaded http://localhost:34857/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34857/tests/kraken/driver.html?testName=audio-oscillator) 16:21:01 INFO - PROCESS | 9918 | RSS: Main: 212684800 16:21:01 INFO - PROCESS | 9918 | 16:21:03 INFO - PROCESS | 9918 | Cycle 1(1): loaded http://localhost:34857/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34857/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:21:04 INFO - PROCESS | 9918 | RSS: Main: 215564288 16:21:04 INFO - PROCESS | 9918 | 16:21:07 INFO - PROCESS | 9918 | Cycle 1(1): loaded http://localhost:34857/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34857/tests/kraken/driver.html?testName=imaging-darkroom) 16:21:08 INFO - PROCESS | 9918 | RSS: Main: 254218240 16:21:08 INFO - PROCESS | 9918 | 16:21:11 INFO - PROCESS | 9918 | Cycle 1(1): loaded http://localhost:34857/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34857/tests/kraken/driver.html?testName=imaging-desaturate) 16:21:12 INFO - PROCESS | 9918 | RSS: Main: 248713216 16:21:12 INFO - PROCESS | 9918 | 16:21:15 INFO - PROCESS | 9918 | Cycle 1(1): loaded http://localhost:34857/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34857/tests/kraken/driver.html?testName=json-parse-financial) 16:21:15 INFO - PROCESS | 9918 | RSS: Main: 252030976 16:21:15 INFO - PROCESS | 9918 | 16:21:17 INFO - PROCESS | 9918 | Cycle 1(1): loaded http://localhost:34857/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34857/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:21:18 INFO - PROCESS | 9918 | RSS: Main: 215707648 16:21:18 INFO - PROCESS | 9918 | 16:21:19 INFO - PROCESS | 9918 | Cycle 1(1): loaded http://localhost:34857/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34857/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:21:20 INFO - PROCESS | 9918 | RSS: Main: 223850496 16:21:20 INFO - PROCESS | 9918 | 16:21:22 INFO - PROCESS | 9918 | Cycle 1(1): loaded http://localhost:34857/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34857/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:21:23 INFO - PROCESS | 9918 | RSS: Main: 222093312 16:21:23 INFO - PROCESS | 9918 | 16:21:26 INFO - PROCESS | 9918 | Cycle 1(1): loaded http://localhost:34857/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34857/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:21:26 INFO - PROCESS | 9918 | RSS: Main: 223469568 16:21:26 INFO - PROCESS | 9918 | 16:21:29 INFO - PROCESS | 9918 | Cycle 1(1): loaded http://localhost:34857/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34857/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:21:30 INFO - PROCESS | 9918 | RSS: Main: 221130752 16:21:30 INFO - PROCESS | 9918 | 16:21:32 INFO - PROCESS | 9918 | Cycle 1(1): loaded http://localhost:34857/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34857/tests/kraken/driver.html?testName=ai-astar) 16:21:32 INFO - PROCESS | 9918 | RSS: Main: 272027648 16:21:32 INFO - PROCESS | 9918 | 16:21:32 INFO - PROCESS | 9918 | __start_tp_report 16:21:32 INFO - PROCESS | 9918 | _x_x_mozilla_page_load 16:21:32 INFO - PROCESS | 9918 | _x_x_mozilla_page_load_details 16:21:32 INFO - PROCESS | 9918 | |i|pagename|runs| 16:21:32 INFO - PROCESS | 9918 | |0;ai-astar;115;115;129;115;113;115;114;113;114;114 16:21:32 INFO - PROCESS | 9918 | |1;audio-beat-detection;158;124;148;187;124;153;145;128;184;122 16:21:32 INFO - PROCESS | 9918 | |2;audio-dft;163;164;163;162;162;161;164;163;163;162 16:21:32 INFO - PROCESS | 9918 | |3;audio-fft;76;77;76;161;77;77;77;76;171;76 16:21:32 INFO - PROCESS | 9918 | |4;audio-oscillator;85;85;145;84;84;85;152;84;83;139 16:21:32 INFO - PROCESS | 9918 | |5;imaging-gaussian-blur;117;117;118;118;117;118;118;117;117;117 16:21:32 INFO - PROCESS | 9918 | |6;imaging-darkroom;147;146;146;146;147;146;146;145;146;146 16:21:32 INFO - PROCESS | 9918 | |7;imaging-desaturate;96;95;96;96;95;94;95;96;96;96 16:21:32 INFO - PROCESS | 9918 | |8;json-parse-financial;63;67;63;64;62;64;64;65;63;63 16:21:32 INFO - PROCESS | 9918 | |9;json-stringify-tinderbox;64;65;65;65;65;65;64;65;65;65 16:21:32 INFO - PROCESS | 9918 | |10;stanford-crypto-aes;82;81;90;81;86;81;81;82;87;84 16:21:32 INFO - PROCESS | 9918 | |11;stanford-crypto-ccm;135;134;133;149;143;141;136;132;182;131 16:21:32 INFO - PROCESS | 9918 | |12;stanford-crypto-pbkdf2;171;171;171;171;171;172;172;171;171;178 16:21:32 INFO - PROCESS | 9918 | |13;stanford-crypto-sha256-iterative;67;68;68;67;68;68;67;68;67;68 16:21:32 INFO - PROCESS | 9918 | __end_tp_report 16:21:32 INFO - PROCESS | 9918 | __start_cc_report 16:21:32 INFO - PROCESS | 9918 | _x_x_mozilla_cycle_collect,1964 16:21:32 INFO - PROCESS | 9918 | __end_cc_report 16:21:32 INFO - PROCESS | 9918 | __startTimestamp1472253692494__endTimestamp 16:21:32 INFO - PROCESS | 9918 | 16:21:32 INFO - PROCESS | 9918 | ------- Summary: start ------- 16:21:32 INFO - PROCESS | 9918 | Number of tests: 14 16:21:32 INFO - PROCESS | 9918 | 16:21:32 INFO - PROCESS | 9918 | [#0] ai-astar Cycles:10 Average:115.70 Median:115.00 stddev:4.74 (4.1%) stddev-sans-first:5.02 16:21:32 INFO - PROCESS | 9918 | Values: 115.0 115.0 129.0 115.0 113.0 115.0 114.0 113.0 114.0 114.0 16:21:32 INFO - PROCESS | 9918 | 16:21:32 INFO - PROCESS | 9918 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:150.50 stddev:23.98 (15.9%) stddev-sans-first:25.12 16:21:32 INFO - PROCESS | 9918 | Values: 158.0 124.0 148.0 187.0 124.0 153.0 145.0 128.0 184.0 122.0 16:21:32 INFO - PROCESS | 9918 | 16:21:32 INFO - PROCESS | 9918 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 16:21:32 INFO - PROCESS | 9918 | Values: 163.0 164.0 163.0 162.0 162.0 161.0 164.0 163.0 163.0 162.0 16:21:32 INFO - PROCESS | 9918 | 16:21:32 INFO - PROCESS | 9918 | [#3] audio-fft Cycles:10 Average:94.40 Median:76.50 stddev:37.81 (49.4%) stddev-sans-first:39.52 16:21:32 INFO - PROCESS | 9918 | Values: 76.0 77.0 76.0 161.0 77.0 77.0 77.0 76.0 171.0 76.0 16:21:32 INFO - PROCESS | 9918 | 16:21:32 INFO - PROCESS | 9918 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:84.00 stddev:29.65 (35.3%) stddev-sans-first:30.76 16:21:32 INFO - PROCESS | 9918 | Values: 85.0 85.0 145.0 84.0 84.0 85.0 152.0 84.0 83.0 139.0 16:21:32 INFO - PROCESS | 9918 | 16:21:32 INFO - PROCESS | 9918 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 16:21:32 INFO - PROCESS | 9918 | Values: 117.0 117.0 118.0 118.0 117.0 118.0 118.0 117.0 117.0 117.0 16:21:32 INFO - PROCESS | 9918 | 16:21:32 INFO - PROCESS | 9918 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 16:21:32 INFO - PROCESS | 9918 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 146.0 145.0 146.0 146.0 16:21:32 INFO - PROCESS | 9918 | 16:21:32 INFO - PROCESS | 9918 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.71 (0.7%) stddev-sans-first:0.73 16:21:32 INFO - PROCESS | 9918 | Values: 96.0 95.0 96.0 96.0 95.0 94.0 95.0 96.0 96.0 96.0 16:21:32 INFO - PROCESS | 9918 | 16:21:32 INFO - PROCESS | 9918 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:1.40 (2.2%) stddev-sans-first:1.45 16:21:32 INFO - PROCESS | 9918 | Values: 63.0 67.0 63.0 64.0 62.0 64.0 64.0 65.0 63.0 63.0 16:21:32 INFO - PROCESS | 9918 | 16:21:32 INFO - PROCESS | 9918 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 16:21:32 INFO - PROCESS | 9918 | Values: 64.0 65.0 65.0 65.0 65.0 65.0 64.0 65.0 65.0 65.0 16:21:32 INFO - PROCESS | 9918 | 16:21:32 INFO - PROCESS | 9918 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.00 stddev:3.17 (3.8%) stddev-sans-first:3.32 16:21:32 INFO - PROCESS | 9918 | Values: 82.0 81.0 90.0 81.0 86.0 81.0 81.0 82.0 87.0 84.0 16:21:32 INFO - PROCESS | 9918 | 16:21:32 INFO - PROCESS | 9918 | [#11] stanford-crypto-ccm Cycles:10 Average:141.60 Median:138.50 stddev:15.28 (11.0%) stddev-sans-first:16.02 16:21:32 INFO - PROCESS | 9918 | Values: 135.0 134.0 133.0 149.0 143.0 141.0 136.0 132.0 182.0 131.0 16:21:32 INFO - PROCESS | 9918 | 16:21:32 INFO - PROCESS | 9918 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.90 Median:171.00 stddev:2.18 (1.3%) stddev-sans-first:2.29 16:21:32 INFO - PROCESS | 9918 | Values: 171.0 171.0 171.0 171.0 171.0 172.0 172.0 171.0 171.0 178.0 16:21:32 INFO - PROCESS | 9918 | 16:21:32 INFO - PROCESS | 9918 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 16:21:32 INFO - PROCESS | 9918 | Values: 67.0 68.0 68.0 67.0 68.0 68.0 67.0 68.0 67.0 68.0 16:21:32 INFO - PROCESS | 9918 | -------- Summary: end -------- 16:21:32 INFO - PROCESS | 9918 | 16:21:33 INFO - TEST-INFO | 9918: exit 0 16:21:33 INFO - TEST-OK | kraken | took 64415ms 16:21:33 INFO - SUITE-END | took 1185s 16:21:34 INFO - Completed test suite (00:19:45) 16:21:34 INFO - javascript benchmark 16:21:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2563.397601563632, 2581.6385706001174, 2588.559944809382, 2604.986975065124, 2606.3353844769576, 4498.190325741365, 4583.839565615204, 4682.625389968803, 4719.4336679598455, 4801.159797035518, 4653.767311634413, 4699.67102302839, 4733.857984260478, 4750.548697873705, 4756.690815097025, 4247.405363249148, 4270.530241673413, 4314.633256173213, 4373.978130109361, 4510.143072816154, 4410.647148228134, 4438.245498265286, 4462.754548499831, 4469.284914413694, 4487.932681009787, 4218.2196293685765, 4245.426867372927, 4255.702100852942, 4294.0, 4359.280718681413, 4329.567043295677, 4378.321360189176, 4395.780210989437, 4398.3622374755805, 4405.449318835145, 4244.0663054128045, 4246.660267178619, 4247.426597409341, 4299.441072660534, 4352.151330490556, 4631.0506346198945, 4688.695234809727, 4689.366935463703, 4691.296305554194, 4759.524047595248, 4878.463369029404, 5005.199168133081, 5016.122178618727, 5062.569681577071, 5073.416557095944, 5094.31226784383, 5098.770555325019, 5101.158308879068, 5102.617303702237, 5107.948920510785, 4701.529847015339, 4749.4063242094735, 4750.643701722384, 4755.524447555217, 4809.302651115569, 4995.0, 5179.948200517946, 5234.26720259164, 5249.790008399697, 5328.49379308965, 5004.174311238605, 5036.093503169392, 5037.596992240612, 5038.84883453497, 5041.773120209599, 5123.666961647481, 5126.846194614093, 5136.4606716295, 5138.254953031864, 5180.300659411007, 4806.615470762401, 4914.827981020647, 4920.065187614342, 4970.502949705001, 5042.142835717937, 4943.3573635427165, 4950.455449900508, 4951.034548263126, 4955.72743499111, 5008.824691135866, 4258.957410425918, 4265.274903266452, 4272.764997925144, 4281.01536646573, 4326.610605045561, 3659.3596120678776, 3685.4840322354894, 3694.464302676097, 3709.1283548366114, 3768.7361884668358, 4298.785060747013, 4317.762523061199, 4319.157764235943, 4364.4980827204645, 4369.453818272716, 5016.724080175625, 5026.0, 5030.410984876855, 5030.899382012412, 5082.313887625197, 4213.0099426634715, 4302.935455968163, 4324.805383757738, 4368.803403846835, 4378.824847006148, 4582.656300777455, 4599.264117741145, 4606.009707912748, 4647.95352046482, 4664.230401983703, 4829.758512074382, 4841.806327746851, 4841.951580484291, 4843.297721830385, 4903.509649035068, 4897.46127925935, 4991.15150424436, 5061.746912654279, 5076.873078172927, 5137.306463627512, 4810.59109975642, 4823.56587907076, 4827.662063655511, 4866.29438731389, 4886.144924638103, 5003.074431230234, 5036.6726162799305, 5037.294778730908, 5040.193569029085, 5042.39491261051, 4830.637702172281, 4871.732054737024, 4878.414590249193, 5060.569851562511, 5199.74001299941, 4967.205247160437, 5019.974900125622, 5022.924656130234, 5082.186850103965, 5086.694798312114, 5004.124278251365, 5013.924791128209, 5014.0974624567925, 5019.347484826949, 5084.059449001947, 4723.929141062956, 4924.458309585871, 4930.211166213388, 4941.876453088702, 5002.474740152232, 5020.146575082318, 5031.371078615173, 5038.269450929668, 5089.160288552347, 5092.134337162617, 4917.164082106122, 4919.803207871645, 4920.507949205051, 4932.8026878925875, 4999.975000124976], "value": 4647.820215266002, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.7704786941614, 545.8144230961475, 551.7985935133678, 551.9337679478463, 567.9634666733211, 37418.43872341914, 39244.626438074636, 39287.41068883962, 43296.134077318435, 43340.0, 39733.8013309933, 40136.0, 40207.19585608294, 40218.798906005504, 40223.39664905021, 7186.461015423864, 7722.498037627564, 7775.727849525268, 7801.258880406353, 7856.567888766115, 9741.90258097417, 10022.899771002307, 10027.64903228387, 10368.0, 10377.429241391721, 9723.562439690231, 9766.0, 9766.511674416286, 9768.316217864753, 9779.070988256104, 9978.850317245211, 10007.14939230159, 10027.147692446151, 10032.046955539248, 10036.14692751117, 9805.068518490732, 9874.802503949953, 9876.061774131518, 9878.259130565164, 9881.604735810559, 38279.425808612614, 38451.8077409614, 38514.4594216231, 38547.22905541902, 38611.61388386136, 3000.3699223162944, 3086.9691303086906, 3097.829619370934, 3156.0847354267235, 3176.2218256527067, 28268.85865570659, 28466.573001404788, 28882.27794305138, 28927.132186034243, 30065.248368790737, 3279.0, 3386.407378708716, 3412.6246112927556, 3421.674940880612, 3462.97150738486, 254356.0, 254768.0, 256072.0, 256353.0, 258504.0, 50928.23607645888, 51005.0, 51009.744951275745, 51028.489715102376, 51260.487395126314, 32112.35775284481, 33042.17394565107, 33186.0, 34718.0, 34721.65278347184, 14168.574942751733, 14237.216953067473, 14237.715245695235, 14262.3581938813, 14276.57170284893, 10142.188624910137, 11374.488148033359, 11527.654170374903, 11560.595379161858, 11595.942020289845, 17677.292908283784, 17691.203895824463, 17738.0, 17775.200115994812, 17782.91108544449, 6603.740761174866, 6622.9006564901565, 6718.798436046926, 6917.792466226021, 6947.895781563179, 777.6772639354605, 874.5845723281391, 896.8968568614692, 899.0515006668028, 950.5627411390699, 26610.866945665533, 27050.0, 27104.593431098154, 27525.724742752718, 27656.446871062468, 906.6917248135666, 924.930630202724, 935.2751617496494, 947.8815148106487, 1035.7307100153864, 13670.087764378268, 14424.855751442561, 14485.855141448661, 14692.191929443983, 14840.777388339184, 385939.0, 389583.0, 390063.0, 390798.0, 391032.0, 46151.38470153596, 46512.3023154653, 47019.52980470152, 47175.76412117918, 47178.29232561514, 1061.6337363609696, 1125.6454216921807, 1135.7444574970566, 1151.8790526994544, 1184.9644510664693, 26941.0, 28142.859285703442, 28993.42013159767, 29285.560716589694, 29404.55893161647, 40759.592404076764, 41505.0, 41595.37606935959, 41612.58387416208, 41626.167476649694, 281928.0, 284374.0, 284788.0, 285988.0, 286589.0, 24528.0, 25549.616755748306, 25795.613065804402, 26610.33474163084, 26675.866620666773, 39922.201555969295, 40011.0, 40667.593324067566, 41087.794561027, 41486.377704335064, 33740.49389259212, 34607.30785384228, 34756.65243347534, 34836.303273933874, 34913.12717182091, 34050.65949340574, 34089.48865766966, 34158.31683366369, 34378.077863380895, 34551.30897381988, 34395.31209375848, 34799.826000869834, 35133.297334053685, 35269.64730352664, 35442.46836297406, 29836.70163298426, 31265.958241047752, 32019.35961280808, 32033.359332812746, 34568.82715586406, 24748.628770568816, 24797.25608231756, 24889.751102488743, 25116.24651260465, 25351.72029530581], "value": 17466.091463543893, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.9644804657513, 346.3246668995458, 360.421523454855, 364.9616790237025, 381.5821675265583, 12295.200811947228, 16839.579010524743, 17191.570210744736, 17480.125993700327, 18504.537386565342, 16261.0, 16776.83223167768, 17061.658766824658, 17349.39277125301, 17477.0, 4904.313396124546, 4988.102141614508, 5060.190369540875, 5100.77046532905, 5100.948990510103, 3677.5219221501166, 5001.14980453322, 5097.515736005073, 5589.692566908819, 5935.73289201987, 5929.466348028676, 5951.791687290945, 5964.075568286922, 5964.761409543613, 5966.403359664042, 5938.910916336258, 6719.563228390163, 7071.611061391622, 7086.539374940612, 7198.460115491359, 6690.565113267622, 6795.252522222551, 6864.759733409357, 6930.584164950119, 6944.409725173316, 23273.301800946, 23463.296101116994, 23852.045918163254, 23944.16195433169, 23970.520589588286, 1950.3271371376852, 2147.409462397853, 2241.865488070721, 2319.153508969231, 2595.1176599955916, 13595.864041359559, 14159.929200353932, 14548.272586370638, 15243.847561524464, 15386.384544618202, 1861.9627607447776, 1878.6806242938733, 1893.1575448925234, 1895.8198971097725, 1921.0, 82672.0, 83764.99999999939, 84346.57826710888, 84628.0, 84650.0, 16324.510264692079, 16378.508644740677, 16398.83601163997, 16436.75344869828, 16469.91765041191, 29003.709962900524, 29018.486487567294, 29070.7092929068, 29079.273018174714, 29254.853725731235, 8699.217070463688, 8736.388452808369, 9056.230220431336, 9095.36332456735, 9144.131307525775, 7257.201707812136, 7277.417806575461, 7329.963350183215, 7479.214682458263, 7495.925040749523, 8060.556669383241, 8327.541985190872, 8413.284870785928, 8574.528400937883, 8604.913950860537, 2992.5361568956846, 3066.9846650766603, 3247.184558144171, 3282.8522716477814, 3297.3734990351754, 770.5761830992932, 835.3275613131487, 839.5256679975917, 867.7223288547605, 922.0908035149115, 16239.269232884548, 16627.916860415862, 17149.399771008204, 17213.913930430517, 17677.11614419274, 820.6430202861774, 821.4783612406166, 826.0541679776622, 847.0809172048273, 879.1867522541623, 8935.821283574292, 9583.281253905845, 9661.372010819274, 9664.130228279488, 9674.322797404115, 137359.0, 303632.4818375894, 383721.0, 384995.0, 386205.0, 49083.0, 64115.0, 81042.0, 81126.0, 81606.18393816105, 872.1757938747949, 887.8268737596106, 899.9370044096981, 905.8188362327561, 905.8233644439402, 15467.922660386626, 15634.687306253583, 16234.350625975301, 16309.0, 16516.0, 37082.629173707915, 37541.2491750158, 37824.81087594655, 38257.23485530218, 38266.6173338263, 47014.76492617515, 48726.756366217945, 48841.0, 49605.751971239915, 54597.727011366274, 7480.129967508123, 7678.5392876427595, 7706.306432421109, 7883.763487095396, 7929.207079292025, 9915.900840991499, 11739.178257521891, 11831.17181797266, 11935.403229838299, 12114.75770484603, 10137.543810528692, 10254.436006019441, 10273.845892311472, 10362.637307694496, 10887.618933337295, 4587.0, 5714.971425142848, 9651.662191823252, 10029.890733872231, 10375.256083545755, 9932.304738668225, 9989.750256243651, 10075.143612792996, 10222.0, 10675.0, 7605.0, 7784.299413052852, 7836.09884863248, 7884.566348850868, 8032.558209298545, 9243.39917905334, 9600.75998100053, 9999.450030248407, 10096.444695541815, 10604.310719803188], "value": 9076.325053114155, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.2326473909873, 1371.8490965993742, 1443.870051695348, 1659.0543390267553, 1689.1216567384968, 7302.853942921139, 7895.052593688751, 7897.131315555292, 7905.446618736691, 7910.090339610946, 6639.601623902558, 7304.160021597518, 7487.51331163474, 7538.057742782153, 7726.96136519318, 2135.3380452059832, 2184.803367696915, 2203.6914831923546, 2205.184081889695, 2206.172685243034, 2138.1981756841183, 2169.663702126173, 2219.001449347792, 2220.888955552224, 2222.2333295013277, 2148.581026699794, 2148.8603240789375, 2149.924752633658, 2153.246363772683, 2203.4271089516683, 2122.7877212278804, 2123.7132987046707, 2126.5640543688505, 2128.1274677382276, 2128.2019242783954, 2084.8436367272516, 2154.6229409853213, 2157.331227319536, 2163.8268938484885, 2164.177612507253, 7732.342750866183, 7823.100343460461, 7857.882131768028, 7859.292663660298, 7862.135165131831, 4380.18966491197, 4442.577955094261, 4496.415465989433, 4497.168023915586, 4542.205114105019, 2914.213162446149, 2944.764418846487, 3039.361734035833, 3057.3579548294883, 3062.5099984002677, 906.5104843384564, 946.7349142240183, 957.0381766324799, 973.634886917406, 979.745266230778, 10560.94719526405, 10569.63006294776, 10591.470426478645, 10613.681589552403, 10697.144228461782, 3926.9018274543364, 4032.2338755636333, 4219.156168766259, 4244.808983595745, 4275.508316543575, 9036.096390360912, 9036.141566551167, 9040.502772347583, 9042.412243204171, 9042.63829446828, 4566.269396896547, 4568.908621827612, 4569.314602809539, 4574.039451715111, 4580.0, 3643.854245830137, 4020.276350256982, 4124.13393187428, 4172.833086676499, 4176.749395036308, 3520.2959408118477, 3552.236269202134, 3661.377565813818, 3697.1681371691157, 3714.4428335749312, 1163.976720465603, 1168.1239070696977, 1169.7660467906453, 1182.255179237075, 1190.4940400329824, 745.9589722565311, 810.7121971700079, 811.1037303779357, 841.3353450773942, 855.7561095087871, 5041.621878359065, 5117.744112794346, 5146.485351464824, 5159.767810448464, 5219.739013049332, 390.33058305006483, 412.0091180710396, 412.0933945320248, 414.5792021098587, 416.02649799469384, 3473.9652603474146, 3501.8074005929407, 3502.2820321833965, 3564.946525802115, 3668.926621467556, 9064.50145242018, 9478.146966773023, 9502.097300756555, 9503.334766566273, 9510.0, 9391.859122113174, 9402.764930876647, 9440.669576564924, 9442.244620430349, 9454.905450945402, 6461.967690161519, 6693.564918280296, 6771.4582833373215, 6892.310768923167, 6893.069435626227, 5211.114110601283, 5219.4780521947505, 5264.78940842362, 5321.680699158062, 5555.527780138734, 8499.277561407349, 8610.698625548326, 8696.21734043939, 8779.692710755093, 8848.292136629183, 8586.484810911365, 8635.56822158877, 8667.4366166199, 8814.86777698348, 8815.162559557088, 5942.970285148546, 6091.573589848668, 6138.570300078952, 6690.364415380531, 6801.1158549388265, 7387.556746595222, 7461.477696561188, 7463.925360746323, 7464.178940316452, 7465.738699145504, 6590.340965903371, 6618.139641846529, 6628.403443690091, 6648.301928297653, 6812.386885180357, 6204.968975155095, 6295.401936815995, 6336.651484168231, 6433.774817881352, 6492.026196070438, 5938.396632909176, 6042.8791424170395, 6043.36544662804, 6049.274087109575, 6049.637021778707, 4294.8067336970535, 4374.234508960855, 4405.823767049282, 4439.556044395664, 4447.888802779957, 4209.810558524812, 4360.934585981149, 4376.649868010488, 4380.9780951095045, 4381.101874115862], "value": 3988.025491308436, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.42120285219585, 284.6342449951812, 289.7001603340542, 291.2732731834074, 292.2343460134448, 4902.5097490250955, 4930.728809915453, 4945.777440015199, 4950.603951683861, 4960.255961605761, 4784.736839473828, 4794.472608013116, 4869.9269510957365, 4882.316475693406, 4893.7797799099035, 3588.7129029677694, 3644.9271014579695, 3738.5700644425833, 3759.9624003760023, 3785.734998550103, 3763.9247215055684, 3764.8352197486556, 3765.3222419964395, 3777.9799454147364, 3791.4265579784355, 3717.8103007037757, 3730.3844865597143, 3736.4021756518964, 3743.307488114694, 3752.9061773455746, 3555.288942211555, 3623.4927110204594, 3735.570409402926, 3749.7750134991716, 3768.9811550942345, 3319.751018673609, 3325.983370083158, 3329.866805327784, 3333.8166400847945, 3348.79907205566, 4728.787204575802, 4732.384789977315, 4739.73931433771, 4752.168370535177, 4754.904901901978, 4190.748555086705, 4272.807723652443, 4304.7632380219075, 4316.3741257517795, 4328.935065974013, 5034.421041580228, 5045.84862454127, 5047.949520504784, 5051.6716413433005, 5066.974665126688, 3623.6376362363817, 3629.9455508167134, 3644.469322884395, 3646.268022689201, 3659.0852286928266, 5135.332406787131, 5268.683878967274, 5288.312519372495, 5288.709120998344, 5295.258663787073, 3677.8528858845348, 3709.499217605589, 3711.31340701971, 3714.4242642390473, 3730.291244663505, 3738.7382883197915, 3744.8127593620757, 3758.492603498493, 3765.2657731742047, 3780.6030366811638, 4236.809343579546, 4255.468066491689, 4275.48694156697, 4282.143571285756, 4295.506016808107, 4823.27650852375, 4983.227599722049, 4997.0, 5023.2214006829, 5032.874178145576, 1289.7420515896858, 1304.6673098359859, 1305.7203940138718, 1306.9479069349075, 1309.3322405573226, 802.9638666260032, 835.6907944060737, 836.3016880904513, 836.3768992100923, 841.8737189421513, 4349.695521313478, 4417.293233082755, 4450.132224216311, 4458.977705111453, 4473.792076139489, 5194.92207616886, 5208.088584497697, 5208.374995000624, 5210.869728256748, 5238.030964271622, 4424.446944131983, 4445.644078556072, 4455.576720211575, 4460.24175890093, 4470.815233962938, 2594.6237795519546, 2735.275152084699, 2765.3224959884556, 2776.6112744215825, 2777.666679998413, 4954.603631709455, 4969.552740253323, 4977.32806071183, 4978.800847966113, 4983.6760610560195, 5233.450487698813, 5289.18017707256, 5372.167314066326, 5392.811251606175, 5392.973035134799, 4915.655904086751, 4953.207486802166, 4965.106280869478, 4967.3542439482635, 4970.304157417964, 5235.397929238034, 5245.669000184834, 5246.97376513115, 5248.772005216841, 5251.789928402974, 4893.363862697826, 5144.845654630367, 5154.175331947021, 5165.225216217447, 5168.896622067613, 4976.377952755905, 4980.676256043491, 4982.551570358685, 4983.177775666974, 4987.077390682735, 3637.890863274106, 3654.3422184007136, 3657.725670574771, 3665.5967843537724, 3677.5954644989565, 5059.671121377099, 5221.190715439113, 5288.5985213917575, 5296.602754793329, 5297.5232229099565, 5082.932584157368, 5093.210552364241, 5099.464556221544, 5109.74451277442, 5111.670965548909, 5088.236764485357, 5094.681919726441, 5103.923441148311, 5123.462036486116, 5127.0, 4776.904461910673, 5007.774650140679, 5021.799128034838, 5027.371578552681, 5043.596512278936, 4904.803807847647, 4997.475265097112, 5107.693538387709, 5143.537081662668, 5165.0, 4973.353464049796, 4973.950260497349, 4977.253411988231, 4984.302197692254, 4996.0], "value": 3815.047860505038, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.0863196573174, 610.2524407600689, 655.6754406568749, 685.4208194076007, 714.1323292199976, 12551.435185416656, 13143.47426102957, 13641.93179034106, 13650.249236292, 13727.107737997023, 14098.929505352484, 14242.572722818306, 14253.0, 14257.35841887115, 14258.215798131125, 740.0453415094522, 761.9771406857803, 764.8929149918988, 765.4832987733286, 765.6516285090298, 598.3926314790491, 715.506300652548, 753.6759193546773, 755.391909512842, 763.5609524523394, 795.9602019899011, 797.5095316380442, 798.1300382582983, 798.2655956519986, 798.2935102434359, 779.5907148746896, 785.0736131364987, 785.5483097219122, 785.5522352259214, 791.4578513718093, 459.79079518818855, 542.4169018305298, 569.5699746691222, 570.7517230004961, 572.3275151696739, 12322.75354492914, 12332.0, 12356.938215308866, 12704.237745735192, 12729.0, 11678.416079196091, 12168.513259469699, 12331.93834030833, 12403.317817520032, 12540.498380064786, 9362.110599493037, 9570.0, 11614.245074070159, 11636.592719254786, 11824.822627660593, 4104.302268614343, 4158.0, 4237.322028475429, 4286.335617979218, 4380.233459144669, 53013.46986530124, 54817.72591137059, 54883.72558137224, 60715.392846071416, 61515.38484615141, 9488.478133702574, 10423.739406514898, 10526.73683157912, 10541.84187237192, 10861.891381086247, 18755.90622046881, 19983.300584479475, 20009.399718008484, 20011.399658010283, 20053.298134565513, 7020.630976959444, 7101.325374089453, 7104.857902841914, 7106.538075025107, 7306.232845551141, 3749.9625003750157, 3823.598522155189, 3833.6933045356304, 3859.2281543691374, 3965.7422267552515, 2857.6856545779947, 2952.4537960477383, 2955.06915321673, 2983.6270466191727, 2991.641003079644, 498.8179314550163, 501.6112512802607, 512.0680361741595, 514.5780460022745, 521.6504941689077, 479.20452049598197, 511.8541215753492, 521.942586315505, 594.5808205215313, 601.6841158391879, 7539.954507980939, 7888.290053895177, 8089.110197878229, 8109.351251899834, 8229.25936665703, 544.4827413956757, 588.1706793421256, 593.6289818863211, 594.8156071617813, 597.7220592424457, 3596.4245720684567, 3769.6230376962635, 3956.802159891994, 3970.980145099256, 4103.8974025649, 71727.0, 99884.0, 102590.48704756428, 103395.0, 106365.0, 88080.5595972016, 89608.55195723979, 89770.55114724385, 91579.54210228907, 92669.53665231765, 64129.0, 74524.25475745174, 74924.25075749173, 74933.25066749372, 75240.24759752442, 7555.16893141743, 7590.392768578611, 7797.0, 7800.492967957065, 7918.960405197937, 43612.78193609012, 44332.33501497415, 44438.55561444473, 44800.327995079446, 45206.77396612996, 56387.43612563822, 56965.0, 62464.0, 63499.682501587195, 65707.0, 9575.425474471554, 9897.901020989986, 9988.400695958266, 10186.643467478603, 10258.794824103625, 11073.944630276797, 11098.2786118902, 11319.717007074889, 11383.089352851917, 11660.242084264495, 10556.788864222826, 10565.788684226118, 10579.418132002813, 11132.0, 12211.0, 10324.638637647646, 11152.498137583665, 11182.944085279521, 11282.266652667551, 12764.744705106032, 11115.666530004113, 11183.608573700207, 11552.59565915189, 11981.122702434177, 12367.0, 9332.30007749435, 9538.427694338361, 10104.0, 10122.949385253027, 10937.12502999774, 8898.55507224649, 9808.558614862206, 9921.900780992386, 9934.751631209278, 9942.900570994198], "value": 6477.564762010598, "unit": "score"}], "name": "dromaeo_css", "value": 6459.212101630941, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 129.0, 115.0, 113.0, 115.0, 114.0, 113.0, 114.0, 114.0], "value": 115.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 124.0, 148.0, 187.0, 124.0, 153.0, 145.0, 128.0, 184.0, 122.0], "value": 147.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 162.0, 162.0, 161.0, 164.0, 163.0, 163.0, 162.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 161.0, 77.0, 77.0, 77.0, 76.0, 171.0, 76.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 145.0, 84.0, 84.0, 85.0, 152.0, 84.0, 83.0, 139.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 94.0, 95.0, 96.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 63.0, 64.0, 62.0, 64.0, 64.0, 65.0, 63.0, 63.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 90.0, 81.0, 86.0, 81.0, 81.0, 82.0, 87.0, 84.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 134.0, 133.0, 149.0, 143.0, 141.0, 136.0, 132.0, 182.0, 131.0], "value": 141.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 171.0, 171.0, 171.0, 172.0, 172.0, 171.0, 171.0, 178.0], "value": 171.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 67.0, 68.0, 68.0, 67.0, 68.0, 67.0, 68.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1574.8999999999999, "alertThreshold": 2.0}]} 16:21:34 INFO - Return code: 0 16:21:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:21:34 INFO - # TBPL SUCCESS # 16:21:34 INFO - Running post-action listener: _resource_record_post_action 16:21:34 INFO - [mozharness: 2016-08-26 23:21:34.301825Z] Finished run-tests step (success) 16:21:34 INFO - Running post-run listener: _resource_record_post_run 16:21:34 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 407646208; Read time: 0; Write time: 240324 16:21:34 INFO - TinderboxPrint: CPU usage
13.0% 16:21:34 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:21:34 INFO - TinderboxPrint: I/O write bytes / time
407,646,208 / 240,324 16:21:34 INFO - TinderboxPrint: CPU idle
8,341.8 (87.0%) 16:21:34 INFO - TinderboxPrint: CPU user
1,199.4 (12.5%) 16:21:34 INFO - TinderboxPrint: Swap in / out
0 / 0 16:21:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114331648; Read time: 0; Write time: 78976 16:21:34 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 293314560; Read time: 0; Write time: 161348 16:21:34 INFO - Running post-run listener: _upload_blobber_files 16:21:34 INFO - Blob upload gear active. 16:21:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:21:34 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 16:21:34 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:21:34 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:21:35 INFO - (blobuploader) - INFO - Open directory for files ... 16:21:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:21:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:21:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:21:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:21:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:21:38 INFO - (blobuploader) - INFO - Done attempting. 16:21:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:21:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:21:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:21:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:21:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:21:39 INFO - (blobuploader) - INFO - Done attempting. 16:21:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:21:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:21:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:21:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:21:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:21:40 INFO - (blobuploader) - INFO - Done attempting. 16:21:40 INFO - (blobuploader) - INFO - Iteration through files over. 16:21:40 INFO - Return code: 0 16:21:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:21:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:21:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9d4d8550e8ca3a5138421f63c5f0d6cf5eb78d7bc550a18e36e641a7a2aa1e7e3d0619bf685f1ce738c01631cd8db058ca04661db626da492b73760decbf89e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d51f2478a24a29a8c650fb2458b0179f583bf4a82d6531e0f798b97d0af105aa264fe52384c49cd85b4e10b3b15e466ccdbd2540ebc535470f8dc8f8a55e024", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/add9961f710ef30e02eb202baf80d71c2e5401caba04471c0c5b4ba9dd77da8779d57b7e7e0ee0fdf3bfe0efbcd8f6ad4030360bf943f78db26c2e6f652ab769"} 16:21:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:21:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:21:40 INFO - Contents: 16:21:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9d4d8550e8ca3a5138421f63c5f0d6cf5eb78d7bc550a18e36e641a7a2aa1e7e3d0619bf685f1ce738c01631cd8db058ca04661db626da492b73760decbf89e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d51f2478a24a29a8c650fb2458b0179f583bf4a82d6531e0f798b97d0af105aa264fe52384c49cd85b4e10b3b15e466ccdbd2540ebc535470f8dc8f8a55e024", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/add9961f710ef30e02eb202baf80d71c2e5401caba04471c0c5b4ba9dd77da8779d57b7e7e0ee0fdf3bfe0efbcd8f6ad4030360bf943f78db26c2e6f652ab769"} 16:21:40 INFO - Running post-run listener: copy_logs_to_upload_dir 16:21:40 INFO - Copying logs to upload dir... 16:21:40 INFO - mkdir: /builds/slave/test/build/upload/logs 16:21:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.084098 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-26 16:21:40.585319) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 16:21:40.588419) ========= 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=41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9d4d8550e8ca3a5138421f63c5f0d6cf5eb78d7bc550a18e36e641a7a2aa1e7e3d0619bf685f1ce738c01631cd8db058ca04661db626da492b73760decbf89e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d51f2478a24a29a8c650fb2458b0179f583bf4a82d6531e0f798b97d0af105aa264fe52384c49cd85b4e10b3b15e466ccdbd2540ebc535470f8dc8f8a55e024", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/add9961f710ef30e02eb202baf80d71c2e5401caba04471c0c5b4ba9dd77da8779d57b7e7e0ee0fdf3bfe0efbcd8f6ad4030360bf943f78db26c2e6f652ab769"} build_url:https://queue.taskcluster.net/v1/task/SH17ujm4T2OiIlPCM_2jnA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/SH17ujm4T2OiIlPCM_2jnA/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/Fx-Team-Non-PGO/sha512/9d4d8550e8ca3a5138421f63c5f0d6cf5eb78d7bc550a18e36e641a7a2aa1e7e3d0619bf685f1ce738c01631cd8db058ca04661db626da492b73760decbf89e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d51f2478a24a29a8c650fb2458b0179f583bf4a82d6531e0f798b97d0af105aa264fe52384c49cd85b4e10b3b15e466ccdbd2540ebc535470f8dc8f8a55e024", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/add9961f710ef30e02eb202baf80d71c2e5401caba04471c0c5b4ba9dd77da8779d57b7e7e0ee0fdf3bfe0efbcd8f6ad4030360bf943f78db26c2e6f652ab769"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 16:21:40.614013) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 16:21:40.614396) ========= 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=41a7e32711b8e08598a63237000001d6-1472248848.57737-992978266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 16:21:40.698855) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 16:21:40.699179) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 16:21:40.699478) ========= ========= Total master_lag: 0.17 =========