builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-040 starttime: 1467384780.55 results: success (0) buildid: 20160701072121 builduid: 2f56ab0efbeb441e8a565816dc9239e6 revision: 22c6ee548233a87bace78f804eac487970f95ddb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 07:53:00.549379) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 07:53:00.549887) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 07:53:00.550178) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 07:53:00.566135) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 07:53:00.566458) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-01 07:53:00-- 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% 66.8M=0s 2016-07-01 07:53:00 (66.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123730 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 07:53:00.705554) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 07:53:00.705892) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015501 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 07:53:00.765440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 07:53:00.765821) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 22c6ee548233a87bace78f804eac487970f95ddb --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 22c6ee548233a87bace78f804eac487970f95ddb --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=9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-01 07:53:00,839 truncating revision to first 12 chars 2016-07-01 07:53:00,839 Setting DEBUG logging. 2016-07-01 07:53:00,839 attempt 1/10 2016-07-01 07:53:00,839 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/22c6ee548233?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 07:53:01,823 unpacking tar archive at: fx-team-22c6ee548233/testing/mozharness/ program finished with exit code 0 elapsedTime=1.393161 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 07:53:02.175767) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 07:53:02.176405) ========= script_repo_revision: 22c6ee548233a87bace78f804eac487970f95ddb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 07:53:02.177262) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 07:53:02.177786) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 07:53:02.190453) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-01 07:53:02.190919) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:53:02 INFO - MultiFileLogger online at 20160701 07:53:02 in /builds/slave/test 07:53:02 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 07:53:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:53:02 INFO - {'append_to_log': False, 07:53:02 INFO - 'base_work_dir': '/builds/slave/test', 07:53:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:53:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:53:02 INFO - 'branch': 'Fx-Team-Non-PGO', 07:53:02 INFO - 'buildbot_json_path': 'buildprops.json', 07:53:02 INFO - 'config_files': ('talos/linux_config.py',), 07:53:02 INFO - 'default_actions': ('clobber', 07:53:02 INFO - 'read-buildbot-config', 07:53:02 INFO - 'download-and-extract', 07:53:02 INFO - 'populate-webroot', 07:53:02 INFO - 'create-virtualenv', 07:53:02 INFO - 'install', 07:53:02 INFO - 'run-tests'), 07:53:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:53:02 INFO - 'download_minidump_stackwalk': True, 07:53:02 INFO - 'download_symbols': 'ondemand', 07:53:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:53:02 INFO - 'tooltool.py': '/tools/tooltool.py', 07:53:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:53:02 INFO - '/tools/misc-python/virtualenv.py')}, 07:53:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:53:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:53:02 INFO - 'installer_path': 'installer.exe', 07:53:02 INFO - 'log_level': 'info', 07:53:02 INFO - 'log_name': 'talos', 07:53:02 INFO - 'log_to_console': True, 07:53:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:53:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:53:02 INFO - 'opt_config_files': (), 07:53:02 INFO - 'pip_index': False, 07:53:02 INFO - 'sps_profile': False, 07:53:02 INFO - 'sps_profile_interval': 0, 07:53:02 INFO - 'suite': 'dromaeojs', 07:53:02 INFO - 'system_bits': '32', 07:53:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:53:02 INFO - 'title': 'talos-linux64-ix-040', 07:53:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:53:02 INFO - 'use_talos_json': True, 07:53:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:53:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:53:02 INFO - 'work_dir': 'build'} 07:53:02 INFO - ##### 07:53:02 INFO - ##### Running clobber step. 07:53:02 INFO - ##### 07:53:02 INFO - Running pre-action listener: _resource_record_pre_action 07:53:02 INFO - Running main action method: clobber 07:53:02 INFO - rmtree: /builds/slave/test/build 07:53:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:53:02 INFO - Running post-action listener: _resource_record_post_action 07:53:02 INFO - ##### 07:53:02 INFO - ##### Finished clobber step (success) 07:53:02 INFO - ##### 07:53:02 INFO - ##### 07:53:02 INFO - ##### Running read-buildbot-config step. 07:53:02 INFO - ##### 07:53:02 INFO - Running pre-action listener: _resource_record_pre_action 07:53:02 INFO - Running main action method: read_buildbot_config 07:53:02 INFO - Using buildbot properties: 07:53:02 INFO - { 07:53:02 INFO - "project": "", 07:53:02 INFO - "product": "firefox", 07:53:02 INFO - "script_repo_revision": "production", 07:53:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:53:02 INFO - "repository": "", 07:53:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:53:02 INFO - "buildid": "20160701072121", 07:53:02 INFO - "pgo_build": "False", 07:53:02 INFO - "basedir": "/builds/slave/test", 07:53:02 INFO - "buildnumber": 1917, 07:53:02 INFO - "slavename": "talos-linux64-ix-040", 07:53:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:53:02 INFO - "platform": "ubuntu64_hw", 07:53:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:53:02 INFO - "branch": "fx-team", 07:53:02 INFO - "repo_path": "integration/fx-team", 07:53:02 INFO - "revision": "22c6ee548233a87bace78f804eac487970f95ddb", 07:53:02 INFO - "stage_platform": "linux64", 07:53:02 INFO - "builduid": "2f56ab0efbeb441e8a565816dc9239e6", 07:53:02 INFO - "slavebuilddir": "test" 07:53:02 INFO - } 07:53:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:53:02 INFO - Running post-action listener: _resource_record_post_action 07:53:02 INFO - ##### 07:53:02 INFO - ##### Finished read-buildbot-config step (success) 07:53:02 INFO - ##### 07:53:02 INFO - ##### 07:53:02 INFO - ##### Running download-and-extract step. 07:53:02 INFO - ##### 07:53:02 INFO - Running pre-action listener: _resource_record_pre_action 07:53:02 INFO - Running main action method: download_and_extract 07:53:02 INFO - mkdir: /builds/slave/test/build/tests 07:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:02 INFO - https://queue.taskcluster.net/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:53:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:53:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:53:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:53:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:53:08 INFO - Downloaded 1361 bytes. 07:53:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:53:08 INFO - Using the following test package requirements: 07:53:08 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:53:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:53:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:53:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:08 INFO - u'jsshell-linux-x86_64.zip'], 07:53:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:53:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:53:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:53:08 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:53:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:53:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:53:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:53:08 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:08 INFO - https://queue.taskcluster.net/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:53:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:53:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:53:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:53:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:53:11 INFO - Downloaded 22704123 bytes. 07:53:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:53:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:53:12 INFO - Return code: 0 07:53:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:12 INFO - https://queue.taskcluster.net/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:53:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:53:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:53:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:53:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:53:15 INFO - Downloaded 22704123 bytes. 07:53:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:53:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:53:16 INFO - Return code: 0 07:53:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:16 INFO - https://queue.taskcluster.net/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:53:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:53:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:53:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:53:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:53:17 INFO - Downloaded 14405242 bytes. 07:53:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:53:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:53:17 INFO - Return code: 0 07:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:17 INFO - https://queue.taskcluster.net/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:53:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:53:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:53:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:53:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:53:19 INFO - Downloaded 56452939 bytes. 07:53:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:53:19 INFO - mkdir: /builds/slave/test/properties 07:53:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:53:19 INFO - Writing to file /builds/slave/test/properties/build_url 07:53:19 INFO - Contents: 07:53:19 INFO - build_url:https://queue.taskcluster.net/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:53:20 INFO - Running post-action listener: _resource_record_post_action 07:53:20 INFO - Running post-action listener: set_extra_try_arguments 07:53:20 INFO - ##### 07:53:20 INFO - ##### Finished download-and-extract step (success) 07:53:20 INFO - ##### 07:53:20 INFO - ##### 07:53:20 INFO - ##### Running populate-webroot step. 07:53:20 INFO - ##### 07:53:20 INFO - Running pre-action listener: _resource_record_pre_action 07:53:20 INFO - Running main action method: populate_webroot 07:53:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:53:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:53:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:53:20 INFO - '--tppagecycles', 07:53:20 INFO - '7'], 07:53:20 INFO - 'tests': ['tsvgm']}}, 07:53:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:53:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:53:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:53:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:53:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:53:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:53:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:20 INFO - 'talos_options': ['--disable-e10s'], 07:53:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:53:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:53:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:20 INFO - 'talos_options': ['--disable-e10s'], 07:53:20 INFO - 'tests': ['damp', 'tps']}, 07:53:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:20 INFO - 'tests': ['damp', 'tps']}, 07:53:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:53:20 INFO - 'tests': ['dromaeo_dom']}, 07:53:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:53:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:53:20 INFO - 'tests': ['basic_compositor_video']}, 07:53:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:53:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:53:20 INFO - 'tests': ['a11yr', 07:53:20 INFO - 'ts_paint', 07:53:20 INFO - 'tpaint', 07:53:20 INFO - 'sessionrestore', 07:53:20 INFO - 'sessionrestore_no_auto_restore', 07:53:20 INFO - 'tabpaint']}, 07:53:20 INFO - 'other-e10s': {'tests': ['a11yr', 07:53:20 INFO - 'ts_paint', 07:53:20 INFO - 'tpaint', 07:53:20 INFO - 'sessionrestore', 07:53:20 INFO - 'sessionrestore_no_auto_restore', 07:53:20 INFO - 'tabpaint']}, 07:53:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:53:20 INFO - 'ts_paint', 07:53:20 INFO - 'tpaint', 07:53:20 INFO - 'sessionrestore', 07:53:20 INFO - 'sessionrestore_no_auto_restore', 07:53:20 INFO - 'tabpaint']}, 07:53:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:53:20 INFO - 'ts_paint', 07:53:20 INFO - 'tpaint', 07:53:20 INFO - 'sessionrestore', 07:53:20 INFO - 'sessionrestore_no_auto_restore', 07:53:20 INFO - 'tabpaint']}, 07:53:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:53:20 INFO - 'tests': ['a11yr', 07:53:20 INFO - 'ts_paint', 07:53:20 INFO - 'tpaint', 07:53:20 INFO - 'sessionrestore', 07:53:20 INFO - 'sessionrestore_no_auto_restore', 07:53:20 INFO - 'tabpaint']}, 07:53:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:53:20 INFO - 'tests': ['a11yr', 07:53:20 INFO - 'ts_paint', 07:53:20 INFO - 'tpaint', 07:53:20 INFO - 'sessionrestore', 07:53:20 INFO - 'sessionrestore_no_auto_restore', 07:53:20 INFO - 'tabpaint']}, 07:53:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:53:20 INFO - 'tests': ['tsvgx', 07:53:20 INFO - 'tsvgr_opacity', 07:53:20 INFO - 'tart', 07:53:20 INFO - 'tscrollx', 07:53:20 INFO - 'cart']}, 07:53:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:53:20 INFO - 'tsvgr_opacity', 07:53:20 INFO - 'tart', 07:53:20 INFO - 'tscrollx', 07:53:20 INFO - 'cart']}, 07:53:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:20 INFO - 'talos_options': ['--disable-e10s'], 07:53:20 INFO - 'tests': ['tp5o']}, 07:53:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:20 INFO - 'tests': ['tp5o']}, 07:53:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:20 INFO - 'talos_options': ['--disable-e10s', 07:53:20 INFO - '--xperf_path', 07:53:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:53:20 INFO - 'tests': ['tp5n']}, 07:53:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:20 INFO - 'talos_options': ['--xperf_path', 07:53:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:53:20 INFO - 'tests': ['tp5n']}}, 07:53:20 INFO - 'talos.zip': {'path': '', 07:53:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:53:20 INFO - Running post-action listener: _resource_record_post_action 07:53:20 INFO - ##### 07:53:20 INFO - ##### Finished populate-webroot step (success) 07:53:20 INFO - ##### 07:53:20 INFO - ##### 07:53:20 INFO - ##### Running create-virtualenv step. 07:53:20 INFO - ##### 07:53:20 INFO - Running pre-action listener: _resource_record_pre_action 07:53:20 INFO - Running main action method: create_virtualenv 07:53:20 INFO - Creating virtualenv /builds/slave/test/build/venv 07:53:20 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 07:53:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:53:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:53:20 INFO - Using real prefix '/usr' 07:53:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:53:21 INFO - Installing distribute.............................................................................................................................................................................................done. 07:53:23 INFO - Installing pip.................done. 07:53:23 INFO - Return code: 0 07:53:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0xd98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10573b0>, '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 0x10582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111', '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 07:53:23 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 07:53:23 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 07:53:23 INFO - Using env: {'DISPLAY': ':0', 07:53:23 INFO - 'HOME': '/home/cltbld', 07:53:23 INFO - 'LANG': 'en_US.UTF-8', 07:53:23 INFO - 'LANGUAGE': 'en_US:en', 07:53:23 INFO - 'LOGNAME': 'cltbld', 07:53:23 INFO - 'MAIL': '/var/mail/cltbld', 07:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:23 INFO - 'MOZ_NO_REMOTE': '1', 07:53:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:23 INFO - 'NO_EM_RESTART': '1', 07:53:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:23 INFO - 'PWD': '/builds/slave/test', 07:53:23 INFO - 'SHELL': '/bin/bash', 07:53:23 INFO - 'SHLVL': '1', 07:53:23 INFO - 'TERM': 'linux', 07:53:23 INFO - 'TMOUT': '86400', 07:53:23 INFO - 'USER': 'cltbld', 07:53:23 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111', 07:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:23 INFO - '_': '/tools/buildbot/bin/python'} 07:53:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:23 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 07:53:23 INFO - Cleaning up... 07:53:23 INFO - Return code: 0 07:53:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0xd98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10573b0>, '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 0x10582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111', '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 07:53:23 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 07:53:23 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 07:53:23 INFO - Using env: {'DISPLAY': ':0', 07:53:23 INFO - 'HOME': '/home/cltbld', 07:53:23 INFO - 'LANG': 'en_US.UTF-8', 07:53:23 INFO - 'LANGUAGE': 'en_US:en', 07:53:23 INFO - 'LOGNAME': 'cltbld', 07:53:23 INFO - 'MAIL': '/var/mail/cltbld', 07:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:23 INFO - 'MOZ_NO_REMOTE': '1', 07:53:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:23 INFO - 'NO_EM_RESTART': '1', 07:53:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:23 INFO - 'PWD': '/builds/slave/test', 07:53:23 INFO - 'SHELL': '/bin/bash', 07:53:23 INFO - 'SHLVL': '1', 07:53:23 INFO - 'TERM': 'linux', 07:53:23 INFO - 'TMOUT': '86400', 07:53:23 INFO - 'USER': 'cltbld', 07:53:23 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111', 07:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:23 INFO - '_': '/tools/buildbot/bin/python'} 07:53:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:23 INFO - Downloading/unpacking psutil>=3.1.1 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:53:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:53:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:53:25 INFO - Installing collected packages: psutil 07:53:25 INFO - Running setup.py install for psutil 07:53:25 INFO - building 'psutil._psutil_linux' extension 07:53:25 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 07:53:25 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 07:53:25 INFO - building 'psutil._psutil_posix' extension 07:53:25 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 07:53:25 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 07:53:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:53:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:53:26 INFO - Successfully installed psutil 07:53:26 INFO - Cleaning up... 07:53:26 INFO - Return code: 0 07:53:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10573b0>, '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 0x10582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111', '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 07:53:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:53:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:53:26 INFO - Using env: {'DISPLAY': ':0', 07:53:26 INFO - 'HOME': '/home/cltbld', 07:53:26 INFO - 'LANG': 'en_US.UTF-8', 07:53:26 INFO - 'LANGUAGE': 'en_US:en', 07:53:26 INFO - 'LOGNAME': 'cltbld', 07:53:26 INFO - 'MAIL': '/var/mail/cltbld', 07:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:26 INFO - 'MOZ_NO_REMOTE': '1', 07:53:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:26 INFO - 'NO_EM_RESTART': '1', 07:53:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:26 INFO - 'PWD': '/builds/slave/test', 07:53:26 INFO - 'SHELL': '/bin/bash', 07:53:26 INFO - 'SHLVL': '1', 07:53:26 INFO - 'TERM': 'linux', 07:53:26 INFO - 'TMOUT': '86400', 07:53:26 INFO - 'USER': 'cltbld', 07:53:26 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111', 07:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:26 INFO - '_': '/tools/buildbot/bin/python'} 07:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:53:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:53:28 INFO - Installing collected packages: mozsystemmonitor 07:53:28 INFO - Running setup.py install for mozsystemmonitor 07:53:28 INFO - Successfully installed mozsystemmonitor 07:53:28 INFO - Cleaning up... 07:53:28 INFO - Return code: 0 07:53:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:53:28 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:28 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:28 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 0xd98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10573b0>, '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 0x10582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111', '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 07:53:28 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 07:53:28 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 07:53:28 INFO - Using env: {'DISPLAY': ':0', 07:53:28 INFO - 'HOME': '/home/cltbld', 07:53:28 INFO - 'LANG': 'en_US.UTF-8', 07:53:28 INFO - 'LANGUAGE': 'en_US:en', 07:53:28 INFO - 'LOGNAME': 'cltbld', 07:53:28 INFO - 'MAIL': '/var/mail/cltbld', 07:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:28 INFO - 'MOZ_NO_REMOTE': '1', 07:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:28 INFO - 'NO_EM_RESTART': '1', 07:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:28 INFO - 'PWD': '/builds/slave/test', 07:53:28 INFO - 'SHELL': '/bin/bash', 07:53:28 INFO - 'SHLVL': '1', 07:53:28 INFO - 'TERM': 'linux', 07:53:28 INFO - 'TMOUT': '86400', 07:53:28 INFO - 'USER': 'cltbld', 07:53:28 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111', 07:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:28 INFO - '_': '/tools/buildbot/bin/python'} 07:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:28 INFO - Downloading/unpacking jsonschema==2.5.1 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:53:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:30 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 07:53:30 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 07:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:31 INFO - Downloading functools32-3.2.3-2.tar.gz 07:53:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:53:31 INFO - warning: no files found matching '*.txt' 07:53:31 INFO - no previously-included directories found matching 'build' 07:53:31 INFO - no previously-included directories found matching 'dist' 07:53:31 INFO - no previously-included directories found matching '.git*' 07:53:31 INFO - Installing collected packages: jsonschema, functools32 07:53:31 INFO - Running setup.py install for functools32 07:53:31 INFO - warning: no files found matching '*.txt' 07:53:31 INFO - no previously-included directories found matching 'build' 07:53:31 INFO - no previously-included directories found matching 'dist' 07:53:31 INFO - no previously-included directories found matching '.git*' 07:53:31 INFO - Successfully installed jsonschema functools32 07:53:31 INFO - Cleaning up... 07:53:31 INFO - Return code: 0 07:53:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53: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', '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 0xd98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10573b0>, '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 0x10582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111', '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 07:53: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:53: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 blobuploader==1.2.4 07:53:31 INFO - Using env: {'DISPLAY': ':0', 07:53:31 INFO - 'HOME': '/home/cltbld', 07:53:31 INFO - 'LANG': 'en_US.UTF-8', 07:53:31 INFO - 'LANGUAGE': 'en_US:en', 07:53:31 INFO - 'LOGNAME': 'cltbld', 07:53:31 INFO - 'MAIL': '/var/mail/cltbld', 07:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:31 INFO - 'MOZ_NO_REMOTE': '1', 07:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:31 INFO - 'NO_EM_RESTART': '1', 07:53:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:31 INFO - 'PWD': '/builds/slave/test', 07:53:31 INFO - 'SHELL': '/bin/bash', 07:53:31 INFO - 'SHLVL': '1', 07:53:31 INFO - 'TERM': 'linux', 07:53:31 INFO - 'TMOUT': '86400', 07:53:31 INFO - 'USER': 'cltbld', 07:53:31 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111', 07:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:31 INFO - '_': '/tools/buildbot/bin/python'} 07:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:31 INFO - Downloading/unpacking blobuploader==1.2.4 07:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:33 INFO - Downloading blobuploader-1.2.4.tar.gz 07:53:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:53:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:53:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:34 INFO - Downloading docopt-0.6.1.tar.gz 07:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:53:34 INFO - Installing collected packages: blobuploader, requests, docopt 07:53:34 INFO - Running setup.py install for blobuploader 07:53:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:53:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:53:34 INFO - Running setup.py install for requests 07:53:34 INFO - Running setup.py install for docopt 07:53:34 INFO - Successfully installed blobuploader requests docopt 07:53:34 INFO - Cleaning up... 07:53:34 INFO - Return code: 0 07:53:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:34 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 0xd98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10573b0>, '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 0x10582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111', '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 07:53:34 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 07:53:34 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 07:53:34 INFO - Using env: {'DISPLAY': ':0', 07:53:34 INFO - 'HOME': '/home/cltbld', 07:53:34 INFO - 'LANG': 'en_US.UTF-8', 07:53:34 INFO - 'LANGUAGE': 'en_US:en', 07:53:34 INFO - 'LOGNAME': 'cltbld', 07:53:34 INFO - 'MAIL': '/var/mail/cltbld', 07:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:34 INFO - 'MOZ_NO_REMOTE': '1', 07:53:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:34 INFO - 'NO_EM_RESTART': '1', 07:53:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:34 INFO - 'PWD': '/builds/slave/test', 07:53:34 INFO - 'SHELL': '/bin/bash', 07:53:34 INFO - 'SHLVL': '1', 07:53:34 INFO - 'TERM': 'linux', 07:53:34 INFO - 'TMOUT': '86400', 07:53:34 INFO - 'USER': 'cltbld', 07:53:34 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111', 07:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:34 INFO - '_': '/tools/buildbot/bin/python'} 07:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:53:35 INFO - Running setup.py (path:/tmp/pip-wSyZt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:53:35 INFO - Running setup.py (path:/tmp/pip-86eaG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:53:35 INFO - Running setup.py (path:/tmp/pip-6JMgGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:53:35 INFO - Running setup.py (path:/tmp/pip-1UoO_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:53:35 INFO - Running setup.py (path:/tmp/pip-c8n6_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:53:35 INFO - Running setup.py (path:/tmp/pip-vPXDPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:53:35 INFO - Running setup.py (path:/tmp/pip-XE6B_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:53:35 INFO - Running setup.py (path:/tmp/pip-5zOONX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:53:35 INFO - Running setup.py (path:/tmp/pip-PmPHWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:53:35 INFO - Running setup.py (path:/tmp/pip-Bo0Cqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:53:35 INFO - Running setup.py (path:/tmp/pip-c9rmn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:53:35 INFO - Running setup.py (path:/tmp/pip-pqODrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:53:35 INFO - Running setup.py (path:/tmp/pip-5oH7QY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:53:36 INFO - Running setup.py (path:/tmp/pip-sKIOrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:36 INFO - Running setup.py (path:/tmp/pip-Ykdmcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:53:36 INFO - Running setup.py (path:/tmp/pip-ezi6iI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:53:36 INFO - Running setup.py (path:/tmp/pip-2SuTyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:53:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:53:36 INFO - Running setup.py install for manifestparser 07:53:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:53:36 INFO - Running setup.py install for mozcrash 07:53:36 INFO - Running setup.py install for mozdebug 07:53:36 INFO - Running setup.py install for mozdevice 07:53:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:53:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:53:36 INFO - Running setup.py install for mozfile 07:53:36 INFO - Running setup.py install for mozhttpd 07:53:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:53:36 INFO - Running setup.py install for mozinfo 07:53:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:53:37 INFO - Running setup.py install for mozInstall 07:53:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:53:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:53:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:53:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:53:37 INFO - Running setup.py install for mozleak 07:53:37 INFO - Running setup.py install for mozlog 07:53:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:53:37 INFO - Running setup.py install for moznetwork 07:53:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:53:37 INFO - Running setup.py install for mozprocess 07:53:37 INFO - Running setup.py install for mozprofile 07:53:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:53:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:53:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:53:37 INFO - Running setup.py install for mozrunner 07:53:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:53:37 INFO - Running setup.py install for mozscreenshot 07:53:37 INFO - Running setup.py install for moztest 07:53:37 INFO - Running setup.py install for mozversion 07:53:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:53:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:53:38 INFO - Cleaning up... 07:53:38 INFO - Return code: 0 07:53:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:38 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 0xd98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10573b0>, '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 0x10582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111', '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 07:53:38 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 07:53:38 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 07:53:38 INFO - Using env: {'DISPLAY': ':0', 07:53:38 INFO - 'HOME': '/home/cltbld', 07:53:38 INFO - 'LANG': 'en_US.UTF-8', 07:53:38 INFO - 'LANGUAGE': 'en_US:en', 07:53:38 INFO - 'LOGNAME': 'cltbld', 07:53:38 INFO - 'MAIL': '/var/mail/cltbld', 07:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:38 INFO - 'MOZ_NO_REMOTE': '1', 07:53:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:38 INFO - 'NO_EM_RESTART': '1', 07:53:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:38 INFO - 'PWD': '/builds/slave/test', 07:53:38 INFO - 'SHELL': '/bin/bash', 07:53:38 INFO - 'SHLVL': '1', 07:53:38 INFO - 'TERM': 'linux', 07:53:38 INFO - 'TMOUT': '86400', 07:53:38 INFO - 'USER': 'cltbld', 07:53:38 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111', 07:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:38 INFO - '_': '/tools/buildbot/bin/python'} 07:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:53:38 INFO - Running setup.py (path:/tmp/pip-3_zUw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:53:38 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)) 07:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:53:38 INFO - Running setup.py (path:/tmp/pip-A9ynqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:53:38 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)) 07:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:53:38 INFO - Running setup.py (path:/tmp/pip-f007_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:53:38 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)) 07:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:53:38 INFO - Running setup.py (path:/tmp/pip-B_AxNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:53:38 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)) 07:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:53:38 INFO - Running setup.py (path:/tmp/pip-iD_AIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:53:38 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)) 07:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:53:38 INFO - Running setup.py (path:/tmp/pip-Gv2uA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:53:38 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)) 07:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:53:38 INFO - Running setup.py (path:/tmp/pip-rqjBWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:53:38 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)) 07:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:53:38 INFO - Running setup.py (path:/tmp/pip-Ixs0zL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:53:38 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)) 07:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:53:38 INFO - Running setup.py (path:/tmp/pip-PaiC63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:53:38 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)) 07:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:53:38 INFO - Running setup.py (path:/tmp/pip-jVuEts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 07:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:53:39 INFO - Running setup.py (path:/tmp/pip-cBIYoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:53:39 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)) 07:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:53:39 INFO - Running setup.py (path:/tmp/pip-4UN6uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 07:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:53:39 INFO - Running setup.py (path:/tmp/pip-kGIh1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:53:39 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)) 07:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:53:39 INFO - Running setup.py (path:/tmp/pip-2ZZImd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 07:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:39 INFO - Running setup.py (path:/tmp/pip-cm30PL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:39 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)) 07:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:53:39 INFO - Running setup.py (path:/tmp/pip-7Ktn0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:53:39 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)) 07:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:53:39 INFO - Running setup.py (path:/tmp/pip-aQwWqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:53:39 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)) 07:53:39 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)) 07:53:39 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)) 07:53:39 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)) 07:53:39 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)) 07:53:39 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)) 07:53:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:53:39 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 07:53:39 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 07:53:39 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 07:53:39 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 07:53:39 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 07:53:39 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 07:53:41 INFO - Downloading blessings-1.6.tar.gz 07:53:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:53:41 INFO - Installing collected packages: blessings 07:53:41 INFO - Running setup.py install for blessings 07:53:41 INFO - Successfully installed blessings 07:53:41 INFO - Cleaning up... 07:53:41 INFO - Return code: 0 07:53:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:53:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:53:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:53:41 INFO - Reading from file tmpfile_stdout 07:53:41 INFO - Current package versions: 07:53:41 INFO - argparse == 1.2.1 07:53:41 INFO - blessings == 1.6 07:53:41 INFO - blobuploader == 1.2.4 07:53:41 INFO - docopt == 0.6.1 07:53:41 INFO - functools32 == 3.2.3-2 07:53:41 INFO - jsonschema == 2.5.1 07:53:41 INFO - manifestparser == 1.1 07:53:41 INFO - mozInstall == 1.12 07:53:41 INFO - mozcrash == 0.17 07:53:41 INFO - mozdebug == 0.1 07:53:41 INFO - mozdevice == 0.48 07:53:41 INFO - mozfile == 1.2 07:53:41 INFO - mozhttpd == 0.7 07:53:41 INFO - mozinfo == 0.9 07:53:41 INFO - mozleak == 0.1 07:53:41 INFO - mozlog == 3.2 07:53:41 INFO - moznetwork == 0.27 07:53:41 INFO - mozprocess == 0.22 07:53:41 INFO - mozprofile == 0.28 07:53:41 INFO - mozrunner == 6.11 07:53:41 INFO - mozscreenshot == 0.1 07:53:41 INFO - mozsystemmonitor == 0.3 07:53:41 INFO - moztest == 0.7 07:53:41 INFO - mozversion == 1.4 07:53:41 INFO - psutil == 3.1.1 07:53:41 INFO - requests == 1.2.3 07:53:41 INFO - wsgiref == 0.1.2 07:53:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:41 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 0xd98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10573b0>, '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 0x10582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111', '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 07:53:41 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 07:53:41 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 07:53:41 INFO - Using env: {'DISPLAY': ':0', 07:53:41 INFO - 'HOME': '/home/cltbld', 07:53:41 INFO - 'LANG': 'en_US.UTF-8', 07:53:41 INFO - 'LANGUAGE': 'en_US:en', 07:53:41 INFO - 'LOGNAME': 'cltbld', 07:53:41 INFO - 'MAIL': '/var/mail/cltbld', 07:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:41 INFO - 'MOZ_NO_REMOTE': '1', 07:53:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:41 INFO - 'NO_EM_RESTART': '1', 07:53:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:41 INFO - 'PWD': '/builds/slave/test', 07:53:41 INFO - 'SHELL': '/bin/bash', 07:53:41 INFO - 'SHLVL': '1', 07:53:41 INFO - 'TERM': 'linux', 07:53:41 INFO - 'TMOUT': '86400', 07:53:41 INFO - 'USER': 'cltbld', 07:53:41 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111', 07:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:41 INFO - '_': '/tools/buildbot/bin/python'} 07:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:42 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)) 07:53:42 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)) 07:53:42 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)) 07:53:42 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)) 07:53:42 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)) 07:53:42 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)) 07:53:42 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)) 07:53:42 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)) 07:53:42 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)) 07:53:42 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)) 07:53:42 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)) 07:53:42 INFO - Cleaning up... 07:53:42 INFO - Return code: 0 07:53:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:53:42 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:42 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:42 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 0xd98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10573b0>, '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 0x10582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111', '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 07:53:42 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 07:53:42 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 07:53:42 INFO - Using env: {'DISPLAY': ':0', 07:53:42 INFO - 'HOME': '/home/cltbld', 07:53:42 INFO - 'LANG': 'en_US.UTF-8', 07:53:42 INFO - 'LANGUAGE': 'en_US:en', 07:53:42 INFO - 'LOGNAME': 'cltbld', 07:53:42 INFO - 'MAIL': '/var/mail/cltbld', 07:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:42 INFO - 'MOZ_NO_REMOTE': '1', 07:53:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:42 INFO - 'NO_EM_RESTART': '1', 07:53:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:42 INFO - 'PWD': '/builds/slave/test', 07:53:42 INFO - 'SHELL': '/bin/bash', 07:53:42 INFO - 'SHLVL': '1', 07:53:42 INFO - 'TERM': 'linux', 07:53:42 INFO - 'TMOUT': '86400', 07:53:42 INFO - 'USER': 'cltbld', 07:53:42 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111', 07:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:42 INFO - '_': '/tools/buildbot/bin/python'} 07:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:53:42 INFO - Cleaning up... 07:53:42 INFO - Return code: 0 07:53:42 INFO - Running post-action listener: _resource_record_post_action 07:53:42 INFO - Running post-action listener: _start_resource_monitoring 07:53:42 INFO - Starting resource monitoring. 07:53:42 INFO - ##### 07:53:42 INFO - ##### Finished create-virtualenv step (success) 07:53:42 INFO - ##### 07:53:42 INFO - ##### 07:53:42 INFO - ##### Running install step. 07:53:42 INFO - ##### 07:53:42 INFO - Running pre-action listener: _resource_record_pre_action 07:53:42 INFO - Running main action method: install 07:53:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:53:42 INFO - Reading from file tmpfile_stdout 07:53:42 INFO - Detecting whether we're running mozinstall >=1.0... 07:53:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:53:42 INFO - Reading from file tmpfile_stdout 07:53:42 INFO - Output received: 07:53:42 INFO - Usage: mozinstall [options] installer 07:53:42 INFO - Options: 07:53:42 INFO - -h, --help show this help message and exit 07:53:42 INFO - -d DEST, --destination=DEST 07:53:42 INFO - Directory to install application into. [default: 07:53:42 INFO - "/builds/slave/test"] 07:53:42 INFO - --app=APP Application being installed. [default: firefox] 07:53:42 INFO - mkdir: /builds/slave/test/build/application 07:53:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:53:58 INFO - Reading from file tmpfile_stdout 07:53:58 INFO - Output received: 07:53:58 INFO - /builds/slave/test/build/application/firefox/firefox 07:53:58 INFO - Running post-action listener: _resource_record_post_action 07:53:58 INFO - ##### 07:53:58 INFO - ##### Finished install step (success) 07:53:58 INFO - ##### 07:53:58 INFO - ##### 07:53:58 INFO - ##### Running run-tests step. 07:53:58 INFO - ##### 07:53:58 INFO - Running pre-action listener: _resource_record_pre_action 07:53:58 INFO - Running main action method: run_tests 07:53:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:53:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:53:58 INFO - Python 2.7.3 07:53:58 INFO - Return code: 0 07:53:58 INFO - grabbing minidump binary from tooltool 07:53:58 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:58 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 0x10573b0>, '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 0x10582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:53:58 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 07:53:58 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 07:53:58 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 07:53:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:53:58 INFO - Return code: 0 07:53:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:53:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:53:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:53:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:53:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:53:58 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/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 07:53:58 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/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 07:53:58 INFO - Using env: {'DISPLAY': ':0', 07:53:58 INFO - 'HOME': '/home/cltbld', 07:53:58 INFO - 'LANG': 'en_US.UTF-8', 07:53:58 INFO - 'LANGUAGE': 'en_US:en', 07:53:58 INFO - 'LOGNAME': 'cltbld', 07:53:58 INFO - 'MAIL': '/var/mail/cltbld', 07:53:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:53:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:58 INFO - 'MOZ_NO_REMOTE': '1', 07:53:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:58 INFO - 'NO_EM_RESTART': '1', 07:53:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:58 INFO - 'PWD': '/builds/slave/test', 07:53:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:53:58 INFO - 'SHELL': '/bin/bash', 07:53:58 INFO - 'SHLVL': '1', 07:53:58 INFO - 'TERM': 'linux', 07:53:58 INFO - 'TMOUT': '86400', 07:53:58 INFO - 'USER': 'cltbld', 07:53:58 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111', 07:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:58 INFO - '_': '/tools/buildbot/bin/python'} 07:53:58 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/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 07:53:59 INFO - mozversion application_buildid: 20160701072121 07:53:59 INFO - mozversion application_changeset: 22c6ee548233a87bace78f804eac487970f95ddb 07:53:59 INFO - mozversion application_display_name: Nightly 07:53:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:53:59 INFO - mozversion application_name: Firefox 07:53:59 INFO - mozversion application_remotingname: firefox 07:53:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:53:59 INFO - mozversion application_vendor: Mozilla 07:53:59 INFO - mozversion application_version: 50.0a1 07:53:59 INFO - mozversion platform_buildid: 20160701072121 07:53:59 INFO - mozversion platform_changeset: 22c6ee548233a87bace78f804eac487970f95ddb 07:53:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:53:59 INFO - mozversion platform_version: 50.0a1 07:53:59 INFO - using testdate: 1467384839 07:53:59 INFO - actual date: 1467384839 07:53:59 INFO - starting webserver on 'localhost:34351' 07:53:59 INFO - SUITE-START | Running 2 tests 07:53:59 INFO - TEST-START | dromaeo_css 07:53:59 INFO - operating with platform_type : linux_ 07:53:59 INFO - Initialising browser for dromaeo_css test... 07:53:59 INFO - TEST-INFO | started process 10757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2Sfr7E/profile http://localhost:34351/getInfo.html) 07:54:03 INFO - PROCESS | 10757 | __metrics Screen width/height:1600/1200 07:54:03 INFO - PROCESS | 10757 | colorDepth:24 07:54:03 INFO - PROCESS | 10757 | Browser inner width/height: 1024/697 07:54:03 INFO - PROCESS | 10757 | __metrics 07:54:04 INFO - PROCESS | 10757 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:54:05 INFO - TEST-INFO | 10757: exit 0 07:54:05 INFO - Browser initialized. 07:54:05 INFO - Running cycle 1/1 for dromaeo_css test... 07:54:05 INFO - TEST-INFO | started process 10838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2Sfr7E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:54:17 INFO - PROCESS | 10838 | RSS: Main: 159236096 07:54:17 INFO - PROCESS | 10838 | 07:55:08 INFO - PROCESS | 10838 | 1467384908548 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] 07:57:21 INFO - PROCESS | 10838 | Cycle 1(1): loaded http://localhost:34351/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34351/tests/dromaeo/cssquery-ext.html) 07:57:22 INFO - PROCESS | 10838 | RSS: Main: 256233472 07:57:22 INFO - PROCESS | 10838 | 08:00:25 INFO - PROCESS | 10838 | Cycle 1(1): loaded http://localhost:34351/tests/dromaeo/cssquery-ext.html (next: http://localhost:34351/tests/dromaeo/cssquery-jquery.html) 08:00:25 INFO - PROCESS | 10838 | RSS: Main: 236642304 08:00:25 INFO - PROCESS | 10838 | 08:03:28 INFO - PROCESS | 10838 | Cycle 1(1): loaded http://localhost:34351/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34351/tests/dromaeo/cssquery-mootools.html) 08:03:28 INFO - PROCESS | 10838 | RSS: Main: 236658688 08:03:28 INFO - PROCESS | 10838 | 08:06:30 INFO - PROCESS | 10838 | Cycle 1(1): loaded http://localhost:34351/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34351/tests/dromaeo/cssquery-prototype.html) 08:06:31 INFO - PROCESS | 10838 | RSS: Main: 227123200 08:06:31 INFO - PROCESS | 10838 | 08:09:34 INFO - PROCESS | 10838 | Cycle 1(1): loaded http://localhost:34351/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34351/tests/dromaeo/cssquery-yui.html) 08:09:35 INFO - PROCESS | 10838 | RSS: Main: 227684352 08:09:35 INFO - PROCESS | 10838 | 08:12:37 INFO - PROCESS | 10838 | Cycle 1(1): loaded http://localhost:34351/tests/dromaeo/cssquery-yui.html (next: http://localhost:34351/tests/dromaeo/cssquery-dojo.html) 08:12:38 INFO - PROCESS | 10838 | RSS: Main: 271183872 08:12:38 INFO - PROCESS | 10838 | 08:12:38 INFO - PROCESS | 10838 | __start_tp_report 08:12:38 INFO - PROCESS | 10838 | _x_x_mozilla_page_load 08:12:38 INFO - PROCESS | 10838 | _x_x_mozilla_page_load_details 08:12:38 INFO - PROCESS | 10838 | |i|pagename|runs| 08:12:38 INFO - PROCESS | 10838 | |0;dojo.html;2584.793216542676;2634.209737078876;2649.059583847734;2666.0802023301953;2674.7993900457473;4555.726656400619;4634.721916684993;4723.858284251473;4799.592034677056;4826.71039737616;4708;4713.222318317482;4728.054389122172;4745.691530050544;4767.0942520921;4102.958970410303;4256.063665993476;4342.392065110887;4369.868903932887;4463.598276155145;4362.0621566363225;4403.713758605681;4411.05162390086;4417.182821178077;4455;4209.536950935395;4244.745315281062;4255.234057869582;4271.765052922088;4282.272013757669;4258.8509402171085;4263.062126332202;4276.764777937212;4328.5022222444195;4330.783460826946;4290.957090429087;4304.268274393361;4314.094040251551;4315.654747620183;4354.303311470181;4567.2920697291975;4609.562091601292;4624.329472226508;4682.672212945095;4751.857444276678;5016.3980322361185;5033.899322013539;5054.797808087672;5056.140456122431;5062.1141300272675;5090.38915330159;5103.897922041576;5104.183330667112;5105.846824595268;5109.540141387293;4538.546145385435;4655.650826188049;4657.767111644404;4685.758274057377;4756.738379389098;5188.377394712658;5206.739663016834;5218.060749065129;5218.582513398919;5218.739063046833;4866.367372241586;4947.851564453073;4988.800447982113;4999.275105109811;5023.2214006829;5015.899682006339;5051.873703157377;5054.115529782347;5057.519535644108;5131.2559678846355;5007.073691367036;5010.073136469765;5015.4733752956145;5019.498050195024;5072.163093089599;4863.513648635179;4883.633727470454;4998.175301075355;5005.82479613219;5009.348784657971;4257.382679511454;4273.1026484438;4279.614834664895;4293.44185255921;4314.158739045919;3725.6646901778972;3734.7198960078103;3741.4387841823946;3763.8118094095184;3782.829772660182;4286.207051695446;4323.156984388014;4377.321515165155;4385.649148068147;4387.517373088957;5123.180291153398;5137.948620513822;5155.329807125125;5155.716435596079;5219.164933610604;4432.800523976429;4438.822447102079;4446.421965144576;4489.753063581469;4499.6400287976885;4220.430241917364;4435.844745433894;4509.684322097487;4625;4626.629869610423;4756.88107797294;4777.856664300077;4781.569658730731;4817.373741413594;4824.396950381202;5102.336696229467;5103.7448127592725;5107.080725469303;5109.795608175631;5147.227915812508;4566.109608626286;4572.993941332901;4603.355530225838;4783.6651434399255;4821.373221481325;4874.780634871368;4895.461499235153;4901.068796928572;4907.950920490749;4909.533594308535;5045.949540504548;5091.770870310919;5103.7192954387865;5179.145441002343;5187.092258854761;4951.579115775199;4959.752012399294;4962.429320628174;4968;5008.799648014038;4953.578945789648;4964.478729733326;4966.304717339503;4985.052839960396;5042.899142017066;4724.4094488188975;4791.736454494897;4829.855104346875;4839.758012099311;4849.102915960559;4932.21084626458;4942.777575009061;4943.2585112233455;4945.653804233669;4993.076280888047;4720.197566413786;4802.975985120052;4851.369321988119;4857.174280372275;4857.295692124551 08:12:38 INFO - PROCESS | 10838 | |1;ext.html;553.7739980504896;575.9251297331347;577.936426993031;583.0176153181889;595.6396380189985;27150.18549443515;30030.399392012147;30067.699323006764;30068.24829379264;30073.398532029347;29984;41019.38470922931;42305.365419518654;42438.787806061;46742.766286168604;7874.566898820577;8029.879551806727;8044.597770111501;8045.195480451966;8049.758507244792;7661.770146895602;7855;7946.880796788053;10059.64791232307;10297.536610852492;10325.122364599018;10410.739731506736;10416.843747343795;10419.062284394404;10427.947860260727;10245;10285.48572571376;10291.948540257326;10299.897001029969;10304.79390412195;7648.1204661463535;9886.653967111117;10282.691519254435;10309.175265978703;10628.574857005711;38711.806440967615;39046.41430378518;39053.41419878704;39070;39073.60926390728;3016.849157542114;3040.619922509686;3055.4500189965797;3116.594842670461;3363.5795525559306;28865.134045978655;28965.56551651727;29671.703282967326;29888.40223195524;30214.395712085854;3347.9497807532907;3358;3369.9831500842583;3426.7258619310396;3442.8794992175153;255877;260314;260750;261033;261504;55768;55837.441625583226;56400.43599563952;56461.71769141128;56514.71742641261;33933.830330848185;34847.12882177966;34950.82524587412;36507;36525.81737091298;15235;15365.462208822637;15422.305996230196;15431.228438578026;15444.691106178037;9619.51902404877;11215.60745373908;11295.096392288597;11300.265482743594;11306.717332066599;18268.451946441626;18461.353852615095;18839.340623078126;19055.80944190568;19077.141528631244;6846.965765171242;6867.450603951672;6898.448124150156;6966.442684585221;7028.297170282931;912.5665308978182;936.896941336466;939.1641439119189;988.2341185581089;1035.35807799165;28105.71894281072;28611.998580050014;29041.128766137048;29164.270893227414;29253.707462925526;971.9611215551299;984.4191926763244;984.6701355045997;994.1450352696675;1019.8674172357546;15239.771403428957;15358.769618455732;15495.605395514458;15536.300866461037;15611.16496607153;394241;395578;398000;399897;401230;50463.24305135426;51401.48598514042;51442;51473.7426312866;51566;1088.983665245022;1176.4705882352805;1179.4515550268995;1198.5505435461703;1209.4013463335352;28423.28941776472;29201.85399073076;29631.407371852874;30056.69943300539;30123;42423.5757642432;42827.357589636806;42908.570914291704;43003.35494967515;43072.13855722931;302579;303226;303771;304746;304968;22444.663330049734;22863.542729144992;22872;23163.536729265656;23164.420889477897;42323;42603.5739642612;42999.78500107479;43739;43943.340849887914;36167.457488137174;37192.44211336778;37471.43792843055;37756.24487510289;37792.811035944644;36131.45802812908;36503.26993460169;36807.44788828116;36933.81533092317;36990.260194796494;36193.45709814302;36588.26823463463;36689.082772929825;36812.447813282284;36926.63073369232;30555.694443055287;33793.49309760405;33937.32125357528;34365.484517731755;34367.656323436444;25548.872255638602;25851.741482584934;25988.740112598633;26240.553311371223;26592 08:12:38 INFO - PROCESS | 10838 | |2;jquery.html;344.9810260435675;363.91629925117223;366.94862719219316;369.4476757247913;386.79113278829414;12785;16444.588885277873;16996.745048824276;18692.345767898125;18828.71756923644;16757.91621041893;17123.657526849456;18125.637487250246;18142.546436339097;18147.637047259046;5077.5684066854365;5430.212619170218;5430.782768689268;5435.864103397407;5439.184122381635;3761.078535758743;5291.814786482474;5984.73068711909;6307.77922772703;6319.620822750627;6288.465480434169;6378.521610879179;6389.648569328685;6398.584092034026;6410.294867564564;6221.937780622181;6416.743330266784;6421.51838612106;6424.100625912376;6427.93572064278;5546.306711661043;5583.3858275590055;5587.972060139673;5667.773289068432;5669.319681638189;21598.352049438385;21892.45268868275;22237.44406389837;22306.553868922532;22324.218652347252;1956.3348461523008;2092.9162833486644;2132.626790311689;2137.241279345825;2507.949841003188;13092.279924604143;13565.660858478519;13876.791848122286;13884.4446222151;13904.930475347559;1763.444514977778;1832.25793553611;1841.8802777819399;1850.6021205440895;1897.8197071278207;69135;70061;71080.6445967772;71321.93017104799;71839.64080179618;8842.823143537093;8964.462132272085;9705.951470242744;9734.75663108428;10061.54723037465;13782.966277529225;13907.096038757449;13926.721465570834;13954.720905582035;14027.08823926462;7134.750283740044;7352.448566357544;7362.411007119525;7455.627218639155;7456.7390141344795;6798.762043328558;6892.414144797748;6931.930680693128;7088.149422069385;7123.964380178066;6360.173177486897;6404.839879002969;6416.422521973045;6436.967815160988;6445.581037232565;1780.8931464112195;1816.0489205041806;1850.6668799616198;1852.7961924188328;1873.9156737946826;820.2248874813245;871.4248595926784;920.604140219712;921.1065266691298;950.2350607760819;16698.582535436468;17173.398931037354;19299.131539080776;19436.319728809423;19564.119614617375;870.9782255443664;890.1321211818425;923.2383283790765;942.4675058591873;944.504135328944;9894.55474503649;9979.850302245472;10253.641122560824;10287.485625718684;10327.586896524204;388588;390030;396615;402892;405620;81897;82143.5892820544;83272.58363708264;83285.16714832895;84426.15573844183;851.4082712514867;869.9391042627082;885.5483703311357;886.5700135434438;887.3788348156187;15983.360665573711;16302.755458667893;16474;16504.25730842139;16786;37820.62179378281;38050.42924356192;38113.61886381212;38368.587612424926;40372.99067523218;53232.20151697805;53489;54881.45118548923;55045.724771375884;55251.723741381036;7780.688772449265;7893.921060789318;8053.832194331906;8179.141190174946;8257.917420825715;11063.391513466837;11874.168808183344;12288.201266917622;12288.385580721108;12402;10292.897071029194;10440.112590429899;10465.790684186426;10565;10794.56821727122;10624.256302059091;10682.359058456517;10733.302335348177;10748.193885458779;10807.405592692478;10237.232207584311;10670.57317707314;10917.617883374362;10949.343039417661;10985.176111791488;8047.597620119088;8070.152633973583;8094.716684916235;8174.713885013996;8210.425270231026;7990.760277191694;9227.584758685742;9764.707058788248;10046.4428013658;10489.632862849763 08:12:38 INFO - PROCESS | 10838 | |3;mootools.html;1269.961901142965;1339.4575197045197;1407.690308132211;1459.6132025013374;1714.4856543037079;6804.183497980243;7678.961605191973;7921.603919804015;7934.889115523824;8173.060098088721;7885.723999660013;8016.91983080169;8032.156623554531;8032.638531266092;8032.759017229478;2195.681626164205;2227.40973641985;2228.253535065755;2228.4428892776805;2231.843770936027;2138.593667203234;2176.46676564242;2198.8900554972265;2212.126210146999;2214.3799736073925;2160.2115227941767;2184.8798316092607;2187.4640713025333;2189.288481243594;2190.857594256376;2178.085204214226;2178.6949827024227;2188.7045248891354;2192.068370942351;2193.320070778056;2106.557622899193;2130.6803979403057;2132.936011919645;2137.390843609564;2137.5831712816007;7834.686612535492;8007.1992800720045;8063.193680631948;8063.435559510836;8105.918940810576;4565.223911934979;4668.253079507263;4677.0178262564905;4682;4682.040181762731;2841.985790071057;2934.5158048922117;2969.331900322432;2994.4160888626725;2998.055612482061;887.742554659148;905.2576886952702;912.9224015958652;917.1104029091837;918.5820451694462;10885.074768644674;10986.285891417032;10993.955574220436;11020.669379918616;11023.338599684044;4015.578364271768;4142.233686767958;4260.701750877471;4292.12011537634;4292.3561465780385;8431;8493.235608795238;8504.489730616058;8504.53225072627;8516.829663406697;4541.114482675913;4541.137183935041;4544.18204723153;4545.863624091283;4547.02239018606;3737.2338670572467;4102.446169767103;4208.074223670787;4209.915801683949;4231.259529582372;3456.187795867969;3488.686018258318;3512.1746389598425;3542.203004324058;3587.73972397388;1010.7624708193568;1059.0786016165985;1059.7191744187796;1060.867391576053;1076.580133747839;825.8802473641408;829.7386323308259;831.5052543736467;861.7070196133345;878.1350369885657;5051.2423136529815;5191.688498690015;5209.4009188943755;5330.38700549434;5374.3013408256675;414.40739742168387;417.6867349487884;421.93249080147643;428.26338697440355;430.8212091981855;3537.646235376442;3720.162963333228;3723.9069023274633;3728.9440658390145;3785.6971442284553;9511.90488095124;9924.057214564606;9962.950185249172;9976.650817221362;10004.949975250078;9249;9668.081532254424;9895;9899.406035637885;9916.80166396668;7197.244289349543;7266.600336981517;7296.96351518239;7345.963270183614;7357.77926662201;5140.100482415488;5295.393008082839;5370.838874833761;5439.347278326626;5528.585356098229;9170.312226583166;9175.22010629104;9211.078892111003;9372.250219982521;9378.765530861783;9294.442333460014;9311.674091406769;9415.482148481899;9503.61985520599;9545.427274363561;6325.304216536269;6521.771737989147;6540.607563546202;6963.1296087989;7163.06880105583;7113.146422429341;7244.0582724247615;7479.813004674927;7548;7738.535687858746;6757.594544327356;6814.0800991867445;6839.726410943506;6927.826804329932;6963.686634101579;6655.23464801554;6699.933000669931;6763.256041835492;6802.795916122524;6840.486963477859;6329.778457754141;6352.523560733056;6411.711472983634;6414.102025716496;6492.577982431127;4510.6617003725505;4542.454905411372;4580.725156490621;4597.103564804965;4605.700629459075;4514.25514790056;4577.5880170784785;4585.9605505548825;4601.815927362868;4687.086018226413 08:12:38 INFO - PROCESS | 10838 | |4;prototype.html;295.81659371189863;297.5328733887796;304.73534830453616;306.55702509873225;309.54805983264436;4888.242322440023;4909.33723947267;4917.320060566995;4925.26121081837;4925.261210818375;4824.445188803289;4826.54147855954;4826.589739872115;4830.347903033089;4937.679050861691;3601.369760291945;3703.3148867459604;3733.925321493582;3744.7191460640424;3757.66181043706;3687.188818459948;3754.192848537564;3826.330392181371;3852.672522835562;3854;3753.924921501582;3801.923961520768;3803.486529318548;3805.923881522368;3810.7523011004337;3583.835253542583;3770.1140232045445;3808.619138086197;3809.104860357814;3854.2291541691775;3288.490284005983;3297.7032067114073;3301.7853839500353;3310;3310;4777.426708794932;4778.1638213312535;4782.928256076161;4847.418309802811;4867.5132486751045;4173.518400967643;4308.482982042175;4323.724501272132;4339.631131353839;4344.109457561192;5083.186690129562;5092.668976516515;5102.36220472441;5114.900296436247;5129.563987061104;3630.3283892479712;3632.601448442342;3634.945475817865;3640.7087433005295;3687.1703866630064;5138;5319.5478384337375;5329.094054010828;5340.465953404668;5353.384360798519;3688.7971161585833;3692.9076773080888;3707.7404581679025;3708.313961917054;3713.4986776785327;3744.251149770057;3749.8312575934146;3756.530433695788;3759;3827.315980968365;4269.423627810268;4298.699091063658;4301.494476933049;4303.289957157034;4305.784710764512;4928.236123400879;5131.435542090367;5138.332016837787;5142.922856157161;5143.485651434827;1266.1073942870255;1276.5213045108085;1282.24347634894;1285.832841730569;1290.2774446310095;805.9798505037421;820.6799348254185;823.472977294532;833.7082021292499;833.9874901876477;4373.387725718402;4556.977215113903;4563.361129441881;4564.589186973189;4574.108048930493;5262.789488420497;5263.6578622389425;5272.973635131876;5291.259223708684;5336.226247194213;4446.368569418583;4520.773961301922;4526.7510286933875;4528.7509186994375;4542.954570454319;2686.1807148819407;2799.566067259578;2811.676657184409;2817.337925587526;2817.7182281771657;4927.753612319441;4930.852074437773;4936;4943.8022479101155;5029.547340739351;5174.482551744795;5346.518813306821;5388.676679399248;5389.083855744533;5399.515133338364;4862.416510018679;4921.630877684188;4929.728864912464;4945.455999840015;4947.678400903929;5226.529612334908;5240.868978275574;5241.60687948413;5265.6050796189675;5323.760430780701;4940.654154209171;5079.526937188174;5123.538881500683;5153.7165455898785;5184.300119483822;4913.140200464976;4927.926081108714;4928.06366790323;4933.309336692938;4936.765808547863;3719.8326075326136;3723.082612454642;3723.5904050553877;3729.7948612826553;3780.1494663700446;4957.603391728725;5172.456892026283;5232.424433312256;5238.319018527567;5238.53321070101;5064.82273120439;5097.592192624507;5120.206368012964;5131.56381707559;5134.743262836918;5120.462351453044;5123.462961111726;5126.666766660304;5140.43455219933;5232.686038837682;4940.975295123501;4973.433368488914;5053.054573988968;5066.214736715815;5088.847334579968;4932.383452068491;5056.721880296619;5061.569766569883;5065.848024559269;5174.249733788504;4918.360613120271;4960.528749768766;4967.584238492012;5048.526222151193;5052.646314757932 08:12:38 INFO - PROCESS | 10838 | |5;yui.html;640.641240905093;655.2824657000585;669.4008862068446;723.7792473295643;735.8749012667846;12515.311657858814;13416.798748018764;13439.529616463426;13447.932760336185;13457.59627211184;12886.162399444029;12922.870771292284;13028.60914172574;13328.266945318028;13396.598102056929;633.1958412815721;652.217339192968;768.6003278295283;786.673530484851;791.9089304729944;779.3726050529322;797.7925739307764;800.6237068577759;807.475141158246;807.8020884883211;817.435969181263;819.9180081991783;821.9383546234027;822.3585603229461;822.4284122534841;660.9074729537869;806.1414593457948;814.4583851738587;815.7797394703426;824.3775949158407;597.1311741416272;597.3071237364636;597.5428796970322;598.0819442156313;598.1565991951328;12144.757104857941;12265.938670306592;12280.631581052494;12357.073219508573;12486.313252771093;12535.811962820566;12996;13007.154534955293;13014.609561713163;13040.869591304156;11761.588344407905;11788;11797.941010294979;11839.408029598571;12070.396480176043;4151.771652559108;4193.853215137486;4201.936970945439;4206.91586168278;4223.113146239293;56962.715186423804;57409.71295143497;57630.99999999958;58263.708681456745;58303.708481457325;10364.170866330676;10371.636992705218;10470.685879423629;10515.158787296998;10553.683389498327;19406.12672429744;19414.514637133903;19458.5135371614;19483.31808386728;19517.90241048814;6785.287544807823;6791.728330866808;6802.523823332418;6832.180138383425;7014.123234595676;3583.9820800895827;3610.4764809102535;3726.124360775216;3732.328180927405;3841.442990766379;2824.477471667748;2932.105707759154;2957.6746557878614;2958.156925276286;2960.6824962891305;499.78009675742555;509.5745052880812;512.8820371314619;519.7583123847354;527.1276038156857;482.98068077276514;605;608.7443273825004;636.4526507203801;642.6047980491963;7664.386849052063;7876.763697089096;7879.409044321699;8077.394195435366;8143.552104634184;581.5318668471921;585.3765739487433;597.4354235247736;613.9140520327157;617.6294223465884;3731.8134093295225;3748.194138260287;3860.9613903861164;3887.7795527156322;4070.3690927906223;96189;96260.51869740606;97150.5142474283;100251;100710;82140;83746.58126709328;83934.58032709797;83964.58017709872;84213;45099.774501127285;70577.94133088007;71689;73612.63193684105;75090.62454687801;7376.926230737624;7454.329110380092;7604.277593628596;7609.467337286337;7646.311831935152;41377;42846.57153428426;43441.78279108584;43790;45214.77392613016;59986.70006649939;64181.358186419406;64353.356466436606;64637.35362646313;64899;9992.250581206585;10142.184355226374;10346.22403319769;10436.217283703601;10651.840222396826;11700.29798212076;11881.524739010689;11887.881121188677;11961.401929903295;12006.339651319262;8364.832703345777;11486.770264594828;11671.007964323127;11818;11920.940395297968;11867.703307417383;11916.225445346025;12052.819207711716;12374.381280935737;12398.62804115878;10566.366018038942;10976.890231097586;11278.548858045915;11278.887211127783;11528.423578821194;9283.164515193395;9380.953095234754;9549.713508594754;9604.51977401141;10035.09684128432;9772.9022709772;9789;10238.53926573291;10259.692209233735;10288 08:12:38 INFO - PROCESS | 10838 | __end_tp_report 08:12:38 INFO - PROCESS | 10838 | __start_cc_report 08:12:38 INFO - PROCESS | 10838 | _x_x_mozilla_cycle_collect,974 08:12:38 INFO - PROCESS | 10838 | __end_cc_report 08:12:38 INFO - PROCESS | 10838 | __startTimestamp1467385958052__endTimestamp 08:12:38 INFO - PROCESS | 10838 | 08:12:38 INFO - PROCESS | 10838 | ------- Summary: start ------- 08:12:38 INFO - PROCESS | 10838 | Number of tests: 6 08:12:38 INFO - PROCESS | 10838 | 08:12:38 INFO - PROCESS | 10838 | [#0] dojo.html Cycles:165 Average:4664.81 Median:4791.74 stddev:497.37 (10.4%) stddev-sans-first:471.37 08:12:38 INFO - PROCESS | 10838 | Values: 2584.8 2634.2 2649.1 2666.1 2674.8 4555.7 4634.7 4723.9 4799.6 4826.7 4708.0 4713.2 4728.1 4745.7 4767.1 4103.0 4256.1 4342.4 4369.9 4463.6 4362.1 4403.7 4411.1 4417.2 4455.0 4209.5 4244.7 4255.2 4271.8 4282.3 4258.9 4263.1 4276.8 4328.5 4330.8 4291.0 4304.3 4314.1 4315.7 4354.3 4567.3 4609.6 4624.3 4682.7 4751.9 5016.4 5033.9 5054.8 5056.1 5062.1 5090.4 5103.9 5104.2 5105.8 5109.5 4538.5 4655.7 4657.8 4685.8 4756.7 5188.4 5206.7 5218.1 5218.6 5218.7 4866.4 4947.9 4988.8 4999.3 5023.2 5015.9 5051.9 5054.1 5057.5 5131.3 5007.1 5010.1 5015.5 5019.5 5072.2 4863.5 4883.6 4998.2 5005.8 5009.3 4257.4 4273.1 4279.6 4293.4 4314.2 3725.7 3734.7 3741.4 3763.8 3782.8 4286.2 4323.2 4377.3 4385.6 4387.5 5123.2 5137.9 5155.3 5155.7 5219.2 4432.8 4438.8 4446.4 4489.8 4499.6 4220.4 4435.8 4509.7 4625.0 4626.6 4756.9 4777.9 4781.6 4817.4 4824.4 5102.3 5103.7 5107.1 5109.8 5147.2 4566.1 4573.0 4603.4 4783.7 4821.4 4874.8 4895.5 4901.1 4908.0 4909.5 5045.9 5091.8 5103.7 5179.1 5187.1 4951.6 4959.8 4962.4 4968.0 5008.8 4953.6 4964.5 4966.3 4985.1 5042.9 4724.4 4791.7 4829.9 4839.8 4849.1 4932.2 4942.8 4943.3 4945.7 4993.1 4720.2 4803.0 4851.4 4857.2 4857.3 08:12:38 INFO - PROCESS | 10838 | 08:12:38 INFO - PROCESS | 10838 | [#1] ext.html Cycles:180 Average:47359.39 Median:18581.74 stddev:85648.70 (460.9%) stddev-sans-first:85816.87 08:12:38 INFO - PROCESS | 10838 | Values: 553.8 575.9 577.9 583.0 595.6 27150.2 30030.4 30067.7 30068.2 30073.4 29984.0 41019.4 42305.4 42438.8 46742.8 7874.6 8029.9 8044.6 8045.2 8049.8 7661.8 7855.0 7946.9 10059.6 10297.5 10325.1 10410.7 10416.8 10419.1 10427.9 10245.0 10285.5 10291.9 10299.9 10304.8 7648.1 9886.7 10282.7 10309.2 10628.6 38711.8 39046.4 39053.4 39070.0 39073.6 3016.8 3040.6 3055.5 3116.6 3363.6 28865.1 28965.6 29671.7 29888.4 30214.4 3347.9 3358.0 3370.0 3426.7 3442.9 255877.0 260314.0 260750.0 261033.0 261504.0 55768.0 55837.4 56400.4 56461.7 56514.7 33933.8 34847.1 34950.8 36507.0 36525.8 15235.0 15365.5 15422.3 15431.2 15444.7 9619.5 11215.6 11295.1 11300.3 11306.7 18268.5 18461.4 18839.3 19055.8 19077.1 6847.0 6867.5 6898.4 6966.4 7028.3 912.6 936.9 939.2 988.2 1035.4 28105.7 28612.0 29041.1 29164.3 29253.7 972.0 984.4 984.7 994.1 1019.9 15239.8 15358.8 15495.6 15536.3 15611.2 394241.0 395578.0 398000.0 399897.0 401230.0 50463.2 51401.5 51442.0 51473.7 51566.0 1089.0 1176.5 1179.5 1198.6 1209.4 28423.3 29201.9 29631.4 30056.7 30123.0 42423.6 42827.4 42908.6 43003.4 43072.1 302579.0 303226.0 303771.0 304746.0 304968.0 22444.7 22863.5 22872.0 23163.5 23164.4 42323.0 42603.6 42999.8 43739.0 43943.3 36167.5 37192.4 37471.4 37756.2 37792.8 36131.5 36503.3 36807.4 36933.8 36990.3 36193.5 36588.3 36689.1 36812.4 36926.6 30555.7 33793.5 33937.3 34365.5 34367.7 25548.9 25851.7 25988.7 26240.6 26592.0 08:12:38 INFO - PROCESS | 10838 | 08:12:38 INFO - PROCESS | 10838 | [#2] jquery.html Cycles:180 Average:25288.75 Median:222996.50 stddev:65602.45 (29.4%) stddev-sans-first:65759.75 08:12:38 INFO - PROCESS | 10838 | Values: 345.0 363.9 366.9 369.4 386.8 12785.0 16444.6 16996.7 18692.3 18828.7 16757.9 17123.7 18125.6 18142.5 18147.6 5077.6 5430.2 5430.8 5435.9 5439.2 3761.1 5291.8 5984.7 6307.8 6319.6 6288.5 6378.5 6389.6 6398.6 6410.3 6221.9 6416.7 6421.5 6424.1 6427.9 5546.3 5583.4 5588.0 5667.8 5669.3 21598.4 21892.5 22237.4 22306.6 22324.2 1956.3 2092.9 2132.6 2137.2 2507.9 13092.3 13565.7 13876.8 13884.4 13904.9 1763.4 1832.3 1841.9 1850.6 1897.8 69135.0 70061.0 71080.6 71321.9 71839.6 8842.8 8964.5 9706.0 9734.8 10061.5 13783.0 13907.1 13926.7 13954.7 14027.1 7134.8 7352.4 7362.4 7455.6 7456.7 6798.8 6892.4 6931.9 7088.1 7124.0 6360.2 6404.8 6416.4 6437.0 6445.6 1780.9 1816.0 1850.7 1852.8 1873.9 820.2 871.4 920.6 921.1 950.2 16698.6 17173.4 19299.1 19436.3 19564.1 871.0 890.1 923.2 942.5 944.5 9894.6 9979.9 10253.6 10287.5 10327.6 388588.0 390030.0 396615.0 402892.0 405620.0 81897.0 82143.6 83272.6 83285.2 84426.2 851.4 869.9 885.5 886.6 887.4 15983.4 16302.8 16474.0 16504.3 16786.0 37820.6 38050.4 38113.6 38368.6 40373.0 53232.2 53489.0 54881.5 55045.7 55251.7 7780.7 7893.9 8053.8 8179.1 8257.9 11063.4 11874.2 12288.2 12288.4 12402.0 10292.9 10440.1 10465.8 10565.0 10794.6 10624.3 10682.4 10733.3 10748.2 10807.4 10237.2 10670.6 10917.6 10949.3 10985.2 8047.6 8070.2 8094.7 8174.7 8210.4 7990.8 9227.6 9764.7 10046.4 10489.6 08:12:38 INFO - PROCESS | 10838 | 08:12:38 INFO - PROCESS | 10838 | [#3] mootools.html Cycles:180 Average:5163.47 Median:4869.16 stddev:2955.31 (60.7%) stddev-sans-first:2949.11 08:12:38 INFO - PROCESS | 10838 | Values: 1270.0 1339.5 1407.7 1459.6 1714.5 6804.2 7679.0 7921.6 7934.9 8173.1 7885.7 8016.9 8032.2 8032.6 8032.8 2195.7 2227.4 2228.3 2228.4 2231.8 2138.6 2176.5 2198.9 2212.1 2214.4 2160.2 2184.9 2187.5 2189.3 2190.9 2178.1 2178.7 2188.7 2192.1 2193.3 2106.6 2130.7 2132.9 2137.4 2137.6 7834.7 8007.2 8063.2 8063.4 8105.9 4565.2 4668.3 4677.0 4682.0 4682.0 2842.0 2934.5 2969.3 2994.4 2998.1 887.7 905.3 912.9 917.1 918.6 10885.1 10986.3 10994.0 11020.7 11023.3 4015.6 4142.2 4260.7 4292.1 4292.4 8431.0 8493.2 8504.5 8504.5 8516.8 4541.1 4541.1 4544.2 4545.9 4547.0 3737.2 4102.4 4208.1 4209.9 4231.3 3456.2 3488.7 3512.2 3542.2 3587.7 1010.8 1059.1 1059.7 1060.9 1076.6 825.9 829.7 831.5 861.7 878.1 5051.2 5191.7 5209.4 5330.4 5374.3 414.4 417.7 421.9 428.3 430.8 3537.6 3720.2 3723.9 3728.9 3785.7 9511.9 9924.1 9963.0 9976.7 10004.9 9249.0 9668.1 9895.0 9899.4 9916.8 7197.2 7266.6 7297.0 7346.0 7357.8 5140.1 5295.4 5370.8 5439.3 5528.6 9170.3 9175.2 9211.1 9372.3 9378.8 9294.4 9311.7 9415.5 9503.6 9545.4 6325.3 6521.8 6540.6 6963.1 7163.1 7113.1 7244.1 7479.8 7548.0 7738.5 6757.6 6814.1 6839.7 6927.8 6963.7 6655.2 6699.9 6763.3 6802.8 6840.5 6329.8 6352.5 6411.7 6414.1 6492.6 4510.7 4542.5 4580.7 4597.1 4605.7 4514.3 4577.6 4586.0 4601.8 4687.1 08:12:38 INFO - PROCESS | 10838 | 08:12:38 INFO - PROCESS | 10838 | [#4] prototype.html Cycles:180 Average:4233.18 Median:4898.79 stddev:1236.86 (25.2%) stddev-sans-first:1204.50 08:12:38 INFO - PROCESS | 10838 | Values: 295.8 297.5 304.7 306.6 309.5 4888.2 4909.3 4917.3 4925.3 4925.3 4824.4 4826.5 4826.6 4830.3 4937.7 3601.4 3703.3 3733.9 3744.7 3757.7 3687.2 3754.2 3826.3 3852.7 3854.0 3753.9 3801.9 3803.5 3805.9 3810.8 3583.8 3770.1 3808.6 3809.1 3854.2 3288.5 3297.7 3301.8 3310.0 3310.0 4777.4 4778.2 4782.9 4847.4 4867.5 4173.5 4308.5 4323.7 4339.6 4344.1 5083.2 5092.7 5102.4 5114.9 5129.6 3630.3 3632.6 3634.9 3640.7 3687.2 5138.0 5319.5 5329.1 5340.5 5353.4 3688.8 3692.9 3707.7 3708.3 3713.5 3744.3 3749.8 3756.5 3759.0 3827.3 4269.4 4298.7 4301.5 4303.3 4305.8 4928.2 5131.4 5138.3 5142.9 5143.5 1266.1 1276.5 1282.2 1285.8 1290.3 806.0 820.7 823.5 833.7 834.0 4373.4 4557.0 4563.4 4564.6 4574.1 5262.8 5263.7 5273.0 5291.3 5336.2 4446.4 4520.8 4526.8 4528.8 4543.0 2686.2 2799.6 2811.7 2817.3 2817.7 4927.8 4930.9 4936.0 4943.8 5029.5 5174.5 5346.5 5388.7 5389.1 5399.5 4862.4 4921.6 4929.7 4945.5 4947.7 5226.5 5240.9 5241.6 5265.6 5323.8 4940.7 5079.5 5123.5 5153.7 5184.3 4913.1 4927.9 4928.1 4933.3 4936.8 3719.8 3723.1 3723.6 3729.8 3780.1 4957.6 5172.5 5232.4 5238.3 5238.5 5064.8 5097.6 5120.2 5131.6 5134.7 5120.5 5123.5 5126.7 5140.4 5232.7 4941.0 4973.4 5053.1 5066.2 5088.8 4932.4 5056.7 5061.6 5065.8 5174.2 4918.4 4960.5 4967.6 5048.5 5052.6 08:12:38 INFO - PROCESS | 10838 | 08:12:38 INFO - PROCESS | 10838 | [#5] yui.html Cycles:180 Average:17394.37 Median:491.38 stddev:24781.58 (5043.3%) stddev-sans-first:24819.16 08:12:38 INFO - PROCESS | 10838 | Values: 640.6 655.3 669.4 723.8 735.9 12515.3 13416.8 13439.5 13447.9 13457.6 12886.2 12922.9 13028.6 13328.3 13396.6 633.2 652.2 768.6 786.7 791.9 779.4 797.8 800.6 807.5 807.8 817.4 819.9 821.9 822.4 822.4 660.9 806.1 814.5 815.8 824.4 597.1 597.3 597.5 598.1 598.2 12144.8 12265.9 12280.6 12357.1 12486.3 12535.8 12996.0 13007.2 13014.6 13040.9 11761.6 11788.0 11797.9 11839.4 12070.4 4151.8 4193.9 4201.9 4206.9 4223.1 56962.7 57409.7 57631.0 58263.7 58303.7 10364.2 10371.6 10470.7 10515.2 10553.7 19406.1 19414.5 19458.5 19483.3 19517.9 6785.3 6791.7 6802.5 6832.2 7014.1 3584.0 3610.5 3726.1 3732.3 3841.4 2824.5 2932.1 2957.7 2958.2 2960.7 499.8 509.6 512.9 519.8 527.1 483.0 605.0 608.7 636.5 642.6 7664.4 7876.8 7879.4 8077.4 8143.6 581.5 585.4 597.4 613.9 617.6 3731.8 3748.2 3861.0 3887.8 4070.4 96189.0 96260.5 97150.5 100251.0 100710.0 82140.0 83746.6 83934.6 83964.6 84213.0 45099.8 70577.9 71689.0 73612.6 75090.6 7376.9 7454.3 7604.3 7609.5 7646.3 41377.0 42846.6 43441.8 43790.0 45214.8 59986.7 64181.4 64353.4 64637.4 64899.0 9992.3 10142.2 10346.2 10436.2 10651.8 11700.3 11881.5 11887.9 11961.4 12006.3 8364.8 11486.8 11671.0 11818.0 11920.9 11867.7 11916.2 12052.8 12374.4 12398.6 10566.4 10976.9 11278.5 11278.9 11528.4 9283.2 9381.0 9549.7 9604.5 10035.1 9772.9 9789.0 10238.5 10259.7 10288.0 08:12:38 INFO - PROCESS | 10838 | -------- Summary: end -------- 08:12:38 INFO - PROCESS | 10838 | 08:12:38 INFO - TEST-INFO | 10838: exit 0 08:12:38 INFO - TEST-OK | dromaeo_css | took 1119606ms 08:12:38 INFO - TEST-START | kraken 08:12:38 INFO - operating with platform_type : linux_ 08:12:38 INFO - Initialising browser for kraken test... 08:12:38 INFO - TEST-INFO | started process 11036 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMEOiIr/profile http://localhost:34351/getInfo.html) 08:12:43 INFO - PROCESS | 11036 | __metrics Screen width/height:1600/1200 08:12:43 INFO - PROCESS | 11036 | colorDepth:24 08:12:43 INFO - PROCESS | 11036 | Browser inner width/height: 1024/697 08:12:43 INFO - PROCESS | 11036 | __metrics 08:12:43 INFO - PROCESS | 11036 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:12:44 INFO - TEST-INFO | 11036: exit 0 08:12:44 INFO - Browser initialized. 08:12:44 INFO - Running cycle 1/1 for kraken test... 08:12:44 INFO - TEST-INFO | started process 11118 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMEOiIr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:56 INFO - PROCESS | 11118 | RSS: Main: 159010816 08:12:56 INFO - PROCESS | 11118 | 08:12:59 INFO - PROCESS | 11118 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34351/tests/kraken/driver.html?testName=audio-beat-detection) 08:13:00 INFO - PROCESS | 11118 | RSS: Main: 216391680 08:13:00 INFO - PROCESS | 11118 | 08:13:03 INFO - PROCESS | 11118 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34351/tests/kraken/driver.html?testName=audio-dft) 08:13:03 INFO - PROCESS | 11118 | RSS: Main: 203309056 08:13:03 INFO - PROCESS | 11118 | 08:13:07 INFO - PROCESS | 11118 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34351/tests/kraken/driver.html?testName=audio-fft) 08:13:07 INFO - PROCESS | 11118 | RSS: Main: 270213120 08:13:07 INFO - PROCESS | 11118 | 08:13:09 INFO - PROCESS | 11118 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34351/tests/kraken/driver.html?testName=audio-oscillator) 08:13:10 INFO - PROCESS | 11118 | RSS: Main: 180670464 08:13:10 INFO - PROCESS | 11118 | 08:13:12 INFO - PROCESS | 11118 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34351/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:13:13 INFO - PROCESS | 11118 | RSS: Main: 185372672 08:13:13 INFO - PROCESS | 11118 | 08:13:16 INFO - PROCESS | 11118 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34351/tests/kraken/driver.html?testName=imaging-darkroom) 08:13:16 INFO - PROCESS | 11118 | RSS: Main: 221405184 08:13:16 INFO - PROCESS | 11118 | 08:13:20 INFO - PROCESS | 11118 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34351/tests/kraken/driver.html?testName=imaging-desaturate) 08:13:21 INFO - PROCESS | 11118 | RSS: Main: 221986816 08:13:21 INFO - PROCESS | 11118 | 08:13:23 INFO - PROCESS | 11118 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34351/tests/kraken/driver.html?testName=json-parse-financial) 08:13:24 INFO - PROCESS | 11118 | RSS: Main: 222048256 08:13:24 INFO - PROCESS | 11118 | 08:13:26 INFO - PROCESS | 11118 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34351/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:13:26 INFO - PROCESS | 11118 | RSS: Main: 210182144 08:13:26 INFO - PROCESS | 11118 | 08:13:28 INFO - PROCESS | 11118 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34351/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:13:29 INFO - PROCESS | 11118 | RSS: Main: 213028864 08:13:29 INFO - PROCESS | 11118 | 08:13:31 INFO - PROCESS | 11118 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34351/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:13:32 INFO - PROCESS | 11118 | RSS: Main: 211697664 08:13:32 INFO - PROCESS | 11118 | 08:13:34 INFO - PROCESS | 11118 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34351/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:13:35 INFO - PROCESS | 11118 | RSS: Main: 223100928 08:13:35 INFO - PROCESS | 11118 | 08:13:38 INFO - PROCESS | 11118 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34351/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:13:39 INFO - PROCESS | 11118 | RSS: Main: 223891456 08:13:39 INFO - PROCESS | 11118 | 08:13:40 INFO - PROCESS | 11118 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34351/tests/kraken/driver.html?testName=ai-astar) 08:13:41 INFO - PROCESS | 11118 | RSS: Main: 266735616 08:13:41 INFO - PROCESS | 11118 | 08:13:41 INFO - PROCESS | 11118 | __start_tp_report 08:13:41 INFO - PROCESS | 11118 | _x_x_mozilla_page_load 08:13:41 INFO - PROCESS | 11118 | _x_x_mozilla_page_load_details 08:13:41 INFO - PROCESS | 11118 | |i|pagename|runs| 08:13:41 INFO - PROCESS | 11118 | |0;ai-astar;105;117;117;115;114;115;114;113;114;114 08:13:41 INFO - PROCESS | 11118 | |1;audio-beat-detection;146;122;124;178;125;123;149;126;177;127 08:13:41 INFO - PROCESS | 11118 | |2;audio-dft;162;162;161;163;163;162;162;162;162;163 08:13:41 INFO - PROCESS | 11118 | |3;audio-fft;75;75;77;123;77;77;77;75;99;77 08:13:41 INFO - PROCESS | 11118 | |4;audio-oscillator;86;84;112;85;84;86;123;84;86;124 08:13:41 INFO - PROCESS | 11118 | |5;imaging-gaussian-blur;116;117;117;116;117;117;117;117;117;117 08:13:41 INFO - PROCESS | 11118 | |6;imaging-darkroom;146;147;147;146;146;146;147;146;147;147 08:13:41 INFO - PROCESS | 11118 | |7;imaging-desaturate;95;95;95;96;95;96;95;94;95;95 08:13:41 INFO - PROCESS | 11118 | |8;json-parse-financial;64;65;66;64;64;65;64;64;65;65 08:13:41 INFO - PROCESS | 11118 | |9;json-stringify-tinderbox;64;64;64;64;65;64;65;64;66;64 08:13:41 INFO - PROCESS | 11118 | |10;stanford-crypto-aes;78;78;87;82;78;77;78;80;78;88 08:13:41 INFO - PROCESS | 11118 | |11;stanford-crypto-ccm;130;127;136;127;129;134;140;127;179;131 08:13:41 INFO - PROCESS | 11118 | |12;stanford-crypto-pbkdf2;167;168;171;169;166;169;166;170;167;168 08:13:41 INFO - PROCESS | 11118 | |13;stanford-crypto-sha256-iterative;69;67;77;68;66;67;71;68;71;65 08:13:41 INFO - PROCESS | 11118 | __end_tp_report 08:13:41 INFO - PROCESS | 11118 | __start_cc_report 08:13:41 INFO - PROCESS | 11118 | _x_x_mozilla_cycle_collect,1913 08:13:41 INFO - PROCESS | 11118 | __end_cc_report 08:13:41 INFO - PROCESS | 11118 | __startTimestamp1467386021120__endTimestamp 08:13:41 INFO - PROCESS | 11118 | 08:13:41 INFO - PROCESS | 11118 | ------- Summary: start ------- 08:13:41 INFO - PROCESS | 11118 | Number of tests: 14 08:13:41 INFO - PROCESS | 11118 | 08:13:41 INFO - PROCESS | 11118 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.50 stddev:3.36 (2.9%) stddev-sans-first:1.39 08:13:41 INFO - PROCESS | 11118 | Values: 105.0 117.0 117.0 115.0 114.0 115.0 114.0 113.0 114.0 114.0 08:13:41 INFO - PROCESS | 11118 | 08:13:41 INFO - PROCESS | 11118 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:136.50 stddev:22.08 (16.2%) stddev-sans-first:23.30 08:13:41 INFO - PROCESS | 11118 | Values: 146.0 122.0 124.0 178.0 125.0 123.0 149.0 126.0 177.0 127.0 08:13:41 INFO - PROCESS | 11118 | 08:13:41 INFO - PROCESS | 11118 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 08:13:41 INFO - PROCESS | 11118 | Values: 162.0 162.0 161.0 163.0 163.0 162.0 162.0 162.0 162.0 163.0 08:13:41 INFO - PROCESS | 11118 | 08:13:41 INFO - PROCESS | 11118 | [#3] audio-fft Cycles:10 Average:83.20 Median:77.00 stddev:15.73 (20.4%) stddev-sans-first:16.40 08:13:41 INFO - PROCESS | 11118 | Values: 75.0 75.0 77.0 123.0 77.0 77.0 77.0 75.0 99.0 77.0 08:13:41 INFO - PROCESS | 11118 | 08:13:41 INFO - PROCESS | 11118 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:84.50 stddev:17.06 (20.2%) stddev-sans-first:17.75 08:13:41 INFO - PROCESS | 11118 | Values: 86.0 84.0 112.0 85.0 84.0 86.0 123.0 84.0 86.0 124.0 08:13:41 INFO - PROCESS | 11118 | 08:13:41 INFO - PROCESS | 11118 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 08:13:41 INFO - PROCESS | 11118 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 08:13:41 INFO - PROCESS | 11118 | 08:13:41 INFO - PROCESS | 11118 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 08:13:41 INFO - PROCESS | 11118 | Values: 146.0 147.0 147.0 146.0 146.0 146.0 147.0 146.0 147.0 147.0 08:13:41 INFO - PROCESS | 11118 | 08:13:41 INFO - PROCESS | 11118 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 08:13:41 INFO - PROCESS | 11118 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 95.0 94.0 95.0 95.0 08:13:41 INFO - PROCESS | 11118 | 08:13:41 INFO - PROCESS | 11118 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 08:13:41 INFO - PROCESS | 11118 | Values: 64.0 65.0 66.0 64.0 64.0 65.0 64.0 64.0 65.0 65.0 08:13:41 INFO - PROCESS | 11118 | 08:13:41 INFO - PROCESS | 11118 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 08:13:41 INFO - PROCESS | 11118 | Values: 64.0 64.0 64.0 64.0 65.0 64.0 65.0 64.0 66.0 64.0 08:13:41 INFO - PROCESS | 11118 | 08:13:41 INFO - PROCESS | 11118 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:79.00 stddev:4.01 (5.1%) stddev-sans-first:4.15 08:13:41 INFO - PROCESS | 11118 | Values: 78.0 78.0 87.0 82.0 78.0 77.0 78.0 80.0 78.0 88.0 08:13:41 INFO - PROCESS | 11118 | 08:13:41 INFO - PROCESS | 11118 | [#11] stanford-crypto-ccm Cycles:10 Average:136.00 Median:132.50 stddev:15.71 (11.9%) stddev-sans-first:16.52 08:13:41 INFO - PROCESS | 11118 | Values: 130.0 127.0 136.0 127.0 129.0 134.0 140.0 127.0 179.0 131.0 08:13:41 INFO - PROCESS | 11118 | 08:13:41 INFO - PROCESS | 11118 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:168.50 stddev:1.66 (1.0%) stddev-sans-first:1.72 08:13:41 INFO - PROCESS | 11118 | Values: 167.0 168.0 171.0 169.0 166.0 169.0 166.0 170.0 167.0 168.0 08:13:41 INFO - PROCESS | 11118 | 08:13:41 INFO - PROCESS | 11118 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:68.50 stddev:3.45 (5.0%) stddev-sans-first:3.66 08:13:41 INFO - PROCESS | 11118 | Values: 69.0 67.0 77.0 68.0 66.0 67.0 71.0 68.0 71.0 65.0 08:13:41 INFO - PROCESS | 11118 | -------- Summary: end -------- 08:13:41 INFO - PROCESS | 11118 | 08:13:42 INFO - TEST-INFO | 11118: exit 0 08:13:42 INFO - TEST-OK | kraken | took 63367ms 08:13:42 INFO - SUITE-END | took 1182s 08:13:42 INFO - Completed test suite (00:19:43) 08:13:42 INFO - javascript benchmark 08:13:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2584.793216542676, 2634.209737078876, 2649.059583847734, 2666.0802023301953, 2674.7993900457473, 4555.726656400619, 4634.721916684993, 4723.858284251473, 4799.592034677056, 4826.71039737616, 4708.0, 4713.222318317482, 4728.054389122172, 4745.691530050544, 4767.0942520921, 4102.958970410303, 4256.063665993476, 4342.392065110887, 4369.868903932887, 4463.598276155145, 4362.0621566363225, 4403.713758605681, 4411.05162390086, 4417.182821178077, 4455.0, 4209.536950935395, 4244.745315281062, 4255.234057869582, 4271.765052922088, 4282.272013757669, 4258.8509402171085, 4263.062126332202, 4276.764777937212, 4328.5022222444195, 4330.783460826946, 4290.957090429087, 4304.268274393361, 4314.094040251551, 4315.654747620183, 4354.303311470181, 4567.2920697291975, 4609.562091601292, 4624.329472226508, 4682.672212945095, 4751.857444276678, 5016.3980322361185, 5033.899322013539, 5054.797808087672, 5056.140456122431, 5062.1141300272675, 5090.38915330159, 5103.897922041576, 5104.183330667112, 5105.846824595268, 5109.540141387293, 4538.546145385435, 4655.650826188049, 4657.767111644404, 4685.758274057377, 4756.738379389098, 5188.377394712658, 5206.739663016834, 5218.060749065129, 5218.582513398919, 5218.739063046833, 4866.367372241586, 4947.851564453073, 4988.800447982113, 4999.275105109811, 5023.2214006829, 5015.899682006339, 5051.873703157377, 5054.115529782347, 5057.519535644108, 5131.2559678846355, 5007.073691367036, 5010.073136469765, 5015.4733752956145, 5019.498050195024, 5072.163093089599, 4863.513648635179, 4883.633727470454, 4998.175301075355, 5005.82479613219, 5009.348784657971, 4257.382679511454, 4273.1026484438, 4279.614834664895, 4293.44185255921, 4314.158739045919, 3725.6646901778972, 3734.7198960078103, 3741.4387841823946, 3763.8118094095184, 3782.829772660182, 4286.207051695446, 4323.156984388014, 4377.321515165155, 4385.649148068147, 4387.517373088957, 5123.180291153398, 5137.948620513822, 5155.329807125125, 5155.716435596079, 5219.164933610604, 4432.800523976429, 4438.822447102079, 4446.421965144576, 4489.753063581469, 4499.6400287976885, 4220.430241917364, 4435.844745433894, 4509.684322097487, 4625.0, 4626.629869610423, 4756.88107797294, 4777.856664300077, 4781.569658730731, 4817.373741413594, 4824.396950381202, 5102.336696229467, 5103.7448127592725, 5107.080725469303, 5109.795608175631, 5147.227915812508, 4566.109608626286, 4572.993941332901, 4603.355530225838, 4783.6651434399255, 4821.373221481325, 4874.780634871368, 4895.461499235153, 4901.068796928572, 4907.950920490749, 4909.533594308535, 5045.949540504548, 5091.770870310919, 5103.7192954387865, 5179.145441002343, 5187.092258854761, 4951.579115775199, 4959.752012399294, 4962.429320628174, 4968.0, 5008.799648014038, 4953.578945789648, 4964.478729733326, 4966.304717339503, 4985.052839960396, 5042.899142017066, 4724.4094488188975, 4791.736454494897, 4829.855104346875, 4839.758012099311, 4849.102915960559, 4932.21084626458, 4942.777575009061, 4943.2585112233455, 4945.653804233669, 4993.076280888047, 4720.197566413786, 4802.975985120052, 4851.369321988119, 4857.174280372275, 4857.295692124551], "value": 4632.912680380825, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.7739980504896, 575.9251297331347, 577.936426993031, 583.0176153181889, 595.6396380189985, 27150.18549443515, 30030.399392012147, 30067.699323006764, 30068.24829379264, 30073.398532029347, 29984.0, 41019.38470922931, 42305.365419518654, 42438.787806061, 46742.766286168604, 7874.566898820577, 8029.879551806727, 8044.597770111501, 8045.195480451966, 8049.758507244792, 7661.770146895602, 7855.0, 7946.880796788053, 10059.64791232307, 10297.536610852492, 10325.122364599018, 10410.739731506736, 10416.843747343795, 10419.062284394404, 10427.947860260727, 10245.0, 10285.48572571376, 10291.948540257326, 10299.897001029969, 10304.79390412195, 7648.1204661463535, 9886.653967111117, 10282.691519254435, 10309.175265978703, 10628.574857005711, 38711.806440967615, 39046.41430378518, 39053.41419878704, 39070.0, 39073.60926390728, 3016.849157542114, 3040.619922509686, 3055.4500189965797, 3116.594842670461, 3363.5795525559306, 28865.134045978655, 28965.56551651727, 29671.703282967326, 29888.40223195524, 30214.395712085854, 3347.9497807532907, 3358.0, 3369.9831500842583, 3426.7258619310396, 3442.8794992175153, 255877.0, 260314.0, 260750.0, 261033.0, 261504.0, 55768.0, 55837.441625583226, 56400.43599563952, 56461.71769141128, 56514.71742641261, 33933.830330848185, 34847.12882177966, 34950.82524587412, 36507.0, 36525.81737091298, 15235.0, 15365.462208822637, 15422.305996230196, 15431.228438578026, 15444.691106178037, 9619.51902404877, 11215.60745373908, 11295.096392288597, 11300.265482743594, 11306.717332066599, 18268.451946441626, 18461.353852615095, 18839.340623078126, 19055.80944190568, 19077.141528631244, 6846.965765171242, 6867.450603951672, 6898.448124150156, 6966.442684585221, 7028.297170282931, 912.5665308978182, 936.896941336466, 939.1641439119189, 988.2341185581089, 1035.35807799165, 28105.71894281072, 28611.998580050014, 29041.128766137048, 29164.270893227414, 29253.707462925526, 971.9611215551299, 984.4191926763244, 984.6701355045997, 994.1450352696675, 1019.8674172357546, 15239.771403428957, 15358.769618455732, 15495.605395514458, 15536.300866461037, 15611.16496607153, 394241.0, 395578.0, 398000.0, 399897.0, 401230.0, 50463.24305135426, 51401.48598514042, 51442.0, 51473.7426312866, 51566.0, 1088.983665245022, 1176.4705882352805, 1179.4515550268995, 1198.5505435461703, 1209.4013463335352, 28423.28941776472, 29201.85399073076, 29631.407371852874, 30056.69943300539, 30123.0, 42423.5757642432, 42827.357589636806, 42908.570914291704, 43003.35494967515, 43072.13855722931, 302579.0, 303226.0, 303771.0, 304746.0, 304968.0, 22444.663330049734, 22863.542729144992, 22872.0, 23163.536729265656, 23164.420889477897, 42323.0, 42603.5739642612, 42999.78500107479, 43739.0, 43943.340849887914, 36167.457488137174, 37192.44211336778, 37471.43792843055, 37756.24487510289, 37792.811035944644, 36131.45802812908, 36503.26993460169, 36807.44788828116, 36933.81533092317, 36990.260194796494, 36193.45709814302, 36588.26823463463, 36689.082772929825, 36812.447813282284, 36926.63073369232, 30555.694443055287, 33793.49309760405, 33937.32125357528, 34365.484517731755, 34367.656323436444, 25548.872255638602, 25851.741482584934, 25988.740112598633, 26240.553311371223, 26592.0], "value": 17858.555910174986, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.9810260435675, 363.91629925117223, 366.94862719219316, 369.4476757247913, 386.79113278829414, 12785.0, 16444.588885277873, 16996.745048824276, 18692.345767898125, 18828.71756923644, 16757.91621041893, 17123.657526849456, 18125.637487250246, 18142.546436339097, 18147.637047259046, 5077.5684066854365, 5430.212619170218, 5430.782768689268, 5435.864103397407, 5439.184122381635, 3761.078535758743, 5291.814786482474, 5984.73068711909, 6307.77922772703, 6319.620822750627, 6288.465480434169, 6378.521610879179, 6389.648569328685, 6398.584092034026, 6410.294867564564, 6221.937780622181, 6416.743330266784, 6421.51838612106, 6424.100625912376, 6427.93572064278, 5546.306711661043, 5583.3858275590055, 5587.972060139673, 5667.773289068432, 5669.319681638189, 21598.352049438385, 21892.45268868275, 22237.44406389837, 22306.553868922532, 22324.218652347252, 1956.3348461523008, 2092.9162833486644, 2132.626790311689, 2137.241279345825, 2507.949841003188, 13092.279924604143, 13565.660858478519, 13876.791848122286, 13884.4446222151, 13904.930475347559, 1763.444514977778, 1832.25793553611, 1841.8802777819399, 1850.6021205440895, 1897.8197071278207, 69135.0, 70061.0, 71080.6445967772, 71321.93017104799, 71839.64080179618, 8842.823143537093, 8964.462132272085, 9705.951470242744, 9734.75663108428, 10061.54723037465, 13782.966277529225, 13907.096038757449, 13926.721465570834, 13954.720905582035, 14027.08823926462, 7134.750283740044, 7352.448566357544, 7362.411007119525, 7455.627218639155, 7456.7390141344795, 6798.762043328558, 6892.414144797748, 6931.930680693128, 7088.149422069385, 7123.964380178066, 6360.173177486897, 6404.839879002969, 6416.422521973045, 6436.967815160988, 6445.581037232565, 1780.8931464112195, 1816.0489205041806, 1850.6668799616198, 1852.7961924188328, 1873.9156737946826, 820.2248874813245, 871.4248595926784, 920.604140219712, 921.1065266691298, 950.2350607760819, 16698.582535436468, 17173.398931037354, 19299.131539080776, 19436.319728809423, 19564.119614617375, 870.9782255443664, 890.1321211818425, 923.2383283790765, 942.4675058591873, 944.504135328944, 9894.55474503649, 9979.850302245472, 10253.641122560824, 10287.485625718684, 10327.586896524204, 388588.0, 390030.0, 396615.0, 402892.0, 405620.0, 81897.0, 82143.5892820544, 83272.58363708264, 83285.16714832895, 84426.15573844183, 851.4082712514867, 869.9391042627082, 885.5483703311357, 886.5700135434438, 887.3788348156187, 15983.360665573711, 16302.755458667893, 16474.0, 16504.25730842139, 16786.0, 37820.62179378281, 38050.42924356192, 38113.61886381212, 38368.587612424926, 40372.99067523218, 53232.20151697805, 53489.0, 54881.45118548923, 55045.724771375884, 55251.723741381036, 7780.688772449265, 7893.921060789318, 8053.832194331906, 8179.141190174946, 8257.917420825715, 11063.391513466837, 11874.168808183344, 12288.201266917622, 12288.385580721108, 12402.0, 10292.897071029194, 10440.112590429899, 10465.790684186426, 10565.0, 10794.56821727122, 10624.256302059091, 10682.359058456517, 10733.302335348177, 10748.193885458779, 10807.405592692478, 10237.232207584311, 10670.57317707314, 10917.617883374362, 10949.343039417661, 10985.176111791488, 8047.597620119088, 8070.152633973583, 8094.716684916235, 8174.713885013996, 8210.425270231026, 7990.760277191694, 9227.584758685742, 9764.707058788248, 10046.4428013658, 10489.632862849763], "value": 8705.89594904055, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1269.961901142965, 1339.4575197045197, 1407.690308132211, 1459.6132025013374, 1714.4856543037079, 6804.183497980243, 7678.961605191973, 7921.603919804015, 7934.889115523824, 8173.060098088721, 7885.723999660013, 8016.91983080169, 8032.156623554531, 8032.638531266092, 8032.759017229478, 2195.681626164205, 2227.40973641985, 2228.253535065755, 2228.4428892776805, 2231.843770936027, 2138.593667203234, 2176.46676564242, 2198.8900554972265, 2212.126210146999, 2214.3799736073925, 2160.2115227941767, 2184.8798316092607, 2187.4640713025333, 2189.288481243594, 2190.857594256376, 2178.085204214226, 2178.6949827024227, 2188.7045248891354, 2192.068370942351, 2193.320070778056, 2106.557622899193, 2130.6803979403057, 2132.936011919645, 2137.390843609564, 2137.5831712816007, 7834.686612535492, 8007.1992800720045, 8063.193680631948, 8063.435559510836, 8105.918940810576, 4565.223911934979, 4668.253079507263, 4677.0178262564905, 4682.0, 4682.040181762731, 2841.985790071057, 2934.5158048922117, 2969.331900322432, 2994.4160888626725, 2998.055612482061, 887.742554659148, 905.2576886952702, 912.9224015958652, 917.1104029091837, 918.5820451694462, 10885.074768644674, 10986.285891417032, 10993.955574220436, 11020.669379918616, 11023.338599684044, 4015.578364271768, 4142.233686767958, 4260.701750877471, 4292.12011537634, 4292.3561465780385, 8431.0, 8493.235608795238, 8504.489730616058, 8504.53225072627, 8516.829663406697, 4541.114482675913, 4541.137183935041, 4544.18204723153, 4545.863624091283, 4547.02239018606, 3737.2338670572467, 4102.446169767103, 4208.074223670787, 4209.915801683949, 4231.259529582372, 3456.187795867969, 3488.686018258318, 3512.1746389598425, 3542.203004324058, 3587.73972397388, 1010.7624708193568, 1059.0786016165985, 1059.7191744187796, 1060.867391576053, 1076.580133747839, 825.8802473641408, 829.7386323308259, 831.5052543736467, 861.7070196133345, 878.1350369885657, 5051.2423136529815, 5191.688498690015, 5209.4009188943755, 5330.38700549434, 5374.3013408256675, 414.40739742168387, 417.6867349487884, 421.93249080147643, 428.26338697440355, 430.8212091981855, 3537.646235376442, 3720.162963333228, 3723.9069023274633, 3728.9440658390145, 3785.6971442284553, 9511.90488095124, 9924.057214564606, 9962.950185249172, 9976.650817221362, 10004.949975250078, 9249.0, 9668.081532254424, 9895.0, 9899.406035637885, 9916.80166396668, 7197.244289349543, 7266.600336981517, 7296.96351518239, 7345.963270183614, 7357.77926662201, 5140.100482415488, 5295.393008082839, 5370.838874833761, 5439.347278326626, 5528.585356098229, 9170.312226583166, 9175.22010629104, 9211.078892111003, 9372.250219982521, 9378.765530861783, 9294.442333460014, 9311.674091406769, 9415.482148481899, 9503.61985520599, 9545.427274363561, 6325.304216536269, 6521.771737989147, 6540.607563546202, 6963.1296087989, 7163.06880105583, 7113.146422429341, 7244.0582724247615, 7479.813004674927, 7548.0, 7738.535687858746, 6757.594544327356, 6814.0800991867445, 6839.726410943506, 6927.826804329932, 6963.686634101579, 6655.23464801554, 6699.933000669931, 6763.256041835492, 6802.795916122524, 6840.486963477859, 6329.778457754141, 6352.523560733056, 6411.711472983634, 6414.102025716496, 6492.577982431127, 4510.6617003725505, 4542.454905411372, 4580.725156490621, 4597.103564804965, 4605.700629459075, 4514.25514790056, 4577.5880170784785, 4585.9605505548825, 4601.815927362868, 4687.086018226413], "value": 4063.237282368756, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.81659371189863, 297.5328733887796, 304.73534830453616, 306.55702509873225, 309.54805983264436, 4888.242322440023, 4909.33723947267, 4917.320060566995, 4925.26121081837, 4925.261210818375, 4824.445188803289, 4826.54147855954, 4826.589739872115, 4830.347903033089, 4937.679050861691, 3601.369760291945, 3703.3148867459604, 3733.925321493582, 3744.7191460640424, 3757.66181043706, 3687.188818459948, 3754.192848537564, 3826.330392181371, 3852.672522835562, 3854.0, 3753.924921501582, 3801.923961520768, 3803.486529318548, 3805.923881522368, 3810.7523011004337, 3583.835253542583, 3770.1140232045445, 3808.619138086197, 3809.104860357814, 3854.2291541691775, 3288.490284005983, 3297.7032067114073, 3301.7853839500353, 3310.0, 3310.0, 4777.426708794932, 4778.1638213312535, 4782.928256076161, 4847.418309802811, 4867.5132486751045, 4173.518400967643, 4308.482982042175, 4323.724501272132, 4339.631131353839, 4344.109457561192, 5083.186690129562, 5092.668976516515, 5102.36220472441, 5114.900296436247, 5129.563987061104, 3630.3283892479712, 3632.601448442342, 3634.945475817865, 3640.7087433005295, 3687.1703866630064, 5138.0, 5319.5478384337375, 5329.094054010828, 5340.465953404668, 5353.384360798519, 3688.7971161585833, 3692.9076773080888, 3707.7404581679025, 3708.313961917054, 3713.4986776785327, 3744.251149770057, 3749.8312575934146, 3756.530433695788, 3759.0, 3827.315980968365, 4269.423627810268, 4298.699091063658, 4301.494476933049, 4303.289957157034, 4305.784710764512, 4928.236123400879, 5131.435542090367, 5138.332016837787, 5142.922856157161, 5143.485651434827, 1266.1073942870255, 1276.5213045108085, 1282.24347634894, 1285.832841730569, 1290.2774446310095, 805.9798505037421, 820.6799348254185, 823.472977294532, 833.7082021292499, 833.9874901876477, 4373.387725718402, 4556.977215113903, 4563.361129441881, 4564.589186973189, 4574.108048930493, 5262.789488420497, 5263.6578622389425, 5272.973635131876, 5291.259223708684, 5336.226247194213, 4446.368569418583, 4520.773961301922, 4526.7510286933875, 4528.7509186994375, 4542.954570454319, 2686.1807148819407, 2799.566067259578, 2811.676657184409, 2817.337925587526, 2817.7182281771657, 4927.753612319441, 4930.852074437773, 4936.0, 4943.8022479101155, 5029.547340739351, 5174.482551744795, 5346.518813306821, 5388.676679399248, 5389.083855744533, 5399.515133338364, 4862.416510018679, 4921.630877684188, 4929.728864912464, 4945.455999840015, 4947.678400903929, 5226.529612334908, 5240.868978275574, 5241.60687948413, 5265.6050796189675, 5323.760430780701, 4940.654154209171, 5079.526937188174, 5123.538881500683, 5153.7165455898785, 5184.300119483822, 4913.140200464976, 4927.926081108714, 4928.06366790323, 4933.309336692938, 4936.765808547863, 3719.8326075326136, 3723.082612454642, 3723.5904050553877, 3729.7948612826553, 3780.1494663700446, 4957.603391728725, 5172.456892026283, 5232.424433312256, 5238.319018527567, 5238.53321070101, 5064.82273120439, 5097.592192624507, 5120.206368012964, 5131.56381707559, 5134.743262836918, 5120.462351453044, 5123.462961111726, 5126.666766660304, 5140.43455219933, 5232.686038837682, 4940.975295123501, 4973.433368488914, 5053.054573988968, 5066.214736715815, 5088.847334579968, 4932.383452068491, 5056.721880296619, 5061.569766569883, 5065.848024559269, 5174.249733788504, 4918.360613120271, 4960.528749768766, 4967.584238492012, 5048.526222151193, 5052.646314757932], "value": 3836.4249703333685, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.641240905093, 655.2824657000585, 669.4008862068446, 723.7792473295643, 735.8749012667846, 12515.311657858814, 13416.798748018764, 13439.529616463426, 13447.932760336185, 13457.59627211184, 12886.162399444029, 12922.870771292284, 13028.60914172574, 13328.266945318028, 13396.598102056929, 633.1958412815721, 652.217339192968, 768.6003278295283, 786.673530484851, 791.9089304729944, 779.3726050529322, 797.7925739307764, 800.6237068577759, 807.475141158246, 807.8020884883211, 817.435969181263, 819.9180081991783, 821.9383546234027, 822.3585603229461, 822.4284122534841, 660.9074729537869, 806.1414593457948, 814.4583851738587, 815.7797394703426, 824.3775949158407, 597.1311741416272, 597.3071237364636, 597.5428796970322, 598.0819442156313, 598.1565991951328, 12144.757104857941, 12265.938670306592, 12280.631581052494, 12357.073219508573, 12486.313252771093, 12535.811962820566, 12996.0, 13007.154534955293, 13014.609561713163, 13040.869591304156, 11761.588344407905, 11788.0, 11797.941010294979, 11839.408029598571, 12070.396480176043, 4151.771652559108, 4193.853215137486, 4201.936970945439, 4206.91586168278, 4223.113146239293, 56962.715186423804, 57409.71295143497, 57630.99999999958, 58263.708681456745, 58303.708481457325, 10364.170866330676, 10371.636992705218, 10470.685879423629, 10515.158787296998, 10553.683389498327, 19406.12672429744, 19414.514637133903, 19458.5135371614, 19483.31808386728, 19517.90241048814, 6785.287544807823, 6791.728330866808, 6802.523823332418, 6832.180138383425, 7014.123234595676, 3583.9820800895827, 3610.4764809102535, 3726.124360775216, 3732.328180927405, 3841.442990766379, 2824.477471667748, 2932.105707759154, 2957.6746557878614, 2958.156925276286, 2960.6824962891305, 499.78009675742555, 509.5745052880812, 512.8820371314619, 519.7583123847354, 527.1276038156857, 482.98068077276514, 605.0, 608.7443273825004, 636.4526507203801, 642.6047980491963, 7664.386849052063, 7876.763697089096, 7879.409044321699, 8077.394195435366, 8143.552104634184, 581.5318668471921, 585.3765739487433, 597.4354235247736, 613.9140520327157, 617.6294223465884, 3731.8134093295225, 3748.194138260287, 3860.9613903861164, 3887.7795527156322, 4070.3690927906223, 96189.0, 96260.51869740606, 97150.5142474283, 100251.0, 100710.0, 82140.0, 83746.58126709328, 83934.58032709797, 83964.58017709872, 84213.0, 45099.774501127285, 70577.94133088007, 71689.0, 73612.63193684105, 75090.62454687801, 7376.926230737624, 7454.329110380092, 7604.277593628596, 7609.467337286337, 7646.311831935152, 41377.0, 42846.57153428426, 43441.78279108584, 43790.0, 45214.77392613016, 59986.70006649939, 64181.358186419406, 64353.356466436606, 64637.35362646313, 64899.0, 9992.250581206585, 10142.184355226374, 10346.22403319769, 10436.217283703601, 10651.840222396826, 11700.29798212076, 11881.524739010689, 11887.881121188677, 11961.401929903295, 12006.339651319262, 8364.832703345777, 11486.770264594828, 11671.007964323127, 11818.0, 11920.940395297968, 11867.703307417383, 11916.225445346025, 12052.819207711716, 12374.381280935737, 12398.62804115878, 10566.366018038942, 10976.890231097586, 11278.548858045915, 11278.887211127783, 11528.423578821194, 9283.164515193395, 9380.953095234754, 9549.713508594754, 9604.51977401141, 10035.09684128432, 9772.9022709772, 9789.0, 10238.53926573291, 10259.692209233735, 10288.0], "value": 6523.059811403826, "unit": "score"}], "name": "dromaeo_css", "value": 6468.486194270306, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 117.0, 117.0, 115.0, 114.0, 115.0, 114.0, 113.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 122.0, 124.0, 178.0, 125.0, 123.0, 149.0, 126.0, 177.0, 127.0], "value": 139.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 163.0, 163.0, 162.0, 162.0, 162.0, 162.0, 163.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 123.0, 77.0, 77.0, 77.0, 75.0, 99.0, 77.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 112.0, 85.0, 84.0, 86.0, 123.0, 84.0, 86.0, 124.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 66.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 64.0, 66.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 87.0, 82.0, 78.0, 77.0, 78.0, 80.0, 78.0, 88.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 127.0, 136.0, 127.0, 129.0, 134.0, 140.0, 127.0, 179.0, 131.0], "value": 136.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 171.0, 169.0, 166.0, 169.0, 166.0, 170.0, 167.0, 168.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 77.0, 68.0, 66.0, 67.0, 71.0, 68.0, 71.0, 65.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1535.1000000000001, "alertThreshold": 2.0}]} 08:13:42 INFO - Return code: 0 08:13:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:13:42 INFO - # TBPL SUCCESS # 08:13:42 INFO - Running post-action listener: _resource_record_post_action 08:13:42 INFO - ##### 08:13:42 INFO - ##### Finished run-tests step (success) 08:13:42 INFO - ##### 08:13:42 INFO - Running post-run listener: _resource_record_post_run 08:13:42 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 348160; Write bytes: 290918400; Read time: 144; Write time: 199960 08:13:42 INFO - TinderboxPrint: CPU usage
13.0% 08:13:42 INFO - TinderboxPrint: I/O read bytes / time
348,160 / 144 08:13:42 INFO - TinderboxPrint: I/O write bytes / time
290,918,400 / 199,960 08:13:42 INFO - TinderboxPrint: CPU idle
8,328.8 (87.0%) 08:13:42 INFO - TinderboxPrint: CPU user
1,200.4 (12.5%) 08:13:42 INFO - TinderboxPrint: Swap in / out
0 / 0 08:13:42 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5263360; Read time: 0; Write time: 412 08:13:42 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 344064; Write bytes: 285655040; Read time: 136; Write time: 199548 08:13:43 INFO - Running post-run listener: _upload_blobber_files 08:13:43 INFO - Blob upload gear active. 08:13:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:13:43 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 08:13:43 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'] 08:13:43 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 08:13:43 INFO - (blobuploader) - INFO - Open directory for files ... 08:13:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:13:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:13:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:46 INFO - (blobuploader) - INFO - Done attempting. 08:13:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:13:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:13:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:47 INFO - (blobuploader) - INFO - Done attempting. 08:13:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:13:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:13:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:48 INFO - (blobuploader) - INFO - Done attempting. 08:13:48 INFO - (blobuploader) - INFO - Iteration through files over. 08:13:48 INFO - Return code: 0 08:13:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:13:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:13:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/34ef0d3e08e48ff01cb94470ca9d2418f3737d582caa532eb410539dd6fe7b39b5d52c8206a3d5f8b7dabaec8001f2e839944be1559f1c9158be8699b86f3b51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50c1790d0425e7a6f3c88e7b88d6ac94fcd98dd2100f7ffabf3149b8236b6cbfd505731942764e03439d3ee645d0872902c595d5704a0205526ba62eb7f6d678", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5d2461acfa4f9296319eb15cf30ec222990e90491580648ffde4b20964b8026eceb5c2c0cc7fbe0eb8c9fce2b6848bfd8d53e7ae267eceb5dc84daa713d41c9e"} 08:13:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:13:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:13:48 INFO - Contents: 08:13:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/34ef0d3e08e48ff01cb94470ca9d2418f3737d582caa532eb410539dd6fe7b39b5d52c8206a3d5f8b7dabaec8001f2e839944be1559f1c9158be8699b86f3b51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50c1790d0425e7a6f3c88e7b88d6ac94fcd98dd2100f7ffabf3149b8236b6cbfd505731942764e03439d3ee645d0872902c595d5704a0205526ba62eb7f6d678", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5d2461acfa4f9296319eb15cf30ec222990e90491580648ffde4b20964b8026eceb5c2c0cc7fbe0eb8c9fce2b6848bfd8d53e7ae267eceb5dc84daa713d41c9e"} 08:13:48 INFO - Running post-run listener: copy_logs_to_upload_dir 08:13:48 INFO - Copying logs to upload dir... 08:13:48 INFO - mkdir: /builds/slave/test/build/upload/logs 08:13:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.221015 ========= master_lag: 0.97 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-01 08:13:49.378079) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 08:13:49.386973) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111 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/34ef0d3e08e48ff01cb94470ca9d2418f3737d582caa532eb410539dd6fe7b39b5d52c8206a3d5f8b7dabaec8001f2e839944be1559f1c9158be8699b86f3b51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50c1790d0425e7a6f3c88e7b88d6ac94fcd98dd2100f7ffabf3149b8236b6cbfd505731942764e03439d3ee645d0872902c595d5704a0205526ba62eb7f6d678", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5d2461acfa4f9296319eb15cf30ec222990e90491580648ffde4b20964b8026eceb5c2c0cc7fbe0eb8c9fce2b6848bfd8d53e7ae267eceb5dc84daa713d41c9e"} build_url:https://queue.taskcluster.net/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011175 build_url: 'https://queue.taskcluster.net/v1/task/clIuE3_6QDuaQsJM6bSnow/artifacts/public/build/firefox-50.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/34ef0d3e08e48ff01cb94470ca9d2418f3737d582caa532eb410539dd6fe7b39b5d52c8206a3d5f8b7dabaec8001f2e839944be1559f1c9158be8699b86f3b51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50c1790d0425e7a6f3c88e7b88d6ac94fcd98dd2100f7ffabf3149b8236b6cbfd505731942764e03439d3ee645d0872902c595d5704a0205526ba62eb7f6d678", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5d2461acfa4f9296319eb15cf30ec222990e90491580648ffde4b20964b8026eceb5c2c0cc7fbe0eb8c9fce2b6848bfd8d53e7ae267eceb5dc84daa713d41c9e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 08:13:49.420734) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 08:13:49.421151) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1467384752.793288-387050111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 08:13:49.470287) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 08:13:49.473668) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 08:13:49.474012) ========= ========= Total master_lag: 1.11 =========