builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1467774849.14 results: success (0) buildid: 20160705173010 builduid: dcc4e8beff954b6fbafcb259c9bea0e9 revision: bfcca87598b2ca8e31094d587b7b5cd033ef9577 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 20:14:09.136887) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 20:14:09.137394) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 20:14:09.137746) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 20:14:09.153111) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 20:14:09.153425) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 20:14:09-- 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% 114K=0.1s 2016-07-05 20:14:09 (114 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.228434 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 20:14:09.407495) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 20:14:09.407862) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021901 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 20:14:09.464401) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 20:14:09.464831) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bfcca87598b2ca8e31094d587b7b5cd033ef9577 --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 bfcca87598b2ca8e31094d587b7b5cd033ef9577 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 20:14:09,879 truncating revision to first 12 chars 2016-07-05 20:14:09,879 Setting DEBUG logging. 2016-07-05 20:14:09,879 attempt 1/10 2016-07-05 20:14:09,879 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bfcca87598b2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 20:14:10,186 unpacking tar archive at: fx-team-bfcca87598b2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.640310 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 20:14:10.120017) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 20:14:10.120381) ========= script_repo_revision: bfcca87598b2ca8e31094d587b7b5cd033ef9577 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 20:14:10.120902) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 20:14:10.121224) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 20:14:10.132613) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-05 20:14:10.132974) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:14:10 INFO - MultiFileLogger online at 20160705 20:14:10 in /builds/slave/test 20:14:10 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 20:14:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:14:10 INFO - {'append_to_log': False, 20:14:10 INFO - 'base_work_dir': '/builds/slave/test', 20:14:10 INFO - 'blob_upload_branch': 'Fx-Team', 20:14:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:14:10 INFO - 'branch': 'Fx-Team', 20:14:10 INFO - 'buildbot_json_path': 'buildprops.json', 20:14:10 INFO - 'config_files': ('talos/linux_config.py',), 20:14:10 INFO - 'default_actions': ('clobber', 20:14:10 INFO - 'read-buildbot-config', 20:14:10 INFO - 'download-and-extract', 20:14:10 INFO - 'populate-webroot', 20:14:10 INFO - 'create-virtualenv', 20:14:10 INFO - 'install', 20:14:10 INFO - 'run-tests'), 20:14:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:14:10 INFO - 'download_minidump_stackwalk': True, 20:14:10 INFO - 'download_symbols': 'ondemand', 20:14:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:14:10 INFO - 'tooltool.py': '/tools/tooltool.py', 20:14:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:14:10 INFO - '/tools/misc-python/virtualenv.py')}, 20:14:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:14:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:14:10 INFO - 'installer_path': 'installer.exe', 20:14:10 INFO - 'log_level': 'info', 20:14:10 INFO - 'log_name': 'talos', 20:14:10 INFO - 'log_to_console': True, 20:14:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:14:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:14:10 INFO - 'opt_config_files': (), 20:14:10 INFO - 'pip_index': False, 20:14:10 INFO - 'sps_profile': False, 20:14:10 INFO - 'sps_profile_interval': 0, 20:14:10 INFO - 'suite': 'dromaeojs', 20:14:10 INFO - 'system_bits': '32', 20:14:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:14:10 INFO - 'title': 'talos-linux64-ix-041', 20:14:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:14:10 INFO - 'use_talos_json': True, 20:14:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:14:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:14:10 INFO - 'work_dir': 'build'} 20:14:10 INFO - ##### 20:14:10 INFO - ##### Running clobber step. 20:14:10 INFO - ##### 20:14:10 INFO - Running pre-action listener: _resource_record_pre_action 20:14:10 INFO - Running main action method: clobber 20:14:10 INFO - rmtree: /builds/slave/test/build 20:14:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:14:11 INFO - Running post-action listener: _resource_record_post_action 20:14:11 INFO - ##### 20:14:11 INFO - ##### Finished clobber step (success) 20:14:11 INFO - ##### 20:14:11 INFO - ##### 20:14:11 INFO - ##### Running read-buildbot-config step. 20:14:11 INFO - ##### 20:14:11 INFO - Running pre-action listener: _resource_record_pre_action 20:14:11 INFO - Running main action method: read_buildbot_config 20:14:11 INFO - Using buildbot properties: 20:14:11 INFO - { 20:14:11 INFO - "project": "", 20:14:11 INFO - "product": "firefox", 20:14:11 INFO - "script_repo_revision": "production", 20:14:11 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:14:11 INFO - "repository": "", 20:14:11 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:14:11 INFO - "buildid": "20160705173010", 20:14:11 INFO - "pgo_build": "True", 20:14:11 INFO - "basedir": "/builds/slave/test", 20:14:11 INFO - "buildnumber": 248, 20:14:11 INFO - "slavename": "talos-linux64-ix-041", 20:14:11 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:14:11 INFO - "platform": "ubuntu64_hw", 20:14:11 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:14:11 INFO - "branch": "fx-team", 20:14:11 INFO - "repo_path": "integration/fx-team", 20:14:11 INFO - "revision": "bfcca87598b2ca8e31094d587b7b5cd033ef9577", 20:14:11 INFO - "stage_platform": "linux64-pgo", 20:14:11 INFO - "builduid": "dcc4e8beff954b6fbafcb259c9bea0e9", 20:14:11 INFO - "slavebuilddir": "test" 20:14:11 INFO - } 20:14:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/UNNJAV4rQGGQOmujjnBmxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:14:11 INFO - Running post-action listener: _resource_record_post_action 20:14:11 INFO - ##### 20:14:11 INFO - ##### Finished read-buildbot-config step (success) 20:14:11 INFO - ##### 20:14:11 INFO - ##### 20:14:11 INFO - ##### Running download-and-extract step. 20:14:11 INFO - ##### 20:14:11 INFO - Running pre-action listener: _resource_record_pre_action 20:14:11 INFO - Running main action method: download_and_extract 20:14:11 INFO - mkdir: /builds/slave/test/build/tests 20:14: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')]} 20:14:11 INFO - https://queue.taskcluster.net/v1/task/UNNJAV4rQGGQOmujjnBmxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:14:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UNNJAV4rQGGQOmujjnBmxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:14:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UNNJAV4rQGGQOmujjnBmxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:14:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UNNJAV4rQGGQOmujjnBmxQ/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 20:14:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UNNJAV4rQGGQOmujjnBmxQ/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 20:14:13 INFO - Downloaded 1361 bytes. 20:14:13 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:14:13 INFO - Using the following test package requirements: 20:14:13 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:14:13 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:14:13 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:14:13 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:13 INFO - u'jsshell-linux-x86_64.zip'], 20:14:13 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:14:13 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:14:13 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:14:13 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:14:13 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:14:13 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:14:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:14:13 INFO - https://queue.taskcluster.net/v1/task/UNNJAV4rQGGQOmujjnBmxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:14:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UNNJAV4rQGGQOmujjnBmxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:14:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UNNJAV4rQGGQOmujjnBmxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:14:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UNNJAV4rQGGQOmujjnBmxQ/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 20:14:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UNNJAV4rQGGQOmujjnBmxQ/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 20:14:17 INFO - Downloaded 24300790 bytes. 20:14:17 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'] 20:14:17 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 20:14:18 INFO - Return code: 0 20:14:18 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 20:14: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')]} 20:14:18 INFO - https://queue.taskcluster.net/v1/task/UNNJAV4rQGGQOmujjnBmxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:14:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UNNJAV4rQGGQOmujjnBmxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:14:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UNNJAV4rQGGQOmujjnBmxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:14:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UNNJAV4rQGGQOmujjnBmxQ/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 20:14:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UNNJAV4rQGGQOmujjnBmxQ/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 20:14:20 INFO - Downloaded 24300790 bytes. 20:14:20 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'] 20:14:20 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 20:14:21 INFO - Return code: 0 20:14: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')]} 20:14:21 INFO - https://queue.taskcluster.net/v1/task/UNNJAV4rQGGQOmujjnBmxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:14:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UNNJAV4rQGGQOmujjnBmxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:14:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UNNJAV4rQGGQOmujjnBmxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:14:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UNNJAV4rQGGQOmujjnBmxQ/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 20:14:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UNNJAV4rQGGQOmujjnBmxQ/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 20:14:23 INFO - Downloaded 14403333 bytes. 20:14:23 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'] 20:14:23 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 20:14:23 INFO - Return code: 0 20:14: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')]} 20:14:23 INFO - https://queue.taskcluster.net/v1/task/UNNJAV4rQGGQOmujjnBmxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:14:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UNNJAV4rQGGQOmujjnBmxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:14:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UNNJAV4rQGGQOmujjnBmxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:14:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UNNJAV4rQGGQOmujjnBmxQ/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 20:14:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UNNJAV4rQGGQOmujjnBmxQ/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 20:14:24 INFO - Downloaded 60352620 bytes. 20:14:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UNNJAV4rQGGQOmujjnBmxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:14:24 INFO - mkdir: /builds/slave/test/properties 20:14:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:14:24 INFO - Writing to file /builds/slave/test/properties/build_url 20:14:24 INFO - Contents: 20:14:24 INFO - build_url:https://queue.taskcluster.net/v1/task/UNNJAV4rQGGQOmujjnBmxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:14:25 INFO - Running post-action listener: _resource_record_post_action 20:14:25 INFO - Running post-action listener: set_extra_try_arguments 20:14:25 INFO - ##### 20:14:25 INFO - ##### Finished download-and-extract step (success) 20:14:25 INFO - ##### 20:14:25 INFO - ##### 20:14:25 INFO - ##### Running populate-webroot step. 20:14:25 INFO - ##### 20:14:25 INFO - Running pre-action listener: _resource_record_pre_action 20:14:25 INFO - Running main action method: populate_webroot 20:14:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:14:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:14:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:14:25 INFO - '--tppagecycles', 20:14:25 INFO - '7'], 20:14:25 INFO - 'tests': ['tsvgm']}}, 20:14:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:14:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:14:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:14:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:14:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:14:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:14:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:25 INFO - 'talos_options': ['--disable-e10s'], 20:14:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:14:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:14:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:25 INFO - 'talos_options': ['--disable-e10s'], 20:14:25 INFO - 'tests': ['damp', 'tps']}, 20:14:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:25 INFO - 'tests': ['damp', 'tps']}, 20:14:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:14:25 INFO - 'tests': ['dromaeo_dom']}, 20:14:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:14:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:14:25 INFO - 'tests': ['basic_compositor_video']}, 20:14:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:14:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:14:25 INFO - 'tests': ['a11yr', 20:14:25 INFO - 'ts_paint', 20:14:25 INFO - 'tpaint', 20:14:25 INFO - 'sessionrestore', 20:14:25 INFO - 'sessionrestore_no_auto_restore', 20:14:25 INFO - 'tabpaint']}, 20:14:25 INFO - 'other-e10s': {'tests': ['a11yr', 20:14:25 INFO - 'ts_paint', 20:14:25 INFO - 'tpaint', 20:14:25 INFO - 'sessionrestore', 20:14:25 INFO - 'sessionrestore_no_auto_restore', 20:14:25 INFO - 'tabpaint']}, 20:14:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:14:25 INFO - 'ts_paint', 20:14:25 INFO - 'tpaint', 20:14:25 INFO - 'sessionrestore', 20:14:25 INFO - 'sessionrestore_no_auto_restore', 20:14:25 INFO - 'tabpaint']}, 20:14:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:14:25 INFO - 'ts_paint', 20:14:25 INFO - 'tpaint', 20:14:25 INFO - 'sessionrestore', 20:14:25 INFO - 'sessionrestore_no_auto_restore', 20:14:25 INFO - 'tabpaint']}, 20:14:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:14:25 INFO - 'tests': ['a11yr', 20:14:25 INFO - 'ts_paint', 20:14:25 INFO - 'tpaint', 20:14:25 INFO - 'sessionrestore', 20:14:25 INFO - 'sessionrestore_no_auto_restore', 20:14:25 INFO - 'tabpaint']}, 20:14:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:14:25 INFO - 'tests': ['a11yr', 20:14:25 INFO - 'ts_paint', 20:14:25 INFO - 'tpaint', 20:14:25 INFO - 'sessionrestore', 20:14:25 INFO - 'sessionrestore_no_auto_restore', 20:14:25 INFO - 'tabpaint']}, 20:14:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:14:25 INFO - 'tests': ['tsvgx', 20:14:25 INFO - 'tsvgr_opacity', 20:14:25 INFO - 'tart', 20:14:25 INFO - 'tscrollx', 20:14:25 INFO - 'cart']}, 20:14:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:14:25 INFO - 'tsvgr_opacity', 20:14:25 INFO - 'tart', 20:14:25 INFO - 'tscrollx', 20:14:25 INFO - 'cart']}, 20:14:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:25 INFO - 'talos_options': ['--disable-e10s'], 20:14:25 INFO - 'tests': ['tp5o']}, 20:14:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:25 INFO - 'tests': ['tp5o']}, 20:14:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:25 INFO - 'talos_options': ['--disable-e10s', 20:14:25 INFO - '--xperf_path', 20:14:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:14:25 INFO - 'tests': ['tp5n']}, 20:14:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:25 INFO - 'talos_options': ['--xperf_path', 20:14:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:14:25 INFO - 'tests': ['tp5n']}}, 20:14:25 INFO - 'talos.zip': {'path': '', 20:14:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:14:25 INFO - Running post-action listener: _resource_record_post_action 20:14:25 INFO - ##### 20:14:25 INFO - ##### Finished populate-webroot step (success) 20:14:25 INFO - ##### 20:14:25 INFO - ##### 20:14:25 INFO - ##### Running create-virtualenv step. 20:14:25 INFO - ##### 20:14:25 INFO - Running pre-action listener: _resource_record_pre_action 20:14:25 INFO - Running main action method: create_virtualenv 20:14:25 INFO - Creating virtualenv /builds/slave/test/build/venv 20:14:25 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:14:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:14:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:14:25 INFO - Using real prefix '/usr' 20:14:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:14:26 INFO - Installing distribute.............................................................................................................................................................................................done. 20:14:28 INFO - Installing pip.................done. 20:14:28 INFO - Return code: 0 20:14:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266b3b0>, '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 0x266c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266c740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:14:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:14:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:14:28 INFO - Using env: {'DISPLAY': ':0', 20:14:28 INFO - 'HOME': '/home/cltbld', 20:14:28 INFO - 'LANG': 'en_US.UTF-8', 20:14:28 INFO - 'LANGUAGE': 'en_US:en', 20:14:28 INFO - 'LOGNAME': 'cltbld', 20:14:28 INFO - 'MAIL': '/var/mail/cltbld', 20:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:28 INFO - 'MOZ_NO_REMOTE': '1', 20:14:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:28 INFO - 'NO_EM_RESTART': '1', 20:14:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:28 INFO - 'PWD': '/builds/slave/test', 20:14:28 INFO - 'SHELL': '/bin/bash', 20:14:28 INFO - 'SHLVL': '1', 20:14:28 INFO - 'TERM': 'linux', 20:14:28 INFO - 'TMOUT': '86400', 20:14:28 INFO - 'USER': 'cltbld', 20:14:28 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929', 20:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:28 INFO - '_': '/tools/buildbot/bin/python'} 20:14:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:28 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:14:28 INFO - Cleaning up... 20:14:28 INFO - Return code: 0 20:14:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266b3b0>, '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 0x266c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266c740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:14:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:14:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:14:28 INFO - Using env: {'DISPLAY': ':0', 20:14:28 INFO - 'HOME': '/home/cltbld', 20:14:28 INFO - 'LANG': 'en_US.UTF-8', 20:14:28 INFO - 'LANGUAGE': 'en_US:en', 20:14:28 INFO - 'LOGNAME': 'cltbld', 20:14:28 INFO - 'MAIL': '/var/mail/cltbld', 20:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:28 INFO - 'MOZ_NO_REMOTE': '1', 20:14:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:28 INFO - 'NO_EM_RESTART': '1', 20:14:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:28 INFO - 'PWD': '/builds/slave/test', 20:14:28 INFO - 'SHELL': '/bin/bash', 20:14:28 INFO - 'SHLVL': '1', 20:14:28 INFO - 'TERM': 'linux', 20:14:28 INFO - 'TMOUT': '86400', 20:14:28 INFO - 'USER': 'cltbld', 20:14:28 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929', 20:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:28 INFO - '_': '/tools/buildbot/bin/python'} 20:14:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:28 INFO - Downloading/unpacking psutil>=3.1.1 20:14: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 20:14: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 20:14: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 20:14: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 20:14: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 20:14: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 20:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:14:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:14:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:14:30 INFO - Installing collected packages: psutil 20:14:30 INFO - Running setup.py install for psutil 20:14:30 INFO - building 'psutil._psutil_linux' extension 20:14:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:14:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:14:30 INFO - building 'psutil._psutil_posix' extension 20:14:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:14:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:14:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:14:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:14:31 INFO - Successfully installed psutil 20:14:31 INFO - Cleaning up... 20:14:31 INFO - Return code: 0 20:14:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266b3b0>, '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 0x266c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266c740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:14:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:14:31 INFO - Using env: {'DISPLAY': ':0', 20:14:31 INFO - 'HOME': '/home/cltbld', 20:14:31 INFO - 'LANG': 'en_US.UTF-8', 20:14:31 INFO - 'LANGUAGE': 'en_US:en', 20:14:31 INFO - 'LOGNAME': 'cltbld', 20:14:31 INFO - 'MAIL': '/var/mail/cltbld', 20:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:31 INFO - 'MOZ_NO_REMOTE': '1', 20:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:31 INFO - 'NO_EM_RESTART': '1', 20:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:31 INFO - 'PWD': '/builds/slave/test', 20:14:31 INFO - 'SHELL': '/bin/bash', 20:14:31 INFO - 'SHLVL': '1', 20:14:31 INFO - 'TERM': 'linux', 20:14:31 INFO - 'TMOUT': '86400', 20:14:31 INFO - 'USER': 'cltbld', 20:14:31 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929', 20:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:31 INFO - '_': '/tools/buildbot/bin/python'} 20:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:14:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:14:33 INFO - Installing collected packages: mozsystemmonitor 20:14:33 INFO - Running setup.py install for mozsystemmonitor 20:14:33 INFO - Successfully installed mozsystemmonitor 20:14:33 INFO - Cleaning up... 20:14:33 INFO - Return code: 0 20:14:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:14:33 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')]} 20:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:33 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')]} 20:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:33 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 0x23ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266b3b0>, '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 0x266c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266c740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:14:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:14:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:14:33 INFO - Using env: {'DISPLAY': ':0', 20:14:33 INFO - 'HOME': '/home/cltbld', 20:14:33 INFO - 'LANG': 'en_US.UTF-8', 20:14:33 INFO - 'LANGUAGE': 'en_US:en', 20:14:33 INFO - 'LOGNAME': 'cltbld', 20:14:33 INFO - 'MAIL': '/var/mail/cltbld', 20:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:33 INFO - 'MOZ_NO_REMOTE': '1', 20:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:33 INFO - 'NO_EM_RESTART': '1', 20:14:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:33 INFO - 'PWD': '/builds/slave/test', 20:14:33 INFO - 'SHELL': '/bin/bash', 20:14:33 INFO - 'SHLVL': '1', 20:14:33 INFO - 'TERM': 'linux', 20:14:33 INFO - 'TMOUT': '86400', 20:14:33 INFO - 'USER': 'cltbld', 20:14:33 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929', 20:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:33 INFO - '_': '/tools/buildbot/bin/python'} 20:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:33 INFO - Downloading/unpacking jsonschema==2.5.1 20:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:14:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:35 INFO - Downloading functools32-3.2.3-2.tar.gz 20:14:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:14:35 INFO - warning: no files found matching '*.txt' 20:14:35 INFO - no previously-included directories found matching 'build' 20:14:35 INFO - no previously-included directories found matching 'dist' 20:14:35 INFO - no previously-included directories found matching '.git*' 20:14:35 INFO - Installing collected packages: jsonschema, functools32 20:14:35 INFO - Running setup.py install for functools32 20:14:35 INFO - warning: no files found matching '*.txt' 20:14:35 INFO - no previously-included directories found matching 'build' 20:14:35 INFO - no previously-included directories found matching 'dist' 20:14:35 INFO - no previously-included directories found matching '.git*' 20:14:35 INFO - Successfully installed jsonschema functools32 20:14:35 INFO - Cleaning up... 20:14:35 INFO - Return code: 0 20:14:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:14:35 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')]} 20:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:35 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')]} 20:14:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:35 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 0x23ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266b3b0>, '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 0x266c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266c740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:14:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:14:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:14:35 INFO - Using env: {'DISPLAY': ':0', 20:14:35 INFO - 'HOME': '/home/cltbld', 20:14:35 INFO - 'LANG': 'en_US.UTF-8', 20:14:35 INFO - 'LANGUAGE': 'en_US:en', 20:14:35 INFO - 'LOGNAME': 'cltbld', 20:14:35 INFO - 'MAIL': '/var/mail/cltbld', 20:14:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:35 INFO - 'MOZ_NO_REMOTE': '1', 20:14:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:35 INFO - 'NO_EM_RESTART': '1', 20:14:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:35 INFO - 'PWD': '/builds/slave/test', 20:14:35 INFO - 'SHELL': '/bin/bash', 20:14:35 INFO - 'SHLVL': '1', 20:14:35 INFO - 'TERM': 'linux', 20:14:35 INFO - 'TMOUT': '86400', 20:14:35 INFO - 'USER': 'cltbld', 20:14:35 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929', 20:14:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:35 INFO - '_': '/tools/buildbot/bin/python'} 20:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:36 INFO - Downloading/unpacking blobuploader==1.2.4 20:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:38 INFO - Downloading blobuploader-1.2.4.tar.gz 20:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:14:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:14:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:38 INFO - Downloading docopt-0.6.1.tar.gz 20:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:14:38 INFO - Installing collected packages: blobuploader, requests, docopt 20:14:38 INFO - Running setup.py install for blobuploader 20:14:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:14:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:14:38 INFO - Running setup.py install for requests 20:14:39 INFO - Running setup.py install for docopt 20:14:39 INFO - Successfully installed blobuploader requests docopt 20:14:39 INFO - Cleaning up... 20:14:39 INFO - Return code: 0 20:14:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:14:39 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')]} 20:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:39 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')]} 20:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:39 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 0x23ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266b3b0>, '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 0x266c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266c740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:14:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:14:39 INFO - Using env: {'DISPLAY': ':0', 20:14:39 INFO - 'HOME': '/home/cltbld', 20:14:39 INFO - 'LANG': 'en_US.UTF-8', 20:14:39 INFO - 'LANGUAGE': 'en_US:en', 20:14:39 INFO - 'LOGNAME': 'cltbld', 20:14:39 INFO - 'MAIL': '/var/mail/cltbld', 20:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:39 INFO - 'MOZ_NO_REMOTE': '1', 20:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:39 INFO - 'NO_EM_RESTART': '1', 20:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:39 INFO - 'PWD': '/builds/slave/test', 20:14:39 INFO - 'SHELL': '/bin/bash', 20:14:39 INFO - 'SHLVL': '1', 20:14:39 INFO - 'TERM': 'linux', 20:14:39 INFO - 'TMOUT': '86400', 20:14:39 INFO - 'USER': 'cltbld', 20:14:39 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929', 20:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:39 INFO - '_': '/tools/buildbot/bin/python'} 20:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:14:39 INFO - Running setup.py (path:/tmp/pip-4ciqjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:14:39 INFO - Running setup.py (path:/tmp/pip-Noj3nR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:14:39 INFO - Running setup.py (path:/tmp/pip-8_lFei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:14:39 INFO - Running setup.py (path:/tmp/pip-vVH65n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:14:39 INFO - Running setup.py (path:/tmp/pip-CBSh5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:14:39 INFO - Running setup.py (path:/tmp/pip-UIFo9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:14:40 INFO - Running setup.py (path:/tmp/pip-idkP9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:14:40 INFO - Running setup.py (path:/tmp/pip-ufJyQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:14:40 INFO - Running setup.py (path:/tmp/pip-BcJyWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:14:40 INFO - Running setup.py (path:/tmp/pip-CI4xFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:14:40 INFO - Running setup.py (path:/tmp/pip-ucXUWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:14:40 INFO - Running setup.py (path:/tmp/pip-a0H_p6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:14:40 INFO - Running setup.py (path:/tmp/pip-PmMpyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:14:40 INFO - Running setup.py (path:/tmp/pip-YBSScb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:40 INFO - Running setup.py (path:/tmp/pip-9MyibE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:14:40 INFO - Running setup.py (path:/tmp/pip-YD8Jfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:14:40 INFO - Running setup.py (path:/tmp/pip-B9axMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:14:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:14:40 INFO - Running setup.py install for manifestparser 20:14:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:14:40 INFO - Running setup.py install for mozcrash 20:14:41 INFO - Running setup.py install for mozdebug 20:14:41 INFO - Running setup.py install for mozdevice 20:14:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:14:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:14:41 INFO - Running setup.py install for mozfile 20:14:41 INFO - Running setup.py install for mozhttpd 20:14:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:14:41 INFO - Running setup.py install for mozinfo 20:14:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:14:41 INFO - Running setup.py install for mozInstall 20:14:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:14:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:14:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:14:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:14:41 INFO - Running setup.py install for mozleak 20:14:41 INFO - Running setup.py install for mozlog 20:14:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:14:41 INFO - Running setup.py install for moznetwork 20:14:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:14:41 INFO - Running setup.py install for mozprocess 20:14:42 INFO - Running setup.py install for mozprofile 20:14:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:14:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:14:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:14:42 INFO - Running setup.py install for mozrunner 20:14:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:14:42 INFO - Running setup.py install for mozscreenshot 20:14:42 INFO - Running setup.py install for moztest 20:14:42 INFO - Running setup.py install for mozversion 20:14:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:14:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:14:42 INFO - Cleaning up... 20:14:42 INFO - Return code: 0 20:14:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:42 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 0x23ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266b3b0>, '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 0x266c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266c740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:14:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:14:42 INFO - Using env: {'DISPLAY': ':0', 20:14:42 INFO - 'HOME': '/home/cltbld', 20:14:42 INFO - 'LANG': 'en_US.UTF-8', 20:14:42 INFO - 'LANGUAGE': 'en_US:en', 20:14:42 INFO - 'LOGNAME': 'cltbld', 20:14:42 INFO - 'MAIL': '/var/mail/cltbld', 20:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:42 INFO - 'MOZ_NO_REMOTE': '1', 20:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:42 INFO - 'NO_EM_RESTART': '1', 20:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:42 INFO - 'PWD': '/builds/slave/test', 20:14:42 INFO - 'SHELL': '/bin/bash', 20:14:42 INFO - 'SHLVL': '1', 20:14:42 INFO - 'TERM': 'linux', 20:14:42 INFO - 'TMOUT': '86400', 20:14:42 INFO - 'USER': 'cltbld', 20:14:42 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929', 20:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:42 INFO - '_': '/tools/buildbot/bin/python'} 20:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:14:42 INFO - Running setup.py (path:/tmp/pip-BPXHCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:14:42 INFO - Running setup.py (path:/tmp/pip-bgoq4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:14:43 INFO - Running setup.py (path:/tmp/pip-vhNcWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:14:43 INFO - Running setup.py (path:/tmp/pip-v1XFbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:14:43 INFO - Running setup.py (path:/tmp/pip-lpzcxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:14:43 INFO - Running setup.py (path:/tmp/pip-E3OpoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:14:43 INFO - Running setup.py (path:/tmp/pip-TDLBNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:14:43 INFO - Running setup.py (path:/tmp/pip-uZNisJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:14:43 INFO - Running setup.py (path:/tmp/pip-XeRLMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:14:43 INFO - Running setup.py (path:/tmp/pip-ARg6ra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:14:43 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)) 20:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:14:43 INFO - Running setup.py (path:/tmp/pip-1K9Nb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:14:43 INFO - Running setup.py (path:/tmp/pip-8uvs9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:14:43 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)) 20:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:14:43 INFO - Running setup.py (path:/tmp/pip-aTmQxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:14:43 INFO - Running setup.py (path:/tmp/pip-9RoG6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:14:43 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)) 20:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:43 INFO - Running setup.py (path:/tmp/pip-k46XlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:14:43 INFO - Running setup.py (path:/tmp/pip-0LYkm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:14:44 INFO - Running setup.py (path:/tmp/pip-ZHvQDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:14:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:46 INFO - Downloading blessings-1.6.tar.gz 20:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:14:46 INFO - Installing collected packages: blessings 20:14:46 INFO - Running setup.py install for blessings 20:14:46 INFO - Successfully installed blessings 20:14:46 INFO - Cleaning up... 20:14:46 INFO - Return code: 0 20:14:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:14:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:14:46 INFO - Reading from file tmpfile_stdout 20:14:46 INFO - Current package versions: 20:14:46 INFO - argparse == 1.2.1 20:14:46 INFO - blessings == 1.6 20:14:46 INFO - blobuploader == 1.2.4 20:14:46 INFO - docopt == 0.6.1 20:14:46 INFO - functools32 == 3.2.3-2 20:14:46 INFO - jsonschema == 2.5.1 20:14:46 INFO - manifestparser == 1.1 20:14:46 INFO - mozInstall == 1.12 20:14:46 INFO - mozcrash == 0.17 20:14:46 INFO - mozdebug == 0.1 20:14:46 INFO - mozdevice == 0.48 20:14:46 INFO - mozfile == 1.2 20:14:46 INFO - mozhttpd == 0.7 20:14:46 INFO - mozinfo == 0.9 20:14:46 INFO - mozleak == 0.1 20:14:46 INFO - mozlog == 3.2 20:14:46 INFO - moznetwork == 0.27 20:14:46 INFO - mozprocess == 0.22 20:14:46 INFO - mozprofile == 0.28 20:14:46 INFO - mozrunner == 6.11 20:14:46 INFO - mozscreenshot == 0.1 20:14:46 INFO - mozsystemmonitor == 0.3 20:14:46 INFO - moztest == 0.7 20:14:46 INFO - mozversion == 1.4 20:14:46 INFO - psutil == 3.1.1 20:14:46 INFO - requests == 1.2.3 20:14:46 INFO - wsgiref == 0.1.2 20:14:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:14:46 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')]} 20:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:46 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')]} 20:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:46 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 0x23ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266b3b0>, '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 0x266c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266c740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:14:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:14:46 INFO - Using env: {'DISPLAY': ':0', 20:14:46 INFO - 'HOME': '/home/cltbld', 20:14:46 INFO - 'LANG': 'en_US.UTF-8', 20:14:46 INFO - 'LANGUAGE': 'en_US:en', 20:14:46 INFO - 'LOGNAME': 'cltbld', 20:14:46 INFO - 'MAIL': '/var/mail/cltbld', 20:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:46 INFO - 'MOZ_NO_REMOTE': '1', 20:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:46 INFO - 'NO_EM_RESTART': '1', 20:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:46 INFO - 'PWD': '/builds/slave/test', 20:14:46 INFO - 'SHELL': '/bin/bash', 20:14:46 INFO - 'SHLVL': '1', 20:14:46 INFO - 'TERM': 'linux', 20:14:46 INFO - 'TMOUT': '86400', 20:14:46 INFO - 'USER': 'cltbld', 20:14:46 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929', 20:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:46 INFO - '_': '/tools/buildbot/bin/python'} 20:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:14:46 INFO - Cleaning up... 20:14:46 INFO - Return code: 0 20:14:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:14:46 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')]} 20:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:46 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')]} 20:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:46 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 0x23ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266b3b0>, '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 0x266c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266c740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:14:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:14:46 INFO - Using env: {'DISPLAY': ':0', 20:14:46 INFO - 'HOME': '/home/cltbld', 20:14:46 INFO - 'LANG': 'en_US.UTF-8', 20:14:46 INFO - 'LANGUAGE': 'en_US:en', 20:14:46 INFO - 'LOGNAME': 'cltbld', 20:14:46 INFO - 'MAIL': '/var/mail/cltbld', 20:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:46 INFO - 'MOZ_NO_REMOTE': '1', 20:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:46 INFO - 'NO_EM_RESTART': '1', 20:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:46 INFO - 'PWD': '/builds/slave/test', 20:14:46 INFO - 'SHELL': '/bin/bash', 20:14:46 INFO - 'SHLVL': '1', 20:14:46 INFO - 'TERM': 'linux', 20:14:46 INFO - 'TMOUT': '86400', 20:14:46 INFO - 'USER': 'cltbld', 20:14:46 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929', 20:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:46 INFO - '_': '/tools/buildbot/bin/python'} 20:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:14:46 INFO - Cleaning up... 20:14:46 INFO - Return code: 0 20:14:46 INFO - Running post-action listener: _resource_record_post_action 20:14:46 INFO - Running post-action listener: _start_resource_monitoring 20:14:46 INFO - Starting resource monitoring. 20:14:46 INFO - ##### 20:14:46 INFO - ##### Finished create-virtualenv step (success) 20:14:46 INFO - ##### 20:14:46 INFO - ##### 20:14:46 INFO - ##### Running install step. 20:14:46 INFO - ##### 20:14:46 INFO - Running pre-action listener: _resource_record_pre_action 20:14:46 INFO - Running main action method: install 20:14:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:14:47 INFO - Reading from file tmpfile_stdout 20:14:47 INFO - Detecting whether we're running mozinstall >=1.0... 20:14:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:14:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:14:47 INFO - Reading from file tmpfile_stdout 20:14:47 INFO - Output received: 20:14:47 INFO - Usage: mozinstall [options] installer 20:14:47 INFO - Options: 20:14:47 INFO - -h, --help show this help message and exit 20:14:47 INFO - -d DEST, --destination=DEST 20:14:47 INFO - Directory to install application into. [default: 20:14:47 INFO - "/builds/slave/test"] 20:14:47 INFO - --app=APP Application being installed. [default: firefox] 20:14:47 INFO - mkdir: /builds/slave/test/build/application 20:14:47 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'] 20:14:47 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 20:15:04 INFO - Reading from file tmpfile_stdout 20:15:04 INFO - Output received: 20:15:04 INFO - /builds/slave/test/build/application/firefox/firefox 20:15:04 INFO - Running post-action listener: _resource_record_post_action 20:15:04 INFO - ##### 20:15:04 INFO - ##### Finished install step (success) 20:15:04 INFO - ##### 20:15:04 INFO - ##### 20:15:04 INFO - ##### Running run-tests step. 20:15:04 INFO - ##### 20:15:04 INFO - Running pre-action listener: _resource_record_pre_action 20:15:04 INFO - Running main action method: run_tests 20:15:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:15:04 INFO - Python 2.7.3 20:15:04 INFO - Return code: 0 20:15:04 INFO - grabbing minidump binary from tooltool 20:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:15:04 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 0x266b3b0>, '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 0x266c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:15:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:15:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:15:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:15:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:15:04 INFO - Return code: 0 20:15:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:15:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:15:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:15:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:15:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:15:04 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/UNNJAV4rQGGQOmujjnBmxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:15:04 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/UNNJAV4rQGGQOmujjnBmxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:15:04 INFO - Using env: {'DISPLAY': ':0', 20:15:04 INFO - 'HOME': '/home/cltbld', 20:15:04 INFO - 'LANG': 'en_US.UTF-8', 20:15:04 INFO - 'LANGUAGE': 'en_US:en', 20:15:04 INFO - 'LOGNAME': 'cltbld', 20:15:04 INFO - 'MAIL': '/var/mail/cltbld', 20:15:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:15:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:04 INFO - 'MOZ_NO_REMOTE': '1', 20:15:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:04 INFO - 'NO_EM_RESTART': '1', 20:15:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:04 INFO - 'PWD': '/builds/slave/test', 20:15:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:15:04 INFO - 'SHELL': '/bin/bash', 20:15:04 INFO - 'SHLVL': '1', 20:15:04 INFO - 'TERM': 'linux', 20:15:04 INFO - 'TMOUT': '86400', 20:15:04 INFO - 'USER': 'cltbld', 20:15:04 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929', 20:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:04 INFO - '_': '/tools/buildbot/bin/python'} 20:15:04 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/UNNJAV4rQGGQOmujjnBmxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:15:04 INFO - mozversion application_buildid: 20160705173010 20:15:04 INFO - mozversion application_changeset: bfcca87598b2ca8e31094d587b7b5cd033ef9577 20:15:04 INFO - mozversion application_display_name: Nightly 20:15:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:15:04 INFO - mozversion application_name: Firefox 20:15:04 INFO - mozversion application_remotingname: firefox 20:15:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:15:04 INFO - mozversion application_vendor: Mozilla 20:15:04 INFO - mozversion application_version: 50.0a1 20:15:04 INFO - mozversion platform_buildid: 20160705173010 20:15:04 INFO - mozversion platform_changeset: bfcca87598b2ca8e31094d587b7b5cd033ef9577 20:15:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:15:04 INFO - mozversion platform_version: 50.0a1 20:15:04 INFO - using testdate: 1467774904 20:15:04 INFO - actual date: 1467774904 20:15:04 INFO - starting webserver on 'localhost:56130' 20:15:04 INFO - SUITE-START | Running 2 tests 20:15:04 INFO - TEST-START | dromaeo_css 20:15:04 INFO - operating with platform_type : linux_ 20:15:04 INFO - Initialising browser for dromaeo_css test... 20:15:04 INFO - TEST-INFO | started process 22538 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpchR9XY/profile http://localhost:56130/getInfo.html) 20:15:08 INFO - PROCESS | 22538 | __metrics Screen width/height:1600/1200 20:15:08 INFO - PROCESS | 22538 | colorDepth:24 20:15:08 INFO - PROCESS | 22538 | Browser inner width/height: 1024/697 20:15:08 INFO - PROCESS | 22538 | __metrics 20:15:09 INFO - PROCESS | 22538 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:15:10 INFO - TEST-INFO | 22538: exit 0 20:15:10 INFO - Browser initialized. 20:15:10 INFO - Running cycle 1/1 for dromaeo_css test... 20:15:10 INFO - TEST-INFO | started process 22620 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpchR9XY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:15:22 INFO - PROCESS | 22620 | RSS: Main: 157143040 20:15:22 INFO - PROCESS | 22620 | 20:16:14 INFO - PROCESS | 22620 | 1467774974027 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:18:21 INFO - PROCESS | 22620 | Cycle 1(1): loaded http://localhost:56130/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56130/tests/dromaeo/cssquery-ext.html) 20:18:22 INFO - PROCESS | 22620 | RSS: Main: 244150272 20:18:22 INFO - PROCESS | 22620 | 20:21:25 INFO - PROCESS | 22620 | Cycle 1(1): loaded http://localhost:56130/tests/dromaeo/cssquery-ext.html (next: http://localhost:56130/tests/dromaeo/cssquery-jquery.html) 20:21:25 INFO - PROCESS | 22620 | RSS: Main: 243580928 20:21:25 INFO - PROCESS | 22620 | 20:24:27 INFO - PROCESS | 22620 | Cycle 1(1): loaded http://localhost:56130/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56130/tests/dromaeo/cssquery-mootools.html) 20:24:28 INFO - PROCESS | 22620 | RSS: Main: 236421120 20:24:28 INFO - PROCESS | 22620 | 20:27:30 INFO - PROCESS | 22620 | Cycle 1(1): loaded http://localhost:56130/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56130/tests/dromaeo/cssquery-prototype.html) 20:27:30 INFO - PROCESS | 22620 | RSS: Main: 235438080 20:27:30 INFO - PROCESS | 22620 | 20:30:33 INFO - PROCESS | 22620 | Cycle 1(1): loaded http://localhost:56130/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56130/tests/dromaeo/cssquery-yui.html) 20:30:34 INFO - PROCESS | 22620 | RSS: Main: 219242496 20:30:34 INFO - PROCESS | 22620 | 20:33:36 INFO - PROCESS | 22620 | Cycle 1(1): loaded http://localhost:56130/tests/dromaeo/cssquery-yui.html (next: http://localhost:56130/tests/dromaeo/cssquery-dojo.html) 20:33:37 INFO - PROCESS | 22620 | RSS: Main: 330895360 20:33:37 INFO - PROCESS | 22620 | 20:33:37 INFO - PROCESS | 22620 | __start_tp_report 20:33:37 INFO - PROCESS | 22620 | _x_x_mozilla_page_load 20:33:37 INFO - PROCESS | 22620 | _x_x_mozilla_page_load_details 20:33:37 INFO - PROCESS | 22620 | |i|pagename|runs| 20:33:37 INFO - PROCESS | 22620 | |0;dojo.html;3045.4518186726386;3063.8927637532693;3077.461444247255;3094.4584697677915;3113.9065828025155;5038.521340472649;5180.04169228692;5241.528262456383;5338.306020217376;5357.035733567961;5188.8702782430455;5231.189165679316;5257.579393648509;5278.47215278473;5300.072487314724;4768.427788665356;4834.371531700874;4876.731779752112;4888.291197776321;5009.649324547283;4921.704697718131;4963;4978.427480839714;4978.626603004789;4988.401391832985;4710.434747830265;4727.952720472803;4775.283707443877;4795.760211989386;4869.14789911764;4800.447948485934;4812.927806082912;4819.228923372244;4865.2945322928335;4903.141950158708;4822.083804077214;4844.370231869834;4850.563449289581;4853.757312134415;4858.319835223072;5055.469175736568;5257.631965762398;5259.263703081571;5269.710165940872;5280.498352656491;5563.388027316992;5592.468715472064;5676.858078548028;5680.4319568043275;5683.772649094031;5683.516901063374;5712.314522257356;5733.226014488074;5740.0815869460685;5744.655320680772;5064.696118232918;5251.4485978972425;5311.814086506993;5319.867003324909;5374.35507739066;5843.444872737083;5845.41545845412;5856.970715146482;5864.354920958691;5873.647581145145;5348.491893270133;5625;5629.4652008059165;5640;5643.379228284885;5522.6134170608475;5574;5580.776768929279;5628.71856407178;5660.122680984454;5580.86047848807;5584.994700953867;5586;5589.441055894378;5590.217369568264;5401.945980540223;5535.806246781343;5547.5007249347755;5594.244776955059;5600.439956004367;4317.460317460317;4331.805068771912;4333.978330108329;4356.716813407118;4378.627816635558;3845.2117315950723;3852.6339997700175;3860.8841734748003;3901.453796468497;3906;5095.312132862016;5189.091908915924;5211.557017653466;5340.519353258225;5344.893102137936;5477.972610136924;5552.694601796859;5570.164475328652;5575.4424557544735;5587.38538760736;5241.397239317451;5249.42256351801;5266.4470230626;5271.998320319204;5274.604404669665;4716.103940251342;4822.807087716522;4825.986542825975;4838.250071238964;4838.830640927551;5782.074868021096;5783.855403614859;5786.971065144648;5790;5816.709164541756;5616.213730077874;5622.2128901954575;5638.323401191719;5639.520640745583;5645;5575.99632066232;5689.175069614966;5720.456556627114;5752.079667253387;5770.249867517364;5498.477644623755;5502.0371434999515;5504.53211477029;5504.9449505504435;5512.035393806148;5551.167324901297;5578.079616863172;5587.469190426903;5603;5647.830565083054;5291.232771248225;5428.45715428454;5436.565074794086;5479.835604931858;5498.725063746717;5471.644343117844;5481.972590137024;5483.259759932358;5483.533899618417;5489.39616642177;5259.342582177228;5369.409364969928;5414.83755487336;5420.512153906167;5471.781128754965;5468.179773034077;5485.588580856372;5514.5864060196445;5529.391766905717;5568.16477528374;5373.650712703662;5386.380566234933;5390.326209223847;5392.08334583114;5396.1905714143195 20:33:37 INFO - PROCESS | 22620 | |1;ext.html;595.9344472108068;622.7446746833799;631.5673763472025;632.1087266953599;638.5370606310424;32140.83929580352;35880.820595896985;35912;35978.46032309514;42324.57675423245;41120;45817.77091114548;45873;45924.311135332995;45926.31110533344;8923.107689231074;9069.909300906973;9078.500682462462;9080.727578172666;9087.31845111616;8987.820243595124;9067.682631107913;9078.86381704275;9079;9084.09159084093;9089.136532029446;9119.72640820773;9134.451932884014;9142.405743626676;9143.314251431137;9046.095390460934;9061.184493395593;9070.682526111554;9083.182513573744;9087.636494540244;8819.206271435602;8869.334799890034;8886.4668119913;8892.555372231363;8894.24398926092;41311.58688413107;41549;41574.37638435426;41612.79193604043;41647.58352416467;3799.392097264452;3871.632194941476;4259.850905218303;4297.677674174418;4423.668224883115;32945.505817412755;33033.66966330354;33518.32963340719;34878.65121348779;34957.12607184815;4355.281378572532;4379.605835474823;4384;4403.713758605681;4504.527024662396;351250.2437487822;351640;352117;352346;352642;34557.481637775454;35784.46323305152;60542;60623;60935;35685;35709.64290357063;35735.28529429449;35981.8200908999;35991.4601280981;14918.70162596742;15129.621759456102;15145.242737863064;15148.772768408482;15152.242387880782;12491.250524968531;12567.434465449076;12619.116661833767;12682.80975785364;12684.30236336992;8285.50286982783;8303.584820759059;8306.377021723394;8316.584170791437;8367.535681255757;3196.1210667066744;3202.5356323333453;3225.9193520162185;3229.838508074587;3256.1208473711963;1019.9133073688671;1085.7502774361783;1133.4955944604737;1151.7408583068743;1187.9049676025897;30087.548686769715;30172.24569385783;30269.69730302669;30361.544576831366;30822.229444263623;1131.4682099413262;1162.8953394194564;1168.4274705394296;1173.8554908963692;1180.734334774669;15885.920570397075;16593.336266549202;16698.749518757228;16718.49844504667;17138.314467421413;433299;434975;438341;440618;441950;55209.171862422096;55234.447655523734;55334.72332638311;55759;55864.72067639717;1189.3993533265818;1268.5813681485088;1360.6938438851378;1364.5838019404177;1376.8210132682686;29722.554161688025;32537.34925301528;32694;32905;33812.661873381934;49224.75387623182;56045;57335.426645734675;57363.426365737476;62607;515430;517519;519741;522547;526498;35046.82476587601;42893.785531073394;43767.343489847044;44083.55916440795;44740.55259447364;48512;48720.26919596138;48936.75531622319;49449.25826112539;49939.25091123709;41145.38281925714;41698.791506042275;41700.79149604232;41831.581684183984;43087;41495.17009659729;41568;41761.164776703685;41893.1621367577;42767.786161068994;40380.394294085025;40809;40834.79582602068;40921.79539102285;41333.79333103315;36166;37134.25731485409;37557.493100826985;37649.4352584706;37804.43293350547;27664.446711065262;27666.72333276722;27932;28166.43667126687;28194.577081344207 20:33:37 INFO - PROCESS | 22620 | |2;jquery.html;367.7131837167007;395.2214138147848;396.5875489490929;398.81654438958077;412.72141304619373;14355.425782968681;16860.662786744273;19469.123889424973;19711.211551537956;19770.604587908234;18614.34849780258;19049.61900761984;19351.129199186034;19356.322528711462;19358.709619355723;4114.958850411503;5604.99110160172;5820.272465941757;5820.330661973885;5820.767169313222;6099.817005489843;6622.37087476689;6632.303608121126;6632.834179145511;6642.867142657144;6248.3751624837605;6427.8071657850105;6432;6514.674266286666;6557.967210163943;6248.281447633535;6466.482681385525;6485.772997945073;6492.05865149553;6544.181977252843;5574.191742197399;5592.105263157875;5620.100783874601;5625.043742563733;5631.465010823965;22653;22734.204302849485;23010.424739381648;23698.644520332207;23803.166889158798;2365.3613524348502;3127.890523831655;3169.904902852918;3183.71346578809;3190.489521676544;14588.70822583553;14617.196054217015;14625.707485850224;14756.40974361035;15222.46721364747;1925.2876435718874;1950.5806251655963;1953.394447721211;1984.2459865251255;1991.152651708057;79302;80451;80891;82174.17825821725;82802.75795863126;10278.280520363503;10317.793644127076;10553.155747540332;10792.136629069655;10915.072218861327;14665.853341466449;14670.706585868224;14677.825773938059;14680.632984175481;14697.706045879022;7986.800329991681;8227.629756660965;8298.54358010303;8401.15988401155;8403.663853445916;7802.414818888493;7840.843183136305;7942.602869856484;7997.440179187401;8017.318527925192;6505.096941834861;6526.379993900572;6531.1509503765155;6569.146011018537;6606.4384527315715;1931.1309910540313;1943.990280048619;1954.9120289587004;1966.4985428715586;1975.387629834727;856.2721686566493;1007.2797949466167;1050.7845891592206;1062.3625824505389;1072.5066469423996;19092.427227183205;19150.80849191518;19447.319343823183;19447.8055219446;19518.219271229274;994.8159590475785;1030.4950574218578;1044.7179261599326;1046.529061922138;1084.9132069434427;10285.43430111351;11020.44897755109;11165.94417027926;11316.94341528287;11346.886531134747;347779;349736;353255;482510;483405;96579;99751;99834.50082749686;100649;102254;1011.3375738891039;1027.5786927359748;1065.2223876570147;1067.7063807453012;1068.316277582348;16607.169641518118;16872.409465668643;17085;17420.390286339916;17482.30070797154;41750.37374439446;44373;45204.547954520036;45744.313835293164;46273;58039.41960580509;63124;63871.36128638654;64649.67675161594;65153.67423162854;8343.541105239028;8515.361347898808;8569.442986205877;8828.028916819016;8843.646254149762;12748.490060397851;13214.075014748876;13405.597832065054;13517;13886.513972010931;11622.418879055844;11723.648290551297;11810.527578896748;11826;11826.76346473083;7201.783946481614;7686.116096648957;11679.532818687157;11763.235389699643;11978.10164237703;11952.34262115592;12201.265405259513;12303;12398.442070107047;12663.176893502261;8316.708915187939;8724.912750872663;8812;8891.599878005634;9015.729528114167;10859.237813826217;12248.938755306166;12296.631101066982;12316;12396.690082748004 20:33:37 INFO - PROCESS | 22620 | |3;mootools.html;1289.8194252804615;1443.1990245413795;1501.7897494350793;1540.8844336674745;1680.168316683242;8366.79083022924;8722.520261385622;8740.082291359411;8994.820103597924;9001;8752;8877.822443551126;8922.732318030454;8945.552722363873;8946.955265223682;1921.730957665928;2193;2254.5040091179912;2264.7961683448484;2289.381866895937;2266.954660906781;2275.215050807477;2276.5788329159077;2281.817454603636;2282;2237.59723249815;2239.8992045358;2278.51012032413;2280.0765689895534;2281.8402711810095;1862.096883011745;1911.8374938130275;1912.1013123831776;2088.289981406314;2173.576152650234;2241.529278851443;2276.943076423103;2277.202978957368;2277.6241920083166;2277.8861056947253;8908.73273801787;8934.4192627479;8972.416792908505;8979.461232326015;8983.595738191798;5188.662736922126;5312.3093997780425;5312.548433383128;5317.548008419289;5323.041852466555;3255.2838375557576;3325.534425180477;3380.7126394256516;3390.762646614738;3395.711364534018;1139.2879450343535;1177.3818745158774;1185.4233868954357;1202.789511835434;1212.6665167079036;12590.0557458191;12704.110712250145;12721.10952233344;12722.173058751152;12741.55404560836;4436.6672499562665;4571.725696458223;4578.2602611007605;4780.306855505932;4788.640851936049;10465.843012354668;10550.15598752098;10553.788924221626;10584.89415105839;10595.311304765166;5165.509276618715;5170.405403378584;5185.429602743695;5188.688678679291;5197.350331208599;4016.377461493473;4558.33904083906;4698.765061746899;4702.717836929795;4776.546228108324;3866.8839934802;3937.5078115235597;3999.1002024544246;4002.839886404511;4015.2772500949527;1083.8970297821695;1189.120051162134;1235.5922545559943;1240.8635050144476;1250.412306216077;908.3550679017972;998.6404894238068;1006.8439391894268;1020.4744556553381;1027.3887533720533;6098.298695649968;6233.688315584202;6273.0904018917;6290.056491526308;6377.5535712500605;903.6084628704491;922.1879007749803;931.2270815223349;935.5228833295068;1020.5101551255439;4264.530901600821;4430.291153415438;4482.282834746425;4501.392312037833;4520.186366454004;10925.836112458319;11204.215704900742;11251.043661288719;11298.54805807775;11301.434928253555;10481.842772358268;11160.776784464428;11162.441877906072;11184.161187910939;11188.049015833745;8127.552984585786;8436.198561136805;8452.704155354533;8488.236058754619;8498.915010849936;6209.534284928739;6413.1021656969;6483.740650374121;6498.610083395011;6504.837379065561;10372.481375931324;10465.267431279737;10508;10529;10562.102221311274;9935.751606209902;10307.536160872629;10309.896901030894;10419.06228439444;10534.315269507457;7920.485168464032;8134;8143.75568732939;8144;8145.959270203611;8360.832783344178;8589.52757598338;8597.054324024477;8642.135786421308;8818.426802257833;7867.9606601966625;8011.599420029092;8029.478083924526;8048.87926681112;8135.145809689898;7735.265149810759;7741.341985931259;7783.844323113619;7794.454388192772;7832;7229.09636295463;7241.131064272321;7271.709131634675;7284.307990740871;7306.744263950949;5065.13892638245;5134.640575159703;5145;5209.374875015023;5266.315379000705;5015.974920125376;5092.261622064854;5115.590752739847;5168;5193.143131383279 20:33:37 INFO - PROCESS | 22620 | |4;prototype.html;328.65983706863386;330.45639922327774;337.87329751343236;338.43819260028357;341.106301490096;5317.787288508464;5337.626366154371;5363.758630861611;5378.520906750646;5380.300560927074;5199.246109314147;5238.554722848553;5243.816466423676;5278.9208161877605;5283.63014588979;3918.2751191029606;3981.9601803981877;4078.490188726409;4114.136031433402;4149.585041495841;4124.587541245882;4158.4405847807075;4167.6457501112445;4190.841716515996;4236.385724070024;4090.2228576570506;4130.318497447917;4156.189543039109;4173.728707634009;4176.874693759192;3876.8255428505786;4080.306672730843;4115.753054816706;4170.791460426966;4173.499180098408;3690.852365905361;3696.5564132304294;3697.7226707997006;3701.648343407399;3732.1789206374824;5227.398849132361;5240.475952404767;5243.6067294952645;5246.186841039645;5258.158694608845;4678.578927896471;4751.976240118812;4768.690035147739;4769.689970151963;4812.470628230892;5477.534409575191;5501.779928802843;5502.449755024506;5503.422140675251;5532.474414930615;3814.4850445189822;4044;4050;4057.4319595256393;4074.4092106644666;5663.603547751659;5712.400197979236;5715.2855893013375;5724.4561766632105;5728.742206600713;4057.2494088593116;4083.816228269735;4089.488813898263;4097.959020409818;4098.836046558164;4055.5741647127215;4117.485314335708;4136.875893723193;4143.440635514227;4153.335466325373;4681.274402467623;4688.906221875612;4718.31584420264;4726.8109275628585;4734;5604.859878502988;5615.961047206199;5621.465960733805;5630.690312032878;5637.323521177403;1385.217352196006;1396.9790453143212;1412.7073727539187;1416.7945647881;1416.824036050076;906.2885634776669;909.3043821476575;915.9129882661136;926.0276709455045;928.3640706116332;5288.576913846883;5393.9730301348245;5418.322709661293;5419.485148910926;5420.268263784339;5654.9151762723595;5665.971670141623;5674.1488776683;5681.289838770153;5695.686737229492;5236.869078273074;5382.569394448435;5390.137577987503;5409.972950135224;5428.37573679032;2987.2979849735293;3011.6988301170145;3026.6821983691834;3026.969730302713;3033.4388138194504;5796.14477061237;5850.619709718854;5885.852853678607;5887.499562537232;5935.40645935403;5663.575231857627;5783.537317014629;5814.563907706939;5817.534597232211;5829.650220986754;5751.424857514299;5850.561207909509;5864.67744274069;5867.471927526543;5872.941270587325;5428.022955867982;5659.207710920392;5676.382231064127;5686.2607860977805;5697.971510142423;5556.833295001156;5561.277033985556;5567.38120221859;5583.916241256303;5588.608797384144;5832.3292821326095;5862.94137058624;5863.20846685692;5876.471117599436;5910.379410161871;3873.4189871519498;4048.595140485928;4067.9796601016806;4070.2876996526084;4078.775667338325;5681.77272909079;5697.943020569907;5707.4577915098;5719.685417302088;5764.106563482667;5403.463605202842;5622.622457497776;5633.915491267552;5645.745941432728;5649.971750141387;5541.065843251336;5558.416366281483;5558.583106266965;5565.332160140809;5574.331080270394;5262.815801446931;5463.289772329572;5468.4531546845;5484.753186106555;5544.97227513876;5263.499967503081;5524.4199359068325;5561.193626924154;5562.360328562268;5580.330360356783;5418.864528386822;5419.214213939035;5439.3200849893765;5449.564034877121;5454.3454785426 20:33:37 INFO - PROCESS | 22620 | |5;yui.html;772.9265719756625;801.6993627389729;815.4291995603079;840.5713086325972;857.0829212742366;15802;17026.82973170268;17038.65922681547;17041;17142.742858857113;15395;15603;15606.297716602752;15627.453039143633;15643.374265029384;647.3591144766671;789.3803364358979;812.8293058457701;816.0859836982588;818.4025661267278;806.1173015547965;810.440795850861;813.6541969662899;813.9389545784061;814.3281792521165;576.5618130221042;856.3534531428762;857.9356548258875;859.5186695450536;860.1269711243093;838.4927119092922;854.0520022774715;854.2055888024136;856.7258477287271;858.429144618834;626.2485017978398;626.3266987987886;626.4737620398841;626.6678660310043;626.7774939896317;15302.693946121126;15327.540173794803;15364.231788410534;15366.385344586202;15367.231638418034;14755.483558075415;14905.105693658415;14910.105393676415;14910.925445372812;15149.394024239018;13339.06239851317;13534.932325338408;13667.726645467035;13723.588292351245;13789.793153102712;4543.5002149763495;4582.843129954775;4617.722936623813;4639.884002899921;4722.716637001757;72010;74173;74208;75087;75668;11775.823362649568;11864.703382415508;11873.525058997544;11935.343556104324;12357.38213089342;21595.784042159376;21609.67585486219;21626.783732162476;21826.236081737065;22869.19957801469;9517.524123793783;9566.234701223886;9643.710688679352;9657.565409556586;9697.563609637584;5090.211017292326;5100.948990510122;5106.131957567222;5120.513551212629;5257.263983042377;3544.4151714967256;3622.9818850905576;3639.1993761372987;3647.908802279964;3655.433407821739;622.5548732656173;638.7732355013903;639.8560323927079;640.7212862404868;649.655682488282;625.9061140828912;724.7572063358729;730.9802825059013;743.3867059675789;758.1887380502919;9568.95215523918;9593.184579310837;9812.90187098134;9931.702048938543;10051.145652619463;736.5838301359714;750.7522517569189;772.5094564951296;776.2005134711256;782.6595430987538;4785.952140478551;4963.305137280783;4995;4999.925001124986;5023;104292;111629.44185279022;115707.42146289215;116939;117332.41333793277;59972.100418493756;81861;100839;104009;104075.4796226014;86942.56528717442;87627;88587;89120;89622;9842;9888.555015024485;9931;10211.234157438073;10637.946810266209;37385;43023.35464968091;49826.25260621166;51344.48655513547;51729.741351293;48170;48314.27528587004;49446.50553494419;62032.37967620266;73415.26584734298;13451.798223026859;13518.464280218272;13794;13862.237576933365;13975;15221;15457.61355966065;15915.920420397824;16170.487889789532;17029.744553831453;13244.27156506363;13355.332233388486;13371.197728136343;13400.530981415604;13970.301484925916;13251.403686833923;13443.327833608477;13516.189028658311;15436.382544698086;15442.691146177238;13785.586432407044;13960.092593981359;14709.852901470847;14718.484853030093;14745.557633271019;11889.702757431134;12157.209781364183;12230.449629766505;12329.876701233232;12362.072844536517;12039.578614748441;12135.635930922086;12481.500739970663;12589.083091133583;12617.873821262037 20:33:37 INFO - PROCESS | 22620 | __end_tp_report 20:33:37 INFO - PROCESS | 22620 | __start_cc_report 20:33:37 INFO - PROCESS | 22620 | _x_x_mozilla_cycle_collect,808 20:33:37 INFO - PROCESS | 22620 | __end_cc_report 20:33:37 INFO - PROCESS | 22620 | __startTimestamp1467776017074__endTimestamp 20:33:37 INFO - PROCESS | 22620 | 20:33:37 INFO - PROCESS | 22620 | ------- Summary: start ------- 20:33:37 INFO - PROCESS | 22620 | Number of tests: 6 20:33:37 INFO - PROCESS | 22620 | 20:33:37 INFO - PROCESS | 22620 | [#0] dojo.html Cycles:165 Average:5223.06 Median:5392.08 stddev:572.61 (10.6%) stddev-sans-first:548.29 20:33:37 INFO - PROCESS | 22620 | Values: 3045.5 3063.9 3077.5 3094.5 3113.9 5038.5 5180.0 5241.5 5338.3 5357.0 5188.9 5231.2 5257.6 5278.5 5300.1 4768.4 4834.4 4876.7 4888.3 5009.6 4921.7 4963.0 4978.4 4978.6 4988.4 4710.4 4728.0 4775.3 4795.8 4869.1 4800.4 4812.9 4819.2 4865.3 4903.1 4822.1 4844.4 4850.6 4853.8 4858.3 5055.5 5257.6 5259.3 5269.7 5280.5 5563.4 5592.5 5676.9 5680.4 5683.8 5683.5 5712.3 5733.2 5740.1 5744.7 5064.7 5251.4 5311.8 5319.9 5374.4 5843.4 5845.4 5857.0 5864.4 5873.6 5348.5 5625.0 5629.5 5640.0 5643.4 5522.6 5574.0 5580.8 5628.7 5660.1 5580.9 5585.0 5586.0 5589.4 5590.2 5401.9 5535.8 5547.5 5594.2 5600.4 4317.5 4331.8 4334.0 4356.7 4378.6 3845.2 3852.6 3860.9 3901.5 3906.0 5095.3 5189.1 5211.6 5340.5 5344.9 5478.0 5552.7 5570.2 5575.4 5587.4 5241.4 5249.4 5266.4 5272.0 5274.6 4716.1 4822.8 4826.0 4838.3 4838.8 5782.1 5783.9 5787.0 5790.0 5816.7 5616.2 5622.2 5638.3 5639.5 5645.0 5576.0 5689.2 5720.5 5752.1 5770.2 5498.5 5502.0 5504.5 5504.9 5512.0 5551.2 5578.1 5587.5 5603.0 5647.8 5291.2 5428.5 5436.6 5479.8 5498.7 5471.6 5482.0 5483.3 5483.5 5489.4 5259.3 5369.4 5414.8 5420.5 5471.8 5468.2 5485.6 5514.6 5529.4 5568.2 5373.7 5386.4 5390.3 5392.1 5396.2 20:33:37 INFO - PROCESS | 22620 | 20:33:37 INFO - PROCESS | 22620 | [#1] ext.html Cycles:180 Average:58966.11 Median:41593.58 stddev:117283.08 (282.0%) stddev-sans-first:117530.21 20:33:37 INFO - PROCESS | 22620 | Values: 595.9 622.7 631.6 632.1 638.5 32140.8 35880.8 35912.0 35978.5 42324.6 41120.0 45817.8 45873.0 45924.3 45926.3 8923.1 9069.9 9078.5 9080.7 9087.3 8987.8 9067.7 9078.9 9079.0 9084.1 9089.1 9119.7 9134.5 9142.4 9143.3 9046.1 9061.2 9070.7 9083.2 9087.6 8819.2 8869.3 8886.5 8892.6 8894.2 41311.6 41549.0 41574.4 41612.8 41647.6 3799.4 3871.6 4259.9 4297.7 4423.7 32945.5 33033.7 33518.3 34878.7 34957.1 4355.3 4379.6 4384.0 4403.7 4504.5 351250.2 351640.0 352117.0 352346.0 352642.0 34557.5 35784.5 60542.0 60623.0 60935.0 35685.0 35709.6 35735.3 35981.8 35991.5 14918.7 15129.6 15145.2 15148.8 15152.2 12491.3 12567.4 12619.1 12682.8 12684.3 8285.5 8303.6 8306.4 8316.6 8367.5 3196.1 3202.5 3225.9 3229.8 3256.1 1019.9 1085.8 1133.5 1151.7 1187.9 30087.5 30172.2 30269.7 30361.5 30822.2 1131.5 1162.9 1168.4 1173.9 1180.7 15885.9 16593.3 16698.7 16718.5 17138.3 433299.0 434975.0 438341.0 440618.0 441950.0 55209.2 55234.4 55334.7 55759.0 55864.7 1189.4 1268.6 1360.7 1364.6 1376.8 29722.6 32537.3 32694.0 32905.0 33812.7 49224.8 56045.0 57335.4 57363.4 62607.0 515430.0 517519.0 519741.0 522547.0 526498.0 35046.8 42893.8 43767.3 44083.6 44740.6 48512.0 48720.3 48936.8 49449.3 49939.3 41145.4 41698.8 41700.8 41831.6 43087.0 41495.2 41568.0 41761.2 41893.2 42767.8 40380.4 40809.0 40834.8 40921.8 41333.8 36166.0 37134.3 37557.5 37649.4 37804.4 27664.4 27666.7 27932.0 28166.4 28194.6 20:33:37 INFO - PROCESS | 22620 | 20:33:37 INFO - PROCESS | 22620 | [#2] jquery.html Cycles:180 Average:27228.13 Median:12687.89 stddev:68208.76 (537.6%) stddev-sans-first:68370.29 20:33:37 INFO - PROCESS | 22620 | Values: 367.7 395.2 396.6 398.8 412.7 14355.4 16860.7 19469.1 19711.2 19770.6 18614.3 19049.6 19351.1 19356.3 19358.7 4115.0 5605.0 5820.3 5820.3 5820.8 6099.8 6622.4 6632.3 6632.8 6642.9 6248.4 6427.8 6432.0 6514.7 6558.0 6248.3 6466.5 6485.8 6492.1 6544.2 5574.2 5592.1 5620.1 5625.0 5631.5 22653.0 22734.2 23010.4 23698.6 23803.2 2365.4 3127.9 3169.9 3183.7 3190.5 14588.7 14617.2 14625.7 14756.4 15222.5 1925.3 1950.6 1953.4 1984.2 1991.2 79302.0 80451.0 80891.0 82174.2 82802.8 10278.3 10317.8 10553.2 10792.1 10915.1 14665.9 14670.7 14677.8 14680.6 14697.7 7986.8 8227.6 8298.5 8401.2 8403.7 7802.4 7840.8 7942.6 7997.4 8017.3 6505.1 6526.4 6531.2 6569.1 6606.4 1931.1 1944.0 1954.9 1966.5 1975.4 856.3 1007.3 1050.8 1062.4 1072.5 19092.4 19150.8 19447.3 19447.8 19518.2 994.8 1030.5 1044.7 1046.5 1084.9 10285.4 11020.4 11165.9 11316.9 11346.9 347779.0 349736.0 353255.0 482510.0 483405.0 96579.0 99751.0 99834.5 100649.0 102254.0 1011.3 1027.6 1065.2 1067.7 1068.3 16607.2 16872.4 17085.0 17420.4 17482.3 41750.4 44373.0 45204.5 45744.3 46273.0 58039.4 63124.0 63871.4 64649.7 65153.7 8343.5 8515.4 8569.4 8828.0 8843.6 12748.5 13214.1 13405.6 13517.0 13886.5 11622.4 11723.6 11810.5 11826.0 11826.8 7201.8 7686.1 11679.5 11763.2 11978.1 11952.3 12201.3 12303.0 12398.4 12663.2 8316.7 8724.9 8812.0 8891.6 9015.7 10859.2 12248.9 12296.6 12316.0 12396.7 20:33:37 INFO - PROCESS | 22620 | 20:33:37 INFO - PROCESS | 22620 | [#3] mootools.html Cycles:180 Average:5894.39 Median:4565.03 stddev:3413.58 (74.8%) stddev-sans-first:3405.61 20:33:37 INFO - PROCESS | 22620 | Values: 1289.8 1443.2 1501.8 1540.9 1680.2 8366.8 8722.5 8740.1 8994.8 9001.0 8752.0 8877.8 8922.7 8945.6 8947.0 1921.7 2193.0 2254.5 2264.8 2289.4 2267.0 2275.2 2276.6 2281.8 2282.0 2237.6 2239.9 2278.5 2280.1 2281.8 1862.1 1911.8 1912.1 2088.3 2173.6 2241.5 2276.9 2277.2 2277.6 2277.9 8908.7 8934.4 8972.4 8979.5 8983.6 5188.7 5312.3 5312.5 5317.5 5323.0 3255.3 3325.5 3380.7 3390.8 3395.7 1139.3 1177.4 1185.4 1202.8 1212.7 12590.1 12704.1 12721.1 12722.2 12741.6 4436.7 4571.7 4578.3 4780.3 4788.6 10465.8 10550.2 10553.8 10584.9 10595.3 5165.5 5170.4 5185.4 5188.7 5197.4 4016.4 4558.3 4698.8 4702.7 4776.5 3866.9 3937.5 3999.1 4002.8 4015.3 1083.9 1189.1 1235.6 1240.9 1250.4 908.4 998.6 1006.8 1020.5 1027.4 6098.3 6233.7 6273.1 6290.1 6377.6 903.6 922.2 931.2 935.5 1020.5 4264.5 4430.3 4482.3 4501.4 4520.2 10925.8 11204.2 11251.0 11298.5 11301.4 10481.8 11160.8 11162.4 11184.2 11188.0 8127.6 8436.2 8452.7 8488.2 8498.9 6209.5 6413.1 6483.7 6498.6 6504.8 10372.5 10465.3 10508.0 10529.0 10562.1 9935.8 10307.5 10309.9 10419.1 10534.3 7920.5 8134.0 8143.8 8144.0 8146.0 8360.8 8589.5 8597.1 8642.1 8818.4 7868.0 8011.6 8029.5 8048.9 8135.1 7735.3 7741.3 7783.8 7794.5 7832.0 7229.1 7241.1 7271.7 7284.3 7306.7 5065.1 5134.6 5145.0 5209.4 5266.3 5016.0 5092.3 5115.6 5168.0 5193.1 20:33:37 INFO - PROCESS | 22620 | 20:33:37 INFO - PROCESS | 22620 | [#4] prototype.html Cycles:180 Average:4679.56 Median:5392.06 stddev:1375.17 (25.5%) stddev-sans-first:1339.69 20:33:37 INFO - PROCESS | 22620 | Values: 328.7 330.5 337.9 338.4 341.1 5317.8 5337.6 5363.8 5378.5 5380.3 5199.2 5238.6 5243.8 5278.9 5283.6 3918.3 3982.0 4078.5 4114.1 4149.6 4124.6 4158.4 4167.6 4190.8 4236.4 4090.2 4130.3 4156.2 4173.7 4176.9 3876.8 4080.3 4115.8 4170.8 4173.5 3690.9 3696.6 3697.7 3701.6 3732.2 5227.4 5240.5 5243.6 5246.2 5258.2 4678.6 4752.0 4768.7 4769.7 4812.5 5477.5 5501.8 5502.4 5503.4 5532.5 3814.5 4044.0 4050.0 4057.4 4074.4 5663.6 5712.4 5715.3 5724.5 5728.7 4057.2 4083.8 4089.5 4098.0 4098.8 4055.6 4117.5 4136.9 4143.4 4153.3 4681.3 4688.9 4718.3 4726.8 4734.0 5604.9 5616.0 5621.5 5630.7 5637.3 1385.2 1397.0 1412.7 1416.8 1416.8 906.3 909.3 915.9 926.0 928.4 5288.6 5394.0 5418.3 5419.5 5420.3 5654.9 5666.0 5674.1 5681.3 5695.7 5236.9 5382.6 5390.1 5410.0 5428.4 2987.3 3011.7 3026.7 3027.0 3033.4 5796.1 5850.6 5885.9 5887.5 5935.4 5663.6 5783.5 5814.6 5817.5 5829.7 5751.4 5850.6 5864.7 5867.5 5872.9 5428.0 5659.2 5676.4 5686.3 5698.0 5556.8 5561.3 5567.4 5583.9 5588.6 5832.3 5862.9 5863.2 5876.5 5910.4 3873.4 4048.6 4068.0 4070.3 4078.8 5681.8 5697.9 5707.5 5719.7 5764.1 5403.5 5622.6 5633.9 5645.7 5650.0 5541.1 5558.4 5558.6 5565.3 5574.3 5262.8 5463.3 5468.5 5484.8 5545.0 5263.5 5524.4 5561.2 5562.4 5580.3 5418.9 5419.2 5439.3 5449.6 5454.3 20:33:37 INFO - PROCESS | 22620 | 20:33:37 INFO - PROCESS | 22620 | [#5] yui.html Cycles:180 Average:20277.13 Median:4628.80 stddev:28345.85 (612.4%) stddev-sans-first:28387.53 20:33:37 INFO - PROCESS | 22620 | Values: 772.9 801.7 815.4 840.6 857.1 15802.0 17026.8 17038.7 17041.0 17142.7 15395.0 15603.0 15606.3 15627.5 15643.4 647.4 789.4 812.8 816.1 818.4 806.1 810.4 813.7 813.9 814.3 576.6 856.4 857.9 859.5 860.1 838.5 854.1 854.2 856.7 858.4 626.2 626.3 626.5 626.7 626.8 15302.7 15327.5 15364.2 15366.4 15367.2 14755.5 14905.1 14910.1 14910.9 15149.4 13339.1 13534.9 13667.7 13723.6 13789.8 4543.5 4582.8 4617.7 4639.9 4722.7 72010.0 74173.0 74208.0 75087.0 75668.0 11775.8 11864.7 11873.5 11935.3 12357.4 21595.8 21609.7 21626.8 21826.2 22869.2 9517.5 9566.2 9643.7 9657.6 9697.6 5090.2 5100.9 5106.1 5120.5 5257.3 3544.4 3623.0 3639.2 3647.9 3655.4 622.6 638.8 639.9 640.7 649.7 625.9 724.8 731.0 743.4 758.2 9569.0 9593.2 9812.9 9931.7 10051.1 736.6 750.8 772.5 776.2 782.7 4786.0 4963.3 4995.0 4999.9 5023.0 104292.0 111629.4 115707.4 116939.0 117332.4 59972.1 81861.0 100839.0 104009.0 104075.5 86942.6 87627.0 88587.0 89120.0 89622.0 9842.0 9888.6 9931.0 10211.2 10637.9 37385.0 43023.4 49826.3 51344.5 51729.7 48170.0 48314.3 49446.5 62032.4 73415.3 13451.8 13518.5 13794.0 13862.2 13975.0 15221.0 15457.6 15915.9 16170.5 17029.7 13244.3 13355.3 13371.2 13400.5 13970.3 13251.4 13443.3 13516.2 15436.4 15442.7 13785.6 13960.1 14709.9 14718.5 14745.6 11889.7 12157.2 12230.4 12329.9 12362.1 12039.6 12135.6 12481.5 12589.1 12617.9 20:33:37 INFO - PROCESS | 22620 | -------- Summary: end -------- 20:33:37 INFO - PROCESS | 22620 | 20:33:37 INFO - TEST-INFO | 22620: exit 0 20:33:37 INFO - TEST-OK | dromaeo_css | took 1113163ms 20:33:37 INFO - TEST-START | kraken 20:33:37 INFO - operating with platform_type : linux_ 20:33:37 INFO - Initialising browser for kraken test... 20:33:37 INFO - TEST-INFO | started process 22815 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpofGUFv/profile http://localhost:56130/getInfo.html) 20:33:41 INFO - PROCESS | 22815 | __metrics Screen width/height:1600/1200 20:33:41 INFO - PROCESS | 22815 | colorDepth:24 20:33:41 INFO - PROCESS | 22815 | Browser inner width/height: 1024/697 20:33:41 INFO - PROCESS | 22815 | __metrics 20:33:42 INFO - PROCESS | 22815 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:33:43 INFO - TEST-INFO | 22815: exit 0 20:33:43 INFO - Browser initialized. 20:33:43 INFO - Running cycle 1/1 for kraken test... 20:33:43 INFO - TEST-INFO | started process 22898 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpofGUFv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:33:55 INFO - PROCESS | 22898 | RSS: Main: 156856320 20:33:55 INFO - PROCESS | 22898 | 20:33:58 INFO - PROCESS | 22898 | Cycle 1(1): loaded http://localhost:56130/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56130/tests/kraken/driver.html?testName=audio-beat-detection) 20:33:59 INFO - PROCESS | 22898 | RSS: Main: 215560192 20:33:59 INFO - PROCESS | 22898 | 20:34:01 INFO - PROCESS | 22898 | Cycle 1(1): loaded http://localhost:56130/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56130/tests/kraken/driver.html?testName=audio-dft) 20:34:02 INFO - PROCESS | 22898 | RSS: Main: 203923456 20:34:02 INFO - PROCESS | 22898 | 20:34:05 INFO - PROCESS | 22898 | Cycle 1(1): loaded http://localhost:56130/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56130/tests/kraken/driver.html?testName=audio-fft) 20:34:06 INFO - PROCESS | 22898 | RSS: Main: 269574144 20:34:06 INFO - PROCESS | 22898 | 20:34:08 INFO - PROCESS | 22898 | Cycle 1(1): loaded http://localhost:56130/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56130/tests/kraken/driver.html?testName=audio-oscillator) 20:34:08 INFO - PROCESS | 22898 | RSS: Main: 180846592 20:34:08 INFO - PROCESS | 22898 | 20:34:10 INFO - PROCESS | 22898 | Cycle 1(1): loaded http://localhost:56130/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56130/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:34:11 INFO - PROCESS | 22898 | RSS: Main: 185077760 20:34:11 INFO - PROCESS | 22898 | 20:34:14 INFO - PROCESS | 22898 | Cycle 1(1): loaded http://localhost:56130/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56130/tests/kraken/driver.html?testName=imaging-darkroom) 20:34:15 INFO - PROCESS | 22898 | RSS: Main: 219676672 20:34:15 INFO - PROCESS | 22898 | 20:34:18 INFO - PROCESS | 22898 | Cycle 1(1): loaded http://localhost:56130/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56130/tests/kraken/driver.html?testName=imaging-desaturate) 20:34:18 INFO - PROCESS | 22898 | RSS: Main: 221798400 20:34:18 INFO - PROCESS | 22898 | 20:34:21 INFO - PROCESS | 22898 | Cycle 1(1): loaded http://localhost:56130/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56130/tests/kraken/driver.html?testName=json-parse-financial) 20:34:22 INFO - PROCESS | 22898 | RSS: Main: 221573120 20:34:22 INFO - PROCESS | 22898 | 20:34:23 INFO - PROCESS | 22898 | Cycle 1(1): loaded http://localhost:56130/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56130/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:34:24 INFO - PROCESS | 22898 | RSS: Main: 209072128 20:34:24 INFO - PROCESS | 22898 | 20:34:26 INFO - PROCESS | 22898 | Cycle 1(1): loaded http://localhost:56130/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56130/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:34:26 INFO - PROCESS | 22898 | RSS: Main: 211660800 20:34:26 INFO - PROCESS | 22898 | 20:34:28 INFO - PROCESS | 22898 | Cycle 1(1): loaded http://localhost:56130/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56130/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:34:29 INFO - PROCESS | 22898 | RSS: Main: 208949248 20:34:29 INFO - PROCESS | 22898 | 20:34:32 INFO - PROCESS | 22898 | Cycle 1(1): loaded http://localhost:56130/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56130/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:34:32 INFO - PROCESS | 22898 | RSS: Main: 231903232 20:34:32 INFO - PROCESS | 22898 | 20:34:35 INFO - PROCESS | 22898 | Cycle 1(1): loaded http://localhost:56130/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56130/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:34:35 INFO - PROCESS | 22898 | RSS: Main: 227041280 20:34:35 INFO - PROCESS | 22898 | 20:34:37 INFO - PROCESS | 22898 | Cycle 1(1): loaded http://localhost:56130/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56130/tests/kraken/driver.html?testName=ai-astar) 20:34:37 INFO - PROCESS | 22898 | RSS: Main: 269582336 20:34:37 INFO - PROCESS | 22898 | 20:34:37 INFO - PROCESS | 22898 | __start_tp_report 20:34:37 INFO - PROCESS | 22898 | _x_x_mozilla_page_load 20:34:37 INFO - PROCESS | 22898 | _x_x_mozilla_page_load_details 20:34:37 INFO - PROCESS | 22898 | |i|pagename|runs| 20:34:37 INFO - PROCESS | 22898 | |0;ai-astar;102;111;111;110;113;111;110;111;111;110 20:34:37 INFO - PROCESS | 22898 | |1;audio-beat-detection;149;115;117;168;122;118;150;120;160;117 20:34:37 INFO - PROCESS | 22898 | |2;audio-dft;162;161;161;162;161;162;161;161;162;161 20:34:37 INFO - PROCESS | 22898 | |3;audio-fft;75;75;76;116;75;75;76;74;104;75 20:34:37 INFO - PROCESS | 22898 | |4;audio-oscillator;85;84;115;85;85;84;112;84;84;129 20:34:37 INFO - PROCESS | 22898 | |5;imaging-gaussian-blur;117;116;116;117;117;117;116;117;117;117 20:34:37 INFO - PROCESS | 22898 | |6;imaging-darkroom;146;146;146;146;146;145;146;146;145;145 20:34:37 INFO - PROCESS | 22898 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 20:34:37 INFO - PROCESS | 22898 | |8;json-parse-financial;51;54;52;53;53;53;54;52;51;52 20:34:37 INFO - PROCESS | 22898 | |9;json-stringify-tinderbox;61;60;61;60;62;61;61;61;62;62 20:34:37 INFO - PROCESS | 22898 | |10;stanford-crypto-aes;76;74;74;75;77;75;75;78;74;75 20:34:37 INFO - PROCESS | 22898 | |11;stanford-crypto-ccm;130;124;145;128;126;119;121;118;167;118 20:34:37 INFO - PROCESS | 22898 | |12;stanford-crypto-pbkdf2;159;160;155;160;156;156;158;157;160;162 20:34:37 INFO - PROCESS | 22898 | |13;stanford-crypto-sha256-iterative;65;63;65;63;64;63;65;61;62;60 20:34:37 INFO - PROCESS | 22898 | __end_tp_report 20:34:37 INFO - PROCESS | 22898 | __start_cc_report 20:34:37 INFO - PROCESS | 22898 | _x_x_mozilla_cycle_collect,1650 20:34:37 INFO - PROCESS | 22898 | __end_cc_report 20:34:37 INFO - PROCESS | 22898 | __startTimestamp1467776077861__endTimestamp 20:34:37 INFO - PROCESS | 22898 | 20:34:37 INFO - PROCESS | 22898 | ------- Summary: start ------- 20:34:37 INFO - PROCESS | 22898 | Number of tests: 14 20:34:37 INFO - PROCESS | 22898 | 20:34:37 INFO - PROCESS | 22898 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.94 (2.7%) stddev-sans-first:0.93 20:34:37 INFO - PROCESS | 22898 | Values: 102.0 111.0 111.0 110.0 113.0 111.0 110.0 111.0 111.0 110.0 20:34:37 INFO - PROCESS | 22898 | 20:34:37 INFO - PROCESS | 22898 | [#1] audio-beat-detection Cycles:10 Average:133.60 Median:135.50 stddev:20.67 (15.3%) stddev-sans-first:21.16 20:34:37 INFO - PROCESS | 22898 | Values: 149.0 115.0 117.0 168.0 122.0 118.0 150.0 120.0 160.0 117.0 20:34:37 INFO - PROCESS | 22898 | 20:34:37 INFO - PROCESS | 22898 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.52 (0.3%) stddev-sans-first:0.50 20:34:37 INFO - PROCESS | 22898 | Values: 162.0 161.0 161.0 162.0 161.0 162.0 161.0 161.0 162.0 161.0 20:34:37 INFO - PROCESS | 22898 | 20:34:37 INFO - PROCESS | 22898 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.00 stddev:14.98 (20.0%) stddev-sans-first:15.67 20:34:37 INFO - PROCESS | 22898 | Values: 75.0 75.0 76.0 116.0 75.0 75.0 76.0 74.0 104.0 75.0 20:34:37 INFO - PROCESS | 22898 | 20:34:37 INFO - PROCESS | 22898 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:84.00 stddev:17.09 (20.3%) stddev-sans-first:17.76 20:34:37 INFO - PROCESS | 22898 | Values: 85.0 84.0 115.0 85.0 85.0 84.0 112.0 84.0 84.0 129.0 20:34:37 INFO - PROCESS | 22898 | 20:34:37 INFO - PROCESS | 22898 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 20:34:37 INFO - PROCESS | 22898 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 20:34:37 INFO - PROCESS | 22898 | 20:34:37 INFO - PROCESS | 22898 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 20:34:37 INFO - PROCESS | 22898 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 20:34:37 INFO - PROCESS | 22898 | 20:34:37 INFO - PROCESS | 22898 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 20:34:37 INFO - PROCESS | 22898 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 20:34:37 INFO - PROCESS | 22898 | 20:34:37 INFO - PROCESS | 22898 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:53.00 stddev:1.08 (2.0%) stddev-sans-first:1.00 20:34:37 INFO - PROCESS | 22898 | Values: 51.0 54.0 52.0 53.0 53.0 53.0 54.0 52.0 51.0 52.0 20:34:37 INFO - PROCESS | 22898 | 20:34:37 INFO - PROCESS | 22898 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 20:34:37 INFO - PROCESS | 22898 | Values: 61.0 60.0 61.0 60.0 62.0 61.0 61.0 61.0 62.0 62.0 20:34:37 INFO - PROCESS | 22898 | 20:34:37 INFO - PROCESS | 22898 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:75.00 stddev:1.34 (1.8%) stddev-sans-first:1.39 20:34:37 INFO - PROCESS | 22898 | Values: 76.0 74.0 74.0 75.0 77.0 75.0 75.0 78.0 74.0 75.0 20:34:37 INFO - PROCESS | 22898 | 20:34:37 INFO - PROCESS | 22898 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:127.00 stddev:15.41 (12.1%) stddev-sans-first:16.35 20:34:37 INFO - PROCESS | 22898 | Values: 130.0 124.0 145.0 128.0 126.0 119.0 121.0 118.0 167.0 118.0 20:34:37 INFO - PROCESS | 22898 | 20:34:37 INFO - PROCESS | 22898 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.30 Median:159.50 stddev:2.26 (1.4%) stddev-sans-first:2.39 20:34:37 INFO - PROCESS | 22898 | Values: 159.0 160.0 155.0 160.0 156.0 156.0 158.0 157.0 160.0 162.0 20:34:37 INFO - PROCESS | 22898 | 20:34:37 INFO - PROCESS | 22898 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.50 stddev:1.73 (2.7%) stddev-sans-first:1.69 20:34:37 INFO - PROCESS | 22898 | Values: 65.0 63.0 65.0 63.0 64.0 63.0 65.0 61.0 62.0 60.0 20:34:37 INFO - PROCESS | 22898 | -------- Summary: end -------- 20:34:37 INFO - PROCESS | 22898 | 20:34:38 INFO - TEST-INFO | 22898: exit 0 20:34:38 INFO - TEST-OK | kraken | took 61029ms 20:34:38 INFO - SUITE-END | took 1174s 20:34:39 INFO - Completed test suite (00:19:34) 20:34:39 INFO - javascript benchmark 20:34:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3045.4518186726386, 3063.8927637532693, 3077.461444247255, 3094.4584697677915, 3113.9065828025155, 5038.521340472649, 5180.04169228692, 5241.528262456383, 5338.306020217376, 5357.035733567961, 5188.8702782430455, 5231.189165679316, 5257.579393648509, 5278.47215278473, 5300.072487314724, 4768.427788665356, 4834.371531700874, 4876.731779752112, 4888.291197776321, 5009.649324547283, 4921.704697718131, 4963.0, 4978.427480839714, 4978.626603004789, 4988.401391832985, 4710.434747830265, 4727.952720472803, 4775.283707443877, 4795.760211989386, 4869.14789911764, 4800.447948485934, 4812.927806082912, 4819.228923372244, 4865.2945322928335, 4903.141950158708, 4822.083804077214, 4844.370231869834, 4850.563449289581, 4853.757312134415, 4858.319835223072, 5055.469175736568, 5257.631965762398, 5259.263703081571, 5269.710165940872, 5280.498352656491, 5563.388027316992, 5592.468715472064, 5676.858078548028, 5680.4319568043275, 5683.772649094031, 5683.516901063374, 5712.314522257356, 5733.226014488074, 5740.0815869460685, 5744.655320680772, 5064.696118232918, 5251.4485978972425, 5311.814086506993, 5319.867003324909, 5374.35507739066, 5843.444872737083, 5845.41545845412, 5856.970715146482, 5864.354920958691, 5873.647581145145, 5348.491893270133, 5625.0, 5629.4652008059165, 5640.0, 5643.379228284885, 5522.6134170608475, 5574.0, 5580.776768929279, 5628.71856407178, 5660.122680984454, 5580.86047848807, 5584.994700953867, 5586.0, 5589.441055894378, 5590.217369568264, 5401.945980540223, 5535.806246781343, 5547.5007249347755, 5594.244776955059, 5600.439956004367, 4317.460317460317, 4331.805068771912, 4333.978330108329, 4356.716813407118, 4378.627816635558, 3845.2117315950723, 3852.6339997700175, 3860.8841734748003, 3901.453796468497, 3906.0, 5095.312132862016, 5189.091908915924, 5211.557017653466, 5340.519353258225, 5344.893102137936, 5477.972610136924, 5552.694601796859, 5570.164475328652, 5575.4424557544735, 5587.38538760736, 5241.397239317451, 5249.42256351801, 5266.4470230626, 5271.998320319204, 5274.604404669665, 4716.103940251342, 4822.807087716522, 4825.986542825975, 4838.250071238964, 4838.830640927551, 5782.074868021096, 5783.855403614859, 5786.971065144648, 5790.0, 5816.709164541756, 5616.213730077874, 5622.2128901954575, 5638.323401191719, 5639.520640745583, 5645.0, 5575.99632066232, 5689.175069614966, 5720.456556627114, 5752.079667253387, 5770.249867517364, 5498.477644623755, 5502.0371434999515, 5504.53211477029, 5504.9449505504435, 5512.035393806148, 5551.167324901297, 5578.079616863172, 5587.469190426903, 5603.0, 5647.830565083054, 5291.232771248225, 5428.45715428454, 5436.565074794086, 5479.835604931858, 5498.725063746717, 5471.644343117844, 5481.972590137024, 5483.259759932358, 5483.533899618417, 5489.39616642177, 5259.342582177228, 5369.409364969928, 5414.83755487336, 5420.512153906167, 5471.781128754965, 5468.179773034077, 5485.588580856372, 5514.5864060196445, 5529.391766905717, 5568.16477528374, 5373.650712703662, 5386.380566234933, 5390.326209223847, 5392.08334583114, 5396.1905714143195], "value": 5185.814614329855, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.9344472108068, 622.7446746833799, 631.5673763472025, 632.1087266953599, 638.5370606310424, 32140.83929580352, 35880.820595896985, 35912.0, 35978.46032309514, 42324.57675423245, 41120.0, 45817.77091114548, 45873.0, 45924.311135332995, 45926.31110533344, 8923.107689231074, 9069.909300906973, 9078.500682462462, 9080.727578172666, 9087.31845111616, 8987.820243595124, 9067.682631107913, 9078.86381704275, 9079.0, 9084.09159084093, 9089.136532029446, 9119.72640820773, 9134.451932884014, 9142.405743626676, 9143.314251431137, 9046.095390460934, 9061.184493395593, 9070.682526111554, 9083.182513573744, 9087.636494540244, 8819.206271435602, 8869.334799890034, 8886.4668119913, 8892.555372231363, 8894.24398926092, 41311.58688413107, 41549.0, 41574.37638435426, 41612.79193604043, 41647.58352416467, 3799.392097264452, 3871.632194941476, 4259.850905218303, 4297.677674174418, 4423.668224883115, 32945.505817412755, 33033.66966330354, 33518.32963340719, 34878.65121348779, 34957.12607184815, 4355.281378572532, 4379.605835474823, 4384.0, 4403.713758605681, 4504.527024662396, 351250.2437487822, 351640.0, 352117.0, 352346.0, 352642.0, 34557.481637775454, 35784.46323305152, 60542.0, 60623.0, 60935.0, 35685.0, 35709.64290357063, 35735.28529429449, 35981.8200908999, 35991.4601280981, 14918.70162596742, 15129.621759456102, 15145.242737863064, 15148.772768408482, 15152.242387880782, 12491.250524968531, 12567.434465449076, 12619.116661833767, 12682.80975785364, 12684.30236336992, 8285.50286982783, 8303.584820759059, 8306.377021723394, 8316.584170791437, 8367.535681255757, 3196.1210667066744, 3202.5356323333453, 3225.9193520162185, 3229.838508074587, 3256.1208473711963, 1019.9133073688671, 1085.7502774361783, 1133.4955944604737, 1151.7408583068743, 1187.9049676025897, 30087.548686769715, 30172.24569385783, 30269.69730302669, 30361.544576831366, 30822.229444263623, 1131.4682099413262, 1162.8953394194564, 1168.4274705394296, 1173.8554908963692, 1180.734334774669, 15885.920570397075, 16593.336266549202, 16698.749518757228, 16718.49844504667, 17138.314467421413, 433299.0, 434975.0, 438341.0, 440618.0, 441950.0, 55209.171862422096, 55234.447655523734, 55334.72332638311, 55759.0, 55864.72067639717, 1189.3993533265818, 1268.5813681485088, 1360.6938438851378, 1364.5838019404177, 1376.8210132682686, 29722.554161688025, 32537.34925301528, 32694.0, 32905.0, 33812.661873381934, 49224.75387623182, 56045.0, 57335.426645734675, 57363.426365737476, 62607.0, 515430.0, 517519.0, 519741.0, 522547.0, 526498.0, 35046.82476587601, 42893.785531073394, 43767.343489847044, 44083.55916440795, 44740.55259447364, 48512.0, 48720.26919596138, 48936.75531622319, 49449.25826112539, 49939.25091123709, 41145.38281925714, 41698.791506042275, 41700.79149604232, 41831.581684183984, 43087.0, 41495.17009659729, 41568.0, 41761.164776703685, 41893.1621367577, 42767.786161068994, 40380.394294085025, 40809.0, 40834.79582602068, 40921.79539102285, 41333.79333103315, 36166.0, 37134.25731485409, 37557.493100826985, 37649.4352584706, 37804.43293350547, 27664.446711065262, 27666.72333276722, 27932.0, 28166.43667126687, 28194.577081344207], "value": 19196.85787017697, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.7131837167007, 395.2214138147848, 396.5875489490929, 398.81654438958077, 412.72141304619373, 14355.425782968681, 16860.662786744273, 19469.123889424973, 19711.211551537956, 19770.604587908234, 18614.34849780258, 19049.61900761984, 19351.129199186034, 19356.322528711462, 19358.709619355723, 4114.958850411503, 5604.99110160172, 5820.272465941757, 5820.330661973885, 5820.767169313222, 6099.817005489843, 6622.37087476689, 6632.303608121126, 6632.834179145511, 6642.867142657144, 6248.3751624837605, 6427.8071657850105, 6432.0, 6514.674266286666, 6557.967210163943, 6248.281447633535, 6466.482681385525, 6485.772997945073, 6492.05865149553, 6544.181977252843, 5574.191742197399, 5592.105263157875, 5620.100783874601, 5625.043742563733, 5631.465010823965, 22653.0, 22734.204302849485, 23010.424739381648, 23698.644520332207, 23803.166889158798, 2365.3613524348502, 3127.890523831655, 3169.904902852918, 3183.71346578809, 3190.489521676544, 14588.70822583553, 14617.196054217015, 14625.707485850224, 14756.40974361035, 15222.46721364747, 1925.2876435718874, 1950.5806251655963, 1953.394447721211, 1984.2459865251255, 1991.152651708057, 79302.0, 80451.0, 80891.0, 82174.17825821725, 82802.75795863126, 10278.280520363503, 10317.793644127076, 10553.155747540332, 10792.136629069655, 10915.072218861327, 14665.853341466449, 14670.706585868224, 14677.825773938059, 14680.632984175481, 14697.706045879022, 7986.800329991681, 8227.629756660965, 8298.54358010303, 8401.15988401155, 8403.663853445916, 7802.414818888493, 7840.843183136305, 7942.602869856484, 7997.440179187401, 8017.318527925192, 6505.096941834861, 6526.379993900572, 6531.1509503765155, 6569.146011018537, 6606.4384527315715, 1931.1309910540313, 1943.990280048619, 1954.9120289587004, 1966.4985428715586, 1975.387629834727, 856.2721686566493, 1007.2797949466167, 1050.7845891592206, 1062.3625824505389, 1072.5066469423996, 19092.427227183205, 19150.80849191518, 19447.319343823183, 19447.8055219446, 19518.219271229274, 994.8159590475785, 1030.4950574218578, 1044.7179261599326, 1046.529061922138, 1084.9132069434427, 10285.43430111351, 11020.44897755109, 11165.94417027926, 11316.94341528287, 11346.886531134747, 347779.0, 349736.0, 353255.0, 482510.0, 483405.0, 96579.0, 99751.0, 99834.50082749686, 100649.0, 102254.0, 1011.3375738891039, 1027.5786927359748, 1065.2223876570147, 1067.7063807453012, 1068.316277582348, 16607.169641518118, 16872.409465668643, 17085.0, 17420.390286339916, 17482.30070797154, 41750.37374439446, 44373.0, 45204.547954520036, 45744.313835293164, 46273.0, 58039.41960580509, 63124.0, 63871.36128638654, 64649.67675161594, 65153.67423162854, 8343.541105239028, 8515.361347898808, 8569.442986205877, 8828.028916819016, 8843.646254149762, 12748.490060397851, 13214.075014748876, 13405.597832065054, 13517.0, 13886.513972010931, 11622.418879055844, 11723.648290551297, 11810.527578896748, 11826.0, 11826.76346473083, 7201.783946481614, 7686.116096648957, 11679.532818687157, 11763.235389699643, 11978.10164237703, 11952.34262115592, 12201.265405259513, 12303.0, 12398.442070107047, 12663.176893502261, 8316.708915187939, 8724.912750872663, 8812.0, 8891.599878005634, 9015.729528114167, 10859.237813826217, 12248.938755306166, 12296.631101066982, 12316.0, 12396.690082748004], "value": 9552.838132773184, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1289.8194252804615, 1443.1990245413795, 1501.7897494350793, 1540.8844336674745, 1680.168316683242, 8366.79083022924, 8722.520261385622, 8740.082291359411, 8994.820103597924, 9001.0, 8752.0, 8877.822443551126, 8922.732318030454, 8945.552722363873, 8946.955265223682, 1921.730957665928, 2193.0, 2254.5040091179912, 2264.7961683448484, 2289.381866895937, 2266.954660906781, 2275.215050807477, 2276.5788329159077, 2281.817454603636, 2282.0, 2237.59723249815, 2239.8992045358, 2278.51012032413, 2280.0765689895534, 2281.8402711810095, 1862.096883011745, 1911.8374938130275, 1912.1013123831776, 2088.289981406314, 2173.576152650234, 2241.529278851443, 2276.943076423103, 2277.202978957368, 2277.6241920083166, 2277.8861056947253, 8908.73273801787, 8934.4192627479, 8972.416792908505, 8979.461232326015, 8983.595738191798, 5188.662736922126, 5312.3093997780425, 5312.548433383128, 5317.548008419289, 5323.041852466555, 3255.2838375557576, 3325.534425180477, 3380.7126394256516, 3390.762646614738, 3395.711364534018, 1139.2879450343535, 1177.3818745158774, 1185.4233868954357, 1202.789511835434, 1212.6665167079036, 12590.0557458191, 12704.110712250145, 12721.10952233344, 12722.173058751152, 12741.55404560836, 4436.6672499562665, 4571.725696458223, 4578.2602611007605, 4780.306855505932, 4788.640851936049, 10465.843012354668, 10550.15598752098, 10553.788924221626, 10584.89415105839, 10595.311304765166, 5165.509276618715, 5170.405403378584, 5185.429602743695, 5188.688678679291, 5197.350331208599, 4016.377461493473, 4558.33904083906, 4698.765061746899, 4702.717836929795, 4776.546228108324, 3866.8839934802, 3937.5078115235597, 3999.1002024544246, 4002.839886404511, 4015.2772500949527, 1083.8970297821695, 1189.120051162134, 1235.5922545559943, 1240.8635050144476, 1250.412306216077, 908.3550679017972, 998.6404894238068, 1006.8439391894268, 1020.4744556553381, 1027.3887533720533, 6098.298695649968, 6233.688315584202, 6273.0904018917, 6290.056491526308, 6377.5535712500605, 903.6084628704491, 922.1879007749803, 931.2270815223349, 935.5228833295068, 1020.5101551255439, 4264.530901600821, 4430.291153415438, 4482.282834746425, 4501.392312037833, 4520.186366454004, 10925.836112458319, 11204.215704900742, 11251.043661288719, 11298.54805807775, 11301.434928253555, 10481.842772358268, 11160.776784464428, 11162.441877906072, 11184.161187910939, 11188.049015833745, 8127.552984585786, 8436.198561136805, 8452.704155354533, 8488.236058754619, 8498.915010849936, 6209.534284928739, 6413.1021656969, 6483.740650374121, 6498.610083395011, 6504.837379065561, 10372.481375931324, 10465.267431279737, 10508.0, 10529.0, 10562.102221311274, 9935.751606209902, 10307.536160872629, 10309.896901030894, 10419.06228439444, 10534.315269507457, 7920.485168464032, 8134.0, 8143.75568732939, 8144.0, 8145.959270203611, 8360.832783344178, 8589.52757598338, 8597.054324024477, 8642.135786421308, 8818.426802257833, 7867.9606601966625, 8011.599420029092, 8029.478083924526, 8048.87926681112, 8135.145809689898, 7735.265149810759, 7741.341985931259, 7783.844323113619, 7794.454388192772, 7832.0, 7229.09636295463, 7241.131064272321, 7271.709131634675, 7284.307990740871, 7306.744263950949, 5065.13892638245, 5134.640575159703, 5145.0, 5209.374875015023, 5266.315379000705, 5015.974920125376, 5092.261622064854, 5115.590752739847, 5168.0, 5193.143131383279], "value": 4666.02576659564, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.65983706863386, 330.45639922327774, 337.87329751343236, 338.43819260028357, 341.106301490096, 5317.787288508464, 5337.626366154371, 5363.758630861611, 5378.520906750646, 5380.300560927074, 5199.246109314147, 5238.554722848553, 5243.816466423676, 5278.9208161877605, 5283.63014588979, 3918.2751191029606, 3981.9601803981877, 4078.490188726409, 4114.136031433402, 4149.585041495841, 4124.587541245882, 4158.4405847807075, 4167.6457501112445, 4190.841716515996, 4236.385724070024, 4090.2228576570506, 4130.318497447917, 4156.189543039109, 4173.728707634009, 4176.874693759192, 3876.8255428505786, 4080.306672730843, 4115.753054816706, 4170.791460426966, 4173.499180098408, 3690.852365905361, 3696.5564132304294, 3697.7226707997006, 3701.648343407399, 3732.1789206374824, 5227.398849132361, 5240.475952404767, 5243.6067294952645, 5246.186841039645, 5258.158694608845, 4678.578927896471, 4751.976240118812, 4768.690035147739, 4769.689970151963, 4812.470628230892, 5477.534409575191, 5501.779928802843, 5502.449755024506, 5503.422140675251, 5532.474414930615, 3814.4850445189822, 4044.0, 4050.0, 4057.4319595256393, 4074.4092106644666, 5663.603547751659, 5712.400197979236, 5715.2855893013375, 5724.4561766632105, 5728.742206600713, 4057.2494088593116, 4083.816228269735, 4089.488813898263, 4097.959020409818, 4098.836046558164, 4055.5741647127215, 4117.485314335708, 4136.875893723193, 4143.440635514227, 4153.335466325373, 4681.274402467623, 4688.906221875612, 4718.31584420264, 4726.8109275628585, 4734.0, 5604.859878502988, 5615.961047206199, 5621.465960733805, 5630.690312032878, 5637.323521177403, 1385.217352196006, 1396.9790453143212, 1412.7073727539187, 1416.7945647881, 1416.824036050076, 906.2885634776669, 909.3043821476575, 915.9129882661136, 926.0276709455045, 928.3640706116332, 5288.576913846883, 5393.9730301348245, 5418.322709661293, 5419.485148910926, 5420.268263784339, 5654.9151762723595, 5665.971670141623, 5674.1488776683, 5681.289838770153, 5695.686737229492, 5236.869078273074, 5382.569394448435, 5390.137577987503, 5409.972950135224, 5428.37573679032, 2987.2979849735293, 3011.6988301170145, 3026.6821983691834, 3026.969730302713, 3033.4388138194504, 5796.14477061237, 5850.619709718854, 5885.852853678607, 5887.499562537232, 5935.40645935403, 5663.575231857627, 5783.537317014629, 5814.563907706939, 5817.534597232211, 5829.650220986754, 5751.424857514299, 5850.561207909509, 5864.67744274069, 5867.471927526543, 5872.941270587325, 5428.022955867982, 5659.207710920392, 5676.382231064127, 5686.2607860977805, 5697.971510142423, 5556.833295001156, 5561.277033985556, 5567.38120221859, 5583.916241256303, 5588.608797384144, 5832.3292821326095, 5862.94137058624, 5863.20846685692, 5876.471117599436, 5910.379410161871, 3873.4189871519498, 4048.595140485928, 4067.9796601016806, 4070.2876996526084, 4078.775667338325, 5681.77272909079, 5697.943020569907, 5707.4577915098, 5719.685417302088, 5764.106563482667, 5403.463605202842, 5622.622457497776, 5633.915491267552, 5645.745941432728, 5649.971750141387, 5541.065843251336, 5558.416366281483, 5558.583106266965, 5565.332160140809, 5574.331080270394, 5262.815801446931, 5463.289772329572, 5468.4531546845, 5484.753186106555, 5544.97227513876, 5263.499967503081, 5524.4199359068325, 5561.193626924154, 5562.360328562268, 5580.330360356783, 5418.864528386822, 5419.214213939035, 5439.3200849893765, 5449.564034877121, 5454.3454785426], "value": 4238.794590814807, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.9265719756625, 801.6993627389729, 815.4291995603079, 840.5713086325972, 857.0829212742366, 15802.0, 17026.82973170268, 17038.65922681547, 17041.0, 17142.742858857113, 15395.0, 15603.0, 15606.297716602752, 15627.453039143633, 15643.374265029384, 647.3591144766671, 789.3803364358979, 812.8293058457701, 816.0859836982588, 818.4025661267278, 806.1173015547965, 810.440795850861, 813.6541969662899, 813.9389545784061, 814.3281792521165, 576.5618130221042, 856.3534531428762, 857.9356548258875, 859.5186695450536, 860.1269711243093, 838.4927119092922, 854.0520022774715, 854.2055888024136, 856.7258477287271, 858.429144618834, 626.2485017978398, 626.3266987987886, 626.4737620398841, 626.6678660310043, 626.7774939896317, 15302.693946121126, 15327.540173794803, 15364.231788410534, 15366.385344586202, 15367.231638418034, 14755.483558075415, 14905.105693658415, 14910.105393676415, 14910.925445372812, 15149.394024239018, 13339.06239851317, 13534.932325338408, 13667.726645467035, 13723.588292351245, 13789.793153102712, 4543.5002149763495, 4582.843129954775, 4617.722936623813, 4639.884002899921, 4722.716637001757, 72010.0, 74173.0, 74208.0, 75087.0, 75668.0, 11775.823362649568, 11864.703382415508, 11873.525058997544, 11935.343556104324, 12357.38213089342, 21595.784042159376, 21609.67585486219, 21626.783732162476, 21826.236081737065, 22869.19957801469, 9517.524123793783, 9566.234701223886, 9643.710688679352, 9657.565409556586, 9697.563609637584, 5090.211017292326, 5100.948990510122, 5106.131957567222, 5120.513551212629, 5257.263983042377, 3544.4151714967256, 3622.9818850905576, 3639.1993761372987, 3647.908802279964, 3655.433407821739, 622.5548732656173, 638.7732355013903, 639.8560323927079, 640.7212862404868, 649.655682488282, 625.9061140828912, 724.7572063358729, 730.9802825059013, 743.3867059675789, 758.1887380502919, 9568.95215523918, 9593.184579310837, 9812.90187098134, 9931.702048938543, 10051.145652619463, 736.5838301359714, 750.7522517569189, 772.5094564951296, 776.2005134711256, 782.6595430987538, 4785.952140478551, 4963.305137280783, 4995.0, 4999.925001124986, 5023.0, 104292.0, 111629.44185279022, 115707.42146289215, 116939.0, 117332.41333793277, 59972.100418493756, 81861.0, 100839.0, 104009.0, 104075.4796226014, 86942.56528717442, 87627.0, 88587.0, 89120.0, 89622.0, 9842.0, 9888.555015024485, 9931.0, 10211.234157438073, 10637.946810266209, 37385.0, 43023.35464968091, 49826.25260621166, 51344.48655513547, 51729.741351293, 48170.0, 48314.27528587004, 49446.50553494419, 62032.37967620266, 73415.26584734298, 13451.798223026859, 13518.464280218272, 13794.0, 13862.237576933365, 13975.0, 15221.0, 15457.61355966065, 15915.920420397824, 16170.487889789532, 17029.744553831453, 13244.27156506363, 13355.332233388486, 13371.197728136343, 13400.530981415604, 13970.301484925916, 13251.403686833923, 13443.327833608477, 13516.189028658311, 15436.382544698086, 15442.691146177238, 13785.586432407044, 13960.092593981359, 14709.852901470847, 14718.484853030093, 14745.557633271019, 11889.702757431134, 12157.209781364183, 12230.449629766505, 12329.876701233232, 12362.072844536517, 12039.578614748441, 12135.635930922086, 12481.500739970663, 12589.083091133583, 12617.873821262037], "value": 7759.011635690191, "unit": "score"}], "name": "dromaeo_css", "value": 7256.100331925411, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 110.0, 113.0, 111.0, 110.0, 111.0, 111.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 115.0, 117.0, 168.0, 122.0, 118.0, 150.0, 120.0, 160.0, 117.0], "value": 133.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 161.0, 162.0, 161.0, 161.0, 162.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 116.0, 75.0, 75.0, 76.0, 74.0, 104.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 115.0, 85.0, 85.0, 84.0, 112.0, 84.0, 84.0, 129.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 54.0, 52.0, 53.0, 53.0, 53.0, 54.0, 52.0, 51.0, 52.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 60.0, 62.0, 61.0, 61.0, 61.0, 62.0, 62.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 75.0, 77.0, 75.0, 75.0, 78.0, 74.0, 75.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 124.0, 145.0, 128.0, 126.0, 119.0, 121.0, 118.0, 167.0, 118.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 155.0, 160.0, 156.0, 156.0, 158.0, 157.0, 160.0, 162.0], "value": 158.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 63.0, 64.0, 63.0, 65.0, 61.0, 62.0, 60.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1479.0999999999997, "alertThreshold": 2.0}]} 20:34:39 INFO - Return code: 0 20:34:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:34:39 INFO - # TBPL SUCCESS # 20:34:39 INFO - Running post-action listener: _resource_record_post_action 20:34:39 INFO - ##### 20:34:39 INFO - ##### Finished run-tests step (success) 20:34:39 INFO - ##### 20:34:39 INFO - Running post-run listener: _resource_record_post_run 20:34:39 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 568942592; Read time: 12; Write time: 460572 20:34:39 INFO - TinderboxPrint: CPU usage
13.0% 20:34:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:34:39 INFO - TinderboxPrint: I/O write bytes / time
568,942,592 / 460,572 20:34:39 INFO - TinderboxPrint: CPU idle
8,281.5 (87.0%) 20:34:39 INFO - TinderboxPrint: CPU user
1,189.2 (12.5%) 20:34:39 INFO - TinderboxPrint: Swap in / out
0 / 0 20:34:39 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 273653760; Read time: 0; Write time: 236008 20:34:39 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 295002112; Read time: 0; Write time: 224540 20:34:39 INFO - Running post-run listener: _upload_blobber_files 20:34:39 INFO - Blob upload gear active. 20:34:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:34:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:34:39 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'] 20:34:39 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 20:34:40 INFO - (blobuploader) - INFO - Open directory for files ... 20:34:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:34:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:34:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:34:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:34:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:34:43 INFO - (blobuploader) - INFO - Done attempting. 20:34:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:34:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:34:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:34:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:34:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:34:44 INFO - (blobuploader) - INFO - Done attempting. 20:34:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:34:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:34:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:34:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:34:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:34:45 INFO - (blobuploader) - INFO - Done attempting. 20:34:45 INFO - (blobuploader) - INFO - Iteration through files over. 20:34:45 INFO - Return code: 0 20:34:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:34:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:34:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8069dba38c02b8394d38971babf8a030b9159c0745a5ed0f6533edbc9c4e890789e1c8e50bde3ec0802e39b937a1630b0c7a1292abd1e863a2055d1399801e84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2cf4f0219abec97c6eaeeef0c16987700542830011837c4698a66f6b321eece48c61adf69f5dbf23a18fc35d453af30729a7df51f391dfdfcf25d1c73b514db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dba81a245f926fef7abfe15b9c6943e7acc3a75e404d44e46ffc20cfe46e5f38ff6258918cd6c8c51be0ef92e03ad6487cc0fb6498b4129e3e253dcbe5921f89"} 20:34:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:34:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:34:45 INFO - Contents: 20:34:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8069dba38c02b8394d38971babf8a030b9159c0745a5ed0f6533edbc9c4e890789e1c8e50bde3ec0802e39b937a1630b0c7a1292abd1e863a2055d1399801e84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2cf4f0219abec97c6eaeeef0c16987700542830011837c4698a66f6b321eece48c61adf69f5dbf23a18fc35d453af30729a7df51f391dfdfcf25d1c73b514db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dba81a245f926fef7abfe15b9c6943e7acc3a75e404d44e46ffc20cfe46e5f38ff6258918cd6c8c51be0ef92e03ad6487cc0fb6498b4129e3e253dcbe5921f89"} 20:34:45 INFO - Running post-run listener: copy_logs_to_upload_dir 20:34:45 INFO - Copying logs to upload dir... 20:34:45 INFO - mkdir: /builds/slave/test/build/upload/logs 20:34:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.894460 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-05 20:34:45.052023) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 20:34:45.058053) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929 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/8069dba38c02b8394d38971babf8a030b9159c0745a5ed0f6533edbc9c4e890789e1c8e50bde3ec0802e39b937a1630b0c7a1292abd1e863a2055d1399801e84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2cf4f0219abec97c6eaeeef0c16987700542830011837c4698a66f6b321eece48c61adf69f5dbf23a18fc35d453af30729a7df51f391dfdfcf25d1c73b514db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dba81a245f926fef7abfe15b9c6943e7acc3a75e404d44e46ffc20cfe46e5f38ff6258918cd6c8c51be0ef92e03ad6487cc0fb6498b4129e3e253dcbe5921f89"} build_url:https://queue.taskcluster.net/v1/task/UNNJAV4rQGGQOmujjnBmxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011256 build_url: 'https://queue.taskcluster.net/v1/task/UNNJAV4rQGGQOmujjnBmxQ/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/8069dba38c02b8394d38971babf8a030b9159c0745a5ed0f6533edbc9c4e890789e1c8e50bde3ec0802e39b937a1630b0c7a1292abd1e863a2055d1399801e84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2cf4f0219abec97c6eaeeef0c16987700542830011837c4698a66f6b321eece48c61adf69f5dbf23a18fc35d453af30729a7df51f391dfdfcf25d1c73b514db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dba81a245f926fef7abfe15b9c6943e7acc3a75e404d44e46ffc20cfe46e5f38ff6258918cd6c8c51be0ef92e03ad6487cc0fb6498b4129e3e253dcbe5921f89"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 20:34:45.088134) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 20:34:45.088950) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1467774301.48024-1934615929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004383 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 20:34:45.171483) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 20:34:45.172068) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 20:34:45.172621) ========= ========= Total master_lag: 0.20 =========