builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1467707100.76 results: success (0) buildid: 20160704224116 builduid: f61e200f9cf4408397a9b741167db236 revision: 652fa69526ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 01:25:00.756537) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 01:25:00.757013) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 01:25:00.757291) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 01:25:00.854826) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:25:00.855083) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 01:25: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% 223M=0s 2016-07-05 01:25:01 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084017 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:25:00.969461) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:25:00.969830) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014408 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:25:01.039548) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:25:01.039911) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 652fa69526ff --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 652fa69526ff --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=78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 01:25:01,191 Setting DEBUG logging. 2016-07-05 01:25:01,191 attempt 1/10 2016-07-05 01:25:01,191 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/652fa69526ff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 01:25:01,528 unpacking tar archive at: fx-team-652fa69526ff/testing/mozharness/ program finished with exit code 0 elapsedTime=0.665437 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:25:01.725858) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 01:25:01.726163) ========= script_repo_revision: 652fa69526ff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 01:25:01.726562) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 01:25:01.726829) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 01:25:01.737322) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-05 01:25:01.737729) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:25:01 INFO - MultiFileLogger online at 20160705 01:25:01 in /builds/slave/test 01:25:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 01:25:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:25:01 INFO - {'append_to_log': False, 01:25:01 INFO - 'base_work_dir': '/builds/slave/test', 01:25:01 INFO - 'blob_upload_branch': 'Fx-Team', 01:25:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:25:01 INFO - 'branch': 'Fx-Team', 01:25:01 INFO - 'buildbot_json_path': 'buildprops.json', 01:25:01 INFO - 'config_files': ('talos/linux_config.py',), 01:25:01 INFO - 'default_actions': ('clobber', 01:25:01 INFO - 'read-buildbot-config', 01:25:01 INFO - 'download-and-extract', 01:25:01 INFO - 'populate-webroot', 01:25:01 INFO - 'create-virtualenv', 01:25:01 INFO - 'install', 01:25:01 INFO - 'run-tests'), 01:25:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:25:01 INFO - 'download_minidump_stackwalk': True, 01:25:01 INFO - 'download_symbols': 'ondemand', 01:25:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:25:01 INFO - 'tooltool.py': '/tools/tooltool.py', 01:25:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:25:01 INFO - '/tools/misc-python/virtualenv.py')}, 01:25:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:25:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:25:01 INFO - 'installer_path': 'installer.exe', 01:25:01 INFO - 'log_level': 'info', 01:25:01 INFO - 'log_name': 'talos', 01:25:01 INFO - 'log_to_console': True, 01:25:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:25:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:25:01 INFO - 'opt_config_files': (), 01:25:01 INFO - 'pip_index': False, 01:25:01 INFO - 'sps_profile': False, 01:25:01 INFO - 'sps_profile_interval': 0, 01:25:01 INFO - 'suite': 'dromaeojs', 01:25:01 INFO - 'system_bits': '32', 01:25:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:25:01 INFO - 'title': 'talos-linux64-ix-019', 01:25:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:25:01 INFO - 'use_talos_json': True, 01:25:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:25:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:25:01 INFO - 'work_dir': 'build'} 01:25:01 INFO - ##### 01:25:01 INFO - ##### Running clobber step. 01:25:01 INFO - ##### 01:25:01 INFO - Running pre-action listener: _resource_record_pre_action 01:25:01 INFO - Running main action method: clobber 01:25:01 INFO - rmtree: /builds/slave/test/build 01:25:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:25:02 INFO - Running post-action listener: _resource_record_post_action 01:25:02 INFO - ##### 01:25:02 INFO - ##### Finished clobber step (success) 01:25:02 INFO - ##### 01:25:02 INFO - ##### 01:25:02 INFO - ##### Running read-buildbot-config step. 01:25:02 INFO - ##### 01:25:02 INFO - Running pre-action listener: _resource_record_pre_action 01:25:02 INFO - Running main action method: read_buildbot_config 01:25:02 INFO - Using buildbot properties: 01:25:02 INFO - { 01:25:02 INFO - "project": "", 01:25:02 INFO - "product": "firefox", 01:25:02 INFO - "script_repo_revision": "production", 01:25:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:25:02 INFO - "repository": "", 01:25:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 01:25:02 INFO - "buildid": "20160704224116", 01:25:02 INFO - "pgo_build": "True", 01:25:02 INFO - "basedir": "/builds/slave/test", 01:25:02 INFO - "buildnumber": 244, 01:25:02 INFO - "slavename": "talos-linux64-ix-019", 01:25:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:25:02 INFO - "platform": "ubuntu64_hw", 01:25:02 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 01:25:02 INFO - "branch": "fx-team", 01:25:02 INFO - "repo_path": "integration/fx-team", 01:25:02 INFO - "revision": "652fa69526ff", 01:25:02 INFO - "stage_platform": "linux64-pgo", 01:25:02 INFO - "builduid": "f61e200f9cf4408397a9b741167db236", 01:25:02 INFO - "slavebuilddir": "test" 01:25:02 INFO - } 01:25:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/fIcHHeGlTf2gnUFLv9_j_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:25:02 INFO - Running post-action listener: _resource_record_post_action 01:25:02 INFO - ##### 01:25:02 INFO - ##### Finished read-buildbot-config step (success) 01:25:02 INFO - ##### 01:25:02 INFO - ##### 01:25:02 INFO - ##### Running download-and-extract step. 01:25:02 INFO - ##### 01:25:02 INFO - Running pre-action listener: _resource_record_pre_action 01:25:02 INFO - Running main action method: download_and_extract 01:25:02 INFO - mkdir: /builds/slave/test/build/tests 01:25: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')]} 01:25:02 INFO - https://queue.taskcluster.net/v1/task/fIcHHeGlTf2gnUFLv9_j_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:25:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIcHHeGlTf2gnUFLv9_j_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:25:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIcHHeGlTf2gnUFLv9_j_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:25:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIcHHeGlTf2gnUFLv9_j_g/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 01:25:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIcHHeGlTf2gnUFLv9_j_g/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 01:25:05 INFO - Downloaded 1361 bytes. 01:25:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:25:05 INFO - Using the following test package requirements: 01:25:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:25:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:25:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:25:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:05 INFO - u'jsshell-linux-x86_64.zip'], 01:25:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:25:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:25:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:25:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:25:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:25:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:25:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:25:05 INFO - https://queue.taskcluster.net/v1/task/fIcHHeGlTf2gnUFLv9_j_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:25:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIcHHeGlTf2gnUFLv9_j_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:25:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIcHHeGlTf2gnUFLv9_j_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:25:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIcHHeGlTf2gnUFLv9_j_g/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 01:25:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIcHHeGlTf2gnUFLv9_j_g/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 01:25:06 INFO - Downloaded 24298378 bytes. 01:25:06 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'] 01:25:06 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 01:25:08 INFO - Return code: 0 01:25:08 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 01:25: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')]} 01:25:08 INFO - https://queue.taskcluster.net/v1/task/fIcHHeGlTf2gnUFLv9_j_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:25:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIcHHeGlTf2gnUFLv9_j_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:25:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIcHHeGlTf2gnUFLv9_j_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:25:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIcHHeGlTf2gnUFLv9_j_g/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 01:25:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIcHHeGlTf2gnUFLv9_j_g/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 01:25:09 INFO - Downloaded 24298378 bytes. 01:25:09 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'] 01:25:09 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 01:25:11 INFO - Return code: 0 01:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:25:11 INFO - https://queue.taskcluster.net/v1/task/fIcHHeGlTf2gnUFLv9_j_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:25:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIcHHeGlTf2gnUFLv9_j_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:25:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIcHHeGlTf2gnUFLv9_j_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:25:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIcHHeGlTf2gnUFLv9_j_g/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 01:25:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIcHHeGlTf2gnUFLv9_j_g/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 01:25:12 INFO - Downloaded 14403333 bytes. 01:25:12 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'] 01:25:12 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 01:25:12 INFO - Return code: 0 01:25: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')]} 01:25:12 INFO - https://queue.taskcluster.net/v1/task/fIcHHeGlTf2gnUFLv9_j_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:25:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIcHHeGlTf2gnUFLv9_j_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:25:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIcHHeGlTf2gnUFLv9_j_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:25:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIcHHeGlTf2gnUFLv9_j_g/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 01:25:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIcHHeGlTf2gnUFLv9_j_g/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 01:25:14 INFO - Downloaded 60353577 bytes. 01:25:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fIcHHeGlTf2gnUFLv9_j_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:25:14 INFO - mkdir: /builds/slave/test/properties 01:25:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:25:14 INFO - Writing to file /builds/slave/test/properties/build_url 01:25:14 INFO - Contents: 01:25:14 INFO - build_url:https://queue.taskcluster.net/v1/task/fIcHHeGlTf2gnUFLv9_j_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:25:15 INFO - Running post-action listener: _resource_record_post_action 01:25:15 INFO - Running post-action listener: set_extra_try_arguments 01:25:15 INFO - ##### 01:25:15 INFO - ##### Finished download-and-extract step (success) 01:25:15 INFO - ##### 01:25:15 INFO - ##### 01:25:15 INFO - ##### Running populate-webroot step. 01:25:15 INFO - ##### 01:25:15 INFO - Running pre-action listener: _resource_record_pre_action 01:25:15 INFO - Running main action method: populate_webroot 01:25:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:25:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:25:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:25:15 INFO - '--tppagecycles', 01:25:15 INFO - '7'], 01:25:15 INFO - 'tests': ['tsvgm']}}, 01:25:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:25:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:25:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:25:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:25:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:25:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:25:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:15 INFO - 'talos_options': ['--disable-e10s'], 01:25:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:25:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:25:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:15 INFO - 'talos_options': ['--disable-e10s'], 01:25:15 INFO - 'tests': ['damp', 'tps']}, 01:25:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:15 INFO - 'tests': ['damp', 'tps']}, 01:25:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:25:15 INFO - 'tests': ['dromaeo_dom']}, 01:25:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:25:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:25:15 INFO - 'tests': ['basic_compositor_video']}, 01:25:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:25:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:25:15 INFO - 'tests': ['a11yr', 01:25:15 INFO - 'ts_paint', 01:25:15 INFO - 'tpaint', 01:25:15 INFO - 'sessionrestore', 01:25:15 INFO - 'sessionrestore_no_auto_restore', 01:25:15 INFO - 'tabpaint']}, 01:25:15 INFO - 'other-e10s': {'tests': ['a11yr', 01:25:15 INFO - 'ts_paint', 01:25:15 INFO - 'tpaint', 01:25:15 INFO - 'sessionrestore', 01:25:15 INFO - 'sessionrestore_no_auto_restore', 01:25:15 INFO - 'tabpaint']}, 01:25:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:25:15 INFO - 'ts_paint', 01:25:15 INFO - 'tpaint', 01:25:15 INFO - 'sessionrestore', 01:25:15 INFO - 'sessionrestore_no_auto_restore', 01:25:15 INFO - 'tabpaint']}, 01:25:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:25:15 INFO - 'ts_paint', 01:25:15 INFO - 'tpaint', 01:25:15 INFO - 'sessionrestore', 01:25:15 INFO - 'sessionrestore_no_auto_restore', 01:25:15 INFO - 'tabpaint']}, 01:25:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:25:15 INFO - 'tests': ['a11yr', 01:25:15 INFO - 'ts_paint', 01:25:15 INFO - 'tpaint', 01:25:15 INFO - 'sessionrestore', 01:25:15 INFO - 'sessionrestore_no_auto_restore', 01:25:15 INFO - 'tabpaint']}, 01:25:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:25:15 INFO - 'tests': ['a11yr', 01:25:15 INFO - 'ts_paint', 01:25:15 INFO - 'tpaint', 01:25:15 INFO - 'sessionrestore', 01:25:15 INFO - 'sessionrestore_no_auto_restore', 01:25:15 INFO - 'tabpaint']}, 01:25:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:25:15 INFO - 'tests': ['tsvgx', 01:25:15 INFO - 'tsvgr_opacity', 01:25:15 INFO - 'tart', 01:25:15 INFO - 'tscrollx', 01:25:15 INFO - 'cart']}, 01:25:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:25:15 INFO - 'tsvgr_opacity', 01:25:15 INFO - 'tart', 01:25:15 INFO - 'tscrollx', 01:25:15 INFO - 'cart']}, 01:25:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:15 INFO - 'talos_options': ['--disable-e10s'], 01:25:15 INFO - 'tests': ['tp5o']}, 01:25:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:15 INFO - 'tests': ['tp5o']}, 01:25:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:15 INFO - 'talos_options': ['--disable-e10s', 01:25:15 INFO - '--xperf_path', 01:25:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:25:15 INFO - 'tests': ['tp5n']}, 01:25:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:15 INFO - 'talos_options': ['--xperf_path', 01:25:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:25:15 INFO - 'tests': ['tp5n']}}, 01:25:15 INFO - 'talos.zip': {'path': '', 01:25:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:25:15 INFO - Running post-action listener: _resource_record_post_action 01:25:15 INFO - ##### 01:25:15 INFO - ##### Finished populate-webroot step (success) 01:25:15 INFO - ##### 01:25:15 INFO - ##### 01:25:15 INFO - ##### Running create-virtualenv step. 01:25:15 INFO - ##### 01:25:15 INFO - Running pre-action listener: _resource_record_pre_action 01:25:15 INFO - Running main action method: create_virtualenv 01:25:15 INFO - Creating virtualenv /builds/slave/test/build/venv 01:25:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:25:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:25:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:25:15 INFO - Using real prefix '/usr' 01:25:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:25:16 INFO - Installing distribute.............................................................................................................................................................................................done. 01:25:18 INFO - Installing pip.................done. 01:25:18 INFO - Return code: 0 01:25:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:25:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:25:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d77180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d753b0>, '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 0x1d762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d76740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673', '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 01:25:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:25:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:25:18 INFO - Using env: {'DISPLAY': ':0', 01:25:18 INFO - 'HOME': '/home/cltbld', 01:25:18 INFO - 'LANG': 'en_US.UTF-8', 01:25:18 INFO - 'LANGUAGE': 'en_US:en', 01:25:18 INFO - 'LOGNAME': 'cltbld', 01:25:18 INFO - 'MAIL': '/var/mail/cltbld', 01:25:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:18 INFO - 'MOZ_NO_REMOTE': '1', 01:25:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:18 INFO - 'NO_EM_RESTART': '1', 01:25:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:18 INFO - 'PWD': '/builds/slave/test', 01:25:18 INFO - 'SHELL': '/bin/bash', 01:25:18 INFO - 'SHLVL': '1', 01:25:18 INFO - 'TERM': 'linux', 01:25:18 INFO - 'TMOUT': '86400', 01:25:18 INFO - 'USER': 'cltbld', 01:25:18 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673', 01:25:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:18 INFO - '_': '/tools/buildbot/bin/python'} 01:25:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:25:18 INFO - Cleaning up... 01:25:18 INFO - Return code: 0 01:25:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:25:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:25:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d77180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d753b0>, '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 0x1d762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d76740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673', '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 01:25:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:25:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:25:18 INFO - Using env: {'DISPLAY': ':0', 01:25:18 INFO - 'HOME': '/home/cltbld', 01:25:18 INFO - 'LANG': 'en_US.UTF-8', 01:25:18 INFO - 'LANGUAGE': 'en_US:en', 01:25:18 INFO - 'LOGNAME': 'cltbld', 01:25:18 INFO - 'MAIL': '/var/mail/cltbld', 01:25:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:18 INFO - 'MOZ_NO_REMOTE': '1', 01:25:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:18 INFO - 'NO_EM_RESTART': '1', 01:25:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:18 INFO - 'PWD': '/builds/slave/test', 01:25:18 INFO - 'SHELL': '/bin/bash', 01:25:18 INFO - 'SHLVL': '1', 01:25:18 INFO - 'TERM': 'linux', 01:25:18 INFO - 'TMOUT': '86400', 01:25:18 INFO - 'USER': 'cltbld', 01:25:18 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673', 01:25:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:18 INFO - '_': '/tools/buildbot/bin/python'} 01:25:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:18 INFO - Downloading/unpacking psutil>=3.1.1 01:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:25:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:25:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:25:20 INFO - Installing collected packages: psutil 01:25:20 INFO - Running setup.py install for psutil 01:25:20 INFO - building 'psutil._psutil_linux' extension 01:25:20 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 01:25:20 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 01:25:20 INFO - building 'psutil._psutil_posix' extension 01:25:20 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 01:25:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:25:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:25:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:25:21 INFO - Successfully installed psutil 01:25:21 INFO - Cleaning up... 01:25:21 INFO - Return code: 0 01:25:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d77180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d753b0>, '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 0x1d762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d76740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673', '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 01:25:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:25:21 INFO - Using env: {'DISPLAY': ':0', 01:25:21 INFO - 'HOME': '/home/cltbld', 01:25:21 INFO - 'LANG': 'en_US.UTF-8', 01:25:21 INFO - 'LANGUAGE': 'en_US:en', 01:25:21 INFO - 'LOGNAME': 'cltbld', 01:25:21 INFO - 'MAIL': '/var/mail/cltbld', 01:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:21 INFO - 'MOZ_NO_REMOTE': '1', 01:25:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:21 INFO - 'NO_EM_RESTART': '1', 01:25:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:21 INFO - 'PWD': '/builds/slave/test', 01:25:21 INFO - 'SHELL': '/bin/bash', 01:25:21 INFO - 'SHLVL': '1', 01:25:21 INFO - 'TERM': 'linux', 01:25:21 INFO - 'TMOUT': '86400', 01:25:21 INFO - 'USER': 'cltbld', 01:25:21 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673', 01:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:21 INFO - '_': '/tools/buildbot/bin/python'} 01:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:25:23 INFO - Installing collected packages: mozsystemmonitor 01:25:23 INFO - Running setup.py install for mozsystemmonitor 01:25:23 INFO - Successfully installed mozsystemmonitor 01:25:23 INFO - Cleaning up... 01:25:23 INFO - Return code: 0 01:25:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:25: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')]} 01:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25: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')]} 01:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25: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', '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 0x1ab6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d77180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d753b0>, '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 0x1d762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d76740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673', '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 01:25: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:25: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 jsonschema==2.5.1 01:25:23 INFO - Using env: {'DISPLAY': ':0', 01:25:23 INFO - 'HOME': '/home/cltbld', 01:25:23 INFO - 'LANG': 'en_US.UTF-8', 01:25:23 INFO - 'LANGUAGE': 'en_US:en', 01:25:23 INFO - 'LOGNAME': 'cltbld', 01:25:23 INFO - 'MAIL': '/var/mail/cltbld', 01:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:23 INFO - 'MOZ_NO_REMOTE': '1', 01:25:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:23 INFO - 'NO_EM_RESTART': '1', 01:25:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:23 INFO - 'PWD': '/builds/slave/test', 01:25:23 INFO - 'SHELL': '/bin/bash', 01:25:23 INFO - 'SHLVL': '1', 01:25:23 INFO - 'TERM': 'linux', 01:25:23 INFO - 'TMOUT': '86400', 01:25:23 INFO - 'USER': 'cltbld', 01:25:23 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673', 01:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:23 INFO - '_': '/tools/buildbot/bin/python'} 01:25:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:23 INFO - Downloading/unpacking jsonschema==2.5.1 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:25:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:25:25 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 01:25:25 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 01:25:25 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 01:25:25 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 01:25:25 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 01:25:25 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 01:25:25 INFO - Downloading functools32-3.2.3-2.tar.gz 01:25:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:25:25 INFO - warning: no files found matching '*.txt' 01:25:25 INFO - no previously-included directories found matching 'build' 01:25:25 INFO - no previously-included directories found matching 'dist' 01:25:25 INFO - no previously-included directories found matching '.git*' 01:25:25 INFO - Installing collected packages: jsonschema, functools32 01:25:25 INFO - Running setup.py install for functools32 01:25:25 INFO - warning: no files found matching '*.txt' 01:25:25 INFO - no previously-included directories found matching 'build' 01:25:25 INFO - no previously-included directories found matching 'dist' 01:25:25 INFO - no previously-included directories found matching '.git*' 01:25:26 INFO - Successfully installed jsonschema functools32 01:25:26 INFO - Cleaning up... 01:25:26 INFO - Return code: 0 01:25:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:25: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')]} 01:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25: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')]} 01:25:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d77180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d753b0>, '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 0x1d762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d76740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673', '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 01:25:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:25:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:25:26 INFO - Using env: {'DISPLAY': ':0', 01:25:26 INFO - 'HOME': '/home/cltbld', 01:25:26 INFO - 'LANG': 'en_US.UTF-8', 01:25:26 INFO - 'LANGUAGE': 'en_US:en', 01:25:26 INFO - 'LOGNAME': 'cltbld', 01:25:26 INFO - 'MAIL': '/var/mail/cltbld', 01:25:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:26 INFO - 'MOZ_NO_REMOTE': '1', 01:25:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:26 INFO - 'NO_EM_RESTART': '1', 01:25:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:26 INFO - 'PWD': '/builds/slave/test', 01:25:26 INFO - 'SHELL': '/bin/bash', 01:25:26 INFO - 'SHLVL': '1', 01:25:26 INFO - 'TERM': 'linux', 01:25:26 INFO - 'TMOUT': '86400', 01:25:26 INFO - 'USER': 'cltbld', 01:25:26 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673', 01:25:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:26 INFO - '_': '/tools/buildbot/bin/python'} 01:25:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:26 INFO - Downloading/unpacking blobuploader==1.2.4 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25:28 INFO - Downloading blobuploader-1.2.4.tar.gz 01:25:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:25:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:25:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25:28 INFO - Downloading docopt-0.6.1.tar.gz 01:25:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:25:28 INFO - Installing collected packages: blobuploader, requests, docopt 01:25:28 INFO - Running setup.py install for blobuploader 01:25:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:25:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:25:29 INFO - Running setup.py install for requests 01:25:29 INFO - Running setup.py install for docopt 01:25:29 INFO - Successfully installed blobuploader requests docopt 01:25:29 INFO - Cleaning up... 01:25:29 INFO - Return code: 0 01:25:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:29 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 0x1ab6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d77180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d753b0>, '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 0x1d762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d76740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673', '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 01:25:29 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 01:25:29 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 01:25:29 INFO - Using env: {'DISPLAY': ':0', 01:25:29 INFO - 'HOME': '/home/cltbld', 01:25:29 INFO - 'LANG': 'en_US.UTF-8', 01:25:29 INFO - 'LANGUAGE': 'en_US:en', 01:25:29 INFO - 'LOGNAME': 'cltbld', 01:25:29 INFO - 'MAIL': '/var/mail/cltbld', 01:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:29 INFO - 'MOZ_NO_REMOTE': '1', 01:25:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:29 INFO - 'NO_EM_RESTART': '1', 01:25:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:29 INFO - 'PWD': '/builds/slave/test', 01:25:29 INFO - 'SHELL': '/bin/bash', 01:25:29 INFO - 'SHLVL': '1', 01:25:29 INFO - 'TERM': 'linux', 01:25:29 INFO - 'TMOUT': '86400', 01:25:29 INFO - 'USER': 'cltbld', 01:25:29 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673', 01:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:29 INFO - '_': '/tools/buildbot/bin/python'} 01:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:25:29 INFO - Running setup.py (path:/tmp/pip-dUlHs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:25:29 INFO - Running setup.py (path:/tmp/pip-2tGmAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:25:29 INFO - Running setup.py (path:/tmp/pip-Be5s43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:25:29 INFO - Running setup.py (path:/tmp/pip-7BQO8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:25:30 INFO - Running setup.py (path:/tmp/pip-Kl9gTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:25:30 INFO - Running setup.py (path:/tmp/pip-d65yrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:25:30 INFO - Running setup.py (path:/tmp/pip-xTYiup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:25:30 INFO - Running setup.py (path:/tmp/pip-NedUN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:25:30 INFO - Running setup.py (path:/tmp/pip-3n0JV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:25:30 INFO - Running setup.py (path:/tmp/pip-076iAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:25:30 INFO - Running setup.py (path:/tmp/pip-zmpsCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:25:30 INFO - Running setup.py (path:/tmp/pip-HApeg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:25:30 INFO - Running setup.py (path:/tmp/pip-HL6ojI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:25:30 INFO - Running setup.py (path:/tmp/pip-x5Sjly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:30 INFO - Running setup.py (path:/tmp/pip-umH15c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:25:30 INFO - Running setup.py (path:/tmp/pip-MiKcFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:25:30 INFO - Running setup.py (path:/tmp/pip-QDBJVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:25:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:25:31 INFO - Running setup.py install for manifestparser 01:25:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:25:31 INFO - Running setup.py install for mozcrash 01:25:31 INFO - Running setup.py install for mozdebug 01:25:31 INFO - Running setup.py install for mozdevice 01:25:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:25:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:25:31 INFO - Running setup.py install for mozfile 01:25:31 INFO - Running setup.py install for mozhttpd 01:25:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:25:31 INFO - Running setup.py install for mozinfo 01:25:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:25:31 INFO - Running setup.py install for mozInstall 01:25:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:25:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:25:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:25:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:25:31 INFO - Running setup.py install for mozleak 01:25:31 INFO - Running setup.py install for mozlog 01:25:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:25:32 INFO - Running setup.py install for moznetwork 01:25:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:25:32 INFO - Running setup.py install for mozprocess 01:25:32 INFO - Running setup.py install for mozprofile 01:25:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:25:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:25:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:25:32 INFO - Running setup.py install for mozrunner 01:25:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:25:32 INFO - Running setup.py install for mozscreenshot 01:25:32 INFO - Running setup.py install for moztest 01:25:32 INFO - Running setup.py install for mozversion 01:25:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:25:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:25:32 INFO - Cleaning up... 01:25:32 INFO - Return code: 0 01:25:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:25:32 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')]} 01:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:32 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')]} 01:25:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:32 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 0x1ab6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d77180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d753b0>, '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 0x1d762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d76740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673', '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 01:25:32 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 01:25:32 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 01:25:32 INFO - Using env: {'DISPLAY': ':0', 01:25:32 INFO - 'HOME': '/home/cltbld', 01:25:32 INFO - 'LANG': 'en_US.UTF-8', 01:25:32 INFO - 'LANGUAGE': 'en_US:en', 01:25:32 INFO - 'LOGNAME': 'cltbld', 01:25:32 INFO - 'MAIL': '/var/mail/cltbld', 01:25:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:32 INFO - 'MOZ_NO_REMOTE': '1', 01:25:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:32 INFO - 'NO_EM_RESTART': '1', 01:25:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:32 INFO - 'PWD': '/builds/slave/test', 01:25:32 INFO - 'SHELL': '/bin/bash', 01:25:32 INFO - 'SHLVL': '1', 01:25:32 INFO - 'TERM': 'linux', 01:25:32 INFO - 'TMOUT': '86400', 01:25:32 INFO - 'USER': 'cltbld', 01:25:32 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673', 01:25:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:32 INFO - '_': '/tools/buildbot/bin/python'} 01:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:25:33 INFO - Running setup.py (path:/tmp/pip-y_VLjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:25:33 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)) 01:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:25:33 INFO - Running setup.py (path:/tmp/pip-V3UpYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:25:33 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)) 01:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:25:33 INFO - Running setup.py (path:/tmp/pip-3xxLHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:25:33 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)) 01:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:25:33 INFO - Running setup.py (path:/tmp/pip-Lx4uKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:25:33 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)) 01:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:25:33 INFO - Running setup.py (path:/tmp/pip-TaiN01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:25:33 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)) 01:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:25:33 INFO - Running setup.py (path:/tmp/pip-blqDOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:25:33 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)) 01:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:25:33 INFO - Running setup.py (path:/tmp/pip-U88KgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:25:33 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)) 01:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:25:33 INFO - Running setup.py (path:/tmp/pip-WnvSiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:25:33 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)) 01:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:25:33 INFO - Running setup.py (path:/tmp/pip-3OTg4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:25:33 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)) 01:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:25:33 INFO - Running setup.py (path:/tmp/pip-MEfkeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:25:33 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)) 01:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:25:33 INFO - Running setup.py (path:/tmp/pip-O0KBp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:25:33 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)) 01:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:25:33 INFO - Running setup.py (path:/tmp/pip-pnAjnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:25:33 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)) 01:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:25:33 INFO - Running setup.py (path:/tmp/pip-erOjX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:25:33 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)) 01:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:25:33 INFO - Running setup.py (path:/tmp/pip-cKRN4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:25:34 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)) 01:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:34 INFO - Running setup.py (path:/tmp/pip-81_5Ji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:34 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)) 01:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:25:34 INFO - Running setup.py (path:/tmp/pip-SnbIIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:25:34 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)) 01:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:25:34 INFO - Running setup.py (path:/tmp/pip-UDO9yv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:25:34 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)) 01:25:34 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)) 01:25:34 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)) 01:25:34 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)) 01:25:34 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)) 01:25:34 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)) 01:25:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:36 INFO - Downloading blessings-1.6.tar.gz 01:25:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:25:36 INFO - Installing collected packages: blessings 01:25:36 INFO - Running setup.py install for blessings 01:25:36 INFO - Successfully installed blessings 01:25:36 INFO - Cleaning up... 01:25:36 INFO - Return code: 0 01:25:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:25:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:25:36 INFO - Reading from file tmpfile_stdout 01:25:36 INFO - Current package versions: 01:25:36 INFO - argparse == 1.2.1 01:25:36 INFO - blessings == 1.6 01:25:36 INFO - blobuploader == 1.2.4 01:25:36 INFO - docopt == 0.6.1 01:25:36 INFO - functools32 == 3.2.3-2 01:25:36 INFO - jsonschema == 2.5.1 01:25:36 INFO - manifestparser == 1.1 01:25:36 INFO - mozInstall == 1.12 01:25:36 INFO - mozcrash == 0.17 01:25:36 INFO - mozdebug == 0.1 01:25:36 INFO - mozdevice == 0.48 01:25:36 INFO - mozfile == 1.2 01:25:36 INFO - mozhttpd == 0.7 01:25:36 INFO - mozinfo == 0.9 01:25:36 INFO - mozleak == 0.1 01:25:36 INFO - mozlog == 3.2 01:25:36 INFO - moznetwork == 0.27 01:25:36 INFO - mozprocess == 0.22 01:25:36 INFO - mozprofile == 0.28 01:25:36 INFO - mozrunner == 6.11 01:25:36 INFO - mozscreenshot == 0.1 01:25:36 INFO - mozsystemmonitor == 0.3 01:25:36 INFO - moztest == 0.7 01:25:36 INFO - mozversion == 1.4 01:25:36 INFO - psutil == 3.1.1 01:25:36 INFO - requests == 1.2.3 01:25:36 INFO - wsgiref == 0.1.2 01:25:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:25:36 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')]} 01:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:36 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')]} 01:25:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:36 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 0x1ab6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d77180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d753b0>, '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 0x1d762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d76740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673', '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 01:25:36 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 01:25:36 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 01:25:36 INFO - Using env: {'DISPLAY': ':0', 01:25:36 INFO - 'HOME': '/home/cltbld', 01:25:36 INFO - 'LANG': 'en_US.UTF-8', 01:25:36 INFO - 'LANGUAGE': 'en_US:en', 01:25:36 INFO - 'LOGNAME': 'cltbld', 01:25:36 INFO - 'MAIL': '/var/mail/cltbld', 01:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:36 INFO - 'MOZ_NO_REMOTE': '1', 01:25:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:36 INFO - 'NO_EM_RESTART': '1', 01:25:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:36 INFO - 'PWD': '/builds/slave/test', 01:25:36 INFO - 'SHELL': '/bin/bash', 01:25:36 INFO - 'SHLVL': '1', 01:25:36 INFO - 'TERM': 'linux', 01:25:36 INFO - 'TMOUT': '86400', 01:25:36 INFO - 'USER': 'cltbld', 01:25:36 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673', 01:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:36 INFO - '_': '/tools/buildbot/bin/python'} 01:25:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:36 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)) 01:25:36 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)) 01:25:36 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)) 01:25:36 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)) 01:25:36 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)) 01:25:36 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)) 01:25:36 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)) 01:25:36 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)) 01:25:36 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)) 01:25:36 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)) 01:25:36 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)) 01:25:36 INFO - Cleaning up... 01:25:36 INFO - Return code: 0 01:25:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:25:36 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')]} 01:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:36 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')]} 01:25:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:36 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 0x1ab6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d77180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d753b0>, '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 0x1d762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d76740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673', '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 01:25:36 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 01:25:36 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 01:25:36 INFO - Using env: {'DISPLAY': ':0', 01:25:36 INFO - 'HOME': '/home/cltbld', 01:25:36 INFO - 'LANG': 'en_US.UTF-8', 01:25:36 INFO - 'LANGUAGE': 'en_US:en', 01:25:36 INFO - 'LOGNAME': 'cltbld', 01:25:36 INFO - 'MAIL': '/var/mail/cltbld', 01:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:36 INFO - 'MOZ_NO_REMOTE': '1', 01:25:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:36 INFO - 'NO_EM_RESTART': '1', 01:25:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:36 INFO - 'PWD': '/builds/slave/test', 01:25:36 INFO - 'SHELL': '/bin/bash', 01:25:36 INFO - 'SHLVL': '1', 01:25:36 INFO - 'TERM': 'linux', 01:25:36 INFO - 'TMOUT': '86400', 01:25:36 INFO - 'USER': 'cltbld', 01:25:36 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673', 01:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:36 INFO - '_': '/tools/buildbot/bin/python'} 01:25:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:25:37 INFO - Cleaning up... 01:25:37 INFO - Return code: 0 01:25:37 INFO - Running post-action listener: _resource_record_post_action 01:25:37 INFO - Running post-action listener: _start_resource_monitoring 01:25:37 INFO - Starting resource monitoring. 01:25:37 INFO - ##### 01:25:37 INFO - ##### Finished create-virtualenv step (success) 01:25:37 INFO - ##### 01:25:37 INFO - ##### 01:25:37 INFO - ##### Running install step. 01:25:37 INFO - ##### 01:25:37 INFO - Running pre-action listener: _resource_record_pre_action 01:25:37 INFO - Running main action method: install 01:25:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:25:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:25:37 INFO - Reading from file tmpfile_stdout 01:25:37 INFO - Detecting whether we're running mozinstall >=1.0... 01:25:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:25:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:25:37 INFO - Reading from file tmpfile_stdout 01:25:37 INFO - Output received: 01:25:37 INFO - Usage: mozinstall [options] installer 01:25:37 INFO - Options: 01:25:37 INFO - -h, --help show this help message and exit 01:25:37 INFO - -d DEST, --destination=DEST 01:25:37 INFO - Directory to install application into. [default: 01:25:37 INFO - "/builds/slave/test"] 01:25:37 INFO - --app=APP Application being installed. [default: firefox] 01:25:37 INFO - mkdir: /builds/slave/test/build/application 01:25:37 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'] 01:25:37 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 01:25:54 INFO - Reading from file tmpfile_stdout 01:25:54 INFO - Output received: 01:25:54 INFO - /builds/slave/test/build/application/firefox/firefox 01:25:54 INFO - Running post-action listener: _resource_record_post_action 01:25:54 INFO - ##### 01:25:54 INFO - ##### Finished install step (success) 01:25:54 INFO - ##### 01:25:54 INFO - ##### 01:25:54 INFO - ##### Running run-tests step. 01:25:54 INFO - ##### 01:25:54 INFO - Running pre-action listener: _resource_record_pre_action 01:25:54 INFO - Running main action method: run_tests 01:25:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:25:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:25:54 INFO - Python 2.7.3 01:25:54 INFO - Return code: 0 01:25:54 INFO - grabbing minidump binary from tooltool 01:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:25:54 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 0x1d753b0>, '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 0x1d762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d76740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:25:54 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 01:25:54 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 01:25:54 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 01:25:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:25:54 INFO - Return code: 0 01:25:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:25:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:25:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:25:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:25:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:25:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fIcHHeGlTf2gnUFLv9_j_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 01:25:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fIcHHeGlTf2gnUFLv9_j_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 01:25:54 INFO - Using env: {'DISPLAY': ':0', 01:25:54 INFO - 'HOME': '/home/cltbld', 01:25:54 INFO - 'LANG': 'en_US.UTF-8', 01:25:54 INFO - 'LANGUAGE': 'en_US:en', 01:25:54 INFO - 'LOGNAME': 'cltbld', 01:25:54 INFO - 'MAIL': '/var/mail/cltbld', 01:25:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:25:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:54 INFO - 'MOZ_NO_REMOTE': '1', 01:25:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:25:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:54 INFO - 'NO_EM_RESTART': '1', 01:25:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:54 INFO - 'PWD': '/builds/slave/test', 01:25:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:25:54 INFO - 'SHELL': '/bin/bash', 01:25:54 INFO - 'SHLVL': '1', 01:25:54 INFO - 'TERM': 'linux', 01:25:54 INFO - 'TMOUT': '86400', 01:25:54 INFO - 'USER': 'cltbld', 01:25:54 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673', 01:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:54 INFO - '_': '/tools/buildbot/bin/python'} 01:25:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fIcHHeGlTf2gnUFLv9_j_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 01:25:54 INFO - mozversion application_buildid: 20160704224116 01:25:54 INFO - mozversion application_changeset: 652fa69526ff82afbe7b7e6a360709c457fddf19 01:25:54 INFO - mozversion application_display_name: Nightly 01:25:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:25:54 INFO - mozversion application_name: Firefox 01:25:54 INFO - mozversion application_remotingname: firefox 01:25:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:25:54 INFO - mozversion application_vendor: Mozilla 01:25:54 INFO - mozversion application_version: 50.0a1 01:25:54 INFO - mozversion platform_buildid: 20160704224116 01:25:54 INFO - mozversion platform_changeset: 652fa69526ff82afbe7b7e6a360709c457fddf19 01:25:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:25:54 INFO - mozversion platform_version: 50.0a1 01:25:54 INFO - using testdate: 1467707154 01:25:54 INFO - actual date: 1467707154 01:25:54 INFO - starting webserver on 'localhost:51411' 01:25:54 INFO - SUITE-START | Running 2 tests 01:25:54 INFO - TEST-START | dromaeo_css 01:25:54 INFO - operating with platform_type : linux_ 01:25:54 INFO - Initialising browser for dromaeo_css test... 01:25:54 INFO - TEST-INFO | started process 26174 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl36lEp/profile http://localhost:51411/getInfo.html) 01:25:58 INFO - PROCESS | 26174 | __metrics Screen width/height:1600/1200 01:25:58 INFO - PROCESS | 26174 | colorDepth:24 01:25:58 INFO - PROCESS | 26174 | Browser inner width/height: 1024/697 01:25:58 INFO - PROCESS | 26174 | __metrics 01:25:59 INFO - PROCESS | 26174 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:26:00 INFO - TEST-INFO | 26174: exit 0 01:26:00 INFO - Browser initialized. 01:26:00 INFO - Running cycle 1/1 for dromaeo_css test... 01:26:00 INFO - TEST-INFO | started process 26257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl36lEp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:26:12 INFO - PROCESS | 26257 | RSS: Main: 157626368 01:26:12 INFO - PROCESS | 26257 | 01:27:04 INFO - PROCESS | 26257 | 1467707224376 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] 01:29:12 INFO - PROCESS | 26257 | Cycle 1(1): loaded http://localhost:51411/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51411/tests/dromaeo/cssquery-ext.html) 01:29:13 INFO - PROCESS | 26257 | RSS: Main: 287666176 01:29:13 INFO - PROCESS | 26257 | 01:32:16 INFO - PROCESS | 26257 | Cycle 1(1): loaded http://localhost:51411/tests/dromaeo/cssquery-ext.html (next: http://localhost:51411/tests/dromaeo/cssquery-jquery.html) 01:32:16 INFO - PROCESS | 26257 | RSS: Main: 243810304 01:32:16 INFO - PROCESS | 26257 | 01:35:18 INFO - PROCESS | 26257 | Cycle 1(1): loaded http://localhost:51411/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51411/tests/dromaeo/cssquery-mootools.html) 01:35:19 INFO - PROCESS | 26257 | RSS: Main: 242081792 01:35:19 INFO - PROCESS | 26257 | 01:38:21 INFO - PROCESS | 26257 | Cycle 1(1): loaded http://localhost:51411/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51411/tests/dromaeo/cssquery-prototype.html) 01:38:22 INFO - PROCESS | 26257 | RSS: Main: 238637056 01:38:22 INFO - PROCESS | 26257 | 01:41:24 INFO - PROCESS | 26257 | Cycle 1(1): loaded http://localhost:51411/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51411/tests/dromaeo/cssquery-yui.html) 01:41:25 INFO - PROCESS | 26257 | RSS: Main: 227295232 01:41:25 INFO - PROCESS | 26257 | 01:44:28 INFO - PROCESS | 26257 | Cycle 1(1): loaded http://localhost:51411/tests/dromaeo/cssquery-yui.html (next: http://localhost:51411/tests/dromaeo/cssquery-dojo.html) 01:44:28 INFO - PROCESS | 26257 | RSS: Main: 271335424 01:44:28 INFO - PROCESS | 26257 | 01:44:28 INFO - PROCESS | 26257 | __start_tp_report 01:44:28 INFO - PROCESS | 26257 | _x_x_mozilla_page_load 01:44:28 INFO - PROCESS | 26257 | _x_x_mozilla_page_load_details 01:44:28 INFO - PROCESS | 26257 | |i|pagename|runs| 01:44:28 INFO - PROCESS | 26257 | |0;dojo.html;3065.6167979002626;3122.437961166989;3142.292984078583;3151.732102771264;3168.477201261792;5179.352580927384;5252.894942101156;5278.841634750959;5355.91966120508;5406.567474602032;5301.284326615915;5325;5333.919991200135;5352.4915133062395;5363.436839131884;4808.951910480903;4834.951650483503;4909.705417674933;4917.655764096515;5028.094942910275;4950.232713929347;4959.925601115986;4989.715016076532;5015.673981191211;5020.874478138057;4726.480087190424;4741.644376671747;4751.691140075884;4780.760961951906;4783.378160839104;4803.03939212159;4816.44610869751;4817.51824817519;4817.735024573647;4913.6314776391555;4828.855134345975;4849.9757501212625;4851.296561998491;4858.955324605192;4876.926846097312;5074.974625126888;5156.226566015128;5241.528262456397;5260.579153667735;5284.841454756325;5627.634203776742;5649.378568357477;5653.378128405872;5667.433256674341;5680.971595142039;5700.458456446631;5723.685197314146;5727.455891690282;5735.913961290584;5740.942590574125;5218.452062533417;5313.149896016619;5362.142057270857;5371.462853714636;5443.455654434525;5902.527797776168;5914.645121292736;5915.704214789243;5915.970420147958;5918.822435326947;5621.943780562142;5664.6601203927075;5675.489205971482;5678.119891416837;5679.460451257207;5387.568994480433;5510.338759348823;5618.578606604521;5622.746976386073;5645.1532270159805;5628.521575666115;5632.183333416631;5635.802746903839;5641.464060914206;5650.208970744099;5439.075357189287;5610.775568977277;5635.3519345275;5649.887002260014;5659.547236221175;4195.412642230091;4278.893027674333;4283.20760659279;4308.74147551148;4329.393884856123;3863.30460517104;3877.41838724188;3882.3594106972596;3885.261800257942;3902.083010492532;5226.555742761831;5354.544863686552;5355.758990845421;5363.651362661414;5418.945810541923;5595.328560572676;5643.5203007743985;5658.575606829422;5680.687562184037;5750.367459579443;5320.414754377015;5323.893522129536;5324.41431442541;5329.280547126088;5337.412884582693;4754.738489383048;4908.899859235844;4927.5811556017425;4933.703977761345;4975.253711943237;5699.629524080921;5799.82600521985;5816.534677225812;5848.064309710426;5861.765529378862;5687.744051517609;5690.544756419394;5696.8006119785605;5699.487046165865;5700.600957932905;5595.188697638901;5818.7090645466715;5846.766129354778;5850.0932355484965;5850.765969361178;5582.051051321367;5629.971850140887;5645.350784659817;5651.88696226065;5706.942930570641;5622.18478320633;5677.7161141941915;5695.515881149983;5739.081746920473;5741.483266506035;5297.390800058042;5447.754851031634;5469.589780766538;5511.751971161227;5591.329040515164;5510.421405752339;5512.283403157564;5518.365387980273;5519.69641669712;5550.972245138749;5461.754221060141;5470.617056805985;5473.726313684379;5473.781048758005;5516.200150978166;5293.947060529345;5342.572594192533;5478.80824171168;5533.695646739468;5545.861353466195;5270.183121616155;5318.760655770422;5342.626016178986;5365.9463405367005;5369.140937449989 01:44:28 INFO - PROCESS | 26257 | |1;ext.html;584.0567483514124;614.1187396086615;633.6863252689919;646.2309851276982;647.0585298390836;32989.67010329896;43083.35374969374;44202.33696494551;44236.3364549532;47236.52763472364;45255.77372113143;45795.77102114493;45818.312725309144;45828;45964.310535341996;8126.59367031649;8926.73219803407;9090.636374545044;10669.146468282557;10979.560817567288;10489.58041678332;10928.398938058404;10933.343999360064;10937.343759374464;10947.671569852877;10897.509612067475;10965.451727413638;10967.067799237075;10973.670789876316;10978.176636752236;10863.45682715865;10923.071538919201;10934.726631834188;10935.179861510418;10938.179636527253;10764.569417223302;10840.457977101114;10840.861709520466;10848.457577121191;10855.131589472823;42992;43223.135537289076;43235.56764432347;43251;43254;3682.226732386202;3693.926121477555;3803.2013277211818;3825.196708691178;4020.5376381716183;32930.835345823114;33282.10297302416;33565.83217083923;34313.65686343129;34910.301793963976;4347.174036933005;4381.189479946188;4395.384646149541;4415.602595766364;4564.475085365159;329367;331189.3440532806;331976;332806;332855;64221.35778642154;64224.357756422774;64560.67719661372;64593.35406645967;64733.676331618044;67309;67337.66331168411;67393.66303168453;67410.2924339166;67424.6628766853;17196.914015429844;17651.38220162288;17657.911710441367;17672.204750786244;17684;12935.805962910565;12960.546380876624;12978.221306721627;12989.350532473338;12993.740125197442;19299.421017369503;20463.18147274122;20486.078126484343;20511.692324615142;20592.58814823725;7668.80827979305;7812.687492500237;7836.255555722198;7854.528728276322;7961.203879612109;1016.872890888639;1047.8428235764543;1076.9030787229187;1128.7347473343757;1141.8458508101467;32662.24809405481;32972.50541241835;33094;33103.83448082792;33394.83302583471;906.4606559097326;1110.9333439993627;1113.1373185781085;1138.1236447935044;1149.6148790155391;16974.660506789794;17069.31722731077;17152.48542543726;17218.62833480293;17293.65412691739;555046;556478;559298;559304;559387;57106;57702;57717.71141144267;57760.133597996064;57913.13130303049;1257.937103144839;1284.0947132271726;1342.7515909556764;1370.1368138073149;1396.0227840511682;30954.53568196524;34322;34473.31053378868;34569.82715086408;34983.300333993684;50264;50516.74741626268;50844;50923;50926.74536627293;399090;401016;401098;402592;403135;34496.31007379788;43358.78320608503;43951.12097758091;44447.33329000132;47886;48515.27227091667;48773;49636.751816240685;49954.25068624046;50743.23885141652;41642.79178604088;41788.79105604452;42505.787471062446;43076;43330;42151.36772948469;42447.36328955006;42987.78506107449;43003.139937201704;43053.784731077394;40962;43317.3502397458;44444.77777611091;44682;45300.77349613231;36867.446988295735;37557.62442375541;38343.616563834;38415.807920960215;38894.4165837507;28603.42793144167;28823.90761517017;28884;29207.269818253862;29230.853845730635 01:44:28 INFO - PROCESS | 26257 | |2;jquery.html;389.42365299356953;392.51328352842484;395.2786165248419;396.6687815673912;416.76869337517667;13338.062136473278;18397.264109435622;20122.295719649814;20148.59702805943;21438;15881.126538040404;18652.440426787183;19442.805571944275;19519.609607807834;19521.609567808635;5620.494155525992;5788.82633520995;5791.884162316751;5797.507211886995;5799.884002319951;5638.520725738317;5686.147077938322;5721.170430287606;5724.484796368326;5727;5564.248826408444;5652.321721393439;5684.857878553028;5687.687177205252;5708.857278568048;5558.249636299129;5589.692566908839;5667.838093190907;5678.772849086032;5703.230063941398;5066.746662666888;5071.18860982241;5077.49225077493;5084.618653600958;5096.388433388017;22756.886215568815;23436.882815585814;23899.40251493709;24436;24474.143404980918;2515.132279363617;2525.9494810103697;2572.15119010726;2608.8956441742307;3062.0201535508645;14778;14963.102213867203;15043.473478428203;15113.244337783068;15204;1929.324736342283;1969.990150049255;2014.405750303664;2022.5044864008264;2062.391594479632;83602;84174;85112;85609;87199.12800871974;10329.690109296733;10622.89377106219;10751.892481075245;10864.837027444595;10885.619003334845;14760.261986900827;14907.105573665614;14909.70180596382;14915.179665118523;14922.179280139479;8257.42198046143;8319.001719793663;8358.958205209057;8458.577071146417;8551;6987.812071947781;8272.420930534805;8342;8447.788805279793;8449.23956843887;6217.782377616762;6538.771143010067;6653.168353955755;6681.398674119353;6711.228208755958;1851.129968914608;1912.3609419001966;1917.2426891378107;1956.4424139120283;1973.7138114973247;898.2544488074882;1016.3038318751679;1030.4384110659707;1043.6660268713938;1098.8351747237978;19929.501762455766;20534.794652053588;20544.691829622567;20683;20752.688709669368;1012.4026824173773;1032.3444612671008;1049.192122066005;1071.8017166824163;1087.5106202209038;11232.550697972152;11649.12631552637;11816.88183118175;11818.231814932002;11836.289822610672;461506;463068;468747;475607;479192;83302.5834870834;83910;84042.57978710068;85065;85210.14789852146;1030.7526193713604;1034.1364960258118;1056.345066059033;1058.3596923861107;1062.8990245926625;15972.361105556112;17540.473785785936;17887.910560447635;17957.191926363084;18190.272389104815;37475.625243748305;40116.398254025626;40470;40700;41402.585974139874;51000.23499647434;53225.20162197648;53503;53861.19208211958;54063;5597.720113994203;8100.2304781045705;8521;8687.131286871263;8905.866412003954;12714.364281786058;12779.23324600527;13739.725205496034;13801.309934503033;13872;5626.549876009827;8350.874736879074;11235.4382280884;11569.6529104127;11707.648770536898;11207.831882521605;11523.366214857928;11722.648320550397;12080.39598020113;12281;11099.334039957628;11308.264962777394;11363.261388009752;11444.542218311508;11679.76640467203;8704.738857834274;8748.956255218684;8856.822863542564;8859.468431894107;8915;10794.244402892036;11060.446977651247;11238.83141752858;11378.203525753117;11630 01:44:28 INFO - PROCESS | 26257 | |3;mootools.html;1439.4242303078768;1497.0194522587706;1594.704979578778;1761.0754353964176;1778.2353587957182;8370.372222083346;8983.056779038205;8987.37088403812;9089.727308180749;9107.726768196957;7729.536227826335;8486.321094312456;8655.480671159736;8717.651293948235;8840.690575829847;2292.5071109711407;2326.3021093671914;2328.3480625424822;2329.056732023533;2329.440934175794;2285.1430713482446;2316.7104111986;2328.604137296655;2331.3705299569106;2336.5677349690363;1985.4242269741758;2225.499262665903;2296.1389478945393;2302.5164715409783;2302.9884850575722;2317;2332.521833024226;2340.0756701103137;2342.8242881783935;2349.6710460535455;2274.5678321118935;2276.8178545716305;2285.565742508918;2287.8284128690248;2295.977040229593;9318.487483188423;9339.252859771203;9373.953130234306;9375.203107735852;9378.765530861714;5182.792688292501;5239.607029472805;5277.076511610491;5282.81510147143;5337.893242135175;3204.214967332995;3213.855376508063;3272.9509057364157;3319.589174600785;3330.8834190803204;1149.5172027748365;1157.3518829455531;1159.8840115988419;1169.1990986174499;1174.031424075133;12217;12223.93888030563;12234.08244381666;12235.877641223562;12239.20445171061;4337.1976184405985;4475.552444755498;4567.611753000966;4658.045100754337;4662.230731929194;10227.28409011377;10227.539760710786;10236.129928955974;10237.129843963197;10241;5276.445973172838;5319.069162896555;5320.228566857784;5321.467853214647;5324.1747529133045;4724.267738500538;4826.710397376169;4848.854534363974;4856.465788763233;4892.559669629751;3940.842366305373;3968.523777146761;4025.0943537703783;4061.857834975821;4065.2072845794787;1153.7692461507563;1171.4318555500574;1262.4129779652505;1292.7220647560819;1305.5169587252587;995.5669283861544;996.3922007575374;999.7450650084328;1001.5242759689235;1008.7175590834578;5979.491743201789;5992.370801065913;6024.879502409927;6050.727717252734;6138.938610613836;913.5021413329752;992.3153024413132;1009.152312057875;1035.6116456328878;1107.5680484610848;4096;4124.1133156371525;4142.544320124784;4168.854090106832;4200.05498762782;10775.137988960865;11056.281341712764;11200.831987520194;11218.551257949754;11230.3261804292;9911.65309214174;10777.46112694378;11097.1122310215;11113.055390291916;11125.554977800797;8373.790655233546;8643.87034194475;8665.220130188187;8689.000764911989;8742.213200811957;6070.605410648293;6250.281217660027;6274.462756624656;6335.1447554579545;6335.271443784024;10380.532876020447;10566.894331056592;10653.627123050655;10656.8934310659;10666.466676665981;9921.454320012468;10484.52819623134;10948;11028.669139925814;11081.944590276997;8367.707130250412;8570;8582.871256931026;8631.13688631157;8636.222739953435;8513.276371508491;8531.23218910301;8531.872021919551;8587.570621469027;8639.784005399915;6420.935790642221;7703.88444173349;7815.570143641927;7855.135935047026;8011.599420028859;7546.735864244725;7621.1616722161625;7679.308862202429;7753.108392534705;7789.104253010976;7290.234525374759;7325.304096110861;7330.5968171751065;7337.706491740484;7414.295641914009;5429.809956651498;5439.374471935778;5461.644993075437;5493.587980901369;5536.031194541019;5304.283921670525;5306.177542480922;5490.6431081979545;5714.142878568248;5855.151003104611 01:44:28 INFO - PROCESS | 26257 | |4;prototype.html;321.83264702354774;327.7541843617287;339.4111217038438;340.4416756519308;344.84481983107605;5270.710110943896;5362.43694412087;5435.613918450795;5464.333378319616;5482.5339846113075;5332.840014799563;5345.01117293301;5365.517103460687;5419.376771671259;5430;4256.936145957813;4266.146770645883;4266.2320782259185;4278.679099067583;4289.764062976535;4019.738716983387;4109.958900411002;4279.33670281107;4279.87160385189;4290.2706539888295;4183.17635595973;4211.684123690736;4218.535961044283;4228.577142285778;4232.809523571431;4208.326667733163;4228.344606585984;4241.384999175102;4253.617174454314;4254.42565253693;3642.1805093853936;3724.255148970217;3769.717271204643;3774.6036666149935;3781.5462144542557;5195.896082078375;5196.2465442511;5204.386640141568;5207.583393328525;5211.322528071327;4804.654696684934;4814.9518504815205;4819.253015782524;4825.179719447702;4829.6860704054125;5332.413434522199;5634.464725851038;5648.802291919804;5652.180433837112;5657.1514272858985;4019.8593049243427;4060.675145988314;4066.6136717011836;4067.7559346439307;4070.2266569352023;5744.109663002241;5793.536517078624;5816.302043754777;5825.533957283407;5835.4748072673665;3865.130345672201;4098.159877225162;4103.138340948374;4109.198706252312;4137.77242251673;4184.727992680466;4190.371444283382;4196.664266858644;4208.538005266892;4221.7255878367805;4795.5853023358195;4802.111609352281;4821.276808478686;4829.396325459317;4840.854774356704;5585.162225666101;5694.231278777312;5696.3511966935575;5708.257926469532;5711.457411545896;1365.32416453854;1366.719822436398;1366.90647482014;1380.523719316834;1383.7301726163503;966.6809952715587;967.3699815810382;971.5433746139303;975.6390135649855;990.4305024610877;5316.883454474526;5352.91970620441;5357.544608708304;5365.382980957162;5376.704281264568;5638.154276858504;5653.717314134276;5672.688002159921;5681.9431805681415;5702.885942281131;5105.5149760772665;5353.089974704231;5370.301860758076;5385.3268341457315;5388.973055134699;2678.866056697196;2684.2686467228527;2700.1494529223232;2700.7434293742062;2703.9459210815676;5193.221626429842;5198.298229739013;5229.398619158769;5235.345581802275;5237.869053273623;5183.263606691725;5495.120780675073;5931.4958228550195;5974.699740599814;5982.790602328984;5995.520358371407;6004.759809607567;6007.189029480965;6029.939700602938;6040.244969378739;5612.494875461228;5750.942490575041;5775.711214439345;5787.160861674949;5811.215485909348;5729.341125770423;5736.168255602997;5738.68437235956;5756.194132821324;5758.62568933018;5961.046232602763;5971.044632858721;5973.581849270509;5996.370381110095;5998.730057147526;3897.493325867619;4110.445089912943;4130.318497448007;4148.294789885666;4179.226843034048;5461.508464238079;5611.943880561143;5720.082757793472;5749.706316078848;5779.6014653918155;5614.41048689898;5636.943630563642;5638.195777351209;5647;5660.377358490645;5478.233047373451;5528.474794894479;5539.944600554104;5558.694271814928;5567.63810352342;5291.603129765206;5548.278723765885;5624.831255062355;5627.746751396279;5628;5661.122526008476;5688.943110568841;5691.800786972602;5697.262334987869;5701.743421545957;5424.8842951249835;5518.503334699896;5569.357039673387;5577.8047768327915;5582.3859375467855 01:44:28 INFO - PROCESS | 26257 | |5;yui.html;723.8697034533782;752.604882436721;792.1840504280593;813.5566116466525;868.461553836621;15425.845741542582;15714.607134821636;16614.916925415386;16642.91678541607;16662.1668916554;14202;14390.640233994156;14399.280035998185;14436.206008669518;14436.422543098264;660.4980215036559;795.4749865089043;807.4267270238123;824.3034635732796;829.1542626520945;838.0362583029535;839.8446287436843;839.9580020998956;841.949483031017;842.2167384332569;869.8651708985118;871.7297637732323;871.9972032163;873.5501216873315;882.1487264789477;696.1263614164217;722.5736815278984;725.8366867454833;842.4103127810496;868.5266529741275;637.6046850952439;640.1613885809604;641.2529403245213;641.8395401149712;642.0433554004546;14821.92589037048;14839;14969.775453368207;15017.24913754308;15026.248687565687;14255.78616320756;14428.927855360762;14442.133471991714;14517.927410362987;14591.78112328316;12634.494620215271;12770.80843787344;12842.293673847935;12879.549215777497;13452.529161479399;4334.393184954109;4383.189110014658;4404.581564751344;4488.349189367556;4496.392986946753;84939.57530212372;85441.57279213626;85685;85694;86074.56962715146;10862.945685271523;11162;11355.318680879174;11467.139964502696;11468.770624587629;22287.665685014737;22366.66450003251;22372.776272237395;22396.216132435286;22405.43986400353;8026.197380262044;8164.142765009588;8365.28895043928;8547.74356769298;8576.785580360416;4736.100140973204;4764.404449443819;4803.327534145223;4812.687175333592;5062.7468626568525;3295.0938491914435;3385.7968521888274;3389.796612203276;3389.847456864447;3396.8811091611674;565.6747370262116;574.70115539919;586.762361243697;602.1539736669898;609.135028259872;604.2778879239355;659.1924892007348;667.4960404894274;684.1482354468718;712.5866997141645;8568.443051201652;8736.301095912311;9081.091890810865;9231;9434.339596228336;601.1793901324747;604.6885853785304;624.0857144283556;624.7532224771281;635.7202830754453;4093.3655283431117;4274.123804620045;4448.221561226773;4448.5773851484055;4458.665600080007;108078.45960770303;126207;127263.36368318099;128457.36569757306;130953.34523327513;114396.42801786105;114965.4251728736;115294;115756.42121789337;115785.15826154703;97043.51478242564;97267.51366243123;97314;97837;100462;7997.7600671979935;8037.879431808645;8140.75577732669;8223.629936652746;8304.58477076156;54362.18456723231;55783;55901.44098558962;57150.142747859645;57160.590682939845;52825.20762188493;80407;81019;81687;83654.58172709098;11467.655970320904;11483.196176267915;11845.526178952745;11919.56965164186;11934.283942963102;12576.119671622899;12623.684407889876;13234.338283086;13272.27002514871;13386.129901556367;11133.665990020312;11255.212135150461;11357.716057098638;11746.29522228669;12047.216930899463;11306.434678265889;11502.194846360675;11553.768924621629;11750.529978800752;11873.465694043616;10628.787424251317;10889.237753357189;11155.888441115809;11414.48634811452;11421.657350279505;9485.383450075724;9644.373115747454;9657.613695452384;9678.080582344666;9764.804703906024;9432.386894852087;9433.858492122761;9626.855597165908;9642.373245739005;9731.270154738564 01:44:28 INFO - PROCESS | 26257 | __end_tp_report 01:44:28 INFO - PROCESS | 26257 | __start_cc_report 01:44:28 INFO - PROCESS | 26257 | _x_x_mozilla_cycle_collect,1029 01:44:28 INFO - PROCESS | 26257 | __end_cc_report 01:44:28 INFO - PROCESS | 26257 | __startTimestamp1467708268614__endTimestamp 01:44:28 INFO - PROCESS | 26257 | 01:44:28 INFO - PROCESS | 26257 | ------- Summary: start ------- 01:44:28 INFO - PROCESS | 26257 | Number of tests: 6 01:44:28 INFO - PROCESS | 26257 | 01:44:28 INFO - PROCESS | 26257 | [#0] dojo.html Cycles:165 Average:5262.27 Median:5418.95 stddev:585.23 (10.8%) stddev-sans-first:561.08 01:44:28 INFO - PROCESS | 26257 | Values: 3065.6 3122.4 3142.3 3151.7 3168.5 5179.4 5252.9 5278.8 5355.9 5406.6 5301.3 5325.0 5333.9 5352.5 5363.4 4809.0 4835.0 4909.7 4917.7 5028.1 4950.2 4959.9 4989.7 5015.7 5020.9 4726.5 4741.6 4751.7 4780.8 4783.4 4803.0 4816.4 4817.5 4817.7 4913.6 4828.9 4850.0 4851.3 4859.0 4876.9 5075.0 5156.2 5241.5 5260.6 5284.8 5627.6 5649.4 5653.4 5667.4 5681.0 5700.5 5723.7 5727.5 5735.9 5740.9 5218.5 5313.1 5362.1 5371.5 5443.5 5902.5 5914.6 5915.7 5916.0 5918.8 5621.9 5664.7 5675.5 5678.1 5679.5 5387.6 5510.3 5618.6 5622.7 5645.2 5628.5 5632.2 5635.8 5641.5 5650.2 5439.1 5610.8 5635.4 5649.9 5659.5 4195.4 4278.9 4283.2 4308.7 4329.4 3863.3 3877.4 3882.4 3885.3 3902.1 5226.6 5354.5 5355.8 5363.7 5418.9 5595.3 5643.5 5658.6 5680.7 5750.4 5320.4 5323.9 5324.4 5329.3 5337.4 4754.7 4908.9 4927.6 4933.7 4975.3 5699.6 5799.8 5816.5 5848.1 5861.8 5687.7 5690.5 5696.8 5699.5 5700.6 5595.2 5818.7 5846.8 5850.1 5850.8 5582.1 5630.0 5645.4 5651.9 5706.9 5622.2 5677.7 5695.5 5739.1 5741.5 5297.4 5447.8 5469.6 5511.8 5591.3 5510.4 5512.3 5518.4 5519.7 5551.0 5461.8 5470.6 5473.7 5473.8 5516.2 5293.9 5342.6 5478.8 5533.7 5545.9 5270.2 5318.8 5342.6 5365.9 5369.1 01:44:28 INFO - PROCESS | 26257 | 01:44:28 INFO - PROCESS | 26257 | [#1] ext.html Cycles:180 Average:60905.05 Median:38655.11 stddev:116579.45 (301.6%) stddev-sans-first:116818.51 01:44:28 INFO - PROCESS | 26257 | Values: 584.1 614.1 633.7 646.2 647.1 32989.7 43083.4 44202.3 44236.3 47236.5 45255.8 45795.8 45818.3 45828.0 45964.3 8126.6 8926.7 9090.6 10669.1 10979.6 10489.6 10928.4 10933.3 10937.3 10947.7 10897.5 10965.5 10967.1 10973.7 10978.2 10863.5 10923.1 10934.7 10935.2 10938.2 10764.6 10840.5 10840.9 10848.5 10855.1 42992.0 43223.1 43235.6 43251.0 43254.0 3682.2 3693.9 3803.2 3825.2 4020.5 32930.8 33282.1 33565.8 34313.7 34910.3 4347.2 4381.2 4395.4 4415.6 4564.5 329367.0 331189.3 331976.0 332806.0 332855.0 64221.4 64224.4 64560.7 64593.4 64733.7 67309.0 67337.7 67393.7 67410.3 67424.7 17196.9 17651.4 17657.9 17672.2 17684.0 12935.8 12960.5 12978.2 12989.4 12993.7 19299.4 20463.2 20486.1 20511.7 20592.6 7668.8 7812.7 7836.3 7854.5 7961.2 1016.9 1047.8 1076.9 1128.7 1141.8 32662.2 32972.5 33094.0 33103.8 33394.8 906.5 1110.9 1113.1 1138.1 1149.6 16974.7 17069.3 17152.5 17218.6 17293.7 555046.0 556478.0 559298.0 559304.0 559387.0 57106.0 57702.0 57717.7 57760.1 57913.1 1257.9 1284.1 1342.8 1370.1 1396.0 30954.5 34322.0 34473.3 34569.8 34983.3 50264.0 50516.7 50844.0 50923.0 50926.7 399090.0 401016.0 401098.0 402592.0 403135.0 34496.3 43358.8 43951.1 44447.3 47886.0 48515.3 48773.0 49636.8 49954.3 50743.2 41642.8 41788.8 42505.8 43076.0 43330.0 42151.4 42447.4 42987.8 43003.1 43053.8 40962.0 43317.4 44444.8 44682.0 45300.8 36867.4 37557.6 38343.6 38415.8 38894.4 28603.4 28823.9 28884.0 29207.3 29230.9 01:44:28 INFO - PROCESS | 26257 | 01:44:28 INFO - PROCESS | 26257 | [#2] jquery.html Cycles:180 Average:28299.74 Median:24455.07 stddev:77390.23 (316.5%) stddev-sans-first:77578.96 01:44:28 INFO - PROCESS | 26257 | Values: 389.4 392.5 395.3 396.7 416.8 13338.1 18397.3 20122.3 20148.6 21438.0 15881.1 18652.4 19442.8 19519.6 19521.6 5620.5 5788.8 5791.9 5797.5 5799.9 5638.5 5686.1 5721.2 5724.5 5727.0 5564.2 5652.3 5684.9 5687.7 5708.9 5558.2 5589.7 5667.8 5678.8 5703.2 5066.7 5071.2 5077.5 5084.6 5096.4 22756.9 23436.9 23899.4 24436.0 24474.1 2515.1 2525.9 2572.2 2608.9 3062.0 14778.0 14963.1 15043.5 15113.2 15204.0 1929.3 1970.0 2014.4 2022.5 2062.4 83602.0 84174.0 85112.0 85609.0 87199.1 10329.7 10622.9 10751.9 10864.8 10885.6 14760.3 14907.1 14909.7 14915.2 14922.2 8257.4 8319.0 8359.0 8458.6 8551.0 6987.8 8272.4 8342.0 8447.8 8449.2 6217.8 6538.8 6653.2 6681.4 6711.2 1851.1 1912.4 1917.2 1956.4 1973.7 898.3 1016.3 1030.4 1043.7 1098.8 19929.5 20534.8 20544.7 20683.0 20752.7 1012.4 1032.3 1049.2 1071.8 1087.5 11232.6 11649.1 11816.9 11818.2 11836.3 461506.0 463068.0 468747.0 475607.0 479192.0 83302.6 83910.0 84042.6 85065.0 85210.1 1030.8 1034.1 1056.3 1058.4 1062.9 15972.4 17540.5 17887.9 17957.2 18190.3 37475.6 40116.4 40470.0 40700.0 41402.6 51000.2 53225.2 53503.0 53861.2 54063.0 5597.7 8100.2 8521.0 8687.1 8905.9 12714.4 12779.2 13739.7 13801.3 13872.0 5626.5 8350.9 11235.4 11569.7 11707.6 11207.8 11523.4 11722.6 12080.4 12281.0 11099.3 11308.3 11363.3 11444.5 11679.8 8704.7 8749.0 8856.8 8859.5 8915.0 10794.2 11060.4 11238.8 11378.2 11630.0 01:44:28 INFO - PROCESS | 26257 | 01:44:28 INFO - PROCESS | 26257 | [#3] mootools.html Cycles:180 Average:5913.68 Median:4612.83 stddev:3369.28 (73.0%) stddev-sans-first:3361.95 01:44:28 INFO - PROCESS | 26257 | Values: 1439.4 1497.0 1594.7 1761.1 1778.2 8370.4 8983.1 8987.4 9089.7 9107.7 7729.5 8486.3 8655.5 8717.7 8840.7 2292.5 2326.3 2328.3 2329.1 2329.4 2285.1 2316.7 2328.6 2331.4 2336.6 1985.4 2225.5 2296.1 2302.5 2303.0 2317.0 2332.5 2340.1 2342.8 2349.7 2274.6 2276.8 2285.6 2287.8 2296.0 9318.5 9339.3 9374.0 9375.2 9378.8 5182.8 5239.6 5277.1 5282.8 5337.9 3204.2 3213.9 3273.0 3319.6 3330.9 1149.5 1157.4 1159.9 1169.2 1174.0 12217.0 12223.9 12234.1 12235.9 12239.2 4337.2 4475.6 4567.6 4658.0 4662.2 10227.3 10227.5 10236.1 10237.1 10241.0 5276.4 5319.1 5320.2 5321.5 5324.2 4724.3 4826.7 4848.9 4856.5 4892.6 3940.8 3968.5 4025.1 4061.9 4065.2 1153.8 1171.4 1262.4 1292.7 1305.5 995.6 996.4 999.7 1001.5 1008.7 5979.5 5992.4 6024.9 6050.7 6138.9 913.5 992.3 1009.2 1035.6 1107.6 4096.0 4124.1 4142.5 4168.9 4200.1 10775.1 11056.3 11200.8 11218.6 11230.3 9911.7 10777.5 11097.1 11113.1 11125.6 8373.8 8643.9 8665.2 8689.0 8742.2 6070.6 6250.3 6274.5 6335.1 6335.3 10380.5 10566.9 10653.6 10656.9 10666.5 9921.5 10484.5 10948.0 11028.7 11081.9 8367.7 8570.0 8582.9 8631.1 8636.2 8513.3 8531.2 8531.9 8587.6 8639.8 6420.9 7703.9 7815.6 7855.1 8011.6 7546.7 7621.2 7679.3 7753.1 7789.1 7290.2 7325.3 7330.6 7337.7 7414.3 5429.8 5439.4 5461.6 5493.6 5536.0 5304.3 5306.2 5490.6 5714.1 5855.2 01:44:28 INFO - PROCESS | 26257 | 01:44:28 INFO - PROCESS | 26257 | [#4] prototype.html Cycles:180 Average:4708.45 Median:5359.99 stddev:1390.26 (25.9%) stddev-sans-first:1354.61 01:44:28 INFO - PROCESS | 26257 | Values: 321.8 327.8 339.4 340.4 344.8 5270.7 5362.4 5435.6 5464.3 5482.5 5332.8 5345.0 5365.5 5419.4 5430.0 4256.9 4266.1 4266.2 4278.7 4289.8 4019.7 4110.0 4279.3 4279.9 4290.3 4183.2 4211.7 4218.5 4228.6 4232.8 4208.3 4228.3 4241.4 4253.6 4254.4 3642.2 3724.3 3769.7 3774.6 3781.5 5195.9 5196.2 5204.4 5207.6 5211.3 4804.7 4815.0 4819.3 4825.2 4829.7 5332.4 5634.5 5648.8 5652.2 5657.2 4019.9 4060.7 4066.6 4067.8 4070.2 5744.1 5793.5 5816.3 5825.5 5835.5 3865.1 4098.2 4103.1 4109.2 4137.8 4184.7 4190.4 4196.7 4208.5 4221.7 4795.6 4802.1 4821.3 4829.4 4840.9 5585.2 5694.2 5696.4 5708.3 5711.5 1365.3 1366.7 1366.9 1380.5 1383.7 966.7 967.4 971.5 975.6 990.4 5316.9 5352.9 5357.5 5365.4 5376.7 5638.2 5653.7 5672.7 5681.9 5702.9 5105.5 5353.1 5370.3 5385.3 5389.0 2678.9 2684.3 2700.1 2700.7 2703.9 5193.2 5198.3 5229.4 5235.3 5237.9 5183.3 5495.1 5931.5 5974.7 5982.8 5995.5 6004.8 6007.2 6029.9 6040.2 5612.5 5750.9 5775.7 5787.2 5811.2 5729.3 5736.2 5738.7 5756.2 5758.6 5961.0 5971.0 5973.6 5996.4 5998.7 3897.5 4110.4 4130.3 4148.3 4179.2 5461.5 5611.9 5720.1 5749.7 5779.6 5614.4 5636.9 5638.2 5647.0 5660.4 5478.2 5528.5 5539.9 5558.7 5567.6 5291.6 5548.3 5624.8 5627.7 5628.0 5661.1 5688.9 5691.8 5697.3 5701.7 5424.9 5518.5 5569.4 5577.8 5582.4 01:44:28 INFO - PROCESS | 26257 | 01:44:28 INFO - PROCESS | 26257 | [#5] yui.html Cycles:180 Average:21908.10 Median:28943.98 stddev:33565.39 (116.0%) stddev-sans-first:33621.86 01:44:28 INFO - PROCESS | 26257 | Values: 723.9 752.6 792.2 813.6 868.5 15425.8 15714.6 16614.9 16642.9 16662.2 14202.0 14390.6 14399.3 14436.2 14436.4 660.5 795.5 807.4 824.3 829.2 838.0 839.8 840.0 841.9 842.2 869.9 871.7 872.0 873.6 882.1 696.1 722.6 725.8 842.4 868.5 637.6 640.2 641.3 641.8 642.0 14821.9 14839.0 14969.8 15017.2 15026.2 14255.8 14428.9 14442.1 14517.9 14591.8 12634.5 12770.8 12842.3 12879.5 13452.5 4334.4 4383.2 4404.6 4488.3 4496.4 84939.6 85441.6 85685.0 85694.0 86074.6 10862.9 11162.0 11355.3 11467.1 11468.8 22287.7 22366.7 22372.8 22396.2 22405.4 8026.2 8164.1 8365.3 8547.7 8576.8 4736.1 4764.4 4803.3 4812.7 5062.7 3295.1 3385.8 3389.8 3389.8 3396.9 565.7 574.7 586.8 602.2 609.1 604.3 659.2 667.5 684.1 712.6 8568.4 8736.3 9081.1 9231.0 9434.3 601.2 604.7 624.1 624.8 635.7 4093.4 4274.1 4448.2 4448.6 4458.7 108078.5 126207.0 127263.4 128457.4 130953.3 114396.4 114965.4 115294.0 115756.4 115785.2 97043.5 97267.5 97314.0 97837.0 100462.0 7997.8 8037.9 8140.8 8223.6 8304.6 54362.2 55783.0 55901.4 57150.1 57160.6 52825.2 80407.0 81019.0 81687.0 83654.6 11467.7 11483.2 11845.5 11919.6 11934.3 12576.1 12623.7 13234.3 13272.3 13386.1 11133.7 11255.2 11357.7 11746.3 12047.2 11306.4 11502.2 11553.8 11750.5 11873.5 10628.8 10889.2 11155.9 11414.5 11421.7 9485.4 9644.4 9657.6 9678.1 9764.8 9432.4 9433.9 9626.9 9642.4 9731.3 01:44:28 INFO - PROCESS | 26257 | -------- Summary: end -------- 01:44:28 INFO - PROCESS | 26257 | 01:44:29 INFO - TEST-INFO | 26257: exit 0 01:44:29 INFO - TEST-OK | dromaeo_css | took 1114577ms 01:44:29 INFO - TEST-START | kraken 01:44:29 INFO - operating with platform_type : linux_ 01:44:29 INFO - Initialising browser for kraken test... 01:44:29 INFO - TEST-INFO | started process 26453 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMDwg2P/profile http://localhost:51411/getInfo.html) 01:44:33 INFO - PROCESS | 26453 | __metrics Screen width/height:1600/1200 01:44:33 INFO - PROCESS | 26453 | colorDepth:24 01:44:33 INFO - PROCESS | 26453 | Browser inner width/height: 1024/697 01:44:33 INFO - PROCESS | 26453 | __metrics 01:44:34 INFO - PROCESS | 26453 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:44:35 INFO - TEST-INFO | 26453: exit 0 01:44:35 INFO - Browser initialized. 01:44:35 INFO - Running cycle 1/1 for kraken test... 01:44:35 INFO - TEST-INFO | started process 26538 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMDwg2P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:44:47 INFO - PROCESS | 26538 | RSS: Main: 157032448 01:44:47 INFO - PROCESS | 26538 | 01:44:49 INFO - PROCESS | 26538 | Cycle 1(1): loaded http://localhost:51411/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51411/tests/kraken/driver.html?testName=audio-beat-detection) 01:44:50 INFO - PROCESS | 26538 | RSS: Main: 215064576 01:44:50 INFO - PROCESS | 26538 | 01:44:53 INFO - PROCESS | 26538 | Cycle 1(1): loaded http://localhost:51411/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51411/tests/kraken/driver.html?testName=audio-dft) 01:44:53 INFO - PROCESS | 26538 | RSS: Main: 203915264 01:44:53 INFO - PROCESS | 26538 | 01:44:56 INFO - PROCESS | 26538 | Cycle 1(1): loaded http://localhost:51411/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51411/tests/kraken/driver.html?testName=audio-fft) 01:44:57 INFO - PROCESS | 26538 | RSS: Main: 269172736 01:44:57 INFO - PROCESS | 26538 | 01:44:59 INFO - PROCESS | 26538 | Cycle 1(1): loaded http://localhost:51411/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51411/tests/kraken/driver.html?testName=audio-oscillator) 01:45:00 INFO - PROCESS | 26538 | RSS: Main: 180793344 01:45:00 INFO - PROCESS | 26538 | 01:45:02 INFO - PROCESS | 26538 | Cycle 1(1): loaded http://localhost:51411/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51411/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:45:02 INFO - PROCESS | 26538 | RSS: Main: 185147392 01:45:02 INFO - PROCESS | 26538 | 01:45:05 INFO - PROCESS | 26538 | Cycle 1(1): loaded http://localhost:51411/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51411/tests/kraken/driver.html?testName=imaging-darkroom) 01:45:06 INFO - PROCESS | 26538 | RSS: Main: 219357184 01:45:06 INFO - PROCESS | 26538 | 01:45:09 INFO - PROCESS | 26538 | Cycle 1(1): loaded http://localhost:51411/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51411/tests/kraken/driver.html?testName=imaging-desaturate) 01:45:10 INFO - PROCESS | 26538 | RSS: Main: 221057024 01:45:10 INFO - PROCESS | 26538 | 01:45:13 INFO - PROCESS | 26538 | Cycle 1(1): loaded http://localhost:51411/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51411/tests/kraken/driver.html?testName=json-parse-financial) 01:45:13 INFO - PROCESS | 26538 | RSS: Main: 221224960 01:45:13 INFO - PROCESS | 26538 | 01:45:15 INFO - PROCESS | 26538 | Cycle 1(1): loaded http://localhost:51411/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51411/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:45:16 INFO - PROCESS | 26538 | RSS: Main: 208130048 01:45:16 INFO - PROCESS | 26538 | 01:45:17 INFO - PROCESS | 26538 | Cycle 1(1): loaded http://localhost:51411/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51411/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:45:18 INFO - PROCESS | 26538 | RSS: Main: 211316736 01:45:18 INFO - PROCESS | 26538 | 01:45:20 INFO - PROCESS | 26538 | Cycle 1(1): loaded http://localhost:51411/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51411/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:45:21 INFO - PROCESS | 26538 | RSS: Main: 213622784 01:45:21 INFO - PROCESS | 26538 | 01:45:23 INFO - PROCESS | 26538 | Cycle 1(1): loaded http://localhost:51411/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51411/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:45:24 INFO - PROCESS | 26538 | RSS: Main: 225640448 01:45:24 INFO - PROCESS | 26538 | 01:45:26 INFO - PROCESS | 26538 | Cycle 1(1): loaded http://localhost:51411/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51411/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:45:27 INFO - PROCESS | 26538 | RSS: Main: 225792000 01:45:27 INFO - PROCESS | 26538 | 01:45:29 INFO - PROCESS | 26538 | Cycle 1(1): loaded http://localhost:51411/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51411/tests/kraken/driver.html?testName=ai-astar) 01:45:29 INFO - PROCESS | 26538 | RSS: Main: 268308480 01:45:29 INFO - PROCESS | 26538 | 01:45:29 INFO - PROCESS | 26538 | __start_tp_report 01:45:29 INFO - PROCESS | 26538 | _x_x_mozilla_page_load 01:45:29 INFO - PROCESS | 26538 | _x_x_mozilla_page_load_details 01:45:29 INFO - PROCESS | 26538 | |i|pagename|runs| 01:45:29 INFO - PROCESS | 26538 | |0;ai-astar;103;112;110;110;112;111;110;110;113;111 01:45:29 INFO - PROCESS | 26538 | |1;audio-beat-detection;151;117;122;167;118;118;149;116;148;116 01:45:29 INFO - PROCESS | 26538 | |2;audio-dft;160;162;161;160;161;161;160;161;161;162 01:45:29 INFO - PROCESS | 26538 | |3;audio-fft;74;73;75;127;76;76;75;74;104;75 01:45:29 INFO - PROCESS | 26538 | |4;audio-oscillator;85;84;117;83;83;83;121;84;85;125 01:45:29 INFO - PROCESS | 26538 | |5;imaging-gaussian-blur;117;118;117;116;117;116;117;117;116;116 01:45:29 INFO - PROCESS | 26538 | |6;imaging-darkroom;146;146;146;145;145;145;145;145;145;145 01:45:29 INFO - PROCESS | 26538 | |7;imaging-desaturate;95;96;95;95;94;95;95;95;96;94 01:45:29 INFO - PROCESS | 26538 | |8;json-parse-financial;53;52;53;54;54;53;54;54;54;55 01:45:29 INFO - PROCESS | 26538 | |9;json-stringify-tinderbox;60;61;60;59;60;59;60;60;60;60 01:45:29 INFO - PROCESS | 26538 | |10;stanford-crypto-aes;81;84;75;77;84;78;75;81;76;80 01:45:29 INFO - PROCESS | 26538 | |11;stanford-crypto-ccm;124;118;119;126;117;119;119;130;162;120 01:45:29 INFO - PROCESS | 26538 | |12;stanford-crypto-pbkdf2;157;156;156;155;160;157;156;157;157;156 01:45:29 INFO - PROCESS | 26538 | |13;stanford-crypto-sha256-iterative;63;61;62;62;62;65;62;62;60;60 01:45:29 INFO - PROCESS | 26538 | __end_tp_report 01:45:29 INFO - PROCESS | 26538 | __start_cc_report 01:45:29 INFO - PROCESS | 26538 | _x_x_mozilla_cycle_collect,1676 01:45:29 INFO - PROCESS | 26538 | __end_cc_report 01:45:29 INFO - PROCESS | 26538 | __startTimestamp1467708329348__endTimestamp 01:45:29 INFO - PROCESS | 26538 | 01:45:29 INFO - PROCESS | 26538 | ------- Summary: start ------- 01:45:29 INFO - PROCESS | 26538 | Number of tests: 14 01:45:29 INFO - PROCESS | 26538 | 01:45:29 INFO - PROCESS | 26538 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.74 (2.5%) stddev-sans-first:1.12 01:45:29 INFO - PROCESS | 26538 | Values: 103.0 112.0 110.0 110.0 112.0 111.0 110.0 110.0 113.0 111.0 01:45:29 INFO - PROCESS | 26538 | 01:45:29 INFO - PROCESS | 26538 | [#1] audio-beat-detection Cycles:10 Average:132.20 Median:135.00 stddev:19.32 (14.3%) stddev-sans-first:19.26 01:45:29 INFO - PROCESS | 26538 | Values: 151.0 117.0 122.0 167.0 118.0 118.0 149.0 116.0 148.0 116.0 01:45:29 INFO - PROCESS | 26538 | 01:45:29 INFO - PROCESS | 26538 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 01:45:29 INFO - PROCESS | 26538 | Values: 160.0 162.0 161.0 160.0 161.0 161.0 160.0 161.0 161.0 162.0 01:45:29 INFO - PROCESS | 26538 | 01:45:29 INFO - PROCESS | 26538 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.00 stddev:18.04 (24.1%) stddev-sans-first:18.84 01:45:29 INFO - PROCESS | 26538 | Values: 74.0 73.0 75.0 127.0 76.0 76.0 75.0 74.0 104.0 75.0 01:45:29 INFO - PROCESS | 26538 | 01:45:29 INFO - PROCESS | 26538 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:83.50 stddev:18.06 (21.6%) stddev-sans-first:18.78 01:45:29 INFO - PROCESS | 26538 | Values: 85.0 84.0 117.0 83.0 83.0 83.0 121.0 84.0 85.0 125.0 01:45:29 INFO - PROCESS | 26538 | 01:45:29 INFO - PROCESS | 26538 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 01:45:29 INFO - PROCESS | 26538 | Values: 117.0 118.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 116.0 01:45:29 INFO - PROCESS | 26538 | 01:45:29 INFO - PROCESS | 26538 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 01:45:29 INFO - PROCESS | 26538 | Values: 146.0 146.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 01:45:29 INFO - PROCESS | 26538 | 01:45:29 INFO - PROCESS | 26538 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 01:45:29 INFO - PROCESS | 26538 | Values: 95.0 96.0 95.0 95.0 94.0 95.0 95.0 95.0 96.0 94.0 01:45:29 INFO - PROCESS | 26538 | 01:45:29 INFO - PROCESS | 26538 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:0.84 (1.6%) stddev-sans-first:0.87 01:45:29 INFO - PROCESS | 26538 | Values: 53.0 52.0 53.0 54.0 54.0 53.0 54.0 54.0 54.0 55.0 01:45:29 INFO - PROCESS | 26538 | 01:45:29 INFO - PROCESS | 26538 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 01:45:29 INFO - PROCESS | 26538 | Values: 60.0 61.0 60.0 59.0 60.0 59.0 60.0 60.0 60.0 60.0 01:45:29 INFO - PROCESS | 26538 | 01:45:29 INFO - PROCESS | 26538 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:80.50 stddev:3.41 (4.2%) stddev-sans-first:3.55 01:45:29 INFO - PROCESS | 26538 | Values: 81.0 84.0 75.0 77.0 84.0 78.0 75.0 81.0 76.0 80.0 01:45:29 INFO - PROCESS | 26538 | 01:45:29 INFO - PROCESS | 26538 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:122.00 stddev:13.50 (11.1%) stddev-sans-first:14.31 01:45:29 INFO - PROCESS | 26538 | Values: 124.0 118.0 119.0 126.0 117.0 119.0 119.0 130.0 162.0 120.0 01:45:29 INFO - PROCESS | 26538 | 01:45:29 INFO - PROCESS | 26538 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.70 Median:157.00 stddev:1.34 (0.9%) stddev-sans-first:1.41 01:45:29 INFO - PROCESS | 26538 | Values: 157.0 156.0 156.0 155.0 160.0 157.0 156.0 157.0 157.0 156.0 01:45:29 INFO - PROCESS | 26538 | 01:45:29 INFO - PROCESS | 26538 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:1.45 (2.3%) stddev-sans-first:1.48 01:45:29 INFO - PROCESS | 26538 | Values: 63.0 61.0 62.0 62.0 62.0 65.0 62.0 62.0 60.0 60.0 01:45:29 INFO - PROCESS | 26538 | -------- Summary: end -------- 01:45:29 INFO - PROCESS | 26538 | 01:45:30 INFO - TEST-INFO | 26538: exit 0 01:45:30 INFO - TEST-OK | kraken | took 60992ms 01:45:30 INFO - SUITE-END | took 1175s 01:45:30 INFO - Completed test suite (00:19:35) 01:45:30 INFO - javascript benchmark 01:45:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3065.6167979002626, 3122.437961166989, 3142.292984078583, 3151.732102771264, 3168.477201261792, 5179.352580927384, 5252.894942101156, 5278.841634750959, 5355.91966120508, 5406.567474602032, 5301.284326615915, 5325.0, 5333.919991200135, 5352.4915133062395, 5363.436839131884, 4808.951910480903, 4834.951650483503, 4909.705417674933, 4917.655764096515, 5028.094942910275, 4950.232713929347, 4959.925601115986, 4989.715016076532, 5015.673981191211, 5020.874478138057, 4726.480087190424, 4741.644376671747, 4751.691140075884, 4780.760961951906, 4783.378160839104, 4803.03939212159, 4816.44610869751, 4817.51824817519, 4817.735024573647, 4913.6314776391555, 4828.855134345975, 4849.9757501212625, 4851.296561998491, 4858.955324605192, 4876.926846097312, 5074.974625126888, 5156.226566015128, 5241.528262456397, 5260.579153667735, 5284.841454756325, 5627.634203776742, 5649.378568357477, 5653.378128405872, 5667.433256674341, 5680.971595142039, 5700.458456446631, 5723.685197314146, 5727.455891690282, 5735.913961290584, 5740.942590574125, 5218.452062533417, 5313.149896016619, 5362.142057270857, 5371.462853714636, 5443.455654434525, 5902.527797776168, 5914.645121292736, 5915.704214789243, 5915.970420147958, 5918.822435326947, 5621.943780562142, 5664.6601203927075, 5675.489205971482, 5678.119891416837, 5679.460451257207, 5387.568994480433, 5510.338759348823, 5618.578606604521, 5622.746976386073, 5645.1532270159805, 5628.521575666115, 5632.183333416631, 5635.802746903839, 5641.464060914206, 5650.208970744099, 5439.075357189287, 5610.775568977277, 5635.3519345275, 5649.887002260014, 5659.547236221175, 4195.412642230091, 4278.893027674333, 4283.20760659279, 4308.74147551148, 4329.393884856123, 3863.30460517104, 3877.41838724188, 3882.3594106972596, 3885.261800257942, 3902.083010492532, 5226.555742761831, 5354.544863686552, 5355.758990845421, 5363.651362661414, 5418.945810541923, 5595.328560572676, 5643.5203007743985, 5658.575606829422, 5680.687562184037, 5750.367459579443, 5320.414754377015, 5323.893522129536, 5324.41431442541, 5329.280547126088, 5337.412884582693, 4754.738489383048, 4908.899859235844, 4927.5811556017425, 4933.703977761345, 4975.253711943237, 5699.629524080921, 5799.82600521985, 5816.534677225812, 5848.064309710426, 5861.765529378862, 5687.744051517609, 5690.544756419394, 5696.8006119785605, 5699.487046165865, 5700.600957932905, 5595.188697638901, 5818.7090645466715, 5846.766129354778, 5850.0932355484965, 5850.765969361178, 5582.051051321367, 5629.971850140887, 5645.350784659817, 5651.88696226065, 5706.942930570641, 5622.18478320633, 5677.7161141941915, 5695.515881149983, 5739.081746920473, 5741.483266506035, 5297.390800058042, 5447.754851031634, 5469.589780766538, 5511.751971161227, 5591.329040515164, 5510.421405752339, 5512.283403157564, 5518.365387980273, 5519.69641669712, 5550.972245138749, 5461.754221060141, 5470.617056805985, 5473.726313684379, 5473.781048758005, 5516.200150978166, 5293.947060529345, 5342.572594192533, 5478.80824171168, 5533.695646739468, 5545.861353466195, 5270.183121616155, 5318.760655770422, 5342.626016178986, 5365.9463405367005, 5369.140937449989], "value": 5223.891772758978, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.0567483514124, 614.1187396086615, 633.6863252689919, 646.2309851276982, 647.0585298390836, 32989.67010329896, 43083.35374969374, 44202.33696494551, 44236.3364549532, 47236.52763472364, 45255.77372113143, 45795.77102114493, 45818.312725309144, 45828.0, 45964.310535341996, 8126.59367031649, 8926.73219803407, 9090.636374545044, 10669.146468282557, 10979.560817567288, 10489.58041678332, 10928.398938058404, 10933.343999360064, 10937.343759374464, 10947.671569852877, 10897.509612067475, 10965.451727413638, 10967.067799237075, 10973.670789876316, 10978.176636752236, 10863.45682715865, 10923.071538919201, 10934.726631834188, 10935.179861510418, 10938.179636527253, 10764.569417223302, 10840.457977101114, 10840.861709520466, 10848.457577121191, 10855.131589472823, 42992.0, 43223.135537289076, 43235.56764432347, 43251.0, 43254.0, 3682.226732386202, 3693.926121477555, 3803.2013277211818, 3825.196708691178, 4020.5376381716183, 32930.835345823114, 33282.10297302416, 33565.83217083923, 34313.65686343129, 34910.301793963976, 4347.174036933005, 4381.189479946188, 4395.384646149541, 4415.602595766364, 4564.475085365159, 329367.0, 331189.3440532806, 331976.0, 332806.0, 332855.0, 64221.35778642154, 64224.357756422774, 64560.67719661372, 64593.35406645967, 64733.676331618044, 67309.0, 67337.66331168411, 67393.66303168453, 67410.2924339166, 67424.6628766853, 17196.914015429844, 17651.38220162288, 17657.911710441367, 17672.204750786244, 17684.0, 12935.805962910565, 12960.546380876624, 12978.221306721627, 12989.350532473338, 12993.740125197442, 19299.421017369503, 20463.18147274122, 20486.078126484343, 20511.692324615142, 20592.58814823725, 7668.80827979305, 7812.687492500237, 7836.255555722198, 7854.528728276322, 7961.203879612109, 1016.872890888639, 1047.8428235764543, 1076.9030787229187, 1128.7347473343757, 1141.8458508101467, 32662.24809405481, 32972.50541241835, 33094.0, 33103.83448082792, 33394.83302583471, 906.4606559097326, 1110.9333439993627, 1113.1373185781085, 1138.1236447935044, 1149.6148790155391, 16974.660506789794, 17069.31722731077, 17152.48542543726, 17218.62833480293, 17293.65412691739, 555046.0, 556478.0, 559298.0, 559304.0, 559387.0, 57106.0, 57702.0, 57717.71141144267, 57760.133597996064, 57913.13130303049, 1257.937103144839, 1284.0947132271726, 1342.7515909556764, 1370.1368138073149, 1396.0227840511682, 30954.53568196524, 34322.0, 34473.31053378868, 34569.82715086408, 34983.300333993684, 50264.0, 50516.74741626268, 50844.0, 50923.0, 50926.74536627293, 399090.0, 401016.0, 401098.0, 402592.0, 403135.0, 34496.31007379788, 43358.78320608503, 43951.12097758091, 44447.33329000132, 47886.0, 48515.27227091667, 48773.0, 49636.751816240685, 49954.25068624046, 50743.23885141652, 41642.79178604088, 41788.79105604452, 42505.787471062446, 43076.0, 43330.0, 42151.36772948469, 42447.36328955006, 42987.78506107449, 43003.139937201704, 43053.784731077394, 40962.0, 43317.3502397458, 44444.77777611091, 44682.0, 45300.77349613231, 36867.446988295735, 37557.62442375541, 38343.616563834, 38415.807920960215, 38894.4165837507, 28603.42793144167, 28823.90761517017, 28884.0, 29207.269818253862, 29230.853845730635], "value": 21379.15644965059, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.42365299356953, 392.51328352842484, 395.2786165248419, 396.6687815673912, 416.76869337517667, 13338.062136473278, 18397.264109435622, 20122.295719649814, 20148.59702805943, 21438.0, 15881.126538040404, 18652.440426787183, 19442.805571944275, 19519.609607807834, 19521.609567808635, 5620.494155525992, 5788.82633520995, 5791.884162316751, 5797.507211886995, 5799.884002319951, 5638.520725738317, 5686.147077938322, 5721.170430287606, 5724.484796368326, 5727.0, 5564.248826408444, 5652.321721393439, 5684.857878553028, 5687.687177205252, 5708.857278568048, 5558.249636299129, 5589.692566908839, 5667.838093190907, 5678.772849086032, 5703.230063941398, 5066.746662666888, 5071.18860982241, 5077.49225077493, 5084.618653600958, 5096.388433388017, 22756.886215568815, 23436.882815585814, 23899.40251493709, 24436.0, 24474.143404980918, 2515.132279363617, 2525.9494810103697, 2572.15119010726, 2608.8956441742307, 3062.0201535508645, 14778.0, 14963.102213867203, 15043.473478428203, 15113.244337783068, 15204.0, 1929.324736342283, 1969.990150049255, 2014.405750303664, 2022.5044864008264, 2062.391594479632, 83602.0, 84174.0, 85112.0, 85609.0, 87199.12800871974, 10329.690109296733, 10622.89377106219, 10751.892481075245, 10864.837027444595, 10885.619003334845, 14760.261986900827, 14907.105573665614, 14909.70180596382, 14915.179665118523, 14922.179280139479, 8257.42198046143, 8319.001719793663, 8358.958205209057, 8458.577071146417, 8551.0, 6987.812071947781, 8272.420930534805, 8342.0, 8447.788805279793, 8449.23956843887, 6217.782377616762, 6538.771143010067, 6653.168353955755, 6681.398674119353, 6711.228208755958, 1851.129968914608, 1912.3609419001966, 1917.2426891378107, 1956.4424139120283, 1973.7138114973247, 898.2544488074882, 1016.3038318751679, 1030.4384110659707, 1043.6660268713938, 1098.8351747237978, 19929.501762455766, 20534.794652053588, 20544.691829622567, 20683.0, 20752.688709669368, 1012.4026824173773, 1032.3444612671008, 1049.192122066005, 1071.8017166824163, 1087.5106202209038, 11232.550697972152, 11649.12631552637, 11816.88183118175, 11818.231814932002, 11836.289822610672, 461506.0, 463068.0, 468747.0, 475607.0, 479192.0, 83302.5834870834, 83910.0, 84042.57978710068, 85065.0, 85210.14789852146, 1030.7526193713604, 1034.1364960258118, 1056.345066059033, 1058.3596923861107, 1062.8990245926625, 15972.361105556112, 17540.473785785936, 17887.910560447635, 17957.191926363084, 18190.272389104815, 37475.625243748305, 40116.398254025626, 40470.0, 40700.0, 41402.585974139874, 51000.23499647434, 53225.20162197648, 53503.0, 53861.19208211958, 54063.0, 5597.720113994203, 8100.2304781045705, 8521.0, 8687.131286871263, 8905.866412003954, 12714.364281786058, 12779.23324600527, 13739.725205496034, 13801.309934503033, 13872.0, 5626.549876009827, 8350.874736879074, 11235.4382280884, 11569.6529104127, 11707.648770536898, 11207.831882521605, 11523.366214857928, 11722.648320550397, 12080.39598020113, 12281.0, 11099.334039957628, 11308.264962777394, 11363.261388009752, 11444.542218311508, 11679.76640467203, 8704.738857834274, 8748.956255218684, 8856.822863542564, 8859.468431894107, 8915.0, 10794.244402892036, 11060.446977651247, 11238.83141752858, 11378.203525753117, 11630.0], "value": 9348.09712004054, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1439.4242303078768, 1497.0194522587706, 1594.704979578778, 1761.0754353964176, 1778.2353587957182, 8370.372222083346, 8983.056779038205, 8987.37088403812, 9089.727308180749, 9107.726768196957, 7729.536227826335, 8486.321094312456, 8655.480671159736, 8717.651293948235, 8840.690575829847, 2292.5071109711407, 2326.3021093671914, 2328.3480625424822, 2329.056732023533, 2329.440934175794, 2285.1430713482446, 2316.7104111986, 2328.604137296655, 2331.3705299569106, 2336.5677349690363, 1985.4242269741758, 2225.499262665903, 2296.1389478945393, 2302.5164715409783, 2302.9884850575722, 2317.0, 2332.521833024226, 2340.0756701103137, 2342.8242881783935, 2349.6710460535455, 2274.5678321118935, 2276.8178545716305, 2285.565742508918, 2287.8284128690248, 2295.977040229593, 9318.487483188423, 9339.252859771203, 9373.953130234306, 9375.203107735852, 9378.765530861714, 5182.792688292501, 5239.607029472805, 5277.076511610491, 5282.81510147143, 5337.893242135175, 3204.214967332995, 3213.855376508063, 3272.9509057364157, 3319.589174600785, 3330.8834190803204, 1149.5172027748365, 1157.3518829455531, 1159.8840115988419, 1169.1990986174499, 1174.031424075133, 12217.0, 12223.93888030563, 12234.08244381666, 12235.877641223562, 12239.20445171061, 4337.1976184405985, 4475.552444755498, 4567.611753000966, 4658.045100754337, 4662.230731929194, 10227.28409011377, 10227.539760710786, 10236.129928955974, 10237.129843963197, 10241.0, 5276.445973172838, 5319.069162896555, 5320.228566857784, 5321.467853214647, 5324.1747529133045, 4724.267738500538, 4826.710397376169, 4848.854534363974, 4856.465788763233, 4892.559669629751, 3940.842366305373, 3968.523777146761, 4025.0943537703783, 4061.857834975821, 4065.2072845794787, 1153.7692461507563, 1171.4318555500574, 1262.4129779652505, 1292.7220647560819, 1305.5169587252587, 995.5669283861544, 996.3922007575374, 999.7450650084328, 1001.5242759689235, 1008.7175590834578, 5979.491743201789, 5992.370801065913, 6024.879502409927, 6050.727717252734, 6138.938610613836, 913.5021413329752, 992.3153024413132, 1009.152312057875, 1035.6116456328878, 1107.5680484610848, 4096.0, 4124.1133156371525, 4142.544320124784, 4168.854090106832, 4200.05498762782, 10775.137988960865, 11056.281341712764, 11200.831987520194, 11218.551257949754, 11230.3261804292, 9911.65309214174, 10777.46112694378, 11097.1122310215, 11113.055390291916, 11125.554977800797, 8373.790655233546, 8643.87034194475, 8665.220130188187, 8689.000764911989, 8742.213200811957, 6070.605410648293, 6250.281217660027, 6274.462756624656, 6335.1447554579545, 6335.271443784024, 10380.532876020447, 10566.894331056592, 10653.627123050655, 10656.8934310659, 10666.466676665981, 9921.454320012468, 10484.52819623134, 10948.0, 11028.669139925814, 11081.944590276997, 8367.707130250412, 8570.0, 8582.871256931026, 8631.13688631157, 8636.222739953435, 8513.276371508491, 8531.23218910301, 8531.872021919551, 8587.570621469027, 8639.784005399915, 6420.935790642221, 7703.88444173349, 7815.570143641927, 7855.135935047026, 8011.599420028859, 7546.735864244725, 7621.1616722161625, 7679.308862202429, 7753.108392534705, 7789.104253010976, 7290.234525374759, 7325.304096110861, 7330.5968171751065, 7337.706491740484, 7414.295641914009, 5429.809956651498, 5439.374471935778, 5461.644993075437, 5493.587980901369, 5536.031194541019, 5304.283921670525, 5306.177542480922, 5490.6431081979545, 5714.142878568248, 5855.151003104611], "value": 4721.835765585609, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.83264702354774, 327.7541843617287, 339.4111217038438, 340.4416756519308, 344.84481983107605, 5270.710110943896, 5362.43694412087, 5435.613918450795, 5464.333378319616, 5482.5339846113075, 5332.840014799563, 5345.01117293301, 5365.517103460687, 5419.376771671259, 5430.0, 4256.936145957813, 4266.146770645883, 4266.2320782259185, 4278.679099067583, 4289.764062976535, 4019.738716983387, 4109.958900411002, 4279.33670281107, 4279.87160385189, 4290.2706539888295, 4183.17635595973, 4211.684123690736, 4218.535961044283, 4228.577142285778, 4232.809523571431, 4208.326667733163, 4228.344606585984, 4241.384999175102, 4253.617174454314, 4254.42565253693, 3642.1805093853936, 3724.255148970217, 3769.717271204643, 3774.6036666149935, 3781.5462144542557, 5195.896082078375, 5196.2465442511, 5204.386640141568, 5207.583393328525, 5211.322528071327, 4804.654696684934, 4814.9518504815205, 4819.253015782524, 4825.179719447702, 4829.6860704054125, 5332.413434522199, 5634.464725851038, 5648.802291919804, 5652.180433837112, 5657.1514272858985, 4019.8593049243427, 4060.675145988314, 4066.6136717011836, 4067.7559346439307, 4070.2266569352023, 5744.109663002241, 5793.536517078624, 5816.302043754777, 5825.533957283407, 5835.4748072673665, 3865.130345672201, 4098.159877225162, 4103.138340948374, 4109.198706252312, 4137.77242251673, 4184.727992680466, 4190.371444283382, 4196.664266858644, 4208.538005266892, 4221.7255878367805, 4795.5853023358195, 4802.111609352281, 4821.276808478686, 4829.396325459317, 4840.854774356704, 5585.162225666101, 5694.231278777312, 5696.3511966935575, 5708.257926469532, 5711.457411545896, 1365.32416453854, 1366.719822436398, 1366.90647482014, 1380.523719316834, 1383.7301726163503, 966.6809952715587, 967.3699815810382, 971.5433746139303, 975.6390135649855, 990.4305024610877, 5316.883454474526, 5352.91970620441, 5357.544608708304, 5365.382980957162, 5376.704281264568, 5638.154276858504, 5653.717314134276, 5672.688002159921, 5681.9431805681415, 5702.885942281131, 5105.5149760772665, 5353.089974704231, 5370.301860758076, 5385.3268341457315, 5388.973055134699, 2678.866056697196, 2684.2686467228527, 2700.1494529223232, 2700.7434293742062, 2703.9459210815676, 5193.221626429842, 5198.298229739013, 5229.398619158769, 5235.345581802275, 5237.869053273623, 5183.263606691725, 5495.120780675073, 5931.4958228550195, 5974.699740599814, 5982.790602328984, 5995.520358371407, 6004.759809607567, 6007.189029480965, 6029.939700602938, 6040.244969378739, 5612.494875461228, 5750.942490575041, 5775.711214439345, 5787.160861674949, 5811.215485909348, 5729.341125770423, 5736.168255602997, 5738.68437235956, 5756.194132821324, 5758.62568933018, 5961.046232602763, 5971.044632858721, 5973.581849270509, 5996.370381110095, 5998.730057147526, 3897.493325867619, 4110.445089912943, 4130.318497448007, 4148.294789885666, 4179.226843034048, 5461.508464238079, 5611.943880561143, 5720.082757793472, 5749.706316078848, 5779.6014653918155, 5614.41048689898, 5636.943630563642, 5638.195777351209, 5647.0, 5660.377358490645, 5478.233047373451, 5528.474794894479, 5539.944600554104, 5558.694271814928, 5567.63810352342, 5291.603129765206, 5548.278723765885, 5624.831255062355, 5627.746751396279, 5628.0, 5661.122526008476, 5688.943110568841, 5691.800786972602, 5697.262334987869, 5701.743421545957, 5424.8842951249835, 5518.503334699896, 5569.357039673387, 5577.8047768327915, 5582.3859375467855], "value": 4263.106393425484, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.8697034533782, 752.604882436721, 792.1840504280593, 813.5566116466525, 868.461553836621, 15425.845741542582, 15714.607134821636, 16614.916925415386, 16642.91678541607, 16662.1668916554, 14202.0, 14390.640233994156, 14399.280035998185, 14436.206008669518, 14436.422543098264, 660.4980215036559, 795.4749865089043, 807.4267270238123, 824.3034635732796, 829.1542626520945, 838.0362583029535, 839.8446287436843, 839.9580020998956, 841.949483031017, 842.2167384332569, 869.8651708985118, 871.7297637732323, 871.9972032163, 873.5501216873315, 882.1487264789477, 696.1263614164217, 722.5736815278984, 725.8366867454833, 842.4103127810496, 868.5266529741275, 637.6046850952439, 640.1613885809604, 641.2529403245213, 641.8395401149712, 642.0433554004546, 14821.92589037048, 14839.0, 14969.775453368207, 15017.24913754308, 15026.248687565687, 14255.78616320756, 14428.927855360762, 14442.133471991714, 14517.927410362987, 14591.78112328316, 12634.494620215271, 12770.80843787344, 12842.293673847935, 12879.549215777497, 13452.529161479399, 4334.393184954109, 4383.189110014658, 4404.581564751344, 4488.349189367556, 4496.392986946753, 84939.57530212372, 85441.57279213626, 85685.0, 85694.0, 86074.56962715146, 10862.945685271523, 11162.0, 11355.318680879174, 11467.139964502696, 11468.770624587629, 22287.665685014737, 22366.66450003251, 22372.776272237395, 22396.216132435286, 22405.43986400353, 8026.197380262044, 8164.142765009588, 8365.28895043928, 8547.74356769298, 8576.785580360416, 4736.100140973204, 4764.404449443819, 4803.327534145223, 4812.687175333592, 5062.7468626568525, 3295.0938491914435, 3385.7968521888274, 3389.796612203276, 3389.847456864447, 3396.8811091611674, 565.6747370262116, 574.70115539919, 586.762361243697, 602.1539736669898, 609.135028259872, 604.2778879239355, 659.1924892007348, 667.4960404894274, 684.1482354468718, 712.5866997141645, 8568.443051201652, 8736.301095912311, 9081.091890810865, 9231.0, 9434.339596228336, 601.1793901324747, 604.6885853785304, 624.0857144283556, 624.7532224771281, 635.7202830754453, 4093.3655283431117, 4274.123804620045, 4448.221561226773, 4448.5773851484055, 4458.665600080007, 108078.45960770303, 126207.0, 127263.36368318099, 128457.36569757306, 130953.34523327513, 114396.42801786105, 114965.4251728736, 115294.0, 115756.42121789337, 115785.15826154703, 97043.51478242564, 97267.51366243123, 97314.0, 97837.0, 100462.0, 7997.7600671979935, 8037.879431808645, 8140.75577732669, 8223.629936652746, 8304.58477076156, 54362.18456723231, 55783.0, 55901.44098558962, 57150.142747859645, 57160.590682939845, 52825.20762188493, 80407.0, 81019.0, 81687.0, 83654.58172709098, 11467.655970320904, 11483.196176267915, 11845.526178952745, 11919.56965164186, 11934.283942963102, 12576.119671622899, 12623.684407889876, 13234.338283086, 13272.27002514871, 13386.129901556367, 11133.665990020312, 11255.212135150461, 11357.716057098638, 11746.29522228669, 12047.216930899463, 11306.434678265889, 11502.194846360675, 11553.768924621629, 11750.529978800752, 11873.465694043616, 10628.787424251317, 10889.237753357189, 11155.888441115809, 11414.48634811452, 11421.657350279505, 9485.383450075724, 9644.373115747454, 9657.613695452384, 9678.080582344666, 9764.804703906024, 9432.386894852087, 9433.858492122761, 9626.855597165908, 9642.373245739005, 9731.270154738564], "value": 7386.247144906996, "unit": "score"}], "name": "dromaeo_css", "value": 7331.103029149302, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 110.0, 110.0, 112.0, 111.0, 110.0, 110.0, 113.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 117.0, 122.0, 167.0, 118.0, 118.0, 149.0, 116.0, 148.0, 116.0], "value": 132.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 160.0, 161.0, 161.0, 160.0, 161.0, 161.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 75.0, 127.0, 76.0, 76.0, 75.0, 74.0, 104.0, 75.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 117.0, 83.0, 83.0, 83.0, 121.0, 84.0, 85.0, 125.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 54.0, 54.0, 53.0, 54.0, 54.0, 54.0, 55.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 59.0, 60.0, 59.0, 60.0, 60.0, 60.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 75.0, 77.0, 84.0, 78.0, 75.0, 81.0, 76.0, 80.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 118.0, 119.0, 126.0, 117.0, 119.0, 119.0, 130.0, 162.0, 120.0], "value": 125.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 156.0, 156.0, 155.0, 160.0, 157.0, 156.0, 157.0, 157.0, 156.0], "value": 156.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 62.0, 62.0, 62.0, 65.0, 62.0, 62.0, 60.0, 60.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1474.8000000000002, "alertThreshold": 2.0}]} 01:45:30 INFO - Return code: 0 01:45:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:45:30 INFO - # TBPL SUCCESS # 01:45:30 INFO - Running post-action listener: _resource_record_post_action 01:45:30 INFO - ##### 01:45:30 INFO - ##### Finished run-tests step (success) 01:45:30 INFO - ##### 01:45:30 INFO - Running post-run listener: _resource_record_post_run 01:45:30 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 567070720; Read time: 12; Write time: 530844 01:45:30 INFO - TinderboxPrint: CPU usage
13.0% 01:45:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 01:45:30 INFO - TinderboxPrint: I/O write bytes / time
567,070,720 / 530,844 01:45:30 INFO - TinderboxPrint: CPU idle
8,283.7 (87.0%) 01:45:30 INFO - TinderboxPrint: CPU user
1,194.1 (12.5%) 01:45:30 INFO - TinderboxPrint: Swap in / out
0 / 0 01:45:30 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 272142336; Read time: 0; Write time: 265012 01:45:30 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 294928384; Read time: 0; Write time: 265832 01:45:31 INFO - Running post-run listener: _upload_blobber_files 01:45:31 INFO - Blob upload gear active. 01:45:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:45:31 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 01:45:31 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:45:31 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:45:31 INFO - (blobuploader) - INFO - Open directory for files ... 01:45:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:45:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:45:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:45:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:45:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:45:32 INFO - (blobuploader) - INFO - Done attempting. 01:45:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:45:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:45:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:45:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:45:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:45:33 INFO - (blobuploader) - INFO - Done attempting. 01:45:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:45:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:45:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:45:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:45:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:45:36 INFO - (blobuploader) - INFO - Done attempting. 01:45:36 INFO - (blobuploader) - INFO - Iteration through files over. 01:45:36 INFO - Return code: 0 01:45:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:45:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:45:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41798d4f4618ad0e5429c334cb7b6bc561c47db7e2fe155ddf85dd500903630688f883d8055af52ad54ebc81bb2b0ed0ea7094dbda1158060183823546d5e882", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b32d4903ec8a0f47d8b88875707b0ee960876e6a6cfeb576f55ef1f378e2a345559c19a7b29da900ee4648104e5e5e7cd8ecf1ffe4180d9aaacd66763b43a927", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f00fc3ebdcc9d7203969a07cf444929e46524577c0abd9432e29d73043bc60704df31d27854badb75934d1233c5a85a02b341d4f921953a209d0020b5d4e0a8c"} 01:45:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:45:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:45:36 INFO - Contents: 01:45:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41798d4f4618ad0e5429c334cb7b6bc561c47db7e2fe155ddf85dd500903630688f883d8055af52ad54ebc81bb2b0ed0ea7094dbda1158060183823546d5e882", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b32d4903ec8a0f47d8b88875707b0ee960876e6a6cfeb576f55ef1f378e2a345559c19a7b29da900ee4648104e5e5e7cd8ecf1ffe4180d9aaacd66763b43a927", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f00fc3ebdcc9d7203969a07cf444929e46524577c0abd9432e29d73043bc60704df31d27854badb75934d1233c5a85a02b341d4f921953a209d0020b5d4e0a8c"} 01:45:36 INFO - Running post-run listener: copy_logs_to_upload_dir 01:45:36 INFO - Copying logs to upload dir... 01:45:36 INFO - mkdir: /builds/slave/test/build/upload/logs 01:45:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.149157 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-05 01:45:36.903582) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 01:45:36.906950) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673 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/sha512/41798d4f4618ad0e5429c334cb7b6bc561c47db7e2fe155ddf85dd500903630688f883d8055af52ad54ebc81bb2b0ed0ea7094dbda1158060183823546d5e882", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b32d4903ec8a0f47d8b88875707b0ee960876e6a6cfeb576f55ef1f378e2a345559c19a7b29da900ee4648104e5e5e7cd8ecf1ffe4180d9aaacd66763b43a927", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f00fc3ebdcc9d7203969a07cf444929e46524577c0abd9432e29d73043bc60704df31d27854badb75934d1233c5a85a02b341d4f921953a209d0020b5d4e0a8c"} build_url:https://queue.taskcluster.net/v1/task/fIcHHeGlTf2gnUFLv9_j_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011419 build_url: 'https://queue.taskcluster.net/v1/task/fIcHHeGlTf2gnUFLv9_j_g/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/sha512/41798d4f4618ad0e5429c334cb7b6bc561c47db7e2fe155ddf85dd500903630688f883d8055af52ad54ebc81bb2b0ed0ea7094dbda1158060183823546d5e882", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b32d4903ec8a0f47d8b88875707b0ee960876e6a6cfeb576f55ef1f378e2a345559c19a7b29da900ee4648104e5e5e7cd8ecf1ffe4180d9aaacd66763b43a927", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f00fc3ebdcc9d7203969a07cf444929e46524577c0abd9432e29d73043bc60704df31d27854badb75934d1233c5a85a02b341d4f921953a209d0020b5d4e0a8c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 01:45:36.932625) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:45:36.932933) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467705868.279574-1759457673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004403 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:45:37.016317) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 01:45:37.016641) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 01:45:37.016920) ========= ========= Total master_lag: 0.22 =========