builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1467192480.6 results: success (0) buildid: 20160628233029 builduid: bcf5534bf1f04266b156d89acb86d2da revision: e1af8a633527ae1c95bf0e630a75f9810be3995d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 02:28:00.596484) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 02:28:00.597086) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 02:28:00.598709) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 02:28:00.614994) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:28:00.615416) ========= 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-1467192444.558219-13252116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 02:28:01-- 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% 46.5M=0s 2016-06-29 02:28:01 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076411 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:28:00.706689) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:28:00.707030) ========= 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-1467192444.558219-13252116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018223 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:28:00.757335) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 02:28:00.757727) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e1af8a633527ae1c95bf0e630a75f9810be3995d --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 e1af8a633527ae1c95bf0e630a75f9810be3995d --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-1467192444.558219-13252116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 02:28:01,262 truncating revision to first 12 chars 2016-06-29 02:28:01,262 Setting DEBUG logging. 2016-06-29 02:28:01,262 attempt 1/10 2016-06-29 02:28:01,262 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e1af8a633527?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 02:28:02,501 unpacking tar archive at: fx-team-e1af8a633527/testing/mozharness/ program finished with exit code 0 elapsedTime=1.585940 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 02:28:02.361591) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 02:28:02.362241) ========= script_repo_revision: e1af8a633527ae1c95bf0e630a75f9810be3995d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 02:28:02.362834) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 02:28:02.363155) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 02:28:02.381518) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-29 02:28:02.381867) ========= /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-1467192444.558219-13252116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:28:02 INFO - MultiFileLogger online at 20160629 02:28:02 in /builds/slave/test 02:28:02 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 02:28:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:28:02 INFO - {'append_to_log': False, 02:28:02 INFO - 'base_work_dir': '/builds/slave/test', 02:28:02 INFO - 'blob_upload_branch': 'Fx-Team', 02:28:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:28:02 INFO - 'branch': 'Fx-Team', 02:28:02 INFO - 'buildbot_json_path': 'buildprops.json', 02:28:02 INFO - 'config_files': ('talos/linux_config.py',), 02:28:02 INFO - 'default_actions': ('clobber', 02:28:02 INFO - 'read-buildbot-config', 02:28:02 INFO - 'download-and-extract', 02:28:02 INFO - 'populate-webroot', 02:28:02 INFO - 'create-virtualenv', 02:28:02 INFO - 'install', 02:28:02 INFO - 'run-tests'), 02:28:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:28:02 INFO - 'download_minidump_stackwalk': True, 02:28:02 INFO - 'download_symbols': 'ondemand', 02:28:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:28:02 INFO - 'tooltool.py': '/tools/tooltool.py', 02:28:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:28:02 INFO - '/tools/misc-python/virtualenv.py')}, 02:28:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:28:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:28:02 INFO - 'installer_path': 'installer.exe', 02:28:02 INFO - 'log_level': 'info', 02:28:02 INFO - 'log_name': 'talos', 02:28:02 INFO - 'log_to_console': True, 02:28:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:28:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:28:02 INFO - 'opt_config_files': (), 02:28:02 INFO - 'pip_index': False, 02:28:02 INFO - 'sps_profile': False, 02:28:02 INFO - 'sps_profile_interval': 0, 02:28:02 INFO - 'suite': 'dromaeojs', 02:28:02 INFO - 'system_bits': '32', 02:28:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:28:02 INFO - 'title': 'talos-linux64-ix-041', 02:28:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:28:02 INFO - 'use_talos_json': True, 02:28:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:28:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:28:02 INFO - 'work_dir': 'build'} 02:28:02 INFO - ##### 02:28:02 INFO - ##### Running clobber step. 02:28:02 INFO - ##### 02:28:02 INFO - Running pre-action listener: _resource_record_pre_action 02:28:02 INFO - Running main action method: clobber 02:28:02 INFO - rmtree: /builds/slave/test/build 02:28:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:28:03 INFO - Running post-action listener: _resource_record_post_action 02:28:03 INFO - ##### 02:28:03 INFO - ##### Finished clobber step (success) 02:28:03 INFO - ##### 02:28:03 INFO - ##### 02:28:03 INFO - ##### Running read-buildbot-config step. 02:28:03 INFO - ##### 02:28:03 INFO - Running pre-action listener: _resource_record_pre_action 02:28:03 INFO - Running main action method: read_buildbot_config 02:28:03 INFO - Using buildbot properties: 02:28:03 INFO - { 02:28:03 INFO - "project": "", 02:28:03 INFO - "product": "firefox", 02:28:03 INFO - "script_repo_revision": "production", 02:28:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:28:03 INFO - "repository": "", 02:28:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:28:03 INFO - "buildid": "20160628233029", 02:28:03 INFO - "pgo_build": "True", 02:28:03 INFO - "basedir": "/builds/slave/test", 02:28:03 INFO - "buildnumber": 229, 02:28:03 INFO - "slavename": "talos-linux64-ix-041", 02:28:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:28:03 INFO - "platform": "ubuntu64_hw", 02:28:03 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:28:03 INFO - "branch": "fx-team", 02:28:03 INFO - "repo_path": "integration/fx-team", 02:28:03 INFO - "revision": "e1af8a633527ae1c95bf0e630a75f9810be3995d", 02:28:03 INFO - "stage_platform": "linux64-pgo", 02:28:03 INFO - "builduid": "bcf5534bf1f04266b156d89acb86d2da", 02:28:03 INFO - "slavebuilddir": "test" 02:28:03 INFO - } 02:28:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:28:03 INFO - Running post-action listener: _resource_record_post_action 02:28:03 INFO - ##### 02:28:03 INFO - ##### Finished read-buildbot-config step (success) 02:28:03 INFO - ##### 02:28:03 INFO - ##### 02:28:03 INFO - ##### Running download-and-extract step. 02:28:03 INFO - ##### 02:28:03 INFO - Running pre-action listener: _resource_record_pre_action 02:28:03 INFO - Running main action method: download_and_extract 02:28:03 INFO - mkdir: /builds/slave/test/build/tests 02:28:03 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')]} 02:28:03 INFO - https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:28:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:28:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:28:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:28:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:28:05 INFO - Downloaded 1361 bytes. 02:28:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:28:05 INFO - Using the following test package requirements: 02:28:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:28:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:28:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:28:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:28:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:28:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:28:05 INFO - u'jsshell-linux-x86_64.zip'], 02:28:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:28:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:28:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:28:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:28:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:28:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:28:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:28:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:28:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:28:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:28:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:28:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:05 INFO - https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:28:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:28:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:28:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:28:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:28:09 INFO - Downloaded 24267054 bytes. 02:28:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:28:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:28:10 INFO - Return code: 0 02:28:10 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 02:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:28:10 INFO - https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:28:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:28:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:28:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:28:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:28:12 INFO - Downloaded 24267054 bytes. 02:28:12 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'] 02:28:12 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 02:28:13 INFO - Return code: 0 02:28: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')]} 02:28:13 INFO - https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:28:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:28:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:28:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:28:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:28:14 INFO - Downloaded 14405245 bytes. 02:28:14 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'] 02:28:14 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 02:28:14 INFO - Return code: 0 02:28:14 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')]} 02:28:14 INFO - https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:28:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:28:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:28:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:28:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:28:18 INFO - Downloaded 60319705 bytes. 02:28:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:28:18 INFO - mkdir: /builds/slave/test/properties 02:28:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:28:18 INFO - Writing to file /builds/slave/test/properties/build_url 02:28:18 INFO - Contents: 02:28:18 INFO - build_url:https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:28:19 INFO - Running post-action listener: _resource_record_post_action 02:28:19 INFO - Running post-action listener: set_extra_try_arguments 02:28:19 INFO - ##### 02:28:19 INFO - ##### Finished download-and-extract step (success) 02:28:19 INFO - ##### 02:28:19 INFO - ##### 02:28:19 INFO - ##### Running populate-webroot step. 02:28:19 INFO - ##### 02:28:19 INFO - Running pre-action listener: _resource_record_pre_action 02:28:19 INFO - Running main action method: populate_webroot 02:28:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:28:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:28:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:28:19 INFO - '--tppagecycles', 02:28:19 INFO - '7'], 02:28:19 INFO - 'tests': ['tsvgm']}}, 02:28:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:28:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:28:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:28:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:28:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:28:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:28:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:19 INFO - 'talos_options': ['--disable-e10s'], 02:28:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:28:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:28:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:19 INFO - 'talos_options': ['--disable-e10s'], 02:28:19 INFO - 'tests': ['damp', 'tps']}, 02:28:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:19 INFO - 'tests': ['damp', 'tps']}, 02:28:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:28:19 INFO - 'tests': ['dromaeo_dom']}, 02:28:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:28:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:28:19 INFO - 'tests': ['basic_compositor_video']}, 02:28:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:28:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:28:19 INFO - 'tests': ['a11yr', 02:28:19 INFO - 'ts_paint', 02:28:19 INFO - 'tpaint', 02:28:19 INFO - 'sessionrestore', 02:28:19 INFO - 'sessionrestore_no_auto_restore', 02:28:19 INFO - 'tabpaint']}, 02:28:19 INFO - 'other-e10s': {'tests': ['a11yr', 02:28:19 INFO - 'ts_paint', 02:28:19 INFO - 'tpaint', 02:28:19 INFO - 'sessionrestore', 02:28:19 INFO - 'sessionrestore_no_auto_restore', 02:28:19 INFO - 'tabpaint']}, 02:28:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:28:19 INFO - 'ts_paint', 02:28:19 INFO - 'tpaint', 02:28:19 INFO - 'sessionrestore', 02:28:19 INFO - 'sessionrestore_no_auto_restore', 02:28:19 INFO - 'tabpaint']}, 02:28:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:28:19 INFO - 'ts_paint', 02:28:19 INFO - 'tpaint', 02:28:19 INFO - 'sessionrestore', 02:28:19 INFO - 'sessionrestore_no_auto_restore', 02:28:19 INFO - 'tabpaint']}, 02:28:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:28:19 INFO - 'tests': ['a11yr', 02:28:19 INFO - 'ts_paint', 02:28:19 INFO - 'tpaint', 02:28:19 INFO - 'sessionrestore', 02:28:19 INFO - 'sessionrestore_no_auto_restore', 02:28:19 INFO - 'tabpaint']}, 02:28:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:28:19 INFO - 'tests': ['a11yr', 02:28:19 INFO - 'ts_paint', 02:28:19 INFO - 'tpaint', 02:28:19 INFO - 'sessionrestore', 02:28:19 INFO - 'sessionrestore_no_auto_restore', 02:28:19 INFO - 'tabpaint']}, 02:28:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:28:19 INFO - 'tests': ['tsvgx', 02:28:19 INFO - 'tsvgr_opacity', 02:28:19 INFO - 'tart', 02:28:19 INFO - 'tscrollx', 02:28:19 INFO - 'cart']}, 02:28:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:28:19 INFO - 'tsvgr_opacity', 02:28:19 INFO - 'tart', 02:28:19 INFO - 'tscrollx', 02:28:19 INFO - 'cart']}, 02:28:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:19 INFO - 'talos_options': ['--disable-e10s'], 02:28:19 INFO - 'tests': ['tp5o']}, 02:28:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:19 INFO - 'tests': ['tp5o']}, 02:28:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:19 INFO - 'talos_options': ['--disable-e10s', 02:28:19 INFO - '--xperf_path', 02:28:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:28:19 INFO - 'tests': ['tp5n']}, 02:28:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:19 INFO - 'talos_options': ['--xperf_path', 02:28:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:28:19 INFO - 'tests': ['tp5n']}}, 02:28:19 INFO - 'talos.zip': {'path': '', 02:28:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:28:19 INFO - Running post-action listener: _resource_record_post_action 02:28:19 INFO - ##### 02:28:19 INFO - ##### Finished populate-webroot step (success) 02:28:19 INFO - ##### 02:28:19 INFO - ##### 02:28:19 INFO - ##### Running create-virtualenv step. 02:28:19 INFO - ##### 02:28:19 INFO - Running pre-action listener: _resource_record_pre_action 02:28:19 INFO - Running main action method: create_virtualenv 02:28:19 INFO - Creating virtualenv /builds/slave/test/build/venv 02:28:19 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 02:28:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:28:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:28:19 INFO - Using real prefix '/usr' 02:28:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:28:20 INFO - Installing distribute.............................................................................................................................................................................................done. 02:28:22 INFO - Installing pip.................done. 02:28:22 INFO - Return code: 0 02:28:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:22 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 0x15a8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1869180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18673b0>, '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 0x18682b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1868740>, '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-1467192444.558219-13252116', '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 02:28:22 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 02:28:22 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 02:28:22 INFO - Using env: {'DISPLAY': ':0', 02:28:22 INFO - 'HOME': '/home/cltbld', 02:28:22 INFO - 'LANG': 'en_US.UTF-8', 02:28:22 INFO - 'LANGUAGE': 'en_US:en', 02:28:22 INFO - 'LOGNAME': 'cltbld', 02:28:22 INFO - 'MAIL': '/var/mail/cltbld', 02:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:22 INFO - 'MOZ_NO_REMOTE': '1', 02:28:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:22 INFO - 'NO_EM_RESTART': '1', 02:28:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:22 INFO - 'PWD': '/builds/slave/test', 02:28:22 INFO - 'SHELL': '/bin/bash', 02:28:22 INFO - 'SHLVL': '1', 02:28:22 INFO - 'TERM': 'linux', 02:28:22 INFO - 'TMOUT': '86400', 02:28:22 INFO - 'USER': 'cltbld', 02:28:22 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467192444.558219-13252116', 02:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:22 INFO - '_': '/tools/buildbot/bin/python'} 02:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:22 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 02:28:22 INFO - Cleaning up... 02:28:22 INFO - Return code: 0 02:28:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:22 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 0x15a8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1869180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18673b0>, '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 0x18682b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1868740>, '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-1467192444.558219-13252116', '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 02:28:22 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 02:28:22 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 02:28:22 INFO - Using env: {'DISPLAY': ':0', 02:28:22 INFO - 'HOME': '/home/cltbld', 02:28:22 INFO - 'LANG': 'en_US.UTF-8', 02:28:22 INFO - 'LANGUAGE': 'en_US:en', 02:28:22 INFO - 'LOGNAME': 'cltbld', 02:28:22 INFO - 'MAIL': '/var/mail/cltbld', 02:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:22 INFO - 'MOZ_NO_REMOTE': '1', 02:28:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:22 INFO - 'NO_EM_RESTART': '1', 02:28:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:22 INFO - 'PWD': '/builds/slave/test', 02:28:22 INFO - 'SHELL': '/bin/bash', 02:28:22 INFO - 'SHLVL': '1', 02:28:22 INFO - 'TERM': 'linux', 02:28:22 INFO - 'TMOUT': '86400', 02:28:22 INFO - 'USER': 'cltbld', 02:28:22 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467192444.558219-13252116', 02:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:22 INFO - '_': '/tools/buildbot/bin/python'} 02:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:22 INFO - Downloading/unpacking psutil>=3.1.1 02:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:28:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:28:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:28:24 INFO - Installing collected packages: psutil 02:28:24 INFO - Running setup.py install for psutil 02:28:24 INFO - building 'psutil._psutil_linux' extension 02:28:24 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 02:28:24 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 02:28:24 INFO - building 'psutil._psutil_posix' extension 02:28:24 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 02:28:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:28:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:28:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:28:25 INFO - Successfully installed psutil 02:28:25 INFO - Cleaning up... 02:28:25 INFO - Return code: 0 02:28:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:25 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 0x15a8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1869180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18673b0>, '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 0x18682b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1868740>, '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-1467192444.558219-13252116', '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 02:28:25 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 02:28:25 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 02:28:25 INFO - Using env: {'DISPLAY': ':0', 02:28:25 INFO - 'HOME': '/home/cltbld', 02:28:25 INFO - 'LANG': 'en_US.UTF-8', 02:28:25 INFO - 'LANGUAGE': 'en_US:en', 02:28:25 INFO - 'LOGNAME': 'cltbld', 02:28:25 INFO - 'MAIL': '/var/mail/cltbld', 02:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:25 INFO - 'MOZ_NO_REMOTE': '1', 02:28:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:25 INFO - 'NO_EM_RESTART': '1', 02:28:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:25 INFO - 'PWD': '/builds/slave/test', 02:28:25 INFO - 'SHELL': '/bin/bash', 02:28:25 INFO - 'SHLVL': '1', 02:28:25 INFO - 'TERM': 'linux', 02:28:25 INFO - 'TMOUT': '86400', 02:28:25 INFO - 'USER': 'cltbld', 02:28:25 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467192444.558219-13252116', 02:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:25 INFO - '_': '/tools/buildbot/bin/python'} 02:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:28:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:28:27 INFO - Installing collected packages: mozsystemmonitor 02:28:27 INFO - Running setup.py install for mozsystemmonitor 02:28:27 INFO - Successfully installed mozsystemmonitor 02:28:27 INFO - Cleaning up... 02:28:27 INFO - Return code: 0 02:28:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:28:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:28:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:27 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 0x15a8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1869180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18673b0>, '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 0x18682b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1868740>, '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-1467192444.558219-13252116', '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 02:28:27 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 02:28:27 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 02:28:27 INFO - Using env: {'DISPLAY': ':0', 02:28:27 INFO - 'HOME': '/home/cltbld', 02:28:27 INFO - 'LANG': 'en_US.UTF-8', 02:28:27 INFO - 'LANGUAGE': 'en_US:en', 02:28:27 INFO - 'LOGNAME': 'cltbld', 02:28:27 INFO - 'MAIL': '/var/mail/cltbld', 02:28:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:27 INFO - 'MOZ_NO_REMOTE': '1', 02:28:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:27 INFO - 'NO_EM_RESTART': '1', 02:28:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:27 INFO - 'PWD': '/builds/slave/test', 02:28:27 INFO - 'SHELL': '/bin/bash', 02:28:27 INFO - 'SHLVL': '1', 02:28:27 INFO - 'TERM': 'linux', 02:28:27 INFO - 'TMOUT': '86400', 02:28:27 INFO - 'USER': 'cltbld', 02:28:27 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467192444.558219-13252116', 02:28:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:27 INFO - '_': '/tools/buildbot/bin/python'} 02:28:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:27 INFO - Downloading/unpacking jsonschema==2.5.1 02:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:28:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:28:29 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 02:28:29 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 02:28:29 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 02:28:29 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 02:28:29 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 02:28:29 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 02:28:29 INFO - Downloading functools32-3.2.3-2.tar.gz 02:28:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:28:29 INFO - warning: no files found matching '*.txt' 02:28:29 INFO - no previously-included directories found matching 'build' 02:28:29 INFO - no previously-included directories found matching 'dist' 02:28:29 INFO - no previously-included directories found matching '.git*' 02:28:29 INFO - Installing collected packages: jsonschema, functools32 02:28:29 INFO - Running setup.py install for functools32 02:28:30 INFO - warning: no files found matching '*.txt' 02:28:30 INFO - no previously-included directories found matching 'build' 02:28:30 INFO - no previously-included directories found matching 'dist' 02:28:30 INFO - no previously-included directories found matching '.git*' 02:28:30 INFO - Successfully installed jsonschema functools32 02:28:30 INFO - Cleaning up... 02:28:30 INFO - Return code: 0 02:28:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:28:30 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')]} 02:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:30 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')]} 02:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:30 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 0x15a8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1869180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18673b0>, '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 0x18682b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1868740>, '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-1467192444.558219-13252116', '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 02:28:30 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 02:28:30 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 02:28:30 INFO - Using env: {'DISPLAY': ':0', 02:28:30 INFO - 'HOME': '/home/cltbld', 02:28:30 INFO - 'LANG': 'en_US.UTF-8', 02:28:30 INFO - 'LANGUAGE': 'en_US:en', 02:28:30 INFO - 'LOGNAME': 'cltbld', 02:28:30 INFO - 'MAIL': '/var/mail/cltbld', 02:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:30 INFO - 'MOZ_NO_REMOTE': '1', 02:28:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:30 INFO - 'NO_EM_RESTART': '1', 02:28:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:30 INFO - 'PWD': '/builds/slave/test', 02:28:30 INFO - 'SHELL': '/bin/bash', 02:28:30 INFO - 'SHLVL': '1', 02:28:30 INFO - 'TERM': 'linux', 02:28:30 INFO - 'TMOUT': '86400', 02:28:30 INFO - 'USER': 'cltbld', 02:28:30 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467192444.558219-13252116', 02:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:30 INFO - '_': '/tools/buildbot/bin/python'} 02:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:30 INFO - Downloading/unpacking blobuploader==1.2.4 02:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:32 INFO - Downloading blobuploader-1.2.4.tar.gz 02:28:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:28:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:28:32 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 02:28:32 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 02:28:32 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 02:28:32 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 02:28:32 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 02:28:32 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 02:28:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:28:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:28:32 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 02:28:32 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 02:28:32 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 02:28:32 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 02:28:32 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 02:28:32 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 02:28:32 INFO - Downloading docopt-0.6.1.tar.gz 02:28:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:28:32 INFO - Installing collected packages: blobuploader, requests, docopt 02:28:32 INFO - Running setup.py install for blobuploader 02:28:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:28:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:28:33 INFO - Running setup.py install for requests 02:28:33 INFO - Running setup.py install for docopt 02:28:33 INFO - Successfully installed blobuploader requests docopt 02:28:33 INFO - Cleaning up... 02:28:33 INFO - Return code: 0 02:28:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28: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')]} 02:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28: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')]} 02:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:33 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 0x15a8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1869180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18673b0>, '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 0x18682b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1868740>, '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-1467192444.558219-13252116', '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 02:28:33 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 02:28:33 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 02:28:33 INFO - Using env: {'DISPLAY': ':0', 02:28:33 INFO - 'HOME': '/home/cltbld', 02:28:33 INFO - 'LANG': 'en_US.UTF-8', 02:28:33 INFO - 'LANGUAGE': 'en_US:en', 02:28:33 INFO - 'LOGNAME': 'cltbld', 02:28:33 INFO - 'MAIL': '/var/mail/cltbld', 02:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:33 INFO - 'MOZ_NO_REMOTE': '1', 02:28:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:33 INFO - 'NO_EM_RESTART': '1', 02:28:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:33 INFO - 'PWD': '/builds/slave/test', 02:28:33 INFO - 'SHELL': '/bin/bash', 02:28:33 INFO - 'SHLVL': '1', 02:28:33 INFO - 'TERM': 'linux', 02:28:33 INFO - 'TMOUT': '86400', 02:28:33 INFO - 'USER': 'cltbld', 02:28:33 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467192444.558219-13252116', 02:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:33 INFO - '_': '/tools/buildbot/bin/python'} 02:28:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:28:33 INFO - Running setup.py (path:/tmp/pip-mnNUq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:28:33 INFO - Running setup.py (path:/tmp/pip-GpVvJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:28:33 INFO - Running setup.py (path:/tmp/pip-c2jMAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:28:34 INFO - Running setup.py (path:/tmp/pip-I3wUr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:28:34 INFO - Running setup.py (path:/tmp/pip-3f7pTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:28:34 INFO - Running setup.py (path:/tmp/pip-bxdmWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:28:34 INFO - Running setup.py (path:/tmp/pip-h8faUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:28:34 INFO - Running setup.py (path:/tmp/pip-y85kU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:28:34 INFO - Running setup.py (path:/tmp/pip-86ak1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:28:34 INFO - Running setup.py (path:/tmp/pip-LD21xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:28:34 INFO - Running setup.py (path:/tmp/pip-LhxU9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:28:34 INFO - Running setup.py (path:/tmp/pip-zF_zs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:28:34 INFO - Running setup.py (path:/tmp/pip-Z0WxAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:28:34 INFO - Running setup.py (path:/tmp/pip-GmSstV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:34 INFO - Running setup.py (path:/tmp/pip-vxYkKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:28:34 INFO - Running setup.py (path:/tmp/pip-6zWFJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:28:34 INFO - Running setup.py (path:/tmp/pip-ZJxtqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:28:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:28:35 INFO - Running setup.py install for manifestparser 02:28:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:28:35 INFO - Running setup.py install for mozcrash 02:28:35 INFO - Running setup.py install for mozdebug 02:28:35 INFO - Running setup.py install for mozdevice 02:28:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:28:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:28:35 INFO - Running setup.py install for mozfile 02:28:35 INFO - Running setup.py install for mozhttpd 02:28:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:28:35 INFO - Running setup.py install for mozinfo 02:28:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:28:35 INFO - Running setup.py install for mozInstall 02:28:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:28:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:28:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:28:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:28:35 INFO - Running setup.py install for mozleak 02:28:35 INFO - Running setup.py install for mozlog 02:28:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:28:36 INFO - Running setup.py install for moznetwork 02:28:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:28:36 INFO - Running setup.py install for mozprocess 02:28:36 INFO - Running setup.py install for mozprofile 02:28:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:28:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:28:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:28:36 INFO - Running setup.py install for mozrunner 02:28:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:28:36 INFO - Running setup.py install for mozscreenshot 02:28:36 INFO - Running setup.py install for moztest 02:28:36 INFO - Running setup.py install for mozversion 02:28:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:28:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:28:36 INFO - Cleaning up... 02:28:36 INFO - Return code: 0 02:28:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:36 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 0x15a8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1869180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18673b0>, '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 0x18682b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1868740>, '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-1467192444.558219-13252116', '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 02:28:36 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 02:28:36 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 02:28:36 INFO - Using env: {'DISPLAY': ':0', 02:28:36 INFO - 'HOME': '/home/cltbld', 02:28:36 INFO - 'LANG': 'en_US.UTF-8', 02:28:36 INFO - 'LANGUAGE': 'en_US:en', 02:28:36 INFO - 'LOGNAME': 'cltbld', 02:28:36 INFO - 'MAIL': '/var/mail/cltbld', 02:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:36 INFO - 'MOZ_NO_REMOTE': '1', 02:28:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:36 INFO - 'NO_EM_RESTART': '1', 02:28:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:36 INFO - 'PWD': '/builds/slave/test', 02:28:36 INFO - 'SHELL': '/bin/bash', 02:28:36 INFO - 'SHLVL': '1', 02:28:36 INFO - 'TERM': 'linux', 02:28:36 INFO - 'TMOUT': '86400', 02:28:36 INFO - 'USER': 'cltbld', 02:28:36 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467192444.558219-13252116', 02:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:36 INFO - '_': '/tools/buildbot/bin/python'} 02:28:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:28:37 INFO - Running setup.py (path:/tmp/pip-YEwZ1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:28:37 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)) 02:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:28:37 INFO - Running setup.py (path:/tmp/pip-XD8HpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:28:37 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)) 02:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:28:37 INFO - Running setup.py (path:/tmp/pip-eX18lF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:28:37 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)) 02:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:28:37 INFO - Running setup.py (path:/tmp/pip-C2YzdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:28:37 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)) 02:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:28:37 INFO - Running setup.py (path:/tmp/pip-wqWk8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:28:37 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)) 02:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:28:37 INFO - Running setup.py (path:/tmp/pip-_IMW74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:28:37 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)) 02:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:28:37 INFO - Running setup.py (path:/tmp/pip-KlVPfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:28:37 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)) 02:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:28:37 INFO - Running setup.py (path:/tmp/pip-3B4dir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:28:37 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)) 02:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:28:37 INFO - Running setup.py (path:/tmp/pip-Ukpklx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:28:37 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)) 02:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:28:37 INFO - Running setup.py (path:/tmp/pip-WxprDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:28:37 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)) 02:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:28:37 INFO - Running setup.py (path:/tmp/pip-0xdP2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:28:38 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)) 02:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:28:38 INFO - Running setup.py (path:/tmp/pip-3XBX2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:28:38 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)) 02:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:28:38 INFO - Running setup.py (path:/tmp/pip-WTuIa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:28:38 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)) 02:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:28:38 INFO - Running setup.py (path:/tmp/pip-RLWSav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:28:38 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)) 02:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:38 INFO - Running setup.py (path:/tmp/pip-rzltM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:38 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)) 02:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:28:38 INFO - Running setup.py (path:/tmp/pip-qunrDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:28:38 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)) 02:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:28:38 INFO - Running setup.py (path:/tmp/pip-Xe9kNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:28:38 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)) 02:28:38 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)) 02:28:38 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)) 02:28:38 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)) 02:28:38 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)) 02:28:38 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)) 02:28:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28:40 INFO - Downloading blessings-1.6.tar.gz 02:28:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:28:40 INFO - Installing collected packages: blessings 02:28:40 INFO - Running setup.py install for blessings 02:28:40 INFO - Successfully installed blessings 02:28:40 INFO - Cleaning up... 02:28:40 INFO - Return code: 0 02:28:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:28:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:28:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:28:40 INFO - Reading from file tmpfile_stdout 02:28:40 INFO - Current package versions: 02:28:40 INFO - argparse == 1.2.1 02:28:40 INFO - blessings == 1.6 02:28:40 INFO - blobuploader == 1.2.4 02:28:40 INFO - docopt == 0.6.1 02:28:40 INFO - functools32 == 3.2.3-2 02:28:40 INFO - jsonschema == 2.5.1 02:28:40 INFO - manifestparser == 1.1 02:28:40 INFO - mozInstall == 1.12 02:28:40 INFO - mozcrash == 0.17 02:28:40 INFO - mozdebug == 0.1 02:28:40 INFO - mozdevice == 0.48 02:28:40 INFO - mozfile == 1.2 02:28:40 INFO - mozhttpd == 0.7 02:28:40 INFO - mozinfo == 0.9 02:28:40 INFO - mozleak == 0.1 02:28:40 INFO - mozlog == 3.2 02:28:40 INFO - moznetwork == 0.27 02:28:40 INFO - mozprocess == 0.22 02:28:40 INFO - mozprofile == 0.28 02:28:40 INFO - mozrunner == 6.11 02:28:40 INFO - mozscreenshot == 0.1 02:28:40 INFO - mozsystemmonitor == 0.3 02:28:40 INFO - moztest == 0.7 02:28:40 INFO - mozversion == 1.4 02:28:40 INFO - psutil == 3.1.1 02:28:40 INFO - requests == 1.2.3 02:28:40 INFO - wsgiref == 0.1.2 02:28:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:40 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')]} 02:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:40 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')]} 02:28:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:40 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 0x15a8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1869180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18673b0>, '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 0x18682b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1868740>, '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-1467192444.558219-13252116', '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 02:28:40 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 02:28:40 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 02:28:40 INFO - Using env: {'DISPLAY': ':0', 02:28:40 INFO - 'HOME': '/home/cltbld', 02:28:40 INFO - 'LANG': 'en_US.UTF-8', 02:28:40 INFO - 'LANGUAGE': 'en_US:en', 02:28:40 INFO - 'LOGNAME': 'cltbld', 02:28:40 INFO - 'MAIL': '/var/mail/cltbld', 02:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:40 INFO - 'MOZ_NO_REMOTE': '1', 02:28:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:40 INFO - 'NO_EM_RESTART': '1', 02:28:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:40 INFO - 'PWD': '/builds/slave/test', 02:28:40 INFO - 'SHELL': '/bin/bash', 02:28:40 INFO - 'SHLVL': '1', 02:28:40 INFO - 'TERM': 'linux', 02:28:40 INFO - 'TMOUT': '86400', 02:28:40 INFO - 'USER': 'cltbld', 02:28:40 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467192444.558219-13252116', 02:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:40 INFO - '_': '/tools/buildbot/bin/python'} 02:28:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:40 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)) 02:28:40 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)) 02:28:40 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)) 02:28:40 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)) 02:28:40 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)) 02:28:40 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)) 02:28:40 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)) 02:28:41 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)) 02:28:41 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)) 02:28:41 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)) 02:28:41 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)) 02:28:41 INFO - Cleaning up... 02:28:41 INFO - Return code: 0 02:28:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:41 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 0x15a8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1869180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18673b0>, '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 0x18682b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1868740>, '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-1467192444.558219-13252116', '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 02:28:41 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 02:28:41 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 02:28:41 INFO - Using env: {'DISPLAY': ':0', 02:28:41 INFO - 'HOME': '/home/cltbld', 02:28:41 INFO - 'LANG': 'en_US.UTF-8', 02:28:41 INFO - 'LANGUAGE': 'en_US:en', 02:28:41 INFO - 'LOGNAME': 'cltbld', 02:28:41 INFO - 'MAIL': '/var/mail/cltbld', 02:28:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:41 INFO - 'MOZ_NO_REMOTE': '1', 02:28:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:41 INFO - 'NO_EM_RESTART': '1', 02:28:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:41 INFO - 'PWD': '/builds/slave/test', 02:28:41 INFO - 'SHELL': '/bin/bash', 02:28:41 INFO - 'SHLVL': '1', 02:28:41 INFO - 'TERM': 'linux', 02:28:41 INFO - 'TMOUT': '86400', 02:28:41 INFO - 'USER': 'cltbld', 02:28:41 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467192444.558219-13252116', 02:28:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:41 INFO - '_': '/tools/buildbot/bin/python'} 02:28:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:28:41 INFO - Cleaning up... 02:28:41 INFO - Return code: 0 02:28:41 INFO - Running post-action listener: _resource_record_post_action 02:28:41 INFO - Running post-action listener: _start_resource_monitoring 02:28:41 INFO - Starting resource monitoring. 02:28:41 INFO - ##### 02:28:41 INFO - ##### Finished create-virtualenv step (success) 02:28:41 INFO - ##### 02:28:41 INFO - ##### 02:28:41 INFO - ##### Running install step. 02:28:41 INFO - ##### 02:28:41 INFO - Running pre-action listener: _resource_record_pre_action 02:28:41 INFO - Running main action method: install 02:28:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:28:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:28:41 INFO - Reading from file tmpfile_stdout 02:28:41 INFO - Detecting whether we're running mozinstall >=1.0... 02:28:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:28:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:28:41 INFO - Reading from file tmpfile_stdout 02:28:41 INFO - Output received: 02:28:41 INFO - Usage: mozinstall [options] installer 02:28:41 INFO - Options: 02:28:41 INFO - -h, --help show this help message and exit 02:28:41 INFO - -d DEST, --destination=DEST 02:28:41 INFO - Directory to install application into. [default: 02:28:41 INFO - "/builds/slave/test"] 02:28:41 INFO - --app=APP Application being installed. [default: firefox] 02:28:41 INFO - mkdir: /builds/slave/test/build/application 02:28:41 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'] 02:28:41 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 02:28:58 INFO - Reading from file tmpfile_stdout 02:28:58 INFO - Output received: 02:28:58 INFO - /builds/slave/test/build/application/firefox/firefox 02:28:58 INFO - Running post-action listener: _resource_record_post_action 02:28:58 INFO - ##### 02:28:58 INFO - ##### Finished install step (success) 02:28:58 INFO - ##### 02:28:58 INFO - ##### 02:28:58 INFO - ##### Running run-tests step. 02:28:58 INFO - ##### 02:28:58 INFO - Running pre-action listener: _resource_record_pre_action 02:28:58 INFO - Running main action method: run_tests 02:28:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:28:58 INFO - Python 2.7.3 02:28:58 INFO - Return code: 0 02:28:58 INFO - grabbing minidump binary from tooltool 02:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:58 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18673b0>, '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 0x18682b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1868740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:28:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:28:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:28:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:28:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:28:58 INFO - Return code: 0 02:28:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:28:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:28:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:28:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:28:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:28:58 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/Kxw9gqoNQ0-8LGU--XFS9g/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 02:28:58 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/Kxw9gqoNQ0-8LGU--XFS9g/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 02:28:58 INFO - Using env: {'DISPLAY': ':0', 02:28:58 INFO - 'HOME': '/home/cltbld', 02:28:58 INFO - 'LANG': 'en_US.UTF-8', 02:28:58 INFO - 'LANGUAGE': 'en_US:en', 02:28:58 INFO - 'LOGNAME': 'cltbld', 02:28:58 INFO - 'MAIL': '/var/mail/cltbld', 02:28:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:28:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:28:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:58 INFO - 'MOZ_NO_REMOTE': '1', 02:28:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:28:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:58 INFO - 'NO_EM_RESTART': '1', 02:28:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:58 INFO - 'PWD': '/builds/slave/test', 02:28:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:28:58 INFO - 'SHELL': '/bin/bash', 02:28:58 INFO - 'SHLVL': '1', 02:28:58 INFO - 'TERM': 'linux', 02:28:58 INFO - 'TMOUT': '86400', 02:28:58 INFO - 'USER': 'cltbld', 02:28:58 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467192444.558219-13252116', 02:28:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:58 INFO - '_': '/tools/buildbot/bin/python'} 02:28:58 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/Kxw9gqoNQ0-8LGU--XFS9g/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 02:28:58 INFO - mozversion application_buildid: 20160628233029 02:28:58 INFO - mozversion application_changeset: e1af8a633527ae1c95bf0e630a75f9810be3995d 02:28:58 INFO - mozversion application_display_name: Nightly 02:28:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:28:58 INFO - mozversion application_name: Firefox 02:28:58 INFO - mozversion application_remotingname: firefox 02:28:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:28:58 INFO - mozversion application_vendor: Mozilla 02:28:58 INFO - mozversion application_version: 50.0a1 02:28:58 INFO - mozversion platform_buildid: 20160628233029 02:28:58 INFO - mozversion platform_changeset: e1af8a633527ae1c95bf0e630a75f9810be3995d 02:28:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:28:58 INFO - mozversion platform_version: 50.0a1 02:28:58 INFO - using testdate: 1467192538 02:28:58 INFO - actual date: 1467192538 02:28:58 INFO - starting webserver on 'localhost:43872' 02:28:58 INFO - SUITE-START | Running 2 tests 02:28:58 INFO - TEST-START | dromaeo_css 02:28:58 INFO - operating with platform_type : linux_ 02:28:58 INFO - Initialising browser for dromaeo_css test... 02:28:58 INFO - TEST-INFO | started process 15906 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptD1Aaj/profile http://localhost:43872/getInfo.html) 02:29:03 INFO - PROCESS | 15906 | __metrics Screen width/height:1600/1200 02:29:03 INFO - PROCESS | 15906 | colorDepth:24 02:29:03 INFO - PROCESS | 15906 | Browser inner width/height: 1024/697 02:29:03 INFO - PROCESS | 15906 | __metrics 02:29:04 INFO - PROCESS | 15906 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:29:04 INFO - TEST-INFO | 15906: exit 0 02:29:04 INFO - Browser initialized. 02:29:04 INFO - Running cycle 1/1 for dromaeo_css test... 02:29:04 INFO - TEST-INFO | started process 15986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptD1Aaj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:29:16 INFO - PROCESS | 15986 | RSS: Main: 156913664 02:29:16 INFO - PROCESS | 15986 | 02:30:08 INFO - PROCESS | 15986 | 1467192608366 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] 02:32:16 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:43872/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43872/tests/dromaeo/cssquery-ext.html) 02:32:16 INFO - PROCESS | 15986 | RSS: Main: 246190080 02:32:16 INFO - PROCESS | 15986 | 02:35:19 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:43872/tests/dromaeo/cssquery-ext.html (next: http://localhost:43872/tests/dromaeo/cssquery-jquery.html) 02:35:20 INFO - PROCESS | 15986 | RSS: Main: 242012160 02:35:20 INFO - PROCESS | 15986 | 02:38:22 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:43872/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43872/tests/dromaeo/cssquery-mootools.html) 02:38:22 INFO - PROCESS | 15986 | RSS: Main: 240951296 02:38:22 INFO - PROCESS | 15986 | 02:41:25 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:43872/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43872/tests/dromaeo/cssquery-prototype.html) 02:41:25 INFO - PROCESS | 15986 | RSS: Main: 227430400 02:41:25 INFO - PROCESS | 15986 | 02:44:28 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:43872/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43872/tests/dromaeo/cssquery-yui.html) 02:44:28 INFO - PROCESS | 15986 | RSS: Main: 223232000 02:44:28 INFO - PROCESS | 15986 | 02:47:31 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:43872/tests/dromaeo/cssquery-yui.html (next: http://localhost:43872/tests/dromaeo/cssquery-dojo.html) 02:47:32 INFO - PROCESS | 15986 | RSS: Main: 295407616 02:47:32 INFO - PROCESS | 15986 | 02:47:32 INFO - PROCESS | 15986 | __start_tp_report 02:47:32 INFO - PROCESS | 15986 | _x_x_mozilla_page_load 02:47:32 INFO - PROCESS | 15986 | _x_x_mozilla_page_load_details 02:47:32 INFO - PROCESS | 15986 | |i|pagename|runs| 02:47:32 INFO - PROCESS | 15986 | |0;dojo.html;3035.590195323631;3050.313679422129;3086.4752991991368;3098.7366073883704;3107.7824552281336;5184.559312458437;5203.583713302936;5268.07808633489;5271.15661494161;5307.787688492461;5156.071907056728;5164.2253661950635;5243.8164664236665;5316.308879845625;5330.946690533094;4604.125216208918;4700.318453824193;4714.080754252922;4772.141014617368;4965.925511117336;4883.511648835123;4940.5800506956775;4947.060058588874;4947.233178857283;4947.6784009039475;4707.929381059287;4709.764511774431;4751.049790041988;4753.120672675532;4824.17988941879;4725.66920315578;4735.857924262277;4747.216709242971;4795.328653988445;4842.6368022398465;4750.209656163894;4779.80880764769;4786.018866132435;4790.257510085942;4833.975830120862;5118.795248190068;5215.113430716788;5215.452377500384;5271.789128434858;5308.23030660552;5604.663720176803;5690.459406356389;5710.914336284959;5713.428657134295;5717.399673034313;5688.687122208277;5715.085586306171;5743.741531631086;5761.683107429089;5762.078067509178;5195.558377537914;5215.530602245816;5240.842774716764;5243.397009343936;5293.550048245866;5747.626404283708;5757.740901659436;5760.2223699800825;5764.827055188351;5765.106408506688;5313.309269794902;5533.861653458695;5543.113101903757;5544.972275138599;5545.72271386429;5597.916031259534;5615.9157612635845;5619.297587801525;5677.347105082886;5681.261436013292;5600.663960162403;5600.803971860965;5602.691851948182;5603.963266795656;5606.1590761385305;5419.187121931742;5557.499825015768;5580.302462192226;5605.607607467519;5608.69152196625;4215.283401821697;4260.360945858084;4275.957240427618;4287.164003019444;4297.162053399557;3794.4687743715904;3797.8480860765812;3803.7147213959065;3830.751001184914;3839;5127.589792816566;5171.689698618095;5181.974090129601;5249.396319423239;5266.394364648115;5553.694546799884;5558.722063896789;5590.329160500766;5593.07714227148;5600.131979543177;5192.1173400522;5205.141151710001;5212.270282160501;5217.0870097733505;5272.736363181903;4734.053189362141;4778.880527986828;4806.591439727662;4808.975955120202;4811.037792441526;5815.621984570989;5821.825345239649;5826.941730582725;5838.620489668158;5873.3245676746865;5598.524125449382;5606.383297837153;5620.437956204511;5621.634593751393;5623.100303951348;5722.198892155185;5738.770449181986;5750.281214848144;5779.566532509994;5810.912836307374;5475.753591088331;5478.698671573102;5488.204210389551;5492.917606235989;5498.560115190695;5555.7499912504845;5582.888342233214;5593.496585307342;5603.271574695426;5637.49262566371;5329.7068661224;5434.701091439851;5460.6177567569885;5480.725963701879;5518.227448157181;5481.424450432806;5508.697021663847;5516.420775818481;5517.917231241454;5525.033119204043;5295.25866378715;5396.514313711785;5443.319585051869;5451.672899626035;5502.8349149525575;5341.7062061586985;5367.597430192829;5377.919331210113;5475.4524547544925;5483.835484935458;5313.362396512443;5313.574914006793;5319;5320.042392369411;5327.9200811987075 02:47:32 INFO - PROCESS | 15986 | |1;ext.html;600.3786081405743;612.3814946903626;613.1538476901875;638.1353266324134;648.6108334999001;32124.839375803116;36127;41587.37618935714;42588.78705606468;42664.78667606665;44976.3253551197;45317.546824531746;45411.54588454114;45462.545374546244;45469.317960230626;7703.268189521987;8888.511131887744;8985.236254918307;8994.595243214038;9036.50299233542;7983.321417679475;8247;8268.586570671472;10346.53440595175;10616.256862019662;10839.891601084006;10854.511546980404;10881.12950963925;10885.619003334885;10887.945560272226;10769.353838769699;10836.403997780119;10843.67468975928;10843.78312433747;10843.78312433747;7933.920660793434;10186.134178594828;10529.84205236922;10530.578776848917;10899;42245.577544224776;42387.78806105981;42670.78664606688;42677.146457070994;42734.085580158055;3527.5590551181103;3687.520622319108;3764.9435258471144;3842.3275926712995;3910.960890391088;32518.041122382798;32600;32875.6712432875;33193.3361332772;34329.656703433146;4447.221736196185;4469.7318160910445;4591.288350305708;4628.236341003731;4643.419572553431;229519;231895;232888;233000.83499582563;233312;56846.43153568494;57129;57524;57611.4238857606;57626.4237357621;34701.47947780785;35674;35716.64283357185;37664.62335376666;37844.43233351502;17173.914130429268;17265.3957111503;17314.480565582802;17317.307307707804;17322.39371621987;13290.73418531624;13325.200487970753;13391.866081339062;13394.665133371549;13410.865891340962;19348.903255483914;19405.350262957236;19457.465687712356;19487.255999005345;19561.625509781334;7381.224971378036;7401.148867880155;7419.109706835106;7436.144843343085;7507.962460187664;995.9452230127267;1013.8580598716186;1103.1340397787699;1143.3197247637643;1150.396042077899;30834.383312334077;32054.839725801223;32217.838910805294;32416.513752293733;32768.18079547983;1106.1980064453207;1123.528118190362;1140.0651465798132;1196.9825648198962;1200.711829160995;17009.404670836462;17048.82951170497;17134.314627414762;17215.82784172167;17422.128893555273;476614;483581;485314;486265;490359;58488.41511584915;59116.704416477645;59119.40880591225;59286;59287.40712592819;1307.952470743166;1384.7715127003933;1388.9652758680709;1408.8802451791507;1416.723738870931;30580.541291880196;31737.36525269528;31903.202419939687;31950;32636.83681581577;51099.74450127874;51525.7423712879;51583;51584.74207628938;51621;416229;424622;425493;426098;426757;23968.52062958766;24829.379265518506;25006.499870002863;27752;27964.720352796212;33808.66191338055;44080.338794918745;44414.3337849926;44925.55074449214;45507.08985820199;37368.093113675015;38835.417468737425;39536.60463395329;39587;39936.80031599823;38301.233975320894;38789.22421551609;39032.2193556133;39108.60891391164;39190;38489.23021539609;39139.2172156561;39268.60731392764;39661.60338396695;39764;33044.339113217124;34647.30705385929;34820.82589587036;35039.299214016086;35142.64857351496;26442.810073546352;27244;27639.170824875288;29113.563296550146;29890.402191955603 02:47:32 INFO - PROCESS | 15986 | |2;jquery.html;373.94764732937375;376.4315883016645;392.5074032089727;393.29992613148596;401.3718530499768;14901.142227633796;15409;17421.390251341207;20440.795592044076;20475.897620511878;17783.46649600511;18690;19658.90170549145;19950.201991920305;20019.099140538674;5157.30376399186;5271.15661494161;5335.813246536372;5349.384820745625;5351.357837059559;3873.341531939563;5583.469570390806;5860.150278209657;5870.412958704138;5963.940360596382;5872.765089396419;5907.7636894524385;5923.940760592403;5931.73307201177;5942.940570594282;5809.477147056764;5930.318013428425;5947.4944629706315;5962.552808539377;5970.373110823388;5712.1431785232135;5766.077427611562;5772.2496075510335;5820.912686309666;5822.796202132948;13109;13114.082014259006;13142.540011099662;13242.73514529704;13378.665533361647;2262.083856038307;2384.177458776719;2464.445499762557;2753.8898444062215;3018.3963207358397;9385.296102792317;9626.470544120071;9776.31565790395;9796.804063918682;9967.352122112039;1852.3794528832857;1958.2460752610205;1962.2935743132462;2017.7175195472646;2018.4348382452936;72370;74511;74761.25238747652;77923.22076779217;83027.5848620759;10017.69946901594;10367.429791361548;10577.36535807854;10660.307080039773;11023.228374013743;15126.848731512764;15209.695806083817;15246.08523488572;15304.08175509473;15312.387504499695;7869.055713314439;7956.2441568050945;8161.102278749451;8253.422260441832;8361.749147525585;7510.1738808731;7516.624168791539;7534.849303013909;7644.159142494321;7644.6942122315595;4432.711873728197;4683;4719.575238228507;4736.478987311393;4741.644376671695;1824.1882362348626;1896.7249748786348;1900.657881581301;1951.0829909942304;1956.7554055743033;917.6971599372324;957.2342126298932;967.0716112531908;979.8334283171878;1030.4744580264119;19258.61482770365;19715.50711232202;19810.70283945742;19862.60274794525;19871.30450434228;980.3186785184229;1030.6804890483975;1036.984445233322;1040.0691381213771;1057.6721216422934;10512.369257844553;11005.284656497302;11022.173336999596;11052.778944421227;11070.28043177191;437238;442491;446417;448767;449846;93897.53051234837;95821;96726.51636741772;96750;97197.51401242948;1019.4749703902496;1031.4997226345217;1073.5705717712976;1095.2388090277182;1099.571167244775;17087.82912170912;17214.311427542758;17618.91190544039;17644.29422823124;17750.644987099928;40125.398119028825;40761;40836.387454187614;41451.37822932598;41522.169556608096;53242;59598.404015959284;59812.700936495035;59836;60183.39816601953;8597.699080532151;8721.258693011165;8764.605592748469;8854.734357969272;8946.731598052069;9843.310968232156;13526.18842869431;13766.724665506834;13807.309634518033;14067.507637232648;10879.292845964987;10930.890691093306;11314.321140731583;11371.601993930173;11437.313761174357;10664.200184986312;11931.234606064989;12039;12077;12175.39123043862;10981.890181098086;11033.33799971972;11413.372264525531;11522.13583981188;11844.111691622991;7430.517016393917;8737.650493980424;8750.64997400097;8812.118788121137;8947.463152210888;10180.541875615467;11680.649580512598;11898.405079746151;12117.454714537691;12203.511859525875 02:47:32 INFO - PROCESS | 15986 | |3;mootools.html;1289.9419526121324;1456.3082535795495;1482.2514630111793;1609.5251900689295;1740.2342969093606;8200.343972482202;8591.699290524833;8598.957005214965;8852.424592401489;8864.246539044188;8555;8734.956325218365;8737.30101591871;8746.606402711894;8747.825043499126;1932.8936908470098;2168.6530155175174;2173.9782602173973;2213.612617791888;2264.29806759905;2183.2031308572414;2194.2429861697688;2194.7037149984785;2196.2752291743686;2196.3301193136167;2192.9890350548303;2239.4177513846435;2270.625346817773;2271.136967952184;2272.4318920269934;1866.664000479913;2099.611571859211;2181.5636872625537;2186.6610675345346;2187.8359123065675;2131.2114517628575;2131.776163502841;2167.924122655715;2169.7504786949544;2171.543975765091;8542.273906717937;8565.186307300797;8598.183172598656;8600.741977740678;8606.87089693655;5138.46046165151;5272.894542109175;5275.894482110375;5279.287296215;5280.3663560373;3193.3613277344625;3195.6325022622464;3226.274088330107;3233.094733474631;3248.512723091555;1028.912542433894;1036.1244748187844;1053.7616321926644;1072.7318170457386;1073.0664322039797;11964.64106076819;12261.019118470502;12284.078694097889;12295.69260768479;12309.876901230962;4550.795214215368;4567.36056952027;4671.346011558385;4672.229082201467;4673.158831410379;10205.591776329013;10209;10221.897781022244;10223.284370094021;10224.948875255575;5276.287701160371;5283.022640811462;5284.154535274338;5285.735713214324;5287.9735601321745;4148.357004664282;4731.432228132646;4865.1485989952325;4869.342638743724;4932.630052746058;3983.072904115137;4027.2146931348693;4076.8369265229057;4092.4475195848777;4210.873673789792;1252.7995520716825;1261.7224210673637;1265.4811527273773;1270.9110362274737;1280.705437749323;945.4091193004373;990.8308196328258;1001.1840350114634;1004.8693669823023;1013.5287091502339;5789.710514474259;5860.912086318709;6012.939870601238;6117.816465506042;6222.097795819672;432.2565187876847;434.0494317444849;446.4597836617664;446.7386578851408;446.77360645029603;3938.6455219030427;4002;4010.258102251093;4038.3336749436603;4110.136871257009;10594.364338139736;10630.946845265878;10873.347599144077;10875.564977400974;10975;10723.892761072446;10758.784824303626;10821.729456763487;10827.133829293794;10837.83743243852;7790.1041380241995;7833.725819596287;7889.960550197327;7908;7913.920860791433;5868.09044598088;5876.118582212532;5992.880142397041;6048;6101;9995.200383969119;10088.899111008795;10104.242181836538;10162.339447935861;10166.949165254126;9937.25470589723;9996;10095.7476063099;10300.742481438025;10336.689899303034;7092.858142837217;7628.427867909818;7739.613019349123;7841.4118941078505;7915.604219789103;8553.657853685783;8566.48601083937;8590.269827064769;8592.570371481526;8621.956890215508;7553.244675532403;7681.078270607562;7755.495892766952;7823.139454660097;7860.646270917708;7402;7402;7543.207963164008;7614.961925190339;7740.496867703581;7019.964900175466;7047.577145371294;7080.327368899946;7084.752033678797;7088.858222835412;4946;5119.692818430906;5214.921776173436;5224.686518808731;5309.522143006993;5204.869878253074;5251.737413129252;5304.177852432879;5308.25684404176;5401.2168235606405 02:47:32 INFO - PROCESS | 15986 | |4;prototype.html;302.13438498701225;302.9727324540791;307.8414616472517;314.1141979617479;321.48401815086777;5229.398619158798;5281.841544753654;5308.867278318044;5331.040412725708;5345.1714984177415;5184.274201611777;5200.453952335007;5225.850312931149;5226.346706661668;5241.5806735461165;3880.553736320324;3939.231849789292;4044.4539987101807;4061.2283666103494;4073.7352072115364;4022.275990321741;4032.9596704033024;4039.4950631171105;4045.8381664733374;4048.210598933209;3890.9416358754643;3986.5216174059155;3986.66113380363;3997.800109994503;4019.859304924328;3997.2012594332523;4034.616711412411;4065.857694980691;4081;4085.101277718897;3591.6228795976567;3594.802285874276;3595.8381872815785;3596.946045809315;3610.4042832932537;5094.006668699605;5168.689878607295;5186.273921650972;5203.713795741232;5205.661631993946;4516.322551617283;4639.234526303156;4666.2067448533835;4667.463241727177;4695.248760198352;5420.214068960018;5439.836804895859;5446.420538044002;5503.367112782002;5503.7798488060425;3949.8150554833437;3970.205958808221;3971.848164032427;3977.7016723745546;3982.9402558961638;5281.683099014033;5610.579206559524;5635.436456354373;5637.267155269829;5665.433456654343;3902.5316961964177;3911.5697273299916;3916.3342231820657;3920.1179734559496;3934.7245692801803;3966.087799806061;3973.5430425501436;3978.960210397859;3979.462772525672;4011.538673052578;4469.396631454777;4576.473705523841;4592.471865735416;4617.307403889444;4638.141943740419;5438.619296649196;5475.315585551806;5489.4236105209175;5500.257465242141;5509.256250406143;1308.8233088533116;1326.8390158611214;1336.659151916255;1336.6658335416146;1340.1356125299321;877.394597727566;879.2614204068485;897.699270744295;924.4776701163821;927.5084205371164;5155.690658560424;5208.661437006583;5210.791568337224;5211.5830733541225;5216.478352164753;5558.138488534284;5575.163725441216;5577.749001294951;5587.7148255901375;5610.943890561042;5048.899022019539;5248.475152484797;5260.710660913686;5269.420363759983;5284.313039304866;2970.8960186393374;2972.2272209225757;2976.9702302977125;2978.927586069057;2983.34366439383;5512.531434828004;5772.3938986406665;5782.566307526952;5797.275340582427;5818.912716309259;5640.379558248589;5667.4615911488345;5695.45893140151;5697.914531282034;5709.286339207599;5694.145878118233;5718.656880587178;5756.827295181151;5792.3917988612275;5805.274340707411;5340.786368545215;5565.526930210977;5612.635178713371;5703.686297253691;5736.368999410145;5650.689212093374;5667.659940403589;5675.460831221028;5681.659100453986;5686.658800471985;5702.6293290935955;5931.673757943182;5947.672877991579;5962.37395073511;5965.6718880461995;3995.880123596297;3996.960030399659;4014.437978682928;4014.9397759033054;4036.57615950321;5692.345380281321;5706.288113565831;5721.771129154954;5739.512141467855;5766.4233576642;5408.188771684278;5473.917891231715;5573.331200255833;5583.944160558505;5603.691796951207;5475.75359108849;5484.533814625802;5499.395066542757;5499.945000549943;5512.3385193777;5205;5255.132903071103;5385.676859388449;5404.108322126805;5422.755975981011;5469.3318537846335;5498.972505137609;5514.80698175562;5550.916736249041;5554.389017208185;5305.867353316198;5389.272448219597;5451.127819548853;5457.99027179973;5486.149646804752 02:47:32 INFO - PROCESS | 15986 | |5;yui.html;754.3286475037216;781.8709912864377;782.432736266207;835.6615570693871;883.1609970528;15857.207139643015;16491.83508164918;16496.257668404905;16517.256723447445;16536;15057.54827355181;15251.31369088391;15269.312880920357;15369;15395.615109622266;665.0888283052225;803.2289002557552;803.9397045221602;806.8547661420941;809.2069771623812;769.0732667136116;812.2324403438753;814.2468216899374;814.6863457568819;819.1521774962914;861.5261606116642;862.1593945902727;862.9170391159117;863.3352318714617;864.0409145848104;685.0512040823446;804.3002587748638;850.7575341027808;851.2381418630322;852.1733918099403;619.3527763487167;625.1154616218091;626.9937300626981;627.3788948940517;627.7959663109508;15221.467248646244;15261.923690381476;15276.618084547865;15279.083255004623;15316;13136.60590182296;13616.795748063787;14112.294385280695;14156.575302740934;14188.716225675533;13436.328183590782;13553.728925421436;13590.38843252056;13885.37515811791;14259.001869869113;4521.434820647419;4628.768561571942;4661.254199328125;4729.834455794065;4770.856874293777;81732.18267817305;82190;83194.58402707947;83492.58253708754;83918.58040709757;11693.824592631117;11857.822132668018;11919.76160476803;11921.582744603897;12095.455704493319;22637.547249055257;22719.432014199778;22729.431764205696;22763.699263606683;22772.544549108927;8614.44006139599;8751.781205469913;8841.911580884109;8854.468731875979;9003;4556.635469162459;4833.081714474239;4889.339939108175;5020.397552293748;5055.165897626924;3459.6367381425093;3583.623719509466;3594.946075808865;3602.3695853226104;3607.9278414431565;639.3734140542294;647.3946859686208;649.5355820588302;650.0444346810182;650.0996120373317;612.4671535763825;624.3257282135284;633.3792882974618;642.8392901774556;712.682856129028;9049.683261085831;9425.57584908667;9624.903750962541;9704.466254355937;9708.5145742714;662.3696795081175;666.513445185008;673.1383828699272;675.722953589036;676.3608390071336;4444.955550444454;4534.771050212467;4558.27067669178;4581.381513495702;4592.609628181575;79920.20079799244;102249;109726;110290;112949;33038.17404564857;33041.3391732164;55592.610184744895;77427;80453.19546804574;81966.59016704878;83540.58229708813;83840.58079709562;85613.57193213994;86664;9537.380070295409;10047.296689231976;10157.441340726331;10267;10275.229357798344;50754.238686419;50827.49172508228;51275.2308715377;51877.22184167316;51913.48086519087;65874.67062664656;67160.6641966787;71440.99826024257;72571.27428725857;73742;12250.387480626112;12292.201006934522;12294.87705122973;12300.876991229974;12507.74984500323;15103.32035058403;15168.021369587457;15252.847471525587;15405.075695458308;15549.455769048029;14015.439382424996;14164.291785410895;14166.43334266659;14178;14419.42322307096;13471.461141554228;13767;14011.229382384066;14088;14155;13673.589792306248;13878.444862205399;14065.718685626434;14191.858081419054;14203.218822964836;11768.411579421167;11902.940485297519;11948.522059117538;11953.402329883646;12348.691282717644;11340.489677964346;12114.428482198626;12265;12334.136610437543;12338.691532711755 02:47:32 INFO - PROCESS | 15986 | __end_tp_report 02:47:32 INFO - PROCESS | 15986 | __start_cc_report 02:47:32 INFO - PROCESS | 15986 | _x_x_mozilla_cycle_collect,742 02:47:32 INFO - PROCESS | 15986 | __end_cc_report 02:47:32 INFO - PROCESS | 15986 | __startTimestamp1467193652122__endTimestamp 02:47:32 INFO - PROCESS | 15986 | 02:47:32 INFO - PROCESS | 15986 | ------- Summary: start ------- 02:47:32 INFO - PROCESS | 15986 | Number of tests: 6 02:47:32 INFO - PROCESS | 15986 | 02:47:32 INFO - PROCESS | 15986 | [#0] dojo.html Cycles:165 Average:5204.57 Median:5330.95 stddev:587.43 (11.0%) stddev-sans-first:564.05 02:47:32 INFO - PROCESS | 15986 | Values: 3035.6 3050.3 3086.5 3098.7 3107.8 5184.6 5203.6 5268.1 5271.2 5307.8 5156.1 5164.2 5243.8 5316.3 5330.9 4604.1 4700.3 4714.1 4772.1 4965.9 4883.5 4940.6 4947.1 4947.2 4947.7 4707.9 4709.8 4751.0 4753.1 4824.2 4725.7 4735.9 4747.2 4795.3 4842.6 4750.2 4779.8 4786.0 4790.3 4834.0 5118.8 5215.1 5215.5 5271.8 5308.2 5604.7 5690.5 5710.9 5713.4 5717.4 5688.7 5715.1 5743.7 5761.7 5762.1 5195.6 5215.5 5240.8 5243.4 5293.6 5747.6 5757.7 5760.2 5764.8 5765.1 5313.3 5533.9 5543.1 5545.0 5545.7 5597.9 5615.9 5619.3 5677.3 5681.3 5600.7 5600.8 5602.7 5604.0 5606.2 5419.2 5557.5 5580.3 5605.6 5608.7 4215.3 4260.4 4276.0 4287.2 4297.2 3794.5 3797.8 3803.7 3830.8 3839.0 5127.6 5171.7 5182.0 5249.4 5266.4 5553.7 5558.7 5590.3 5593.1 5600.1 5192.1 5205.1 5212.3 5217.1 5272.7 4734.1 4778.9 4806.6 4809.0 4811.0 5815.6 5821.8 5826.9 5838.6 5873.3 5598.5 5606.4 5620.4 5621.6 5623.1 5722.2 5738.8 5750.3 5779.6 5810.9 5475.8 5478.7 5488.2 5492.9 5498.6 5555.7 5582.9 5593.5 5603.3 5637.5 5329.7 5434.7 5460.6 5480.7 5518.2 5481.4 5508.7 5516.4 5517.9 5525.0 5295.3 5396.5 5443.3 5451.7 5502.8 5341.7 5367.6 5377.9 5475.5 5483.8 5313.4 5313.6 5319.0 5320.0 5327.9 02:47:32 INFO - PROCESS | 15986 | 02:47:32 INFO - PROCESS | 15986 | [#1] ext.html Cycles:180 Average:54261.86 Median:35921.82 stddev:104684.37 (291.4%) stddev-sans-first:104900.50 02:47:32 INFO - PROCESS | 15986 | Values: 600.4 612.4 613.2 638.1 648.6 32124.8 36127.0 41587.4 42588.8 42664.8 44976.3 45317.5 45411.5 45462.5 45469.3 7703.3 8888.5 8985.2 8994.6 9036.5 7983.3 8247.0 8268.6 10346.5 10616.3 10839.9 10854.5 10881.1 10885.6 10887.9 10769.4 10836.4 10843.7 10843.8 10843.8 7933.9 10186.1 10529.8 10530.6 10899.0 42245.6 42387.8 42670.8 42677.1 42734.1 3527.6 3687.5 3764.9 3842.3 3911.0 32518.0 32600.0 32875.7 33193.3 34329.7 4447.2 4469.7 4591.3 4628.2 4643.4 229519.0 231895.0 232888.0 233000.8 233312.0 56846.4 57129.0 57524.0 57611.4 57626.4 34701.5 35674.0 35716.6 37664.6 37844.4 17173.9 17265.4 17314.5 17317.3 17322.4 13290.7 13325.2 13391.9 13394.7 13410.9 19348.9 19405.4 19457.5 19487.3 19561.6 7381.2 7401.1 7419.1 7436.1 7508.0 995.9 1013.9 1103.1 1143.3 1150.4 30834.4 32054.8 32217.8 32416.5 32768.2 1106.2 1123.5 1140.1 1197.0 1200.7 17009.4 17048.8 17134.3 17215.8 17422.1 476614.0 483581.0 485314.0 486265.0 490359.0 58488.4 59116.7 59119.4 59286.0 59287.4 1308.0 1384.8 1389.0 1408.9 1416.7 30580.5 31737.4 31903.2 31950.0 32636.8 51099.7 51525.7 51583.0 51584.7 51621.0 416229.0 424622.0 425493.0 426098.0 426757.0 23968.5 24829.4 25006.5 27752.0 27964.7 33808.7 44080.3 44414.3 44925.6 45507.1 37368.1 38835.4 39536.6 39587.0 39936.8 38301.2 38789.2 39032.2 39108.6 39190.0 38489.2 39139.2 39268.6 39661.6 39764.0 33044.3 34647.3 34820.8 35039.3 35142.6 26442.8 27244.0 27639.2 29113.6 29890.4 02:47:32 INFO - PROCESS | 15986 | 02:47:32 INFO - PROCESS | 15986 | [#2] jquery.html Cycles:180 Average:27377.60 Median:2124.89 stddev:73712.54 (3469.0%) stddev-sans-first:73891.44 02:47:32 INFO - PROCESS | 15986 | Values: 373.9 376.4 392.5 393.3 401.4 14901.1 15409.0 17421.4 20440.8 20475.9 17783.5 18690.0 19658.9 19950.2 20019.1 5157.3 5271.2 5335.8 5349.4 5351.4 3873.3 5583.5 5860.2 5870.4 5963.9 5872.8 5907.8 5923.9 5931.7 5942.9 5809.5 5930.3 5947.5 5962.6 5970.4 5712.1 5766.1 5772.2 5820.9 5822.8 13109.0 13114.1 13142.5 13242.7 13378.7 2262.1 2384.2 2464.4 2753.9 3018.4 9385.3 9626.5 9776.3 9796.8 9967.4 1852.4 1958.2 1962.3 2017.7 2018.4 72370.0 74511.0 74761.3 77923.2 83027.6 10017.7 10367.4 10577.4 10660.3 11023.2 15126.8 15209.7 15246.1 15304.1 15312.4 7869.1 7956.2 8161.1 8253.4 8361.7 7510.2 7516.6 7534.8 7644.2 7644.7 4432.7 4683.0 4719.6 4736.5 4741.6 1824.2 1896.7 1900.7 1951.1 1956.8 917.7 957.2 967.1 979.8 1030.5 19258.6 19715.5 19810.7 19862.6 19871.3 980.3 1030.7 1037.0 1040.1 1057.7 10512.4 11005.3 11022.2 11052.8 11070.3 437238.0 442491.0 446417.0 448767.0 449846.0 93897.5 95821.0 96726.5 96750.0 97197.5 1019.5 1031.5 1073.6 1095.2 1099.6 17087.8 17214.3 17618.9 17644.3 17750.6 40125.4 40761.0 40836.4 41451.4 41522.2 53242.0 59598.4 59812.7 59836.0 60183.4 8597.7 8721.3 8764.6 8854.7 8946.7 9843.3 13526.2 13766.7 13807.3 14067.5 10879.3 10930.9 11314.3 11371.6 11437.3 10664.2 11931.2 12039.0 12077.0 12175.4 10981.9 11033.3 11413.4 11522.1 11844.1 7430.5 8737.7 8750.6 8812.1 8947.5 10180.5 11680.6 11898.4 12117.5 12203.5 02:47:32 INFO - PROCESS | 15986 | 02:47:32 INFO - PROCESS | 15986 | [#3] mootools.html Cycles:180 Average:5731.80 Median:2498.78 stddev:3308.87 (132.4%) stddev-sans-first:3301.31 02:47:32 INFO - PROCESS | 15986 | Values: 1289.9 1456.3 1482.3 1609.5 1740.2 8200.3 8591.7 8599.0 8852.4 8864.2 8555.0 8735.0 8737.3 8746.6 8747.8 1932.9 2168.7 2174.0 2213.6 2264.3 2183.2 2194.2 2194.7 2196.3 2196.3 2193.0 2239.4 2270.6 2271.1 2272.4 1866.7 2099.6 2181.6 2186.7 2187.8 2131.2 2131.8 2167.9 2169.8 2171.5 8542.3 8565.2 8598.2 8600.7 8606.9 5138.5 5272.9 5275.9 5279.3 5280.4 3193.4 3195.6 3226.3 3233.1 3248.5 1028.9 1036.1 1053.8 1072.7 1073.1 11964.6 12261.0 12284.1 12295.7 12309.9 4550.8 4567.4 4671.3 4672.2 4673.2 10205.6 10209.0 10221.9 10223.3 10224.9 5276.3 5283.0 5284.2 5285.7 5288.0 4148.4 4731.4 4865.1 4869.3 4932.6 3983.1 4027.2 4076.8 4092.4 4210.9 1252.8 1261.7 1265.5 1270.9 1280.7 945.4 990.8 1001.2 1004.9 1013.5 5789.7 5860.9 6012.9 6117.8 6222.1 432.3 434.0 446.5 446.7 446.8 3938.6 4002.0 4010.3 4038.3 4110.1 10594.4 10630.9 10873.3 10875.6 10975.0 10723.9 10758.8 10821.7 10827.1 10837.8 7790.1 7833.7 7890.0 7908.0 7913.9 5868.1 5876.1 5992.9 6048.0 6101.0 9995.2 10088.9 10104.2 10162.3 10166.9 9937.3 9996.0 10095.7 10300.7 10336.7 7092.9 7628.4 7739.6 7841.4 7915.6 8553.7 8566.5 8590.3 8592.6 8622.0 7553.2 7681.1 7755.5 7823.1 7860.6 7402.0 7402.0 7543.2 7615.0 7740.5 7020.0 7047.6 7080.3 7084.8 7088.9 4946.0 5119.7 5214.9 5224.7 5309.5 5204.9 5251.7 5304.2 5308.3 5401.2 02:47:32 INFO - PROCESS | 15986 | 02:47:32 INFO - PROCESS | 15986 | [#4] prototype.html Cycles:180 Average:4606.63 Median:5265.07 stddev:1372.71 (26.1%) stddev-sans-first:1338.00 02:47:32 INFO - PROCESS | 15986 | Values: 302.1 303.0 307.8 314.1 321.5 5229.4 5281.8 5308.9 5331.0 5345.2 5184.3 5200.5 5225.9 5226.3 5241.6 3880.6 3939.2 4044.5 4061.2 4073.7 4022.3 4033.0 4039.5 4045.8 4048.2 3890.9 3986.5 3986.7 3997.8 4019.9 3997.2 4034.6 4065.9 4081.0 4085.1 3591.6 3594.8 3595.8 3596.9 3610.4 5094.0 5168.7 5186.3 5203.7 5205.7 4516.3 4639.2 4666.2 4667.5 4695.2 5420.2 5439.8 5446.4 5503.4 5503.8 3949.8 3970.2 3971.8 3977.7 3982.9 5281.7 5610.6 5635.4 5637.3 5665.4 3902.5 3911.6 3916.3 3920.1 3934.7 3966.1 3973.5 3979.0 3979.5 4011.5 4469.4 4576.5 4592.5 4617.3 4638.1 5438.6 5475.3 5489.4 5500.3 5509.3 1308.8 1326.8 1336.7 1336.7 1340.1 877.4 879.3 897.7 924.5 927.5 5155.7 5208.7 5210.8 5211.6 5216.5 5558.1 5575.2 5577.7 5587.7 5610.9 5048.9 5248.5 5260.7 5269.4 5284.3 2970.9 2972.2 2977.0 2978.9 2983.3 5512.5 5772.4 5782.6 5797.3 5818.9 5640.4 5667.5 5695.5 5697.9 5709.3 5694.1 5718.7 5756.8 5792.4 5805.3 5340.8 5565.5 5612.6 5703.7 5736.4 5650.7 5667.7 5675.5 5681.7 5686.7 5702.6 5931.7 5947.7 5962.4 5965.7 3995.9 3997.0 4014.4 4014.9 4036.6 5692.3 5706.3 5721.8 5739.5 5766.4 5408.2 5473.9 5573.3 5583.9 5603.7 5475.8 5484.5 5499.4 5499.9 5512.3 5205.0 5255.1 5385.7 5404.1 5422.8 5469.3 5499.0 5514.8 5550.9 5554.4 5305.9 5389.3 5451.1 5458.0 5486.1 02:47:32 INFO - PROCESS | 15986 | 02:47:32 INFO - PROCESS | 15986 | [#5] yui.html Cycles:180 Average:19534.19 Median:4587.00 stddev:26698.69 (582.1%) stddev-sans-first:26736.34 02:47:32 INFO - PROCESS | 15986 | Values: 754.3 781.9 782.4 835.7 883.2 15857.2 16491.8 16496.3 16517.3 16536.0 15057.5 15251.3 15269.3 15369.0 15395.6 665.1 803.2 803.9 806.9 809.2 769.1 812.2 814.2 814.7 819.2 861.5 862.2 862.9 863.3 864.0 685.1 804.3 850.8 851.2 852.2 619.4 625.1 627.0 627.4 627.8 15221.5 15261.9 15276.6 15279.1 15316.0 13136.6 13616.8 14112.3 14156.6 14188.7 13436.3 13553.7 13590.4 13885.4 14259.0 4521.4 4628.8 4661.3 4729.8 4770.9 81732.2 82190.0 83194.6 83492.6 83918.6 11693.8 11857.8 11919.8 11921.6 12095.5 22637.5 22719.4 22729.4 22763.7 22772.5 8614.4 8751.8 8841.9 8854.5 9003.0 4556.6 4833.1 4889.3 5020.4 5055.2 3459.6 3583.6 3594.9 3602.4 3607.9 639.4 647.4 649.5 650.0 650.1 612.5 624.3 633.4 642.8 712.7 9049.7 9425.6 9624.9 9704.5 9708.5 662.4 666.5 673.1 675.7 676.4 4445.0 4534.8 4558.3 4581.4 4592.6 79920.2 102249.0 109726.0 110290.0 112949.0 33038.2 33041.3 55592.6 77427.0 80453.2 81966.6 83540.6 83840.6 85613.6 86664.0 9537.4 10047.3 10157.4 10267.0 10275.2 50754.2 50827.5 51275.2 51877.2 51913.5 65874.7 67160.7 71441.0 72571.3 73742.0 12250.4 12292.2 12294.9 12300.9 12507.7 15103.3 15168.0 15252.8 15405.1 15549.5 14015.4 14164.3 14166.4 14178.0 14419.4 13471.5 13767.0 14011.2 14088.0 14155.0 13673.6 13878.4 14065.7 14191.9 14203.2 11768.4 11902.9 11948.5 11953.4 12348.7 11340.5 12114.4 12265.0 12334.1 12338.7 02:47:32 INFO - PROCESS | 15986 | -------- Summary: end -------- 02:47:32 INFO - PROCESS | 15986 | 02:47:32 INFO - TEST-INFO | 15986: exit 0 02:47:32 INFO - TEST-OK | dromaeo_css | took 1113920ms 02:47:32 INFO - TEST-START | kraken 02:47:32 INFO - operating with platform_type : linux_ 02:47:32 INFO - Initialising browser for kraken test... 02:47:32 INFO - TEST-INFO | started process 16166 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUD1TIF/profile http://localhost:43872/getInfo.html) 02:47:37 INFO - PROCESS | 16166 | __metrics Screen width/height:1600/1200 02:47:37 INFO - PROCESS | 16166 | colorDepth:24 02:47:37 INFO - PROCESS | 16166 | Browser inner width/height: 1024/697 02:47:37 INFO - PROCESS | 16166 | __metrics 02:47:38 INFO - PROCESS | 16166 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:47:38 INFO - TEST-INFO | 16166: exit 0 02:47:38 INFO - Browser initialized. 02:47:38 INFO - Running cycle 1/1 for kraken test... 02:47:38 INFO - TEST-INFO | started process 16250 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUD1TIF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:47:50 INFO - PROCESS | 16250 | RSS: Main: 156823552 02:47:50 INFO - PROCESS | 16250 | 02:47:53 INFO - PROCESS | 16250 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43872/tests/kraken/driver.html?testName=audio-beat-detection) 02:47:54 INFO - PROCESS | 16250 | RSS: Main: 215490560 02:47:54 INFO - PROCESS | 16250 | 02:47:56 INFO - PROCESS | 16250 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43872/tests/kraken/driver.html?testName=audio-dft) 02:47:57 INFO - PROCESS | 16250 | RSS: Main: 202530816 02:47:57 INFO - PROCESS | 16250 | 02:48:00 INFO - PROCESS | 16250 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43872/tests/kraken/driver.html?testName=audio-fft) 02:48:01 INFO - PROCESS | 16250 | RSS: Main: 268935168 02:48:01 INFO - PROCESS | 16250 | 02:48:03 INFO - PROCESS | 16250 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43872/tests/kraken/driver.html?testName=audio-oscillator) 02:48:03 INFO - PROCESS | 16250 | RSS: Main: 179720192 02:48:03 INFO - PROCESS | 16250 | 02:48:06 INFO - PROCESS | 16250 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43872/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:48:06 INFO - PROCESS | 16250 | RSS: Main: 184143872 02:48:06 INFO - PROCESS | 16250 | 02:48:09 INFO - PROCESS | 16250 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43872/tests/kraken/driver.html?testName=imaging-darkroom) 02:48:10 INFO - PROCESS | 16250 | RSS: Main: 218411008 02:48:10 INFO - PROCESS | 16250 | 02:48:13 INFO - PROCESS | 16250 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43872/tests/kraken/driver.html?testName=imaging-desaturate) 02:48:14 INFO - PROCESS | 16250 | RSS: Main: 220475392 02:48:14 INFO - PROCESS | 16250 | 02:48:16 INFO - PROCESS | 16250 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43872/tests/kraken/driver.html?testName=json-parse-financial) 02:48:17 INFO - PROCESS | 16250 | RSS: Main: 220803072 02:48:17 INFO - PROCESS | 16250 | 02:48:19 INFO - PROCESS | 16250 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43872/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:48:19 INFO - PROCESS | 16250 | RSS: Main: 207368192 02:48:19 INFO - PROCESS | 16250 | 02:48:21 INFO - PROCESS | 16250 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43872/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:48:22 INFO - PROCESS | 16250 | RSS: Main: 210014208 02:48:22 INFO - PROCESS | 16250 | 02:48:24 INFO - PROCESS | 16250 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43872/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:48:24 INFO - PROCESS | 16250 | RSS: Main: 217649152 02:48:24 INFO - PROCESS | 16250 | 02:48:27 INFO - PROCESS | 16250 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43872/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:48:27 INFO - PROCESS | 16250 | RSS: Main: 222298112 02:48:27 INFO - PROCESS | 16250 | 02:48:30 INFO - PROCESS | 16250 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43872/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:48:31 INFO - PROCESS | 16250 | RSS: Main: 221106176 02:48:31 INFO - PROCESS | 16250 | 02:48:32 INFO - PROCESS | 16250 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43872/tests/kraken/driver.html?testName=ai-astar) 02:48:33 INFO - PROCESS | 16250 | RSS: Main: 263532544 02:48:33 INFO - PROCESS | 16250 | 02:48:33 INFO - PROCESS | 16250 | __start_tp_report 02:48:33 INFO - PROCESS | 16250 | _x_x_mozilla_page_load 02:48:33 INFO - PROCESS | 16250 | _x_x_mozilla_page_load_details 02:48:33 INFO - PROCESS | 16250 | |i|pagename|runs| 02:48:33 INFO - PROCESS | 16250 | |0;ai-astar;101;111;110;111;113;111;110;112;111;112 02:48:33 INFO - PROCESS | 16250 | |1;audio-beat-detection;151;131;129;184;125;128;152;135;164;125 02:48:33 INFO - PROCESS | 16250 | |2;audio-dft;160;162;161;162;160;162;161;161;161;161 02:48:33 INFO - PROCESS | 16250 | |3;audio-fft;74;75;75;130;75;77;76;76;97;75 02:48:33 INFO - PROCESS | 16250 | |4;audio-oscillator;84;85;119;86;86;86;127;85;85;124 02:48:33 INFO - PROCESS | 16250 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;116;117 02:48:33 INFO - PROCESS | 16250 | |6;imaging-darkroom;146;146;146;146;146;146;145;146;145;146 02:48:33 INFO - PROCESS | 16250 | |7;imaging-desaturate;95;95;94;95;95;94;95;95;95;95 02:48:33 INFO - PROCESS | 16250 | |8;json-parse-financial;54;53;53;53;53;54;53;54;55;53 02:48:33 INFO - PROCESS | 16250 | |9;json-stringify-tinderbox;60;61;60;61;61;61;60;60;62;62 02:48:33 INFO - PROCESS | 16250 | |10;stanford-crypto-aes;91;84;78;79;84;82;79;80;94;80 02:48:33 INFO - PROCESS | 16250 | |11;stanford-crypto-ccm;128;126;121;120;127;119;121;123;122;125 02:48:33 INFO - PROCESS | 16250 | |12;stanford-crypto-pbkdf2;161;165;157;158;158;157;158;158;155;155 02:48:33 INFO - PROCESS | 16250 | |13;stanford-crypto-sha256-iterative;63;63;64;63;71;63;63;63;62;61 02:48:33 INFO - PROCESS | 16250 | __end_tp_report 02:48:33 INFO - PROCESS | 16250 | __start_cc_report 02:48:33 INFO - PROCESS | 16250 | _x_x_mozilla_cycle_collect,1630 02:48:33 INFO - PROCESS | 16250 | __end_cc_report 02:48:33 INFO - PROCESS | 16250 | __startTimestamp1467193713084__endTimestamp 02:48:33 INFO - PROCESS | 16250 | 02:48:33 INFO - PROCESS | 16250 | ------- Summary: start ------- 02:48:33 INFO - PROCESS | 16250 | Number of tests: 14 02:48:33 INFO - PROCESS | 16250 | 02:48:33 INFO - PROCESS | 16250 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:3.36 (3.0%) stddev-sans-first:0.97 02:48:33 INFO - PROCESS | 16250 | Values: 101.0 111.0 110.0 111.0 113.0 111.0 110.0 112.0 111.0 112.0 02:48:33 INFO - PROCESS | 16250 | 02:48:33 INFO - PROCESS | 16250 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:143.00 stddev:19.83 (13.9%) stddev-sans-first:20.79 02:48:33 INFO - PROCESS | 16250 | Values: 151.0 131.0 129.0 184.0 125.0 128.0 152.0 135.0 164.0 125.0 02:48:33 INFO - PROCESS | 16250 | 02:48:33 INFO - PROCESS | 16250 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 02:48:33 INFO - PROCESS | 16250 | Values: 160.0 162.0 161.0 162.0 160.0 162.0 161.0 161.0 161.0 161.0 02:48:33 INFO - PROCESS | 16250 | 02:48:33 INFO - PROCESS | 16250 | [#3] audio-fft Cycles:10 Average:83.00 Median:75.50 stddev:17.88 (23.7%) stddev-sans-first:18.66 02:48:33 INFO - PROCESS | 16250 | Values: 74.0 75.0 75.0 130.0 75.0 77.0 76.0 76.0 97.0 75.0 02:48:33 INFO - PROCESS | 16250 | 02:48:33 INFO - PROCESS | 16250 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:85.00 stddev:18.49 (21.8%) stddev-sans-first:19.03 02:48:33 INFO - PROCESS | 16250 | Values: 84.0 85.0 119.0 86.0 86.0 86.0 127.0 85.0 85.0 124.0 02:48:33 INFO - PROCESS | 16250 | 02:48:33 INFO - PROCESS | 16250 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 02:48:33 INFO - PROCESS | 16250 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 02:48:33 INFO - PROCESS | 16250 | 02:48:33 INFO - PROCESS | 16250 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 02:48:33 INFO - PROCESS | 16250 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 02:48:33 INFO - PROCESS | 16250 | 02:48:33 INFO - PROCESS | 16250 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:48:33 INFO - PROCESS | 16250 | Values: 95.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 02:48:33 INFO - PROCESS | 16250 | 02:48:33 INFO - PROCESS | 16250 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 02:48:33 INFO - PROCESS | 16250 | Values: 54.0 53.0 53.0 53.0 53.0 54.0 53.0 54.0 55.0 53.0 02:48:33 INFO - PROCESS | 16250 | 02:48:33 INFO - PROCESS | 16250 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.79 (1.3%) stddev-sans-first:0.78 02:48:33 INFO - PROCESS | 16250 | Values: 60.0 61.0 60.0 61.0 61.0 61.0 60.0 60.0 62.0 62.0 02:48:33 INFO - PROCESS | 16250 | 02:48:33 INFO - PROCESS | 16250 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:5.40 (6.5%) stddev-sans-first:4.92 02:48:33 INFO - PROCESS | 16250 | Values: 91.0 84.0 78.0 79.0 84.0 82.0 79.0 80.0 94.0 80.0 02:48:33 INFO - PROCESS | 16250 | 02:48:33 INFO - PROCESS | 16250 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:124.00 stddev:3.12 (2.5%) stddev-sans-first:2.78 02:48:33 INFO - PROCESS | 16250 | Values: 128.0 126.0 121.0 120.0 127.0 119.0 121.0 123.0 122.0 125.0 02:48:33 INFO - PROCESS | 16250 | 02:48:33 INFO - PROCESS | 16250 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.20 Median:158.00 stddev:2.94 (1.9%) stddev-sans-first:2.93 02:48:33 INFO - PROCESS | 16250 | Values: 161.0 165.0 157.0 158.0 158.0 157.0 158.0 158.0 155.0 155.0 02:48:33 INFO - PROCESS | 16250 | 02:48:33 INFO - PROCESS | 16250 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.00 stddev:2.72 (4.3%) stddev-sans-first:2.87 02:48:33 INFO - PROCESS | 16250 | Values: 63.0 63.0 64.0 63.0 71.0 63.0 63.0 63.0 62.0 61.0 02:48:33 INFO - PROCESS | 16250 | -------- Summary: end -------- 02:48:33 INFO - PROCESS | 16250 | 02:48:34 INFO - TEST-INFO | 16250: exit 0 02:48:34 INFO - TEST-OK | kraken | took 61199ms 02:48:34 INFO - SUITE-END | took 1175s 02:48:34 INFO - Completed test suite (00:19:35) 02:48:34 INFO - javascript benchmark 02:48:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3035.590195323631, 3050.313679422129, 3086.4752991991368, 3098.7366073883704, 3107.7824552281336, 5184.559312458437, 5203.583713302936, 5268.07808633489, 5271.15661494161, 5307.787688492461, 5156.071907056728, 5164.2253661950635, 5243.8164664236665, 5316.308879845625, 5330.946690533094, 4604.125216208918, 4700.318453824193, 4714.080754252922, 4772.141014617368, 4965.925511117336, 4883.511648835123, 4940.5800506956775, 4947.060058588874, 4947.233178857283, 4947.6784009039475, 4707.929381059287, 4709.764511774431, 4751.049790041988, 4753.120672675532, 4824.17988941879, 4725.66920315578, 4735.857924262277, 4747.216709242971, 4795.328653988445, 4842.6368022398465, 4750.209656163894, 4779.80880764769, 4786.018866132435, 4790.257510085942, 4833.975830120862, 5118.795248190068, 5215.113430716788, 5215.452377500384, 5271.789128434858, 5308.23030660552, 5604.663720176803, 5690.459406356389, 5710.914336284959, 5713.428657134295, 5717.399673034313, 5688.687122208277, 5715.085586306171, 5743.741531631086, 5761.683107429089, 5762.078067509178, 5195.558377537914, 5215.530602245816, 5240.842774716764, 5243.397009343936, 5293.550048245866, 5747.626404283708, 5757.740901659436, 5760.2223699800825, 5764.827055188351, 5765.106408506688, 5313.309269794902, 5533.861653458695, 5543.113101903757, 5544.972275138599, 5545.72271386429, 5597.916031259534, 5615.9157612635845, 5619.297587801525, 5677.347105082886, 5681.261436013292, 5600.663960162403, 5600.803971860965, 5602.691851948182, 5603.963266795656, 5606.1590761385305, 5419.187121931742, 5557.499825015768, 5580.302462192226, 5605.607607467519, 5608.69152196625, 4215.283401821697, 4260.360945858084, 4275.957240427618, 4287.164003019444, 4297.162053399557, 3794.4687743715904, 3797.8480860765812, 3803.7147213959065, 3830.751001184914, 3839.0, 5127.589792816566, 5171.689698618095, 5181.974090129601, 5249.396319423239, 5266.394364648115, 5553.694546799884, 5558.722063896789, 5590.329160500766, 5593.07714227148, 5600.131979543177, 5192.1173400522, 5205.141151710001, 5212.270282160501, 5217.0870097733505, 5272.736363181903, 4734.053189362141, 4778.880527986828, 4806.591439727662, 4808.975955120202, 4811.037792441526, 5815.621984570989, 5821.825345239649, 5826.941730582725, 5838.620489668158, 5873.3245676746865, 5598.524125449382, 5606.383297837153, 5620.437956204511, 5621.634593751393, 5623.100303951348, 5722.198892155185, 5738.770449181986, 5750.281214848144, 5779.566532509994, 5810.912836307374, 5475.753591088331, 5478.698671573102, 5488.204210389551, 5492.917606235989, 5498.560115190695, 5555.7499912504845, 5582.888342233214, 5593.496585307342, 5603.271574695426, 5637.49262566371, 5329.7068661224, 5434.701091439851, 5460.6177567569885, 5480.725963701879, 5518.227448157181, 5481.424450432806, 5508.697021663847, 5516.420775818481, 5517.917231241454, 5525.033119204043, 5295.25866378715, 5396.514313711785, 5443.319585051869, 5451.672899626035, 5502.8349149525575, 5341.7062061586985, 5367.597430192829, 5377.919331210113, 5475.4524547544925, 5483.835484935458, 5313.362396512443, 5313.574914006793, 5319.0, 5320.042392369411, 5327.9200811987075], "value": 5165.401960371987, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.3786081405743, 612.3814946903626, 613.1538476901875, 638.1353266324134, 648.6108334999001, 32124.839375803116, 36127.0, 41587.37618935714, 42588.78705606468, 42664.78667606665, 44976.3253551197, 45317.546824531746, 45411.54588454114, 45462.545374546244, 45469.317960230626, 7703.268189521987, 8888.511131887744, 8985.236254918307, 8994.595243214038, 9036.50299233542, 7983.321417679475, 8247.0, 8268.586570671472, 10346.53440595175, 10616.256862019662, 10839.891601084006, 10854.511546980404, 10881.12950963925, 10885.619003334885, 10887.945560272226, 10769.353838769699, 10836.403997780119, 10843.67468975928, 10843.78312433747, 10843.78312433747, 7933.920660793434, 10186.134178594828, 10529.84205236922, 10530.578776848917, 10899.0, 42245.577544224776, 42387.78806105981, 42670.78664606688, 42677.146457070994, 42734.085580158055, 3527.5590551181103, 3687.520622319108, 3764.9435258471144, 3842.3275926712995, 3910.960890391088, 32518.041122382798, 32600.0, 32875.6712432875, 33193.3361332772, 34329.656703433146, 4447.221736196185, 4469.7318160910445, 4591.288350305708, 4628.236341003731, 4643.419572553431, 229519.0, 231895.0, 232888.0, 233000.83499582563, 233312.0, 56846.43153568494, 57129.0, 57524.0, 57611.4238857606, 57626.4237357621, 34701.47947780785, 35674.0, 35716.64283357185, 37664.62335376666, 37844.43233351502, 17173.914130429268, 17265.3957111503, 17314.480565582802, 17317.307307707804, 17322.39371621987, 13290.73418531624, 13325.200487970753, 13391.866081339062, 13394.665133371549, 13410.865891340962, 19348.903255483914, 19405.350262957236, 19457.465687712356, 19487.255999005345, 19561.625509781334, 7381.224971378036, 7401.148867880155, 7419.109706835106, 7436.144843343085, 7507.962460187664, 995.9452230127267, 1013.8580598716186, 1103.1340397787699, 1143.3197247637643, 1150.396042077899, 30834.383312334077, 32054.839725801223, 32217.838910805294, 32416.513752293733, 32768.18079547983, 1106.1980064453207, 1123.528118190362, 1140.0651465798132, 1196.9825648198962, 1200.711829160995, 17009.404670836462, 17048.82951170497, 17134.314627414762, 17215.82784172167, 17422.128893555273, 476614.0, 483581.0, 485314.0, 486265.0, 490359.0, 58488.41511584915, 59116.704416477645, 59119.40880591225, 59286.0, 59287.40712592819, 1307.952470743166, 1384.7715127003933, 1388.9652758680709, 1408.8802451791507, 1416.723738870931, 30580.541291880196, 31737.36525269528, 31903.202419939687, 31950.0, 32636.83681581577, 51099.74450127874, 51525.7423712879, 51583.0, 51584.74207628938, 51621.0, 416229.0, 424622.0, 425493.0, 426098.0, 426757.0, 23968.52062958766, 24829.379265518506, 25006.499870002863, 27752.0, 27964.720352796212, 33808.66191338055, 44080.338794918745, 44414.3337849926, 44925.55074449214, 45507.08985820199, 37368.093113675015, 38835.417468737425, 39536.60463395329, 39587.0, 39936.80031599823, 38301.233975320894, 38789.22421551609, 39032.2193556133, 39108.60891391164, 39190.0, 38489.23021539609, 39139.2172156561, 39268.60731392764, 39661.60338396695, 39764.0, 33044.339113217124, 34647.30705385929, 34820.82589587036, 35039.299214016086, 35142.64857351496, 26442.810073546352, 27244.0, 27639.170824875288, 29113.563296550146, 29890.402191955603], "value": 19801.689761985443, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.94764732937375, 376.4315883016645, 392.5074032089727, 393.29992613148596, 401.3718530499768, 14901.142227633796, 15409.0, 17421.390251341207, 20440.795592044076, 20475.897620511878, 17783.46649600511, 18690.0, 19658.90170549145, 19950.201991920305, 20019.099140538674, 5157.30376399186, 5271.15661494161, 5335.813246536372, 5349.384820745625, 5351.357837059559, 3873.341531939563, 5583.469570390806, 5860.150278209657, 5870.412958704138, 5963.940360596382, 5872.765089396419, 5907.7636894524385, 5923.940760592403, 5931.73307201177, 5942.940570594282, 5809.477147056764, 5930.318013428425, 5947.4944629706315, 5962.552808539377, 5970.373110823388, 5712.1431785232135, 5766.077427611562, 5772.2496075510335, 5820.912686309666, 5822.796202132948, 13109.0, 13114.082014259006, 13142.540011099662, 13242.73514529704, 13378.665533361647, 2262.083856038307, 2384.177458776719, 2464.445499762557, 2753.8898444062215, 3018.3963207358397, 9385.296102792317, 9626.470544120071, 9776.31565790395, 9796.804063918682, 9967.352122112039, 1852.3794528832857, 1958.2460752610205, 1962.2935743132462, 2017.7175195472646, 2018.4348382452936, 72370.0, 74511.0, 74761.25238747652, 77923.22076779217, 83027.5848620759, 10017.69946901594, 10367.429791361548, 10577.36535807854, 10660.307080039773, 11023.228374013743, 15126.848731512764, 15209.695806083817, 15246.08523488572, 15304.08175509473, 15312.387504499695, 7869.055713314439, 7956.2441568050945, 8161.102278749451, 8253.422260441832, 8361.749147525585, 7510.1738808731, 7516.624168791539, 7534.849303013909, 7644.159142494321, 7644.6942122315595, 4432.711873728197, 4683.0, 4719.575238228507, 4736.478987311393, 4741.644376671695, 1824.1882362348626, 1896.7249748786348, 1900.657881581301, 1951.0829909942304, 1956.7554055743033, 917.6971599372324, 957.2342126298932, 967.0716112531908, 979.8334283171878, 1030.4744580264119, 19258.61482770365, 19715.50711232202, 19810.70283945742, 19862.60274794525, 19871.30450434228, 980.3186785184229, 1030.6804890483975, 1036.984445233322, 1040.0691381213771, 1057.6721216422934, 10512.369257844553, 11005.284656497302, 11022.173336999596, 11052.778944421227, 11070.28043177191, 437238.0, 442491.0, 446417.0, 448767.0, 449846.0, 93897.53051234837, 95821.0, 96726.51636741772, 96750.0, 97197.51401242948, 1019.4749703902496, 1031.4997226345217, 1073.5705717712976, 1095.2388090277182, 1099.571167244775, 17087.82912170912, 17214.311427542758, 17618.91190544039, 17644.29422823124, 17750.644987099928, 40125.398119028825, 40761.0, 40836.387454187614, 41451.37822932598, 41522.169556608096, 53242.0, 59598.404015959284, 59812.700936495035, 59836.0, 60183.39816601953, 8597.699080532151, 8721.258693011165, 8764.605592748469, 8854.734357969272, 8946.731598052069, 9843.310968232156, 13526.18842869431, 13766.724665506834, 13807.309634518033, 14067.507637232648, 10879.292845964987, 10930.890691093306, 11314.321140731583, 11371.601993930173, 11437.313761174357, 10664.200184986312, 11931.234606064989, 12039.0, 12077.0, 12175.39123043862, 10981.890181098086, 11033.33799971972, 11413.372264525531, 11522.13583981188, 11844.111691622991, 7430.517016393917, 8737.650493980424, 8750.64997400097, 8812.118788121137, 8947.463152210888, 10180.541875615467, 11680.649580512598, 11898.405079746151, 12117.454714537691, 12203.511859525875], "value": 9008.31446721377, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1289.9419526121324, 1456.3082535795495, 1482.2514630111793, 1609.5251900689295, 1740.2342969093606, 8200.343972482202, 8591.699290524833, 8598.957005214965, 8852.424592401489, 8864.246539044188, 8555.0, 8734.956325218365, 8737.30101591871, 8746.606402711894, 8747.825043499126, 1932.8936908470098, 2168.6530155175174, 2173.9782602173973, 2213.612617791888, 2264.29806759905, 2183.2031308572414, 2194.2429861697688, 2194.7037149984785, 2196.2752291743686, 2196.3301193136167, 2192.9890350548303, 2239.4177513846435, 2270.625346817773, 2271.136967952184, 2272.4318920269934, 1866.664000479913, 2099.611571859211, 2181.5636872625537, 2186.6610675345346, 2187.8359123065675, 2131.2114517628575, 2131.776163502841, 2167.924122655715, 2169.7504786949544, 2171.543975765091, 8542.273906717937, 8565.186307300797, 8598.183172598656, 8600.741977740678, 8606.87089693655, 5138.46046165151, 5272.894542109175, 5275.894482110375, 5279.287296215, 5280.3663560373, 3193.3613277344625, 3195.6325022622464, 3226.274088330107, 3233.094733474631, 3248.512723091555, 1028.912542433894, 1036.1244748187844, 1053.7616321926644, 1072.7318170457386, 1073.0664322039797, 11964.64106076819, 12261.019118470502, 12284.078694097889, 12295.69260768479, 12309.876901230962, 4550.795214215368, 4567.36056952027, 4671.346011558385, 4672.229082201467, 4673.158831410379, 10205.591776329013, 10209.0, 10221.897781022244, 10223.284370094021, 10224.948875255575, 5276.287701160371, 5283.022640811462, 5284.154535274338, 5285.735713214324, 5287.9735601321745, 4148.357004664282, 4731.432228132646, 4865.1485989952325, 4869.342638743724, 4932.630052746058, 3983.072904115137, 4027.2146931348693, 4076.8369265229057, 4092.4475195848777, 4210.873673789792, 1252.7995520716825, 1261.7224210673637, 1265.4811527273773, 1270.9110362274737, 1280.705437749323, 945.4091193004373, 990.8308196328258, 1001.1840350114634, 1004.8693669823023, 1013.5287091502339, 5789.710514474259, 5860.912086318709, 6012.939870601238, 6117.816465506042, 6222.097795819672, 432.2565187876847, 434.0494317444849, 446.4597836617664, 446.7386578851408, 446.77360645029603, 3938.6455219030427, 4002.0, 4010.258102251093, 4038.3336749436603, 4110.136871257009, 10594.364338139736, 10630.946845265878, 10873.347599144077, 10875.564977400974, 10975.0, 10723.892761072446, 10758.784824303626, 10821.729456763487, 10827.133829293794, 10837.83743243852, 7790.1041380241995, 7833.725819596287, 7889.960550197327, 7908.0, 7913.920860791433, 5868.09044598088, 5876.118582212532, 5992.880142397041, 6048.0, 6101.0, 9995.200383969119, 10088.899111008795, 10104.242181836538, 10162.339447935861, 10166.949165254126, 9937.25470589723, 9996.0, 10095.7476063099, 10300.742481438025, 10336.689899303034, 7092.858142837217, 7628.427867909818, 7739.613019349123, 7841.4118941078505, 7915.604219789103, 8553.657853685783, 8566.48601083937, 8590.269827064769, 8592.570371481526, 8621.956890215508, 7553.244675532403, 7681.078270607562, 7755.495892766952, 7823.139454660097, 7860.646270917708, 7402.0, 7402.0, 7543.207963164008, 7614.961925190339, 7740.496867703581, 7019.964900175466, 7047.577145371294, 7080.327368899946, 7084.752033678797, 7088.858222835412, 4946.0, 5119.692818430906, 5214.921776173436, 5224.686518808731, 5309.522143006993, 5204.869878253074, 5251.737413129252, 5304.177852432879, 5308.25684404176, 5401.2168235606405], "value": 4476.837603142613, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.13438498701225, 302.9727324540791, 307.8414616472517, 314.1141979617479, 321.48401815086777, 5229.398619158798, 5281.841544753654, 5308.867278318044, 5331.040412725708, 5345.1714984177415, 5184.274201611777, 5200.453952335007, 5225.850312931149, 5226.346706661668, 5241.5806735461165, 3880.553736320324, 3939.231849789292, 4044.4539987101807, 4061.2283666103494, 4073.7352072115364, 4022.275990321741, 4032.9596704033024, 4039.4950631171105, 4045.8381664733374, 4048.210598933209, 3890.9416358754643, 3986.5216174059155, 3986.66113380363, 3997.800109994503, 4019.859304924328, 3997.2012594332523, 4034.616711412411, 4065.857694980691, 4081.0, 4085.101277718897, 3591.6228795976567, 3594.802285874276, 3595.8381872815785, 3596.946045809315, 3610.4042832932537, 5094.006668699605, 5168.689878607295, 5186.273921650972, 5203.713795741232, 5205.661631993946, 4516.322551617283, 4639.234526303156, 4666.2067448533835, 4667.463241727177, 4695.248760198352, 5420.214068960018, 5439.836804895859, 5446.420538044002, 5503.367112782002, 5503.7798488060425, 3949.8150554833437, 3970.205958808221, 3971.848164032427, 3977.7016723745546, 3982.9402558961638, 5281.683099014033, 5610.579206559524, 5635.436456354373, 5637.267155269829, 5665.433456654343, 3902.5316961964177, 3911.5697273299916, 3916.3342231820657, 3920.1179734559496, 3934.7245692801803, 3966.087799806061, 3973.5430425501436, 3978.960210397859, 3979.462772525672, 4011.538673052578, 4469.396631454777, 4576.473705523841, 4592.471865735416, 4617.307403889444, 4638.141943740419, 5438.619296649196, 5475.315585551806, 5489.4236105209175, 5500.257465242141, 5509.256250406143, 1308.8233088533116, 1326.8390158611214, 1336.659151916255, 1336.6658335416146, 1340.1356125299321, 877.394597727566, 879.2614204068485, 897.699270744295, 924.4776701163821, 927.5084205371164, 5155.690658560424, 5208.661437006583, 5210.791568337224, 5211.5830733541225, 5216.478352164753, 5558.138488534284, 5575.163725441216, 5577.749001294951, 5587.7148255901375, 5610.943890561042, 5048.899022019539, 5248.475152484797, 5260.710660913686, 5269.420363759983, 5284.313039304866, 2970.8960186393374, 2972.2272209225757, 2976.9702302977125, 2978.927586069057, 2983.34366439383, 5512.531434828004, 5772.3938986406665, 5782.566307526952, 5797.275340582427, 5818.912716309259, 5640.379558248589, 5667.4615911488345, 5695.45893140151, 5697.914531282034, 5709.286339207599, 5694.145878118233, 5718.656880587178, 5756.827295181151, 5792.3917988612275, 5805.274340707411, 5340.786368545215, 5565.526930210977, 5612.635178713371, 5703.686297253691, 5736.368999410145, 5650.689212093374, 5667.659940403589, 5675.460831221028, 5681.659100453986, 5686.658800471985, 5702.6293290935955, 5931.673757943182, 5947.672877991579, 5962.37395073511, 5965.6718880461995, 3995.880123596297, 3996.960030399659, 4014.437978682928, 4014.9397759033054, 4036.57615950321, 5692.345380281321, 5706.288113565831, 5721.771129154954, 5739.512141467855, 5766.4233576642, 5408.188771684278, 5473.917891231715, 5573.331200255833, 5583.944160558505, 5603.691796951207, 5475.75359108849, 5484.533814625802, 5499.395066542757, 5499.945000549943, 5512.3385193777, 5205.0, 5255.132903071103, 5385.676859388449, 5404.108322126805, 5422.755975981011, 5469.3318537846335, 5498.972505137609, 5514.80698175562, 5550.916736249041, 5554.389017208185, 5305.867353316198, 5389.272448219597, 5451.127819548853, 5457.99027179973, 5486.149646804752], "value": 4159.287392519335, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.3286475037216, 781.8709912864377, 782.432736266207, 835.6615570693871, 883.1609970528, 15857.207139643015, 16491.83508164918, 16496.257668404905, 16517.256723447445, 16536.0, 15057.54827355181, 15251.31369088391, 15269.312880920357, 15369.0, 15395.615109622266, 665.0888283052225, 803.2289002557552, 803.9397045221602, 806.8547661420941, 809.2069771623812, 769.0732667136116, 812.2324403438753, 814.2468216899374, 814.6863457568819, 819.1521774962914, 861.5261606116642, 862.1593945902727, 862.9170391159117, 863.3352318714617, 864.0409145848104, 685.0512040823446, 804.3002587748638, 850.7575341027808, 851.2381418630322, 852.1733918099403, 619.3527763487167, 625.1154616218091, 626.9937300626981, 627.3788948940517, 627.7959663109508, 15221.467248646244, 15261.923690381476, 15276.618084547865, 15279.083255004623, 15316.0, 13136.60590182296, 13616.795748063787, 14112.294385280695, 14156.575302740934, 14188.716225675533, 13436.328183590782, 13553.728925421436, 13590.38843252056, 13885.37515811791, 14259.001869869113, 4521.434820647419, 4628.768561571942, 4661.254199328125, 4729.834455794065, 4770.856874293777, 81732.18267817305, 82190.0, 83194.58402707947, 83492.58253708754, 83918.58040709757, 11693.824592631117, 11857.822132668018, 11919.76160476803, 11921.582744603897, 12095.455704493319, 22637.547249055257, 22719.432014199778, 22729.431764205696, 22763.699263606683, 22772.544549108927, 8614.44006139599, 8751.781205469913, 8841.911580884109, 8854.468731875979, 9003.0, 4556.635469162459, 4833.081714474239, 4889.339939108175, 5020.397552293748, 5055.165897626924, 3459.6367381425093, 3583.623719509466, 3594.946075808865, 3602.3695853226104, 3607.9278414431565, 639.3734140542294, 647.3946859686208, 649.5355820588302, 650.0444346810182, 650.0996120373317, 612.4671535763825, 624.3257282135284, 633.3792882974618, 642.8392901774556, 712.682856129028, 9049.683261085831, 9425.57584908667, 9624.903750962541, 9704.466254355937, 9708.5145742714, 662.3696795081175, 666.513445185008, 673.1383828699272, 675.722953589036, 676.3608390071336, 4444.955550444454, 4534.771050212467, 4558.27067669178, 4581.381513495702, 4592.609628181575, 79920.20079799244, 102249.0, 109726.0, 110290.0, 112949.0, 33038.17404564857, 33041.3391732164, 55592.610184744895, 77427.0, 80453.19546804574, 81966.59016704878, 83540.58229708813, 83840.58079709562, 85613.57193213994, 86664.0, 9537.380070295409, 10047.296689231976, 10157.441340726331, 10267.0, 10275.229357798344, 50754.238686419, 50827.49172508228, 51275.2308715377, 51877.22184167316, 51913.48086519087, 65874.67062664656, 67160.6641966787, 71440.99826024257, 72571.27428725857, 73742.0, 12250.387480626112, 12292.201006934522, 12294.87705122973, 12300.876991229974, 12507.74984500323, 15103.32035058403, 15168.021369587457, 15252.847471525587, 15405.075695458308, 15549.455769048029, 14015.439382424996, 14164.291785410895, 14166.43334266659, 14178.0, 14419.42322307096, 13471.461141554228, 13767.0, 14011.229382384066, 14088.0, 14155.0, 13673.589792306248, 13878.444862205399, 14065.718685626434, 14191.858081419054, 14203.218822964836, 11768.411579421167, 11902.940485297519, 11948.522059117538, 11953.402329883646, 12348.691282717644, 11340.489677964346, 12114.428482198626, 12265.0, 12334.136610437543, 12338.691532711755], "value": 7556.3320166914655, "unit": "score"}], "name": "dromaeo_css", "value": 7114.313657374913, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 110.0, 111.0, 113.0, 111.0, 110.0, 112.0, 111.0, 112.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 131.0, 129.0, 184.0, 125.0, 128.0, 152.0, 135.0, 164.0, 125.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 162.0, 160.0, 162.0, 161.0, 161.0, 161.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 130.0, 75.0, 77.0, 76.0, 76.0, 97.0, 75.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 119.0, 86.0, 86.0, 86.0, 127.0, 85.0, 85.0, 124.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 53.0, 54.0, 53.0, 54.0, 55.0, 53.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 61.0, 61.0, 60.0, 60.0, 62.0, 62.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 84.0, 78.0, 79.0, 84.0, 82.0, 79.0, 80.0, 94.0, 80.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 126.0, 121.0, 120.0, 127.0, 119.0, 121.0, 123.0, 122.0, 125.0], "value": 123.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 157.0, 158.0, 158.0, 157.0, 158.0, 158.0, 155.0, 155.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 71.0, 63.0, 63.0, 63.0, 62.0, 61.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1493.1999999999998, "alertThreshold": 2.0}]} 02:48:34 INFO - Return code: 0 02:48:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:48:34 INFO - # TBPL SUCCESS # 02:48:34 INFO - Running post-action listener: _resource_record_post_action 02:48:34 INFO - ##### 02:48:34 INFO - ##### Finished run-tests step (success) 02:48:34 INFO - ##### 02:48:34 INFO - Running post-run listener: _resource_record_post_run 02:48:34 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 550957056; Read time: 0; Write time: 393360 02:48:34 INFO - TinderboxPrint: CPU usage
13.1% 02:48:34 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:48:34 INFO - TinderboxPrint: I/O write bytes / time
550,957,056 / 393,360 02:48:34 INFO - TinderboxPrint: CPU idle
8,271.7 (86.9%) 02:48:34 INFO - TinderboxPrint: CPU user
1,205.8 (12.7%) 02:48:34 INFO - TinderboxPrint: Swap in / out
0 / 0 02:48:34 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256462848; Read time: 0; Write time: 226108 02:48:34 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 294494208; Read time: 0; Write time: 167252 02:48:35 INFO - Running post-run listener: _upload_blobber_files 02:48:35 INFO - Blob upload gear active. 02:48:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:48:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:48:35 INFO - (blobuploader) - INFO - Open directory for files ... 02:48:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:48:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:48:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:39 INFO - (blobuploader) - INFO - Done attempting. 02:48:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:48:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:48:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:41 INFO - (blobuploader) - INFO - Done attempting. 02:48:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:48:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:48:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:42 INFO - (blobuploader) - INFO - Done attempting. 02:48:42 INFO - (blobuploader) - INFO - Iteration through files over. 02:48:42 INFO - Return code: 0 02:48:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:48:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:48:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2386d58ca7eb2cace547a6566a4cac77fd0c24e9cd09b497dd1f2cc09a4f60b8a04a4d9159f9ee95ab9c8e25262aee09008259f45215a8074a51da0e30a43d83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e493baad172c8f41dd5781f3ad127881787bf6ce7482ed01ec9d8423b5e1c639810d40e33396069ef622ea732f6b29134b47d938c0d3f2903ad6a64f0508621a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d409f485edb612d7965fbc551409052424c84409ce61be26ffa1c8d5517dcd0643b2bf929f7a6b52cfef46e755ba50d3ccddc04950c824cc7741e8878aa4ba1"} 02:48:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:48:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:48:42 INFO - Contents: 02:48:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2386d58ca7eb2cace547a6566a4cac77fd0c24e9cd09b497dd1f2cc09a4f60b8a04a4d9159f9ee95ab9c8e25262aee09008259f45215a8074a51da0e30a43d83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e493baad172c8f41dd5781f3ad127881787bf6ce7482ed01ec9d8423b5e1c639810d40e33396069ef622ea732f6b29134b47d938c0d3f2903ad6a64f0508621a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d409f485edb612d7965fbc551409052424c84409ce61be26ffa1c8d5517dcd0643b2bf929f7a6b52cfef46e755ba50d3ccddc04950c824cc7741e8878aa4ba1"} 02:48:42 INFO - Running post-run listener: copy_logs_to_upload_dir 02:48:42 INFO - Copying logs to upload dir... 02:48:42 INFO - mkdir: /builds/slave/test/build/upload/logs 02:48:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.334565 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-29 02:48:41.735326) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 02:48:41.739065) ========= 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-1467192444.558219-13252116 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/2386d58ca7eb2cace547a6566a4cac77fd0c24e9cd09b497dd1f2cc09a4f60b8a04a4d9159f9ee95ab9c8e25262aee09008259f45215a8074a51da0e30a43d83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e493baad172c8f41dd5781f3ad127881787bf6ce7482ed01ec9d8423b5e1c639810d40e33396069ef622ea732f6b29134b47d938c0d3f2903ad6a64f0508621a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d409f485edb612d7965fbc551409052424c84409ce61be26ffa1c8d5517dcd0643b2bf929f7a6b52cfef46e755ba50d3ccddc04950c824cc7741e8878aa4ba1"} build_url:https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011451 build_url: 'https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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/2386d58ca7eb2cace547a6566a4cac77fd0c24e9cd09b497dd1f2cc09a4f60b8a04a4d9159f9ee95ab9c8e25262aee09008259f45215a8074a51da0e30a43d83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e493baad172c8f41dd5781f3ad127881787bf6ce7482ed01ec9d8423b5e1c639810d40e33396069ef622ea732f6b29134b47d938c0d3f2903ad6a64f0508621a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d409f485edb612d7965fbc551409052424c84409ce61be26ffa1c8d5517dcd0643b2bf929f7a6b52cfef46e755ba50d3ccddc04950c824cc7741e8878aa4ba1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 02:48:41.766116) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:48:41.766473) ========= 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-1467192444.558219-13252116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004648 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:48:41.851258) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 02:48:41.851583) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 02:48:41.851909) ========= ========= Total master_lag: 0.18 =========