builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1468046385.26 results: success (0) buildid: 20160708203025 builduid: f8eaf2e6efad48bcaf0947038d75a7ca revision: 57d42a4e2ff190b3699fd210891bd5026cc40c22 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 23:39:45.265361) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 23:39:45.265975) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 23:39:45.266269) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 23:39:45.284737) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 23:39:45.285055) ========= 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=af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 23:39:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-07-08 23:39:45 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120231 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 23:39:45.428410) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 23:39:45.428715) ========= 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=af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018937 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 23:39:45.481627) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 23:39:45.481944) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 57d42a4e2ff190b3699fd210891bd5026cc40c22 --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 57d42a4e2ff190b3699fd210891bd5026cc40c22 --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=af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 23:39:45,546 truncating revision to first 12 chars 2016-07-08 23:39:45,546 Setting DEBUG logging. 2016-07-08 23:39:45,546 attempt 1/10 2016-07-08 23:39:45,546 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/57d42a4e2ff1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 23:39:46,515 unpacking tar archive at: fx-team-57d42a4e2ff1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.293897 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 23:39:46.790944) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 23:39:46.791263) ========= script_repo_revision: 57d42a4e2ff190b3699fd210891bd5026cc40c22 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 23:39:46.791696) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 23:39:46.791981) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 23:39:46.802268) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-08 23:39:46.802653) ========= /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=af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:39:46 INFO - MultiFileLogger online at 20160708 23:39:46 in /builds/slave/test 23:39:46 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 23:39:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:39:46 INFO - {'append_to_log': False, 23:39:46 INFO - 'base_work_dir': '/builds/slave/test', 23:39:46 INFO - 'blob_upload_branch': 'Fx-Team', 23:39:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:39:46 INFO - 'branch': 'Fx-Team', 23:39:46 INFO - 'buildbot_json_path': 'buildprops.json', 23:39:46 INFO - 'config_files': ('talos/linux_config.py',), 23:39:46 INFO - 'default_actions': ('clobber', 23:39:46 INFO - 'read-buildbot-config', 23:39:46 INFO - 'download-and-extract', 23:39:46 INFO - 'populate-webroot', 23:39:46 INFO - 'create-virtualenv', 23:39:46 INFO - 'install', 23:39:46 INFO - 'run-tests'), 23:39:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:39:46 INFO - 'download_minidump_stackwalk': True, 23:39:46 INFO - 'download_symbols': 'ondemand', 23:39:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:39:46 INFO - 'tooltool.py': '/tools/tooltool.py', 23:39:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:39:46 INFO - '/tools/misc-python/virtualenv.py')}, 23:39:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:39:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:39:46 INFO - 'installer_path': 'installer.exe', 23:39:46 INFO - 'log_level': 'info', 23:39:46 INFO - 'log_name': 'talos', 23:39:46 INFO - 'log_to_console': True, 23:39:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:39:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:39:46 INFO - 'opt_config_files': (), 23:39:46 INFO - 'pip_index': False, 23:39:46 INFO - 'sps_profile': False, 23:39:46 INFO - 'sps_profile_interval': 0, 23:39:46 INFO - 'suite': 'dromaeojs', 23:39:46 INFO - 'system_bits': '32', 23:39:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:39:46 INFO - 'title': 'talos-linux64-ix-020', 23:39:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:39:46 INFO - 'use_talos_json': True, 23:39:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:39:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:39:46 INFO - 'work_dir': 'build'} 23:39:46 INFO - ##### 23:39:46 INFO - ##### Running clobber step. 23:39:46 INFO - ##### 23:39:46 INFO - Running pre-action listener: _resource_record_pre_action 23:39:46 INFO - Running main action method: clobber 23:39:46 INFO - rmtree: /builds/slave/test/build 23:39:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:39:47 INFO - Running post-action listener: _resource_record_post_action 23:39:47 INFO - ##### 23:39:47 INFO - ##### Finished clobber step (success) 23:39:47 INFO - ##### 23:39:47 INFO - ##### 23:39:47 INFO - ##### Running read-buildbot-config step. 23:39:47 INFO - ##### 23:39:47 INFO - Running pre-action listener: _resource_record_pre_action 23:39:47 INFO - Running main action method: read_buildbot_config 23:39:47 INFO - Using buildbot properties: 23:39:47 INFO - { 23:39:47 INFO - "project": "", 23:39:47 INFO - "product": "firefox", 23:39:47 INFO - "script_repo_revision": "production", 23:39:47 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:39:47 INFO - "repository": "", 23:39:47 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:39:47 INFO - "buildid": "20160708203025", 23:39:47 INFO - "pgo_build": "True", 23:39:47 INFO - "basedir": "/builds/slave/test", 23:39:47 INFO - "buildnumber": 266, 23:39:47 INFO - "slavename": "talos-linux64-ix-020", 23:39:47 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:39:47 INFO - "platform": "ubuntu64_hw", 23:39:47 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:39:47 INFO - "branch": "fx-team", 23:39:47 INFO - "repo_path": "integration/fx-team", 23:39:47 INFO - "revision": "57d42a4e2ff190b3699fd210891bd5026cc40c22", 23:39:47 INFO - "stage_platform": "linux64-pgo", 23:39:47 INFO - "builduid": "f8eaf2e6efad48bcaf0947038d75a7ca", 23:39:47 INFO - "slavebuilddir": "test" 23:39:47 INFO - } 23:39:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:39:47 INFO - Running post-action listener: _resource_record_post_action 23:39:47 INFO - ##### 23:39:47 INFO - ##### Finished read-buildbot-config step (success) 23:39:47 INFO - ##### 23:39:47 INFO - ##### 23:39:47 INFO - ##### Running download-and-extract step. 23:39:47 INFO - ##### 23:39:47 INFO - Running pre-action listener: _resource_record_pre_action 23:39:47 INFO - Running main action method: download_and_extract 23:39:47 INFO - mkdir: /builds/slave/test/build/tests 23:39:47 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')]} 23:39:47 INFO - https://queue.taskcluster.net/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:39:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:39:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:39:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/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 23:39:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/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 23:39:48 INFO - Downloaded 1361 bytes. 23:39:48 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:39:48 INFO - Using the following test package requirements: 23:39:48 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:39:48 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:39:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:39:48 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:39:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:39:48 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:39:48 INFO - u'jsshell-linux-x86_64.zip'], 23:39:48 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:39:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:39:48 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:39:48 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:39:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:39:48 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:39:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:39:48 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:39:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:39:48 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:39:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:39:48 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:39:48 INFO - https://queue.taskcluster.net/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:39:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:39:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:39:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/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 23:39:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/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 23:39:49 INFO - Downloaded 24305278 bytes. 23:39:49 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'] 23:39:49 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 23:39:51 INFO - Return code: 0 23:39:51 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 23:39:51 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')]} 23:39:51 INFO - https://queue.taskcluster.net/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:39:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:39:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:39:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/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 23:39:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/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 23:39:53 INFO - Downloaded 24305278 bytes. 23:39:53 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'] 23:39:53 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 23:39:55 INFO - Return code: 0 23:39:55 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')]} 23:39:55 INFO - https://queue.taskcluster.net/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:39:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:39:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:39:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/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 23:39:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/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 23:39:56 INFO - Downloaded 14403333 bytes. 23:39:56 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'] 23:39:56 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 23:39:56 INFO - Return code: 0 23:39:56 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')]} 23:39:56 INFO - https://queue.taskcluster.net/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:39:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:39:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:39:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/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 23:39:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/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 23:39:58 INFO - Downloaded 60434394 bytes. 23:39:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:39:58 INFO - mkdir: /builds/slave/test/properties 23:39:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:39:58 INFO - Writing to file /builds/slave/test/properties/build_url 23:39:58 INFO - Contents: 23:39:58 INFO - build_url:https://queue.taskcluster.net/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:39:58 INFO - Running post-action listener: _resource_record_post_action 23:39:58 INFO - Running post-action listener: set_extra_try_arguments 23:39:58 INFO - ##### 23:39:58 INFO - ##### Finished download-and-extract step (success) 23:39:58 INFO - ##### 23:39:58 INFO - ##### 23:39:58 INFO - ##### Running populate-webroot step. 23:39:58 INFO - ##### 23:39:58 INFO - Running pre-action listener: _resource_record_pre_action 23:39:58 INFO - Running main action method: populate_webroot 23:39:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:39:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:39:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:39:58 INFO - '--tppagecycles', 23:39:58 INFO - '7'], 23:39:58 INFO - 'tests': ['tsvgm']}}, 23:39:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:39:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:39:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:39:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:39:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:39:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:39:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:39:58 INFO - 'talos_options': ['--disable-e10s'], 23:39:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:39:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:39:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:39:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:39:58 INFO - 'talos_options': ['--disable-e10s'], 23:39:58 INFO - 'tests': ['damp', 'tps']}, 23:39:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:39:58 INFO - 'tests': ['damp', 'tps']}, 23:39:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:39:58 INFO - 'tests': ['dromaeo_dom']}, 23:39:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:39:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:39:58 INFO - 'tests': ['basic_compositor_video']}, 23:39:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:39:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:39:58 INFO - 'tests': ['a11yr', 23:39:58 INFO - 'ts_paint', 23:39:58 INFO - 'tpaint', 23:39:58 INFO - 'sessionrestore', 23:39:58 INFO - 'sessionrestore_no_auto_restore', 23:39:58 INFO - 'tabpaint']}, 23:39:58 INFO - 'other-e10s': {'tests': ['a11yr', 23:39:58 INFO - 'ts_paint', 23:39:58 INFO - 'tpaint', 23:39:58 INFO - 'sessionrestore', 23:39:58 INFO - 'sessionrestore_no_auto_restore', 23:39:58 INFO - 'tabpaint']}, 23:39:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:39:58 INFO - 'ts_paint', 23:39:58 INFO - 'tpaint', 23:39:58 INFO - 'sessionrestore', 23:39:58 INFO - 'sessionrestore_no_auto_restore', 23:39:58 INFO - 'tabpaint']}, 23:39:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:39:58 INFO - 'ts_paint', 23:39:58 INFO - 'tpaint', 23:39:58 INFO - 'sessionrestore', 23:39:58 INFO - 'sessionrestore_no_auto_restore', 23:39:58 INFO - 'tabpaint']}, 23:39:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:39:58 INFO - 'tests': ['a11yr', 23:39:58 INFO - 'ts_paint', 23:39:58 INFO - 'tpaint', 23:39:58 INFO - 'sessionrestore', 23:39:58 INFO - 'sessionrestore_no_auto_restore', 23:39:58 INFO - 'tabpaint']}, 23:39:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:39:58 INFO - 'tests': ['a11yr', 23:39:58 INFO - 'ts_paint', 23:39:58 INFO - 'tpaint', 23:39:58 INFO - 'sessionrestore', 23:39:58 INFO - 'sessionrestore_no_auto_restore', 23:39:58 INFO - 'tabpaint']}, 23:39:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:39:58 INFO - 'tests': ['tsvgx', 23:39:58 INFO - 'tsvgr_opacity', 23:39:58 INFO - 'tart', 23:39:58 INFO - 'tscrollx', 23:39:58 INFO - 'cart']}, 23:39:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:39:58 INFO - 'tsvgr_opacity', 23:39:58 INFO - 'tart', 23:39:58 INFO - 'tscrollx', 23:39:58 INFO - 'cart']}, 23:39:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:39:58 INFO - 'talos_options': ['--disable-e10s'], 23:39:58 INFO - 'tests': ['tp5o']}, 23:39:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:39:58 INFO - 'tests': ['tp5o']}, 23:39:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:39:58 INFO - 'talos_options': ['--disable-e10s', 23:39:58 INFO - '--xperf_path', 23:39:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:39:58 INFO - 'tests': ['tp5n']}, 23:39:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:39:58 INFO - 'talos_options': ['--xperf_path', 23:39:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:39:58 INFO - 'tests': ['tp5n']}}, 23:39:58 INFO - 'talos.zip': {'path': '', 23:39:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:39:58 INFO - Running post-action listener: _resource_record_post_action 23:39:58 INFO - ##### 23:39:58 INFO - ##### Finished populate-webroot step (success) 23:39:58 INFO - ##### 23:39:58 INFO - ##### 23:39:58 INFO - ##### Running create-virtualenv step. 23:39:58 INFO - ##### 23:39:58 INFO - Running pre-action listener: _resource_record_pre_action 23:39:58 INFO - Running main action method: create_virtualenv 23:39:58 INFO - Creating virtualenv /builds/slave/test/build/venv 23:39:58 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 23:39:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:39:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:39:58 INFO - Using real prefix '/usr' 23:39:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:39:59 INFO - Installing distribute.............................................................................................................................................................................................done. 23:40:01 INFO - Installing pip.................done. 23:40:01 INFO - Return code: 0 23:40:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:40:01 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')]} 23:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:01 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')]} 23:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:01 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 0x20a5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2366180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23643b0>, '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 0x23652b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2365740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739', '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 23:40:01 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 23:40:01 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 23:40:01 INFO - Using env: {'DISPLAY': ':0', 23:40:01 INFO - 'HOME': '/home/cltbld', 23:40:01 INFO - 'LANG': 'en_US.UTF-8', 23:40:01 INFO - 'LANGUAGE': 'en_US:en', 23:40:01 INFO - 'LOGNAME': 'cltbld', 23:40:01 INFO - 'MAIL': '/var/mail/cltbld', 23:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:01 INFO - 'MOZ_NO_REMOTE': '1', 23:40:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:40:01 INFO - 'NO_EM_RESTART': '1', 23:40:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:01 INFO - 'PWD': '/builds/slave/test', 23:40:01 INFO - 'SHELL': '/bin/bash', 23:40:01 INFO - 'SHLVL': '1', 23:40:01 INFO - 'TERM': 'linux', 23:40:01 INFO - 'TMOUT': '86400', 23:40:01 INFO - 'USER': 'cltbld', 23:40:01 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739', 23:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:01 INFO - '_': '/tools/buildbot/bin/python'} 23:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:01 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 23:40:01 INFO - Cleaning up... 23:40:01 INFO - Return code: 0 23:40:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:40:01 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')]} 23:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:01 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')]} 23:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:01 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 0x20a5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2366180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23643b0>, '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 0x23652b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2365740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739', '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 23:40:01 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 23:40:01 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 23:40:01 INFO - Using env: {'DISPLAY': ':0', 23:40:01 INFO - 'HOME': '/home/cltbld', 23:40:01 INFO - 'LANG': 'en_US.UTF-8', 23:40:01 INFO - 'LANGUAGE': 'en_US:en', 23:40:01 INFO - 'LOGNAME': 'cltbld', 23:40:01 INFO - 'MAIL': '/var/mail/cltbld', 23:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:01 INFO - 'MOZ_NO_REMOTE': '1', 23:40:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:40:01 INFO - 'NO_EM_RESTART': '1', 23:40:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:01 INFO - 'PWD': '/builds/slave/test', 23:40:01 INFO - 'SHELL': '/bin/bash', 23:40:01 INFO - 'SHLVL': '1', 23:40:01 INFO - 'TERM': 'linux', 23:40:01 INFO - 'TMOUT': '86400', 23:40:01 INFO - 'USER': 'cltbld', 23:40:01 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739', 23:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:01 INFO - '_': '/tools/buildbot/bin/python'} 23:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:01 INFO - Downloading/unpacking psutil>=3.1.1 23:40:01 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 23:40:01 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 23:40:01 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 23:40:01 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 23:40:01 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 23:40:01 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 23:40:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:40:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:40:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:40:03 INFO - Installing collected packages: psutil 23:40:03 INFO - Running setup.py install for psutil 23:40:03 INFO - building 'psutil._psutil_linux' extension 23:40:03 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 23:40:04 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 23:40:04 INFO - building 'psutil._psutil_posix' extension 23:40:04 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 23:40:04 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 23:40:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:40:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:40:04 INFO - Successfully installed psutil 23:40:04 INFO - Cleaning up... 23:40:04 INFO - Return code: 0 23:40:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:04 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 0x20a5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2366180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23643b0>, '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 0x23652b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2365740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739', '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 23:40:04 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 23:40:04 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 23:40:04 INFO - Using env: {'DISPLAY': ':0', 23:40:04 INFO - 'HOME': '/home/cltbld', 23:40:04 INFO - 'LANG': 'en_US.UTF-8', 23:40:04 INFO - 'LANGUAGE': 'en_US:en', 23:40:04 INFO - 'LOGNAME': 'cltbld', 23:40:04 INFO - 'MAIL': '/var/mail/cltbld', 23:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:04 INFO - 'MOZ_NO_REMOTE': '1', 23:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:40:04 INFO - 'NO_EM_RESTART': '1', 23:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:04 INFO - 'PWD': '/builds/slave/test', 23:40:04 INFO - 'SHELL': '/bin/bash', 23:40:04 INFO - 'SHLVL': '1', 23:40:04 INFO - 'TERM': 'linux', 23:40:04 INFO - 'TMOUT': '86400', 23:40:04 INFO - 'USER': 'cltbld', 23:40:04 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739', 23:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:04 INFO - '_': '/tools/buildbot/bin/python'} 23:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:40:04 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 23:40:04 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 23:40:04 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 23:40:04 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 23:40:04 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 23:40:04 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 23:40:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:40:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:40:06 INFO - Installing collected packages: mozsystemmonitor 23:40:06 INFO - Running setup.py install for mozsystemmonitor 23:40:06 INFO - Successfully installed mozsystemmonitor 23:40:06 INFO - Cleaning up... 23:40:06 INFO - Return code: 0 23:40:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:40:06 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')]} 23:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:06 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')]} 23:40:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:06 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 0x20a5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2366180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23643b0>, '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 0x23652b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2365740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739', '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 23:40:06 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 23:40:06 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 23:40:06 INFO - Using env: {'DISPLAY': ':0', 23:40:06 INFO - 'HOME': '/home/cltbld', 23:40:06 INFO - 'LANG': 'en_US.UTF-8', 23:40:06 INFO - 'LANGUAGE': 'en_US:en', 23:40:06 INFO - 'LOGNAME': 'cltbld', 23:40:06 INFO - 'MAIL': '/var/mail/cltbld', 23:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:06 INFO - 'MOZ_NO_REMOTE': '1', 23:40:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:40:06 INFO - 'NO_EM_RESTART': '1', 23:40:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:06 INFO - 'PWD': '/builds/slave/test', 23:40:06 INFO - 'SHELL': '/bin/bash', 23:40:06 INFO - 'SHLVL': '1', 23:40:06 INFO - 'TERM': 'linux', 23:40:06 INFO - 'TMOUT': '86400', 23:40:06 INFO - 'USER': 'cltbld', 23:40:06 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739', 23:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:06 INFO - '_': '/tools/buildbot/bin/python'} 23:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:06 INFO - Downloading/unpacking jsonschema==2.5.1 23:40:06 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 23:40:06 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 23:40:06 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 23:40:06 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 23:40:06 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 23:40:06 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 23:40:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:40:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:40:08 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 23:40:08 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 23:40:08 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 23:40:08 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 23:40:08 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 23:40:08 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 23:40:08 INFO - Downloading functools32-3.2.3-2.tar.gz 23:40:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:40:09 INFO - warning: no files found matching '*.txt' 23:40:09 INFO - no previously-included directories found matching 'build' 23:40:09 INFO - no previously-included directories found matching 'dist' 23:40:09 INFO - no previously-included directories found matching '.git*' 23:40:09 INFO - Installing collected packages: jsonschema, functools32 23:40:09 INFO - Running setup.py install for functools32 23:40:09 INFO - warning: no files found matching '*.txt' 23:40:09 INFO - no previously-included directories found matching 'build' 23:40:09 INFO - no previously-included directories found matching 'dist' 23:40:09 INFO - no previously-included directories found matching '.git*' 23:40:09 INFO - Successfully installed jsonschema functools32 23:40:09 INFO - Cleaning up... 23:40:09 INFO - Return code: 0 23:40:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:40:09 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')]} 23:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:09 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')]} 23:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:09 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 0x20a5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2366180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23643b0>, '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 0x23652b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2365740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739', '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 23:40:09 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 23:40:09 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 23:40:09 INFO - Using env: {'DISPLAY': ':0', 23:40:09 INFO - 'HOME': '/home/cltbld', 23:40:09 INFO - 'LANG': 'en_US.UTF-8', 23:40:09 INFO - 'LANGUAGE': 'en_US:en', 23:40:09 INFO - 'LOGNAME': 'cltbld', 23:40:09 INFO - 'MAIL': '/var/mail/cltbld', 23:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:09 INFO - 'MOZ_NO_REMOTE': '1', 23:40:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:40:09 INFO - 'NO_EM_RESTART': '1', 23:40:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:09 INFO - 'PWD': '/builds/slave/test', 23:40:09 INFO - 'SHELL': '/bin/bash', 23:40:09 INFO - 'SHLVL': '1', 23:40:09 INFO - 'TERM': 'linux', 23:40:09 INFO - 'TMOUT': '86400', 23:40:09 INFO - 'USER': 'cltbld', 23:40:09 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739', 23:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:09 INFO - '_': '/tools/buildbot/bin/python'} 23:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:09 INFO - Downloading/unpacking blobuploader==1.2.4 23:40:09 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 23:40:09 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 23:40:09 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 23:40:09 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 23:40:09 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 23:40:09 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 23:40:11 INFO - Downloading blobuploader-1.2.4.tar.gz 23:40:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:40:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:40:11 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 23:40:11 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 23:40:11 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 23:40:11 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 23:40:11 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 23:40:11 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 23:40:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:40:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:40:11 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 23:40:11 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 23:40:11 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 23:40:11 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 23:40:11 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 23:40:11 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 23:40:12 INFO - Downloading docopt-0.6.1.tar.gz 23:40:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:40:12 INFO - Installing collected packages: blobuploader, requests, docopt 23:40:12 INFO - Running setup.py install for blobuploader 23:40:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:40:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:40:12 INFO - Running setup.py install for requests 23:40:12 INFO - Running setup.py install for docopt 23:40:12 INFO - Successfully installed blobuploader requests docopt 23:40:12 INFO - Cleaning up... 23:40:12 INFO - Return code: 0 23:40:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:40:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:12 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 0x20a5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2366180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23643b0>, '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 0x23652b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2365740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739', '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 23:40:12 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 23:40:12 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 23:40:12 INFO - Using env: {'DISPLAY': ':0', 23:40:12 INFO - 'HOME': '/home/cltbld', 23:40:12 INFO - 'LANG': 'en_US.UTF-8', 23:40:12 INFO - 'LANGUAGE': 'en_US:en', 23:40:12 INFO - 'LOGNAME': 'cltbld', 23:40:12 INFO - 'MAIL': '/var/mail/cltbld', 23:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:12 INFO - 'MOZ_NO_REMOTE': '1', 23:40:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:40:12 INFO - 'NO_EM_RESTART': '1', 23:40:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:12 INFO - 'PWD': '/builds/slave/test', 23:40:12 INFO - 'SHELL': '/bin/bash', 23:40:12 INFO - 'SHLVL': '1', 23:40:12 INFO - 'TERM': 'linux', 23:40:12 INFO - 'TMOUT': '86400', 23:40:12 INFO - 'USER': 'cltbld', 23:40:12 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739', 23:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:12 INFO - '_': '/tools/buildbot/bin/python'} 23:40:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:40:12 INFO - Running setup.py (path:/tmp/pip-s4SGpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:40:12 INFO - Running setup.py (path:/tmp/pip-hulE8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:40:13 INFO - Running setup.py (path:/tmp/pip-uonl6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:40:13 INFO - Running setup.py (path:/tmp/pip-LYnH55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:40:13 INFO - Running setup.py (path:/tmp/pip-Ou1V0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:40:13 INFO - Running setup.py (path:/tmp/pip-Q_rX3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:40:13 INFO - Running setup.py (path:/tmp/pip-f85ZrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:40:13 INFO - Running setup.py (path:/tmp/pip-46Yc_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:40:13 INFO - Running setup.py (path:/tmp/pip-_RBQgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:40:13 INFO - Running setup.py (path:/tmp/pip-xN9ohB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:40:13 INFO - Running setup.py (path:/tmp/pip-lYbYhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:40:13 INFO - Running setup.py (path:/tmp/pip-V74Pq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:40:13 INFO - Running setup.py (path:/tmp/pip-uMlCTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:40:13 INFO - Running setup.py (path:/tmp/pip-ztxn_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:40:13 INFO - Running setup.py (path:/tmp/pip-Bs7H0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:40:13 INFO - Running setup.py (path:/tmp/pip-Ai3rKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:40:14 INFO - Running setup.py (path:/tmp/pip-eHa8EB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:40:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:40:14 INFO - Running setup.py install for manifestparser 23:40:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:40:14 INFO - Running setup.py install for mozcrash 23:40:14 INFO - Running setup.py install for mozdebug 23:40:14 INFO - Running setup.py install for mozdevice 23:40:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:40:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:40:14 INFO - Running setup.py install for mozfile 23:40:14 INFO - Running setup.py install for mozhttpd 23:40:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:40:14 INFO - Running setup.py install for mozinfo 23:40:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:40:14 INFO - Running setup.py install for mozInstall 23:40:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:40:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:40:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:40:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:40:14 INFO - Running setup.py install for mozleak 23:40:15 INFO - Running setup.py install for mozlog 23:40:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:40:15 INFO - Running setup.py install for moznetwork 23:40:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:40:15 INFO - Running setup.py install for mozprocess 23:40:15 INFO - Running setup.py install for mozprofile 23:40:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:40:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:40:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:40:15 INFO - Running setup.py install for mozrunner 23:40:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:40:15 INFO - Running setup.py install for mozscreenshot 23:40:15 INFO - Running setup.py install for moztest 23:40:15 INFO - Running setup.py install for mozversion 23:40:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:40:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:40:15 INFO - Cleaning up... 23:40:15 INFO - Return code: 0 23:40:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:15 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 0x20a5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2366180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23643b0>, '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 0x23652b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2365740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739', '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 23:40:15 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 23:40:15 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 23:40:15 INFO - Using env: {'DISPLAY': ':0', 23:40:15 INFO - 'HOME': '/home/cltbld', 23:40:15 INFO - 'LANG': 'en_US.UTF-8', 23:40:15 INFO - 'LANGUAGE': 'en_US:en', 23:40:15 INFO - 'LOGNAME': 'cltbld', 23:40:15 INFO - 'MAIL': '/var/mail/cltbld', 23:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:15 INFO - 'MOZ_NO_REMOTE': '1', 23:40:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:40:15 INFO - 'NO_EM_RESTART': '1', 23:40:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:15 INFO - 'PWD': '/builds/slave/test', 23:40:15 INFO - 'SHELL': '/bin/bash', 23:40:15 INFO - 'SHLVL': '1', 23:40:15 INFO - 'TERM': 'linux', 23:40:15 INFO - 'TMOUT': '86400', 23:40:15 INFO - 'USER': 'cltbld', 23:40:15 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739', 23:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:15 INFO - '_': '/tools/buildbot/bin/python'} 23:40:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:40:16 INFO - Running setup.py (path:/tmp/pip-w9XrCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:40:16 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)) 23:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:40:16 INFO - Running setup.py (path:/tmp/pip-DurxwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:40:16 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)) 23:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:40:16 INFO - Running setup.py (path:/tmp/pip-a1KI42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:40:16 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)) 23:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:40:16 INFO - Running setup.py (path:/tmp/pip-375QsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:40:16 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)) 23:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:40:16 INFO - Running setup.py (path:/tmp/pip-Lkk7x8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:40:16 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)) 23:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:40:16 INFO - Running setup.py (path:/tmp/pip-35kbNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:40:16 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)) 23:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:40:16 INFO - Running setup.py (path:/tmp/pip-en3ZDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:40:16 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)) 23:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:40:16 INFO - Running setup.py (path:/tmp/pip-VN9Rm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:40:16 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)) 23:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:40:16 INFO - Running setup.py (path:/tmp/pip-wDpPVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:40:16 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)) 23:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:40:16 INFO - Running setup.py (path:/tmp/pip-8KVXKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:40:16 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)) 23:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:40:16 INFO - Running setup.py (path:/tmp/pip-wM6ZWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:40:16 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)) 23:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:40:16 INFO - Running setup.py (path:/tmp/pip-yUYXy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:40:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:40:17 INFO - Running setup.py (path:/tmp/pip-VIKiN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:40:17 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)) 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:40:17 INFO - Running setup.py (path:/tmp/pip-vy1qXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:40:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:40:17 INFO - Running setup.py (path:/tmp/pip-tBZ7xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:40:17 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)) 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:40:17 INFO - Running setup.py (path:/tmp/pip-qjUzuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:40:17 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)) 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:40:17 INFO - Running setup.py (path:/tmp/pip-uD9faU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:40:17 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)) 23:40:17 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)) 23:40:17 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)) 23:40:17 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)) 23:40:17 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)) 23:40:17 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)) 23:40:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:40:17 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 23:40:17 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 23:40:17 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 23:40:17 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 23:40:17 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 23:40:17 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 23:40:20 INFO - Downloading blessings-1.6.tar.gz 23:40:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:40:20 INFO - Installing collected packages: blessings 23:40:20 INFO - Running setup.py install for blessings 23:40:20 INFO - Successfully installed blessings 23:40:20 INFO - Cleaning up... 23:40:20 INFO - Return code: 0 23:40:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:40:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:40:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:40:20 INFO - Reading from file tmpfile_stdout 23:40:20 INFO - Current package versions: 23:40:20 INFO - argparse == 1.2.1 23:40:20 INFO - blessings == 1.6 23:40:20 INFO - blobuploader == 1.2.4 23:40:20 INFO - docopt == 0.6.1 23:40:20 INFO - functools32 == 3.2.3-2 23:40:20 INFO - jsonschema == 2.5.1 23:40:20 INFO - manifestparser == 1.1 23:40:20 INFO - mozInstall == 1.12 23:40:20 INFO - mozcrash == 0.17 23:40:20 INFO - mozdebug == 0.1 23:40:20 INFO - mozdevice == 0.48 23:40:20 INFO - mozfile == 1.2 23:40:20 INFO - mozhttpd == 0.7 23:40:20 INFO - mozinfo == 0.9 23:40:20 INFO - mozleak == 0.1 23:40:20 INFO - mozlog == 3.2 23:40:20 INFO - moznetwork == 0.27 23:40:20 INFO - mozprocess == 0.23 23:40:20 INFO - mozprofile == 0.28 23:40:20 INFO - mozrunner == 6.12 23:40:20 INFO - mozscreenshot == 0.1 23:40:20 INFO - mozsystemmonitor == 0.3 23:40:20 INFO - moztest == 0.7 23:40:20 INFO - mozversion == 1.4 23:40:20 INFO - psutil == 3.1.1 23:40:20 INFO - requests == 1.2.3 23:40:20 INFO - wsgiref == 0.1.2 23:40:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:40:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:20 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 0x20a5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2366180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23643b0>, '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 0x23652b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2365740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739', '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 23:40:20 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 23:40:20 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 23:40:20 INFO - Using env: {'DISPLAY': ':0', 23:40:20 INFO - 'HOME': '/home/cltbld', 23:40:20 INFO - 'LANG': 'en_US.UTF-8', 23:40:20 INFO - 'LANGUAGE': 'en_US:en', 23:40:20 INFO - 'LOGNAME': 'cltbld', 23:40:20 INFO - 'MAIL': '/var/mail/cltbld', 23:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:20 INFO - 'MOZ_NO_REMOTE': '1', 23:40:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:40:20 INFO - 'NO_EM_RESTART': '1', 23:40:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:20 INFO - 'PWD': '/builds/slave/test', 23:40:20 INFO - 'SHELL': '/bin/bash', 23:40:20 INFO - 'SHLVL': '1', 23:40:20 INFO - 'TERM': 'linux', 23:40:20 INFO - 'TMOUT': '86400', 23:40:20 INFO - 'USER': 'cltbld', 23:40:20 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739', 23:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:20 INFO - '_': '/tools/buildbot/bin/python'} 23:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:20 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)) 23:40:20 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)) 23:40:20 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)) 23:40:20 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)) 23:40:20 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)) 23:40:20 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)) 23:40:20 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)) 23:40:20 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)) 23:40:20 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)) 23:40:20 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)) 23:40:20 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)) 23:40:20 INFO - Cleaning up... 23:40:20 INFO - Return code: 0 23:40:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:40:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2366180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23643b0>, '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 0x23652b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2365740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739', '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 23:40:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:40:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:40:20 INFO - Using env: {'DISPLAY': ':0', 23:40:20 INFO - 'HOME': '/home/cltbld', 23:40:20 INFO - 'LANG': 'en_US.UTF-8', 23:40:20 INFO - 'LANGUAGE': 'en_US:en', 23:40:20 INFO - 'LOGNAME': 'cltbld', 23:40:20 INFO - 'MAIL': '/var/mail/cltbld', 23:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:20 INFO - 'MOZ_NO_REMOTE': '1', 23:40:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:40:20 INFO - 'NO_EM_RESTART': '1', 23:40:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:20 INFO - 'PWD': '/builds/slave/test', 23:40:20 INFO - 'SHELL': '/bin/bash', 23:40:20 INFO - 'SHLVL': '1', 23:40:20 INFO - 'TERM': 'linux', 23:40:20 INFO - 'TMOUT': '86400', 23:40:20 INFO - 'USER': 'cltbld', 23:40:20 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739', 23:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:20 INFO - '_': '/tools/buildbot/bin/python'} 23:40:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:40:21 INFO - Cleaning up... 23:40:21 INFO - Return code: 0 23:40:21 INFO - Running post-action listener: _resource_record_post_action 23:40:21 INFO - Running post-action listener: _start_resource_monitoring 23:40:21 INFO - Starting resource monitoring. 23:40:21 INFO - ##### 23:40:21 INFO - ##### Finished create-virtualenv step (success) 23:40:21 INFO - ##### 23:40:21 INFO - ##### 23:40:21 INFO - ##### Running install step. 23:40:21 INFO - ##### 23:40:21 INFO - Running pre-action listener: _resource_record_pre_action 23:40:21 INFO - Running main action method: install 23:40:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:40:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:40:21 INFO - Reading from file tmpfile_stdout 23:40:21 INFO - Detecting whether we're running mozinstall >=1.0... 23:40:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:40:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:40:21 INFO - Reading from file tmpfile_stdout 23:40:21 INFO - Output received: 23:40:21 INFO - Usage: mozinstall [options] installer 23:40:21 INFO - Options: 23:40:21 INFO - -h, --help show this help message and exit 23:40:21 INFO - -d DEST, --destination=DEST 23:40:21 INFO - Directory to install application into. [default: 23:40:21 INFO - "/builds/slave/test"] 23:40:21 INFO - --app=APP Application being installed. [default: firefox] 23:40:21 INFO - mkdir: /builds/slave/test/build/application 23:40:21 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'] 23:40:21 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 23:40:38 INFO - Reading from file tmpfile_stdout 23:40:38 INFO - Output received: 23:40:38 INFO - /builds/slave/test/build/application/firefox/firefox 23:40:38 INFO - Running post-action listener: _resource_record_post_action 23:40:38 INFO - ##### 23:40:38 INFO - ##### Finished install step (success) 23:40:38 INFO - ##### 23:40:38 INFO - ##### 23:40:38 INFO - ##### Running run-tests step. 23:40:38 INFO - ##### 23:40:38 INFO - Running pre-action listener: _resource_record_pre_action 23:40:38 INFO - Running main action method: run_tests 23:40:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:40:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:40:38 INFO - Python 2.7.3 23:40:38 INFO - Return code: 0 23:40:38 INFO - grabbing minidump binary from tooltool 23:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:40:38 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 0x23643b0>, '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 0x23652b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2365740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:40:38 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 23:40:38 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 23:40:38 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 23:40:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:40:38 INFO - Return code: 0 23:40:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:40:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:40:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:40:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:40:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:40:38 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/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 23:40:38 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/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 23:40:38 INFO - Using env: {'DISPLAY': ':0', 23:40:38 INFO - 'HOME': '/home/cltbld', 23:40:38 INFO - 'LANG': 'en_US.UTF-8', 23:40:38 INFO - 'LANGUAGE': 'en_US:en', 23:40:38 INFO - 'LOGNAME': 'cltbld', 23:40:38 INFO - 'MAIL': '/var/mail/cltbld', 23:40:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:40:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:40:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:38 INFO - 'MOZ_NO_REMOTE': '1', 23:40:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:40:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:40:38 INFO - 'NO_EM_RESTART': '1', 23:40:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:40:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:38 INFO - 'PWD': '/builds/slave/test', 23:40:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:40:38 INFO - 'SHELL': '/bin/bash', 23:40:38 INFO - 'SHLVL': '1', 23:40:38 INFO - 'TERM': 'linux', 23:40:38 INFO - 'TMOUT': '86400', 23:40:38 INFO - 'USER': 'cltbld', 23:40:38 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739', 23:40:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:38 INFO - '_': '/tools/buildbot/bin/python'} 23:40:38 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/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 23:40:38 INFO - mozversion application_buildid: 20160708203025 23:40:38 INFO - mozversion application_changeset: 57d42a4e2ff190b3699fd210891bd5026cc40c22 23:40:38 INFO - mozversion application_display_name: Nightly 23:40:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:40:38 INFO - mozversion application_name: Firefox 23:40:38 INFO - mozversion application_remotingname: firefox 23:40:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:40:38 INFO - mozversion application_vendor: Mozilla 23:40:38 INFO - mozversion application_version: 50.0a1 23:40:38 INFO - mozversion platform_buildid: 20160708203025 23:40:38 INFO - mozversion platform_changeset: 57d42a4e2ff190b3699fd210891bd5026cc40c22 23:40:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:40:38 INFO - mozversion platform_version: 50.0a1 23:40:38 INFO - using testdate: 1468046438 23:40:38 INFO - actual date: 1468046438 23:40:38 INFO - starting webserver on 'localhost:60370' 23:40:38 INFO - SUITE-START | Running 2 tests 23:40:38 INFO - TEST-START | dromaeo_css 23:40:38 INFO - operating with platform_type : linux_ 23:40:38 INFO - Initialising browser for dromaeo_css test... 23:40:38 INFO - TEST-INFO | started process 6727 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVtNM2k/profile http://localhost:60370/getInfo.html) 23:40:43 INFO - PROCESS | 6727 | __metrics Screen width/height:1600/1200 23:40:43 INFO - PROCESS | 6727 | colorDepth:24 23:40:43 INFO - PROCESS | 6727 | Browser inner width/height: 1024/697 23:40:43 INFO - PROCESS | 6727 | __metrics 23:40:44 INFO - PROCESS | 6727 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:40:44 INFO - PROCESS | 6727 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:40:45 INFO - TEST-INFO | 6727: exit 0 23:40:45 INFO - Browser initialized. 23:40:45 INFO - Running cycle 1/1 for dromaeo_css test... 23:40:45 INFO - TEST-INFO | started process 6813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVtNM2k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:40:57 INFO - PROCESS | 6813 | RSS: Main: 157327360 23:40:57 INFO - PROCESS | 6813 | 23:41:48 INFO - PROCESS | 6813 | 1468046508591 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] 23:43:56 INFO - PROCESS | 6813 | Cycle 1(1): loaded http://localhost:60370/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60370/tests/dromaeo/cssquery-ext.html) 23:43:57 INFO - PROCESS | 6813 | RSS: Main: 284606464 23:43:57 INFO - PROCESS | 6813 | 23:47:00 INFO - PROCESS | 6813 | Cycle 1(1): loaded http://localhost:60370/tests/dromaeo/cssquery-ext.html (next: http://localhost:60370/tests/dromaeo/cssquery-jquery.html) 23:47:00 INFO - PROCESS | 6813 | RSS: Main: 242171904 23:47:00 INFO - PROCESS | 6813 | 23:50:02 INFO - PROCESS | 6813 | Cycle 1(1): loaded http://localhost:60370/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60370/tests/dromaeo/cssquery-mootools.html) 23:50:03 INFO - PROCESS | 6813 | RSS: Main: 241963008 23:50:03 INFO - PROCESS | 6813 | 23:53:05 INFO - PROCESS | 6813 | Cycle 1(1): loaded http://localhost:60370/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60370/tests/dromaeo/cssquery-prototype.html) 23:53:06 INFO - PROCESS | 6813 | RSS: Main: 229658624 23:53:06 INFO - PROCESS | 6813 | 23:56:08 INFO - PROCESS | 6813 | Cycle 1(1): loaded http://localhost:60370/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60370/tests/dromaeo/cssquery-yui.html) 23:56:09 INFO - PROCESS | 6813 | RSS: Main: 222515200 23:56:09 INFO - PROCESS | 6813 | 23:59:12 INFO - PROCESS | 6813 | Cycle 1(1): loaded http://localhost:60370/tests/dromaeo/cssquery-yui.html (next: http://localhost:60370/tests/dromaeo/cssquery-dojo.html) 23:59:12 INFO - PROCESS | 6813 | RSS: Main: 328638464 23:59:12 INFO - PROCESS | 6813 | 23:59:12 INFO - PROCESS | 6813 | __start_tp_report 23:59:12 INFO - PROCESS | 6813 | _x_x_mozilla_page_load 23:59:12 INFO - PROCESS | 6813 | _x_x_mozilla_page_load_details 23:59:12 INFO - PROCESS | 6813 | |i|pagename|runs| 23:59:12 INFO - PROCESS | 6813 | |0;dojo.html;3008.7141721536454;3028.7728420368476;3040.6655267920532;3071.4624940635385;3074.2160749009;5222.738863056851;5341.786328546863;5348.572114230862;5421.024215641188;5475.616706830523;5334.359876814778;5421.241026256317;5436.3476382834015;5468.043092458824;5481.314835645544;4831.154547954112;4896.902061958759;4909.484504127069;4924.753762311888;5099.235114732783;5008.899822003557;5010.3737032870895;5049.949500505003;5058.747062646871;5063.443021267658;4774.188387974035;4811.158047341719;4845.5396737310075;4915.238138088602;4946.060248552763;4889.608831293488;4897.510248975074;4910.828121015783;4913.091078150554;4954.402750784878;4897.094037603055;4927.211646136601;4940.036692844897;4941.45643979162;4964.751762411901;5306.044911915854;5325.600579956519;5374.543163831079;5379.408265090837;5500.614956953015;5757.942420575782;5761.53907687384;5764.74058667361;5767.538596912237;5818.127280907897;5817.418258174149;5859.033259512175;5869.178315035899;5879.735411906432;5889.734961926681;5239.711815850127;5343.225232341328;5346.144616861284;5372.623916325859;5473.370562385297;5990.041593345044;5995;6014.51883849291;6017.488513476404;6024.57827952048;5714.828555143269;5722.7710891563875;5731.656100633975;5731.971340143273;5735.369109397963;5592.832215033555;5683.744231509592;5727.427257274239;5733.942660573424;5816.098504731774;5734.397888221677;5736.1682556029145;5739.167820666064;5741.827745167651;5753.942460575425;5693.202951586781;5717.171010203498;5757.453041961007;5758.913616295759;5763.942360576424;4227.3447615619625;4277.615014648634;4278.165757677223;4362.1493808707;4388.583084607021;3941.3496773032703;3953.802309884552;3961.3661814110183;3987.4218238355274;4006.09862780872;5475.917861232085;5490.258815059916;5490.945090549123;5491.121420572769;5495.807646732425;5636.323641163087;5830.154627578977;5874.676892770939;5886.823395298148;5941.108833674897;5588.944110558924;5609.887802244014;5615.073512870413;5615.634983726045;5662.405447428043;5070.188769796889;5076.187809950464;5076.923846142311;5081.23781432788;5087.833377179738;5811.854703632443;5978.760849565969;6056.3338032816355;6060.212172417558;6090.025595904634;5876.265466816648;5876.412358764261;5886.676232807065;5887.087501437284;5888.057910734262;6040.365761595145;6072.8785424292155;6093.695315234309;6094.8171554853425;6097.512199023979;5486.91769623448;5615.494605485526;5649.322081350264;5660.886782264414;5704.686242256716;5806.738696758572;5808.593398462236;5812.157237200498;5812.534997200299;5816.883662326645;5519.39286678457;5636.182753500638;5666;5685.687287199078;5688.890666320028;5602.831915042555;5612.354579223442;5676.517496012885;5682.176084467646;5683.744231509675;5611.579131565068;5612.382637909908;5626.887462250814;5633.887322253614;5642.520385767256;5530.115181570929;5598.992181407386;5709.058005429058;5715.657060576379;5777.566682498914;5339.385970613429;5383.0041442333295;5470.288862447856;5471;5530.917036244379 23:59:12 INFO - PROCESS | 6813 | |1;ext.html;590.3299754778328;620.875824835033;621.4220774679552;633.8922383194856;641.2977789320693;32431.837840810793;40730.796346018265;42121.15757684848;42298;46022.76988615061;45380.3192952106;45392;45758.77120614392;45766.08467830641;45859;8923.419977701446;9069.229115525155;9073.682421115262;9073.863892041625;9078.228350590207;8912.955435222815;9008.774780630503;9011.143941325596;9020.503872287021;9024.278057755397;9024;9073.36486445949;9075.13786190311;9075.41009834362;9078.137576930181;8930.553472326357;8954.37319387643;8959.820803583925;9036.8644470333;9051.864222036675;8890.199882010585;8984.685536006209;8985.775355616162;8988.191062804379;8992.730218093468;42423.57576424227;42622.934426639586;42714.57285427137;42721.786391068155;42778;3498;3699;3718.2377612589353;4100.138970816132;4121.381792731085;32248;32311.353772924645;32455.6754432455;32523.349533009445;33653.83173084143;4323;4355.433793606842;4388.363687265361;4450.5104438511735;4576.336431217454;343121;343643;345119;345307.27346363105;345977;33857.66142338594;35099.473507897404;56798.7160064197;57333.14000289999;57530;36583.26833463316;36806.263874722354;36908.63091369106;37009;37058.25883482369;14663.48677796272;14741.55775326742;14743.77884331736;14752.114873107648;14752.262386880613;12625.810612840814;12719.173253738663;12719.872801272053;12720.936395317964;12730.68173295675;8341.165883411732;8342.708005219789;8367.665293388318;8409.075001749803;8411.789705257417;3207.486802111651;3218.7746857720203;3224.3712476067412;3260.494623333387;3305.669433056675;1008.2790804574764;1029.43381140374;1070.8340207267886;1142.5544037825255;1176.6175992802373;32469.443974819285;33429.66570334265;33526.16184595356;33582.8320858399;33767;1061.6443491430302;1119.326606722938;1122.9775404491863;1142.126273400849;1200.9159358844972;15924.442644507619;16315.428959986344;16605.41881034158;16715.582110447092;16898.07060611678;566428;608290;609251;610106;612129;55728.72135639296;56159.43840561542;56478;56523;56599;1204;1383.9031267811156;1386.4107754204624;1388.271157642246;1430.5279257845095;29945.968100686514;34212.82893585516;34334.14164645904;34681.65318346885;34797.652023479444;52240;52507.73746131245;52586.2112068327;52825.735871320394;52841.471585285195;515953;523873;525251;528339;528434;37605.623943761304;38612.80693596514;43601;44920.32619510645;45018;46131.76934115308;46447.53552464432;46888;47171.52828471671;47745;39829.40255896222;40074;40161.598384015786;40373;41073.589264108174;39998.2000359997;40883.18233635251;41089.79455102705;41263.587364127176;41858.1628367437;38823.22353552857;39179.2164156721;40104.39843402409;40127.19745605013;40270.79864600658;34917.30165396729;35287.82356088306;35607.465888012215;36330.27339453249;36426.27147457089;27523.86238068797;27757;27858.86070569634;27870;28128.71871281343 23:59:12 INFO - PROCESS | 6813 | |2;jquery.html;385.6240165838307;391.084861424267;392.6525025352566;401.3718530499768;417.5824175824176;13926.582202533915;18821.247150113995;20385.99999999998;20400.183992640294;20675;14584.416623335053;19094.236230550796;19233.519162020955;20066;20293.0868110935;5643;5789.334226563936;5814.069748840187;5815.040518314473;5826.708664566776;5742.052561327376;5814.302283725959;5815.331236907747;5822.155787410823;5826.912596311059;4245.469316335458;6080.847978800522;6399;6403.7438502459845;6512.218533775954;6138.9693051534905;6407.038944158367;6421.7110230039525;6448.161738973903;6474;5642.661440313554;5652.406497317805;5658.264425624684;5660.632058916199;5677.858053548653;22136.66794998076;23986.640200397007;24055.879720601286;24279;24306;2465.938351541208;2529.6458495810602;2540.847549147057;2689.260453375318;2990.8355040472766;13720;14100.365483553265;14394.42422303117;14563.854361456355;14751.26243687822;1922.4136638325306;1988.9403317900342;1997.2510308634262;2027.5032617008928;2084.5935042666533;80437.19562804356;81349.18650813535;81507.59246203731;81759;82569.58715206386;10573.577056917637;10651.946740266249;11014.44927753609;11021.724456888642;11087.279326843729;15062.322195501229;15215.543533694006;15248.466303679317;15266.3893444261;15299.311530981133;8191;8378.706745263886;8401;8442.451240669337;8447.873281900776;8047.356211503065;8053.718119865894;8124.634391452399;8257.38069644779;8264.421490495608;5897.815179802858;6345.555811093179;6634.933650663528;6741.764038258638;6754.5947243165565;1857.5634725839418;1905.3712274949235;1906.8749437831468;1918.82730554248;1930.2086144680613;902.1654969153507;982.7887004293968;1065.0999905080196;1077.854489643888;1089.700332408594;19642.70535941962;19764.802351976585;20127.62987336706;20144.59710805776;20394.59210815805;1000.3797645459862;1002.9097381235724;1027.4862568715641;1033.715728174758;1061.8407238914224;10844.891551084545;11350;11380.374079425546;11424.942875285571;11431.59989400367;507348;531594;534182;541403;557396;97586.51206743921;102469;102958.48520757348;103223;103322;1004.2819384140374;1030.6083688198587;1057.862477877871;1060.6658902445704;1064.8722153341648;17592.03243821602;17597.29610815553;18059.458216253533;18095.276188952295;18198.181081851613;41721.79139104285;42423.15153696847;42851;42964.570354296055;44070.11859762851;58842.41157588369;63068.36931630625;63961.36038639554;64300;65784.34215657783;7670.8082297943;8075.878861817195;8076.4750291230885;8525.44584601999;9011.549422528717;10578;10865.891341086804;13603.115797473132;14126.858731412554;14510.927445362706;12491.500339986662;12751.426185821845;12789.93605031969;12923.095383323078;13014.4143513544;11962.222455540363;12043.217190882564;12184.51261949512;12405.193662411913;13111.737765244832;6366.681665916778;10477.742670879543;10640.680779576625;12815.871841281469;12997.545085922326;7466.514676546007;7636.579988100708;7756.612169391621;8780.473171609723;9159.633614655339;8581.570921454027;11348.375839328915;11453.656390308304;11831.940840295743;11948 23:59:12 INFO - PROCESS | 6813 | |3;mootools.html;1298.5000774701748;1463.817022872141;1488.5162322245271;1592.2277695317775;1779.9288028478861;8102.351811855045;8440.45137066091;8449.324054075674;8656.697015604455;8663.826723465527;8455.112213217615;8642.91357086429;8649.956750216255;8653.826923461527;8669.739907802776;2044.417341057799;2249.1228420915854;2269.2965180793926;2289.8168146548237;2327.662488939103;2304.274153641606;2304.83866129371;2306.8961896714686;2309.0763694522243;2310.838241323108;2226.532428190082;2265.422317309084;2270.3529494094187;2271.636538153896;2319.7912187903084;1979.762428508581;2135.5515341778246;2199.857009294407;2210.8452408331423;2226.3209721035078;2271.4094335472732;2287.553926984239;2289.713785776778;2290.1526435218907;2292.106078629336;8899.199072083544;9001.50491722955;9013.18881300686;9017.278617710568;9024.8646270306;5197.974010129925;5357.946420535823;5358.490943360374;5363.302770639831;5370.731463426852;3194.3291908699202;3257.2671148991526;3331.783434076777;3342.8495717692763;3349.5478110455265;1050.2385770316537;1054.7574057966633;1072.0780129088978;1073.897979691928;1079.7624522605015;12647.683807904785;12709.491620335268;12735.108542402035;12737.55418560346;12747.872521274761;4617.053504031665;4618.907621847544;4778.665493415428;4803.735794531264;4824.445188803333;10584;10589.470526473646;10591;10592.841107383396;10606.257561970588;5352.384475785335;5369.543588794996;5371.6508426952905;5373.811916582901;5388.084025715638;4352.2818734909015;4732.692374995614;4867.196912509467;4875.293082503017;4962.33008543842;4044.7977601120415;4068.4914385701786;4096.705844726963;4108.6918481114035;4146.730462519927;1138.408027825526;1221.3343727668441;1235.9814602780966;1251.2429979862234;1273.9745205095846;1028.5165971993151;1032.0866033560203;1032.6282538286212;1043.4261156363968;1044.9791004180026;6047.667378294236;6107.144999700045;6331.240251169889;6404.7117879695525;6454.128692626529;983.8622592837008;1011.4726762588398;1016.6136867990116;1027.0448482910965;1032.6695457453693;4304;4312.417823593837;4380.2772542530765;4496.797644106023;4503.166914120898;10926.672199834018;11285;11389.259698119597;11393.886061139448;11399.088072954144;11261.436928153724;11271.492782824793;11284;11285.153613479022;11289.887101129048;8034.15641357649;8373.120822313569;8397.538135402488;8432.662693492191;8491.83016339682;6234.2830574484515;6453.741850325934;6511.609303441809;6572;6579.736810527716;10273;10411.427371494641;10416.479176041319;10524.210684198868;10551.683449496528;9628.614855405705;10244.590216391261;10634.468276586294;10666.679999600025;10695;7814.179511151247;8010.719624813103;8088.87866682012;8105.716299929474;8110.959445202736;8367.246947774729;8655.913440865763;8676.609552570024;8712.477251364939;8714.215720584923;6621.304763000008;7845.725399610987;7911.485753426239;7920.603969801372;8037.638306276114;7719.92280077192;7831.84336313282;7839.686412543434;8026.317762990211;8047.959760201162;7165.283471652793;7166.426685865014;7188.424926005802;7230.168530619047;7316.8536629266055;5212.270282160424;5349.732513374393;5385.8114965976;5441.319835020622;5572.192032155396;5425.782968681208;5441.020616289106;5484.232207491034;5494.1758736189895;5501.834944951658 23:59:12 INFO - PROCESS | 6813 | |4;prototype.html;335.284168300678;335.57214551446907;344.5245561125646;344.6381299635384;344.7896782962392;5183.792648294068;5233.984915807413;5255;5265.499777521139;5270.262163297141;5211.791528338871;5213.139831927737;5216.478352164781;5225.425203227652;5236.423993360737;3923.117298607812;3986.8405263789414;4133.462649855514;4158.688098392618;4161.812718427678;4113.547509773923;4129.4012368206595;4139.730917490354;4148.79256037197;4155.587100385868;3941.4481972523868;4120.1553681495225;4122.42286079949;4127.277726397883;4132.318167502359;3937.606239376068;4074.2055299216663;4087.1607776500396;4091.4067460218253;4104.651104656078;3641.3809652359164;3655.7623754455876;3661.340958627446;3677.3748462761396;3679.5400574928135;5080.542751152414;5090.389153301628;5090.974545127251;5101.617378696613;5106.591472682177;4523.638108951276;4684.648651351163;4689.9765501172615;4700.929486057712;4712.69367491112;5360.973195133999;5396.43337449566;5416.350037995466;5421;5421.457854214586;3994.2610617035944;4007.358822588401;4007.979960100181;4018.6383225509844;4029.979850100731;5406.972965135149;5654.264945557051;5662.292213473316;5692.743826527816;5695.772169113272;4030.8186131624147;4039.6162364575316;4042.5351084625645;4049.1294371710223;4051.47330846988;4068.7355321903983;4072.205919845661;4091.4476545665952;4093.2603643451416;4102.548719640837;4371.562843715603;4593.563611456906;4600.1949658810245;4609.631229501631;4626.514216007271;5409.43200963901;5465.453454654503;5471.179323101487;5473.934596625822;5474.890502189934;1382.3917476310392;1383.163186272311;1393.958181254564;1396.0995158122953;1397.9720405592034;890.3633901760272;914.4741773480142;920.8480600700943;954.3176628710505;959.7168835193635;5292.153255479105;5308.654937429054;5308.9734551327765;5309.867253318621;5325.094733895247;5522.950639378505;5529.557635389159;5541.639793413496;5542.91685624716;5550.139728342114;5169.870753231199;5242.266082748418;5260.421873437953;5290.867728306746;5296.602754793406;2916.824990500534;2930.956035659467;2956.216602600313;2961.363306889029;2974.7917645764587;5504.91742623861;5699.373068962411;5709.200711900337;5745.683987380734;5760.567957403212;5532.612717109844;5596.58025648078;5609.6353737007785;5617.38208797032;5658.830235092953;5700.201971723962;5719.571032172604;5747.5114615257335;5760.884782304331;5775.566832487664;5315.654482458783;5457.481539253765;5546.72266386671;5562.332520097614;5565.916511252253;5443.755031023535;5465.672059676433;5501.724913754377;5511.834644960658;5520.282363292747;5682.488576028178;5714.828555143353;5720.8558288341665;5734.197212390185;5736.598438109292;3794.905127371838;3906.921861562696;3918.5101862267215;3922.941155882607;3927.7250592459395;5457.945420545902;5471.261379713687;5494.911933465258;5502.222666200393;5510.641808282448;5341.866453338697;5381.4169198785585;5390.595705322038;5391.865203369947;5394.163904594794;5143.974280128576;5364.275822763877;5374.919376209438;5384.784608615768;5387.784488620411;5175.844724658266;5205.375354957429;5301.6818990860675;5308.362996440452;5334.973325133349;5482.945170548243;5494.862628434321;5523.4200408956485;5538.141588053858;5542.972285138549;5379.569634429315;5386.622936394571;5388.622796404214;5409.810656626999;5412.269343638558 23:59:12 INFO - PROCESS | 6813 | |5;yui.html;742.9331360177583;762.3977058124084;772.0349563046192;794.2018271637004;813.178689523581;15033.173175475344;15700.37198512058;15707.92146039271;15757;15777.842221577795;14466.349014294356;14528.927355363236;14620.415183392652;14629.487967921124;14646;646.0761111610395;784.1256998446719;823.950562966224;826.2357319479487;826.983460330793;812.0499016151088;815.135955886762;818.5129847740585;818.5457071325412;818.8198596308803;688.187938232885;869.5391442535466;874.1782724239195;878.363186689648;880.3881302494736;710.3322876496103;715.3454589051012;819.7663665855232;854.0562678240517;858.4034096303072;630.8328293002312;631.2141383976978;631.6178711879293;631.649434563817;631.8167731357901;15281.235938203044;15331.616709582238;15347.539573812803;15357.232138393147;15365;14448.638784030378;14477.565673029825;14527.418903243857;14653.120812751162;14700.779488307684;12939.765058735316;13244.602661920158;13262.66843328915;13374.799378009338;13760.105593136414;4450.26570615848;4480.103979204139;4480.126375356806;4502.549745025504;4576.993061526492;73569;74652.25347746507;74730;75285;77969.22030779732;10964.396958167377;10992.945035274772;11138.49876755548;11192.832107518394;11371.601993930339;20186.899065504578;20200.393988180378;20213.292534761214;20244.696329555067;20270.89864550697;8234.711785087493;8347.66609335632;8378.287845533076;8450.323974082059;8556.443831150955;4569.109023740405;4575.794089265991;4639.489656137822;4725.4565724941385;4822.9758851205515;3230.0632816483426;3338.8998330050135;3340.8329583521213;3344.515045318415;3346.0798280473064;533.2028617217285;582.8289621161141;588.7144734803617;594.2304715393576;615.3569519851766;629.5058379172327;671.9496037797185;699.776071657075;753.4499815134982;767.7082708570707;10115.167753029164;10237.846432303522;10251;10274.22943279257;10555.947220264003;701.3757755597522;768.2100705356506;774.3379410603965;783.5455435847194;804.7786858613928;4840.2255639097575;5074.314967479417;5105.33630628016;5114.130597798383;5197.818076367309;68879.65560172267;85405.14594854096;110092.4495377534;115895;116042.41978790221;103589.48205258926;105577;107405.46297268463;109069.45465272781;109181;54650;55554;63862.36137638657;84689;89193.55403222943;9633.277504187354;9700.466474343697;9707.174890134418;9715.46564938935;9718.465484398426;50055;51173.488265116874;51320.74339628278;51833.7408312956;52346.73826630843;76111.61944190244;76864.23135768571;77672.61163694145;78461;78934.605326973;12049.036077113635;12125.75748485043;12417.379131043592;12488;12854.55009074678;13588.93205533966;13692.110012849133;14161.929190353982;14617.269136543344;14709.852901470847;13066.085374024107;13416.932915335752;13487.797683034958;13564.660883477993;14113.153210807384;12947.870521294666;12977.41601627948;13243.536476223286;13561.593152205449;13692.315384230948;13147.474101035852;13790.586282411543;13860.653483662989;13869.306534673427;13960.720785584028;10407.479626018518;10620.582393469878;10807.35155890649;10831.187660925305;10935.945320273666;10540.683779486628;11210.607628732956;11283.266587671775;11508.53965841357;11573.305601663928 23:59:12 INFO - PROCESS | 6813 | __end_tp_report 23:59:12 INFO - PROCESS | 6813 | __start_cc_report 23:59:12 INFO - PROCESS | 6813 | _x_x_mozilla_cycle_collect,1033 23:59:12 INFO - PROCESS | 6813 | __end_cc_report 23:59:12 INFO - PROCESS | 6813 | __startTimestamp1468047552331__endTimestamp 23:59:12 INFO - PROCESS | 6813 | 23:59:12 INFO - PROCESS | 6813 | ------- Summary: start ------- 23:59:12 INFO - PROCESS | 6813 | Number of tests: 6 23:59:12 INFO - PROCESS | 6813 | 23:59:12 INFO - PROCESS | 6813 | [#0] dojo.html Cycles:165 Average:5379.42 Median:5609.89 stddev:629.32 (11.2%) stddev-sans-first:603.15 23:59:12 INFO - PROCESS | 6813 | Values: 3008.7 3028.8 3040.7 3071.5 3074.2 5222.7 5341.8 5348.6 5421.0 5475.6 5334.4 5421.2 5436.3 5468.0 5481.3 4831.2 4896.9 4909.5 4924.8 5099.2 5008.9 5010.4 5049.9 5058.7 5063.4 4774.2 4811.2 4845.5 4915.2 4946.1 4889.6 4897.5 4910.8 4913.1 4954.4 4897.1 4927.2 4940.0 4941.5 4964.8 5306.0 5325.6 5374.5 5379.4 5500.6 5757.9 5761.5 5764.7 5767.5 5818.1 5817.4 5859.0 5869.2 5879.7 5889.7 5239.7 5343.2 5346.1 5372.6 5473.4 5990.0 5995.0 6014.5 6017.5 6024.6 5714.8 5722.8 5731.7 5732.0 5735.4 5592.8 5683.7 5727.4 5733.9 5816.1 5734.4 5736.2 5739.2 5741.8 5753.9 5693.2 5717.2 5757.5 5758.9 5763.9 4227.3 4277.6 4278.2 4362.1 4388.6 3941.3 3953.8 3961.4 3987.4 4006.1 5475.9 5490.3 5490.9 5491.1 5495.8 5636.3 5830.2 5874.7 5886.8 5941.1 5588.9 5609.9 5615.1 5615.6 5662.4 5070.2 5076.2 5076.9 5081.2 5087.8 5811.9 5978.8 6056.3 6060.2 6090.0 5876.3 5876.4 5886.7 5887.1 5888.1 6040.4 6072.9 6093.7 6094.8 6097.5 5486.9 5615.5 5649.3 5660.9 5704.7 5806.7 5808.6 5812.2 5812.5 5816.9 5519.4 5636.2 5666.0 5685.7 5688.9 5602.8 5612.4 5676.5 5682.2 5683.7 5611.6 5612.4 5626.9 5633.9 5642.5 5530.1 5599.0 5709.1 5715.7 5777.6 5339.4 5383.0 5470.3 5471.0 5530.9 23:59:12 INFO - PROCESS | 6813 | 23:59:12 INFO - PROCESS | 6813 | [#1] ext.html Cycles:180 Average:63310.20 Median:22586.86 stddev:133910.17 (592.9%) stddev-sans-first:134203.02 23:59:12 INFO - PROCESS | 6813 | Values: 590.3 620.9 621.4 633.9 641.3 32431.8 40730.8 42121.2 42298.0 46022.8 45380.3 45392.0 45758.8 45766.1 45859.0 8923.4 9069.2 9073.7 9073.9 9078.2 8913.0 9008.8 9011.1 9020.5 9024.3 9024.0 9073.4 9075.1 9075.4 9078.1 8930.6 8954.4 8959.8 9036.9 9051.9 8890.2 8984.7 8985.8 8988.2 8992.7 42423.6 42622.9 42714.6 42721.8 42778.0 3498.0 3699.0 3718.2 4100.1 4121.4 32248.0 32311.4 32455.7 32523.3 33653.8 4323.0 4355.4 4388.4 4450.5 4576.3 343121.0 343643.0 345119.0 345307.3 345977.0 33857.7 35099.5 56798.7 57333.1 57530.0 36583.3 36806.3 36908.6 37009.0 37058.3 14663.5 14741.6 14743.8 14752.1 14752.3 12625.8 12719.2 12719.9 12720.9 12730.7 8341.2 8342.7 8367.7 8409.1 8411.8 3207.5 3218.8 3224.4 3260.5 3305.7 1008.3 1029.4 1070.8 1142.6 1176.6 32469.4 33429.7 33526.2 33582.8 33767.0 1061.6 1119.3 1123.0 1142.1 1200.9 15924.4 16315.4 16605.4 16715.6 16898.1 566428.0 608290.0 609251.0 610106.0 612129.0 55728.7 56159.4 56478.0 56523.0 56599.0 1204.0 1383.9 1386.4 1388.3 1430.5 29946.0 34212.8 34334.1 34681.7 34797.7 52240.0 52507.7 52586.2 52825.7 52841.5 515953.0 523873.0 525251.0 528339.0 528434.0 37605.6 38612.8 43601.0 44920.3 45018.0 46131.8 46447.5 46888.0 47171.5 47745.0 39829.4 40074.0 40161.6 40373.0 41073.6 39998.2 40883.2 41089.8 41263.6 41858.2 38823.2 39179.2 40104.4 40127.2 40270.8 34917.3 35287.8 35607.5 36330.3 36426.3 27523.9 27757.0 27858.9 27870.0 28128.7 23:59:12 INFO - PROCESS | 6813 | 23:59:12 INFO - PROCESS | 6813 | [#2] jquery.html Cycles:180 Average:30923.67 Median:23061.65 stddev:88151.02 (382.2%) stddev-sans-first:88368.49 23:59:12 INFO - PROCESS | 6813 | Values: 385.6 391.1 392.7 401.4 417.6 13926.6 18821.2 20386.0 20400.2 20675.0 14584.4 19094.2 19233.5 20066.0 20293.1 5643.0 5789.3 5814.1 5815.0 5826.7 5742.1 5814.3 5815.3 5822.2 5826.9 4245.5 6080.8 6399.0 6403.7 6512.2 6139.0 6407.0 6421.7 6448.2 6474.0 5642.7 5652.4 5658.3 5660.6 5677.9 22136.7 23986.6 24055.9 24279.0 24306.0 2465.9 2529.6 2540.8 2689.3 2990.8 13720.0 14100.4 14394.4 14563.9 14751.3 1922.4 1988.9 1997.3 2027.5 2084.6 80437.2 81349.2 81507.6 81759.0 82569.6 10573.6 10651.9 11014.4 11021.7 11087.3 15062.3 15215.5 15248.5 15266.4 15299.3 8191.0 8378.7 8401.0 8442.5 8447.9 8047.4 8053.7 8124.6 8257.4 8264.4 5897.8 6345.6 6634.9 6741.8 6754.6 1857.6 1905.4 1906.9 1918.8 1930.2 902.2 982.8 1065.1 1077.9 1089.7 19642.7 19764.8 20127.6 20144.6 20394.6 1000.4 1002.9 1027.5 1033.7 1061.8 10844.9 11350.0 11380.4 11424.9 11431.6 507348.0 531594.0 534182.0 541403.0 557396.0 97586.5 102469.0 102958.5 103223.0 103322.0 1004.3 1030.6 1057.9 1060.7 1064.9 17592.0 17597.3 18059.5 18095.3 18198.2 41721.8 42423.2 42851.0 42964.6 44070.1 58842.4 63068.4 63961.4 64300.0 65784.3 7670.8 8075.9 8076.5 8525.4 9011.5 10578.0 10865.9 13603.1 14126.9 14510.9 12491.5 12751.4 12789.9 12923.1 13014.4 11962.2 12043.2 12184.5 12405.2 13111.7 6366.7 10477.7 10640.7 12815.9 12997.5 7466.5 7636.6 7756.6 8780.5 9159.6 8581.6 11348.4 11453.7 11831.9 11948.0 23:59:12 INFO - PROCESS | 6813 | 23:59:12 INFO - PROCESS | 6813 | [#3] mootools.html Cycles:180 Average:5922.39 Median:4366.28 stddev:3396.25 (77.8%) stddev-sans-first:3388.00 23:59:12 INFO - PROCESS | 6813 | Values: 1298.5 1463.8 1488.5 1592.2 1779.9 8102.4 8440.5 8449.3 8656.7 8663.8 8455.1 8642.9 8650.0 8653.8 8669.7 2044.4 2249.1 2269.3 2289.8 2327.7 2304.3 2304.8 2306.9 2309.1 2310.8 2226.5 2265.4 2270.4 2271.6 2319.8 1979.8 2135.6 2199.9 2210.8 2226.3 2271.4 2287.6 2289.7 2290.2 2292.1 8899.2 9001.5 9013.2 9017.3 9024.9 5198.0 5357.9 5358.5 5363.3 5370.7 3194.3 3257.3 3331.8 3342.8 3349.5 1050.2 1054.8 1072.1 1073.9 1079.8 12647.7 12709.5 12735.1 12737.6 12747.9 4617.1 4618.9 4778.7 4803.7 4824.4 10584.0 10589.5 10591.0 10592.8 10606.3 5352.4 5369.5 5371.7 5373.8 5388.1 4352.3 4732.7 4867.2 4875.3 4962.3 4044.8 4068.5 4096.7 4108.7 4146.7 1138.4 1221.3 1236.0 1251.2 1274.0 1028.5 1032.1 1032.6 1043.4 1045.0 6047.7 6107.1 6331.2 6404.7 6454.1 983.9 1011.5 1016.6 1027.0 1032.7 4304.0 4312.4 4380.3 4496.8 4503.2 10926.7 11285.0 11389.3 11393.9 11399.1 11261.4 11271.5 11284.0 11285.2 11289.9 8034.2 8373.1 8397.5 8432.7 8491.8 6234.3 6453.7 6511.6 6572.0 6579.7 10273.0 10411.4 10416.5 10524.2 10551.7 9628.6 10244.6 10634.5 10666.7 10695.0 7814.2 8010.7 8088.9 8105.7 8111.0 8367.2 8655.9 8676.6 8712.5 8714.2 6621.3 7845.7 7911.5 7920.6 8037.6 7719.9 7831.8 7839.7 8026.3 8048.0 7165.3 7166.4 7188.4 7230.2 7316.9 5212.3 5349.7 5385.8 5441.3 5572.2 5425.8 5441.0 5484.2 5494.2 5501.8 23:59:12 INFO - PROCESS | 6813 | 23:59:12 INFO - PROCESS | 6813 | [#4] prototype.html Cycles:180 Average:4586.79 Median:5280.56 stddev:1332.01 (25.2%) stddev-sans-first:1296.96 23:59:12 INFO - PROCESS | 6813 | Values: 335.3 335.6 344.5 344.6 344.8 5183.8 5234.0 5255.0 5265.5 5270.3 5211.8 5213.1 5216.5 5225.4 5236.4 3923.1 3986.8 4133.5 4158.7 4161.8 4113.5 4129.4 4139.7 4148.8 4155.6 3941.4 4120.2 4122.4 4127.3 4132.3 3937.6 4074.2 4087.2 4091.4 4104.7 3641.4 3655.8 3661.3 3677.4 3679.5 5080.5 5090.4 5091.0 5101.6 5106.6 4523.6 4684.6 4690.0 4700.9 4712.7 5361.0 5396.4 5416.4 5421.0 5421.5 3994.3 4007.4 4008.0 4018.6 4030.0 5407.0 5654.3 5662.3 5692.7 5695.8 4030.8 4039.6 4042.5 4049.1 4051.5 4068.7 4072.2 4091.4 4093.3 4102.5 4371.6 4593.6 4600.2 4609.6 4626.5 5409.4 5465.5 5471.2 5473.9 5474.9 1382.4 1383.2 1394.0 1396.1 1398.0 890.4 914.5 920.8 954.3 959.7 5292.2 5308.7 5309.0 5309.9 5325.1 5523.0 5529.6 5541.6 5542.9 5550.1 5169.9 5242.3 5260.4 5290.9 5296.6 2916.8 2931.0 2956.2 2961.4 2974.8 5504.9 5699.4 5709.2 5745.7 5760.6 5532.6 5596.6 5609.6 5617.4 5658.8 5700.2 5719.6 5747.5 5760.9 5775.6 5315.7 5457.5 5546.7 5562.3 5565.9 5443.8 5465.7 5501.7 5511.8 5520.3 5682.5 5714.8 5720.9 5734.2 5736.6 3794.9 3906.9 3918.5 3922.9 3927.7 5457.9 5471.3 5494.9 5502.2 5510.6 5341.9 5381.4 5390.6 5391.9 5394.2 5144.0 5364.3 5374.9 5384.8 5387.8 5175.8 5205.4 5301.7 5308.4 5335.0 5482.9 5494.9 5523.4 5538.1 5543.0 5379.6 5386.6 5388.6 5409.8 5412.3 23:59:12 INFO - PROCESS | 6813 | 23:59:12 INFO - PROCESS | 6813 | [#5] yui.html Cycles:180 Average:20177.70 Median:4491.34 stddev:28701.60 (639.0%) stddev-sans-first:28745.02 23:59:12 INFO - PROCESS | 6813 | Values: 742.9 762.4 772.0 794.2 813.2 15033.2 15700.4 15707.9 15757.0 15777.8 14466.3 14528.9 14620.4 14629.5 14646.0 646.1 784.1 824.0 826.2 827.0 812.0 815.1 818.5 818.5 818.8 688.2 869.5 874.2 878.4 880.4 710.3 715.3 819.8 854.1 858.4 630.8 631.2 631.6 631.6 631.8 15281.2 15331.6 15347.5 15357.2 15365.0 14448.6 14477.6 14527.4 14653.1 14700.8 12939.8 13244.6 13262.7 13374.8 13760.1 4450.3 4480.1 4480.1 4502.5 4577.0 73569.0 74652.3 74730.0 75285.0 77969.2 10964.4 10992.9 11138.5 11192.8 11371.6 20186.9 20200.4 20213.3 20244.7 20270.9 8234.7 8347.7 8378.3 8450.3 8556.4 4569.1 4575.8 4639.5 4725.5 4823.0 3230.1 3338.9 3340.8 3344.5 3346.1 533.2 582.8 588.7 594.2 615.4 629.5 671.9 699.8 753.4 767.7 10115.2 10237.8 10251.0 10274.2 10555.9 701.4 768.2 774.3 783.5 804.8 4840.2 5074.3 5105.3 5114.1 5197.8 68879.7 85405.1 110092.4 115895.0 116042.4 103589.5 105577.0 107405.5 109069.5 109181.0 54650.0 55554.0 63862.4 84689.0 89193.6 9633.3 9700.5 9707.2 9715.5 9718.5 50055.0 51173.5 51320.7 51833.7 52346.7 76111.6 76864.2 77672.6 78461.0 78934.6 12049.0 12125.8 12417.4 12488.0 12854.6 13588.9 13692.1 14161.9 14617.3 14709.9 13066.1 13416.9 13487.8 13564.7 14113.2 12947.9 12977.4 13243.5 13561.6 13692.3 13147.5 13790.6 13860.7 13869.3 13960.7 10407.5 10620.6 10807.4 10831.2 10935.9 10540.7 11210.6 11283.3 11508.5 11573.3 23:59:12 INFO - PROCESS | 6813 | -------- Summary: end -------- 23:59:12 INFO - PROCESS | 6813 | 23:59:13 INFO - TEST-INFO | 6813: exit 0 23:59:13 INFO - TEST-OK | dromaeo_css | took 1114145ms 23:59:13 INFO - TEST-START | kraken 23:59:13 INFO - operating with platform_type : linux_ 23:59:13 INFO - Initialising browser for kraken test... 23:59:13 INFO - TEST-INFO | started process 7003 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5HyKyq/profile http://localhost:60370/getInfo.html) 23:59:17 INFO - PROCESS | 7003 | __metrics Screen width/height:1600/1200 23:59:17 INFO - PROCESS | 7003 | colorDepth:24 23:59:17 INFO - PROCESS | 7003 | Browser inner width/height: 1024/697 23:59:17 INFO - PROCESS | 7003 | __metrics 23:59:18 INFO - PROCESS | 7003 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:59:19 INFO - TEST-INFO | 7003: exit 0 23:59:19 INFO - Browser initialized. 23:59:19 INFO - Running cycle 1/1 for kraken test... 23:59:19 INFO - TEST-INFO | started process 7088 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5HyKyq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:59:30 INFO - PROCESS | 7088 | RSS: Main: 156876800 23:59:30 INFO - PROCESS | 7088 | 23:59:33 INFO - PROCESS | 7088 | Cycle 1(1): loaded http://localhost:60370/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60370/tests/kraken/driver.html?testName=audio-beat-detection) 23:59:34 INFO - PROCESS | 7088 | RSS: Main: 215703552 23:59:34 INFO - PROCESS | 7088 | 23:59:36 INFO - PROCESS | 7088 | Cycle 1(1): loaded http://localhost:60370/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60370/tests/kraken/driver.html?testName=audio-dft) 23:59:37 INFO - PROCESS | 7088 | RSS: Main: 203583488 23:59:37 INFO - PROCESS | 7088 | 23:59:40 INFO - PROCESS | 7088 | Cycle 1(1): loaded http://localhost:60370/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60370/tests/kraken/driver.html?testName=audio-fft) 23:59:41 INFO - PROCESS | 7088 | RSS: Main: 269373440 23:59:41 INFO - PROCESS | 7088 | 23:59:43 INFO - PROCESS | 7088 | Cycle 1(1): loaded http://localhost:60370/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60370/tests/kraken/driver.html?testName=audio-oscillator) 23:59:43 INFO - PROCESS | 7088 | RSS: Main: 180551680 23:59:43 INFO - PROCESS | 7088 | 23:59:45 INFO - PROCESS | 7088 | Cycle 1(1): loaded http://localhost:60370/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60370/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:59:46 INFO - PROCESS | 7088 | RSS: Main: 184975360 23:59:46 INFO - PROCESS | 7088 | 23:59:49 INFO - PROCESS | 7088 | Cycle 1(1): loaded http://localhost:60370/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60370/tests/kraken/driver.html?testName=imaging-darkroom) 23:59:50 INFO - PROCESS | 7088 | RSS: Main: 219328512 23:59:50 INFO - PROCESS | 7088 | 23:59:53 INFO - PROCESS | 7088 | Cycle 1(1): loaded http://localhost:60370/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60370/tests/kraken/driver.html?testName=imaging-desaturate) 23:59:54 INFO - PROCESS | 7088 | RSS: Main: 221491200 23:59:54 INFO - PROCESS | 7088 | 23:59:56 INFO - PROCESS | 7088 | Cycle 1(1): loaded http://localhost:60370/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60370/tests/kraken/driver.html?testName=json-parse-financial) 23:59:57 INFO - PROCESS | 7088 | RSS: Main: 221028352 23:59:57 INFO - PROCESS | 7088 | 23:59:59 INFO - PROCESS | 7088 | Cycle 1(1): loaded http://localhost:60370/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60370/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:59:59 INFO - PROCESS | 7088 | RSS: Main: 208588800 23:59:59 INFO - PROCESS | 7088 | 00:00:01 INFO - PROCESS | 7088 | Cycle 1(1): loaded http://localhost:60370/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60370/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:00:02 INFO - PROCESS | 7088 | RSS: Main: 211750912 00:00:02 INFO - PROCESS | 7088 | 00:00:04 INFO - PROCESS | 7088 | Cycle 1(1): loaded http://localhost:60370/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60370/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:00:04 INFO - PROCESS | 7088 | RSS: Main: 210804736 00:00:04 INFO - PROCESS | 7088 | 00:00:07 INFO - PROCESS | 7088 | Cycle 1(1): loaded http://localhost:60370/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60370/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:00:07 INFO - PROCESS | 7088 | RSS: Main: 230031360 00:00:07 INFO - PROCESS | 7088 | 00:00:10 INFO - PROCESS | 7088 | Cycle 1(1): loaded http://localhost:60370/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60370/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:00:11 INFO - PROCESS | 7088 | RSS: Main: 224210944 00:00:11 INFO - PROCESS | 7088 | 00:00:12 INFO - PROCESS | 7088 | Cycle 1(1): loaded http://localhost:60370/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60370/tests/kraken/driver.html?testName=ai-astar) 00:00:13 INFO - PROCESS | 7088 | RSS: Main: 265465856 00:00:13 INFO - PROCESS | 7088 | 00:00:13 INFO - PROCESS | 7088 | __start_tp_report 00:00:13 INFO - PROCESS | 7088 | _x_x_mozilla_page_load 00:00:13 INFO - PROCESS | 7088 | _x_x_mozilla_page_load_details 00:00:13 INFO - PROCESS | 7088 | |i|pagename|runs| 00:00:13 INFO - PROCESS | 7088 | |0;ai-astar;100;110;112;111;111;108;109;108;110;109 00:00:13 INFO - PROCESS | 7088 | |1;audio-beat-detection;143;118;119;171;119;118;143;117;159;117 00:00:13 INFO - PROCESS | 7088 | |2;audio-dft;159;161;161;162;161;160;162;160;160;161 00:00:13 INFO - PROCESS | 7088 | |3;audio-fft;73;75;76;130;75;76;73;75;107;74 00:00:13 INFO - PROCESS | 7088 | |4;audio-oscillator;83;83;111;84;84;84;116;82;83;130 00:00:13 INFO - PROCESS | 7088 | |5;imaging-gaussian-blur;117;116;116;117;116;117;117;116;117;117 00:00:13 INFO - PROCESS | 7088 | |6;imaging-darkroom;146;146;145;145;145;145;145;146;145;145 00:00:13 INFO - PROCESS | 7088 | |7;imaging-desaturate;95;95;95;95;95;94;95;94;95;95 00:00:13 INFO - PROCESS | 7088 | |8;json-parse-financial;55;53;54;54;54;54;55;54;54;54 00:00:13 INFO - PROCESS | 7088 | |9;json-stringify-tinderbox;62;62;62;62;62;61;62;63;62;62 00:00:13 INFO - PROCESS | 7088 | |10;stanford-crypto-aes;79;81;74;75;80;75;83;75;75;79 00:00:13 INFO - PROCESS | 7088 | |11;stanford-crypto-ccm;118;121;118;121;120;119;131;119;163;128 00:00:13 INFO - PROCESS | 7088 | |12;stanford-crypto-pbkdf2;156;155;159;156;157;156;159;156;155;155 00:00:13 INFO - PROCESS | 7088 | |13;stanford-crypto-sha256-iterative;64;63;63;62;61;62;60;61;62;64 00:00:13 INFO - PROCESS | 7088 | __end_tp_report 00:00:13 INFO - PROCESS | 7088 | __start_cc_report 00:00:13 INFO - PROCESS | 7088 | _x_x_mozilla_cycle_collect,1608 00:00:13 INFO - PROCESS | 7088 | __end_cc_report 00:00:13 INFO - PROCESS | 7088 | __startTimestamp1468047612999__endTimestamp 00:00:13 INFO - PROCESS | 7088 | 00:00:13 INFO - PROCESS | 7088 | ------- Summary: start ------- 00:00:13 INFO - PROCESS | 7088 | Number of tests: 14 00:00:13 INFO - PROCESS | 7088 | 00:00:13 INFO - PROCESS | 7088 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:3.36 (3.1%) stddev-sans-first:1.39 00:00:13 INFO - PROCESS | 7088 | Values: 100.0 110.0 112.0 111.0 111.0 108.0 109.0 108.0 110.0 109.0 00:00:13 INFO - PROCESS | 7088 | 00:00:13 INFO - PROCESS | 7088 | [#1] audio-beat-detection Cycles:10 Average:132.40 Median:131.00 stddev:20.19 (15.4%) stddev-sans-first:21.05 00:00:13 INFO - PROCESS | 7088 | Values: 143.0 118.0 119.0 171.0 119.0 118.0 143.0 117.0 159.0 117.0 00:00:13 INFO - PROCESS | 7088 | 00:00:13 INFO - PROCESS | 7088 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.95 (0.6%) stddev-sans-first:0.78 00:00:13 INFO - PROCESS | 7088 | Values: 159.0 161.0 161.0 162.0 161.0 160.0 162.0 160.0 160.0 161.0 00:00:13 INFO - PROCESS | 7088 | 00:00:13 INFO - PROCESS | 7088 | [#3] audio-fft Cycles:10 Average:83.40 Median:75.00 stddev:19.31 (25.7%) stddev-sans-first:20.11 00:00:13 INFO - PROCESS | 7088 | Values: 73.0 75.0 76.0 130.0 75.0 76.0 73.0 75.0 107.0 74.0 00:00:13 INFO - PROCESS | 7088 | 00:00:13 INFO - PROCESS | 7088 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:83.00 stddev:17.88 (21.5%) stddev-sans-first:18.51 00:00:13 INFO - PROCESS | 7088 | Values: 83.0 83.0 111.0 84.0 84.0 84.0 116.0 82.0 83.0 130.0 00:00:13 INFO - PROCESS | 7088 | 00:00:13 INFO - PROCESS | 7088 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 00:00:13 INFO - PROCESS | 7088 | Values: 117.0 116.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 00:00:13 INFO - PROCESS | 7088 | 00:00:13 INFO - PROCESS | 7088 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 00:00:13 INFO - PROCESS | 7088 | Values: 146.0 146.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 00:00:13 INFO - PROCESS | 7088 | 00:00:13 INFO - PROCESS | 7088 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 00:00:13 INFO - PROCESS | 7088 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 00:00:13 INFO - PROCESS | 7088 | 00:00:13 INFO - PROCESS | 7088 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:0.57 (1.1%) stddev-sans-first:0.50 00:00:13 INFO - PROCESS | 7088 | Values: 55.0 53.0 54.0 54.0 54.0 54.0 55.0 54.0 54.0 54.0 00:00:13 INFO - PROCESS | 7088 | 00:00:13 INFO - PROCESS | 7088 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 00:00:13 INFO - PROCESS | 7088 | Values: 62.0 62.0 62.0 62.0 62.0 61.0 62.0 63.0 62.0 62.0 00:00:13 INFO - PROCESS | 7088 | 00:00:13 INFO - PROCESS | 7088 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:79.00 stddev:3.17 (4.0%) stddev-sans-first:3.32 00:00:13 INFO - PROCESS | 7088 | Values: 79.0 81.0 74.0 75.0 80.0 75.0 83.0 75.0 75.0 79.0 00:00:13 INFO - PROCESS | 7088 | 00:00:13 INFO - PROCESS | 7088 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:121.00 stddev:13.78 (11.4%) stddev-sans-first:14.33 00:00:13 INFO - PROCESS | 7088 | Values: 118.0 121.0 118.0 121.0 120.0 119.0 131.0 119.0 163.0 128.0 00:00:13 INFO - PROCESS | 7088 | 00:00:13 INFO - PROCESS | 7088 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.40 Median:156.00 stddev:1.51 (1.0%) stddev-sans-first:1.59 00:00:13 INFO - PROCESS | 7088 | Values: 156.0 155.0 159.0 156.0 157.0 156.0 159.0 156.0 155.0 155.0 00:00:13 INFO - PROCESS | 7088 | 00:00:13 INFO - PROCESS | 7088 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.50 stddev:1.32 (2.1%) stddev-sans-first:1.22 00:00:13 INFO - PROCESS | 7088 | Values: 64.0 63.0 63.0 62.0 61.0 62.0 60.0 61.0 62.0 64.0 00:00:13 INFO - PROCESS | 7088 | -------- Summary: end -------- 00:00:13 INFO - PROCESS | 7088 | 00:00:13 INFO - TEST-INFO | 7088: exit 0 00:00:14 INFO - TEST-OK | kraken | took 60967ms 00:00:14 INFO - SUITE-END | took 1175s 00:00:14 INFO - Completed test suite (00:19:35) 00:00:14 INFO - javascript benchmark 00:00:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3008.7141721536454, 3028.7728420368476, 3040.6655267920532, 3071.4624940635385, 3074.2160749009, 5222.738863056851, 5341.786328546863, 5348.572114230862, 5421.024215641188, 5475.616706830523, 5334.359876814778, 5421.241026256317, 5436.3476382834015, 5468.043092458824, 5481.314835645544, 4831.154547954112, 4896.902061958759, 4909.484504127069, 4924.753762311888, 5099.235114732783, 5008.899822003557, 5010.3737032870895, 5049.949500505003, 5058.747062646871, 5063.443021267658, 4774.188387974035, 4811.158047341719, 4845.5396737310075, 4915.238138088602, 4946.060248552763, 4889.608831293488, 4897.510248975074, 4910.828121015783, 4913.091078150554, 4954.402750784878, 4897.094037603055, 4927.211646136601, 4940.036692844897, 4941.45643979162, 4964.751762411901, 5306.044911915854, 5325.600579956519, 5374.543163831079, 5379.408265090837, 5500.614956953015, 5757.942420575782, 5761.53907687384, 5764.74058667361, 5767.538596912237, 5818.127280907897, 5817.418258174149, 5859.033259512175, 5869.178315035899, 5879.735411906432, 5889.734961926681, 5239.711815850127, 5343.225232341328, 5346.144616861284, 5372.623916325859, 5473.370562385297, 5990.041593345044, 5995.0, 6014.51883849291, 6017.488513476404, 6024.57827952048, 5714.828555143269, 5722.7710891563875, 5731.656100633975, 5731.971340143273, 5735.369109397963, 5592.832215033555, 5683.744231509592, 5727.427257274239, 5733.942660573424, 5816.098504731774, 5734.397888221677, 5736.1682556029145, 5739.167820666064, 5741.827745167651, 5753.942460575425, 5693.202951586781, 5717.171010203498, 5757.453041961007, 5758.913616295759, 5763.942360576424, 4227.3447615619625, 4277.615014648634, 4278.165757677223, 4362.1493808707, 4388.583084607021, 3941.3496773032703, 3953.802309884552, 3961.3661814110183, 3987.4218238355274, 4006.09862780872, 5475.917861232085, 5490.258815059916, 5490.945090549123, 5491.121420572769, 5495.807646732425, 5636.323641163087, 5830.154627578977, 5874.676892770939, 5886.823395298148, 5941.108833674897, 5588.944110558924, 5609.887802244014, 5615.073512870413, 5615.634983726045, 5662.405447428043, 5070.188769796889, 5076.187809950464, 5076.923846142311, 5081.23781432788, 5087.833377179738, 5811.854703632443, 5978.760849565969, 6056.3338032816355, 6060.212172417558, 6090.025595904634, 5876.265466816648, 5876.412358764261, 5886.676232807065, 5887.087501437284, 5888.057910734262, 6040.365761595145, 6072.8785424292155, 6093.695315234309, 6094.8171554853425, 6097.512199023979, 5486.91769623448, 5615.494605485526, 5649.322081350264, 5660.886782264414, 5704.686242256716, 5806.738696758572, 5808.593398462236, 5812.157237200498, 5812.534997200299, 5816.883662326645, 5519.39286678457, 5636.182753500638, 5666.0, 5685.687287199078, 5688.890666320028, 5602.831915042555, 5612.354579223442, 5676.517496012885, 5682.176084467646, 5683.744231509675, 5611.579131565068, 5612.382637909908, 5626.887462250814, 5633.887322253614, 5642.520385767256, 5530.115181570929, 5598.992181407386, 5709.058005429058, 5715.657060576379, 5777.566682498914, 5339.385970613429, 5383.0041442333295, 5470.288862447856, 5471.0, 5530.917036244379], "value": 5335.207673710089, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.3299754778328, 620.875824835033, 621.4220774679552, 633.8922383194856, 641.2977789320693, 32431.837840810793, 40730.796346018265, 42121.15757684848, 42298.0, 46022.76988615061, 45380.3192952106, 45392.0, 45758.77120614392, 45766.08467830641, 45859.0, 8923.419977701446, 9069.229115525155, 9073.682421115262, 9073.863892041625, 9078.228350590207, 8912.955435222815, 9008.774780630503, 9011.143941325596, 9020.503872287021, 9024.278057755397, 9024.0, 9073.36486445949, 9075.13786190311, 9075.41009834362, 9078.137576930181, 8930.553472326357, 8954.37319387643, 8959.820803583925, 9036.8644470333, 9051.864222036675, 8890.199882010585, 8984.685536006209, 8985.775355616162, 8988.191062804379, 8992.730218093468, 42423.57576424227, 42622.934426639586, 42714.57285427137, 42721.786391068155, 42778.0, 3498.0, 3699.0, 3718.2377612589353, 4100.138970816132, 4121.381792731085, 32248.0, 32311.353772924645, 32455.6754432455, 32523.349533009445, 33653.83173084143, 4323.0, 4355.433793606842, 4388.363687265361, 4450.5104438511735, 4576.336431217454, 343121.0, 343643.0, 345119.0, 345307.27346363105, 345977.0, 33857.66142338594, 35099.473507897404, 56798.7160064197, 57333.14000289999, 57530.0, 36583.26833463316, 36806.263874722354, 36908.63091369106, 37009.0, 37058.25883482369, 14663.48677796272, 14741.55775326742, 14743.77884331736, 14752.114873107648, 14752.262386880613, 12625.810612840814, 12719.173253738663, 12719.872801272053, 12720.936395317964, 12730.68173295675, 8341.165883411732, 8342.708005219789, 8367.665293388318, 8409.075001749803, 8411.789705257417, 3207.486802111651, 3218.7746857720203, 3224.3712476067412, 3260.494623333387, 3305.669433056675, 1008.2790804574764, 1029.43381140374, 1070.8340207267886, 1142.5544037825255, 1176.6175992802373, 32469.443974819285, 33429.66570334265, 33526.16184595356, 33582.8320858399, 33767.0, 1061.6443491430302, 1119.326606722938, 1122.9775404491863, 1142.126273400849, 1200.9159358844972, 15924.442644507619, 16315.428959986344, 16605.41881034158, 16715.582110447092, 16898.07060611678, 566428.0, 608290.0, 609251.0, 610106.0, 612129.0, 55728.72135639296, 56159.43840561542, 56478.0, 56523.0, 56599.0, 1204.0, 1383.9031267811156, 1386.4107754204624, 1388.271157642246, 1430.5279257845095, 29945.968100686514, 34212.82893585516, 34334.14164645904, 34681.65318346885, 34797.652023479444, 52240.0, 52507.73746131245, 52586.2112068327, 52825.735871320394, 52841.471585285195, 515953.0, 523873.0, 525251.0, 528339.0, 528434.0, 37605.623943761304, 38612.80693596514, 43601.0, 44920.32619510645, 45018.0, 46131.76934115308, 46447.53552464432, 46888.0, 47171.52828471671, 47745.0, 39829.40255896222, 40074.0, 40161.598384015786, 40373.0, 41073.589264108174, 39998.2000359997, 40883.18233635251, 41089.79455102705, 41263.587364127176, 41858.1628367437, 38823.22353552857, 39179.2164156721, 40104.39843402409, 40127.19745605013, 40270.79864600658, 34917.30165396729, 35287.82356088306, 35607.465888012215, 36330.27339453249, 36426.27147457089, 27523.86238068797, 27757.0, 27858.86070569634, 27870.0, 28128.71871281343], "value": 19286.96956811246, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.6240165838307, 391.084861424267, 392.6525025352566, 401.3718530499768, 417.5824175824176, 13926.582202533915, 18821.247150113995, 20385.99999999998, 20400.183992640294, 20675.0, 14584.416623335053, 19094.236230550796, 19233.519162020955, 20066.0, 20293.0868110935, 5643.0, 5789.334226563936, 5814.069748840187, 5815.040518314473, 5826.708664566776, 5742.052561327376, 5814.302283725959, 5815.331236907747, 5822.155787410823, 5826.912596311059, 4245.469316335458, 6080.847978800522, 6399.0, 6403.7438502459845, 6512.218533775954, 6138.9693051534905, 6407.038944158367, 6421.7110230039525, 6448.161738973903, 6474.0, 5642.661440313554, 5652.406497317805, 5658.264425624684, 5660.632058916199, 5677.858053548653, 22136.66794998076, 23986.640200397007, 24055.879720601286, 24279.0, 24306.0, 2465.938351541208, 2529.6458495810602, 2540.847549147057, 2689.260453375318, 2990.8355040472766, 13720.0, 14100.365483553265, 14394.42422303117, 14563.854361456355, 14751.26243687822, 1922.4136638325306, 1988.9403317900342, 1997.2510308634262, 2027.5032617008928, 2084.5935042666533, 80437.19562804356, 81349.18650813535, 81507.59246203731, 81759.0, 82569.58715206386, 10573.577056917637, 10651.946740266249, 11014.44927753609, 11021.724456888642, 11087.279326843729, 15062.322195501229, 15215.543533694006, 15248.466303679317, 15266.3893444261, 15299.311530981133, 8191.0, 8378.706745263886, 8401.0, 8442.451240669337, 8447.873281900776, 8047.356211503065, 8053.718119865894, 8124.634391452399, 8257.38069644779, 8264.421490495608, 5897.815179802858, 6345.555811093179, 6634.933650663528, 6741.764038258638, 6754.5947243165565, 1857.5634725839418, 1905.3712274949235, 1906.8749437831468, 1918.82730554248, 1930.2086144680613, 902.1654969153507, 982.7887004293968, 1065.0999905080196, 1077.854489643888, 1089.700332408594, 19642.70535941962, 19764.802351976585, 20127.62987336706, 20144.59710805776, 20394.59210815805, 1000.3797645459862, 1002.9097381235724, 1027.4862568715641, 1033.715728174758, 1061.8407238914224, 10844.891551084545, 11350.0, 11380.374079425546, 11424.942875285571, 11431.59989400367, 507348.0, 531594.0, 534182.0, 541403.0, 557396.0, 97586.51206743921, 102469.0, 102958.48520757348, 103223.0, 103322.0, 1004.2819384140374, 1030.6083688198587, 1057.862477877871, 1060.6658902445704, 1064.8722153341648, 17592.03243821602, 17597.29610815553, 18059.458216253533, 18095.276188952295, 18198.181081851613, 41721.79139104285, 42423.15153696847, 42851.0, 42964.570354296055, 44070.11859762851, 58842.41157588369, 63068.36931630625, 63961.36038639554, 64300.0, 65784.34215657783, 7670.8082297943, 8075.878861817195, 8076.4750291230885, 8525.44584601999, 9011.549422528717, 10578.0, 10865.891341086804, 13603.115797473132, 14126.858731412554, 14510.927445362706, 12491.500339986662, 12751.426185821845, 12789.93605031969, 12923.095383323078, 13014.4143513544, 11962.222455540363, 12043.217190882564, 12184.51261949512, 12405.193662411913, 13111.737765244832, 6366.681665916778, 10477.742670879543, 10640.680779576625, 12815.871841281469, 12997.545085922326, 7466.514676546007, 7636.579988100708, 7756.612169391621, 8780.473171609723, 9159.633614655339, 8581.570921454027, 11348.375839328915, 11453.656390308304, 11831.940840295743, 11948.0], "value": 9581.442993010345, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.5000774701748, 1463.817022872141, 1488.5162322245271, 1592.2277695317775, 1779.9288028478861, 8102.351811855045, 8440.45137066091, 8449.324054075674, 8656.697015604455, 8663.826723465527, 8455.112213217615, 8642.91357086429, 8649.956750216255, 8653.826923461527, 8669.739907802776, 2044.417341057799, 2249.1228420915854, 2269.2965180793926, 2289.8168146548237, 2327.662488939103, 2304.274153641606, 2304.83866129371, 2306.8961896714686, 2309.0763694522243, 2310.838241323108, 2226.532428190082, 2265.422317309084, 2270.3529494094187, 2271.636538153896, 2319.7912187903084, 1979.762428508581, 2135.5515341778246, 2199.857009294407, 2210.8452408331423, 2226.3209721035078, 2271.4094335472732, 2287.553926984239, 2289.713785776778, 2290.1526435218907, 2292.106078629336, 8899.199072083544, 9001.50491722955, 9013.18881300686, 9017.278617710568, 9024.8646270306, 5197.974010129925, 5357.946420535823, 5358.490943360374, 5363.302770639831, 5370.731463426852, 3194.3291908699202, 3257.2671148991526, 3331.783434076777, 3342.8495717692763, 3349.5478110455265, 1050.2385770316537, 1054.7574057966633, 1072.0780129088978, 1073.897979691928, 1079.7624522605015, 12647.683807904785, 12709.491620335268, 12735.108542402035, 12737.55418560346, 12747.872521274761, 4617.053504031665, 4618.907621847544, 4778.665493415428, 4803.735794531264, 4824.445188803333, 10584.0, 10589.470526473646, 10591.0, 10592.841107383396, 10606.257561970588, 5352.384475785335, 5369.543588794996, 5371.6508426952905, 5373.811916582901, 5388.084025715638, 4352.2818734909015, 4732.692374995614, 4867.196912509467, 4875.293082503017, 4962.33008543842, 4044.7977601120415, 4068.4914385701786, 4096.705844726963, 4108.6918481114035, 4146.730462519927, 1138.408027825526, 1221.3343727668441, 1235.9814602780966, 1251.2429979862234, 1273.9745205095846, 1028.5165971993151, 1032.0866033560203, 1032.6282538286212, 1043.4261156363968, 1044.9791004180026, 6047.667378294236, 6107.144999700045, 6331.240251169889, 6404.7117879695525, 6454.128692626529, 983.8622592837008, 1011.4726762588398, 1016.6136867990116, 1027.0448482910965, 1032.6695457453693, 4304.0, 4312.417823593837, 4380.2772542530765, 4496.797644106023, 4503.166914120898, 10926.672199834018, 11285.0, 11389.259698119597, 11393.886061139448, 11399.088072954144, 11261.436928153724, 11271.492782824793, 11284.0, 11285.153613479022, 11289.887101129048, 8034.15641357649, 8373.120822313569, 8397.538135402488, 8432.662693492191, 8491.83016339682, 6234.2830574484515, 6453.741850325934, 6511.609303441809, 6572.0, 6579.736810527716, 10273.0, 10411.427371494641, 10416.479176041319, 10524.210684198868, 10551.683449496528, 9628.614855405705, 10244.590216391261, 10634.468276586294, 10666.679999600025, 10695.0, 7814.179511151247, 8010.719624813103, 8088.87866682012, 8105.716299929474, 8110.959445202736, 8367.246947774729, 8655.913440865763, 8676.609552570024, 8712.477251364939, 8714.215720584923, 6621.304763000008, 7845.725399610987, 7911.485753426239, 7920.603969801372, 8037.638306276114, 7719.92280077192, 7831.84336313282, 7839.686412543434, 8026.317762990211, 8047.959760201162, 7165.283471652793, 7166.426685865014, 7188.424926005802, 7230.168530619047, 7316.8536629266055, 5212.270282160424, 5349.732513374393, 5385.8114965976, 5441.319835020622, 5572.192032155396, 5425.782968681208, 5441.020616289106, 5484.232207491034, 5494.1758736189895, 5501.834944951658], "value": 4710.012367793814, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.284168300678, 335.57214551446907, 344.5245561125646, 344.6381299635384, 344.7896782962392, 5183.792648294068, 5233.984915807413, 5255.0, 5265.499777521139, 5270.262163297141, 5211.791528338871, 5213.139831927737, 5216.478352164781, 5225.425203227652, 5236.423993360737, 3923.117298607812, 3986.8405263789414, 4133.462649855514, 4158.688098392618, 4161.812718427678, 4113.547509773923, 4129.4012368206595, 4139.730917490354, 4148.79256037197, 4155.587100385868, 3941.4481972523868, 4120.1553681495225, 4122.42286079949, 4127.277726397883, 4132.318167502359, 3937.606239376068, 4074.2055299216663, 4087.1607776500396, 4091.4067460218253, 4104.651104656078, 3641.3809652359164, 3655.7623754455876, 3661.340958627446, 3677.3748462761396, 3679.5400574928135, 5080.542751152414, 5090.389153301628, 5090.974545127251, 5101.617378696613, 5106.591472682177, 4523.638108951276, 4684.648651351163, 4689.9765501172615, 4700.929486057712, 4712.69367491112, 5360.973195133999, 5396.43337449566, 5416.350037995466, 5421.0, 5421.457854214586, 3994.2610617035944, 4007.358822588401, 4007.979960100181, 4018.6383225509844, 4029.979850100731, 5406.972965135149, 5654.264945557051, 5662.292213473316, 5692.743826527816, 5695.772169113272, 4030.8186131624147, 4039.6162364575316, 4042.5351084625645, 4049.1294371710223, 4051.47330846988, 4068.7355321903983, 4072.205919845661, 4091.4476545665952, 4093.2603643451416, 4102.548719640837, 4371.562843715603, 4593.563611456906, 4600.1949658810245, 4609.631229501631, 4626.514216007271, 5409.43200963901, 5465.453454654503, 5471.179323101487, 5473.934596625822, 5474.890502189934, 1382.3917476310392, 1383.163186272311, 1393.958181254564, 1396.0995158122953, 1397.9720405592034, 890.3633901760272, 914.4741773480142, 920.8480600700943, 954.3176628710505, 959.7168835193635, 5292.153255479105, 5308.654937429054, 5308.9734551327765, 5309.867253318621, 5325.094733895247, 5522.950639378505, 5529.557635389159, 5541.639793413496, 5542.91685624716, 5550.139728342114, 5169.870753231199, 5242.266082748418, 5260.421873437953, 5290.867728306746, 5296.602754793406, 2916.824990500534, 2930.956035659467, 2956.216602600313, 2961.363306889029, 2974.7917645764587, 5504.91742623861, 5699.373068962411, 5709.200711900337, 5745.683987380734, 5760.567957403212, 5532.612717109844, 5596.58025648078, 5609.6353737007785, 5617.38208797032, 5658.830235092953, 5700.201971723962, 5719.571032172604, 5747.5114615257335, 5760.884782304331, 5775.566832487664, 5315.654482458783, 5457.481539253765, 5546.72266386671, 5562.332520097614, 5565.916511252253, 5443.755031023535, 5465.672059676433, 5501.724913754377, 5511.834644960658, 5520.282363292747, 5682.488576028178, 5714.828555143353, 5720.8558288341665, 5734.197212390185, 5736.598438109292, 3794.905127371838, 3906.921861562696, 3918.5101862267215, 3922.941155882607, 3927.7250592459395, 5457.945420545902, 5471.261379713687, 5494.911933465258, 5502.222666200393, 5510.641808282448, 5341.866453338697, 5381.4169198785585, 5390.595705322038, 5391.865203369947, 5394.163904594794, 5143.974280128576, 5364.275822763877, 5374.919376209438, 5384.784608615768, 5387.784488620411, 5175.844724658266, 5205.375354957429, 5301.6818990860675, 5308.362996440452, 5334.973325133349, 5482.945170548243, 5494.862628434321, 5523.4200408956485, 5538.141588053858, 5542.972285138549, 5379.569634429315, 5386.622936394571, 5388.622796404214, 5409.810656626999, 5412.269343638558], "value": 4165.221386218771, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.9331360177583, 762.3977058124084, 772.0349563046192, 794.2018271637004, 813.178689523581, 15033.173175475344, 15700.37198512058, 15707.92146039271, 15757.0, 15777.842221577795, 14466.349014294356, 14528.927355363236, 14620.415183392652, 14629.487967921124, 14646.0, 646.0761111610395, 784.1256998446719, 823.950562966224, 826.2357319479487, 826.983460330793, 812.0499016151088, 815.135955886762, 818.5129847740585, 818.5457071325412, 818.8198596308803, 688.187938232885, 869.5391442535466, 874.1782724239195, 878.363186689648, 880.3881302494736, 710.3322876496103, 715.3454589051012, 819.7663665855232, 854.0562678240517, 858.4034096303072, 630.8328293002312, 631.2141383976978, 631.6178711879293, 631.649434563817, 631.8167731357901, 15281.235938203044, 15331.616709582238, 15347.539573812803, 15357.232138393147, 15365.0, 14448.638784030378, 14477.565673029825, 14527.418903243857, 14653.120812751162, 14700.779488307684, 12939.765058735316, 13244.602661920158, 13262.66843328915, 13374.799378009338, 13760.105593136414, 4450.26570615848, 4480.103979204139, 4480.126375356806, 4502.549745025504, 4576.993061526492, 73569.0, 74652.25347746507, 74730.0, 75285.0, 77969.22030779732, 10964.396958167377, 10992.945035274772, 11138.49876755548, 11192.832107518394, 11371.601993930339, 20186.899065504578, 20200.393988180378, 20213.292534761214, 20244.696329555067, 20270.89864550697, 8234.711785087493, 8347.66609335632, 8378.287845533076, 8450.323974082059, 8556.443831150955, 4569.109023740405, 4575.794089265991, 4639.489656137822, 4725.4565724941385, 4822.9758851205515, 3230.0632816483426, 3338.8998330050135, 3340.8329583521213, 3344.515045318415, 3346.0798280473064, 533.2028617217285, 582.8289621161141, 588.7144734803617, 594.2304715393576, 615.3569519851766, 629.5058379172327, 671.9496037797185, 699.776071657075, 753.4499815134982, 767.7082708570707, 10115.167753029164, 10237.846432303522, 10251.0, 10274.22943279257, 10555.947220264003, 701.3757755597522, 768.2100705356506, 774.3379410603965, 783.5455435847194, 804.7786858613928, 4840.2255639097575, 5074.314967479417, 5105.33630628016, 5114.130597798383, 5197.818076367309, 68879.65560172267, 85405.14594854096, 110092.4495377534, 115895.0, 116042.41978790221, 103589.48205258926, 105577.0, 107405.46297268463, 109069.45465272781, 109181.0, 54650.0, 55554.0, 63862.36137638657, 84689.0, 89193.55403222943, 9633.277504187354, 9700.466474343697, 9707.174890134418, 9715.46564938935, 9718.465484398426, 50055.0, 51173.488265116874, 51320.74339628278, 51833.7408312956, 52346.73826630843, 76111.61944190244, 76864.23135768571, 77672.61163694145, 78461.0, 78934.605326973, 12049.036077113635, 12125.75748485043, 12417.379131043592, 12488.0, 12854.55009074678, 13588.93205533966, 13692.110012849133, 14161.929190353982, 14617.269136543344, 14709.852901470847, 13066.085374024107, 13416.932915335752, 13487.797683034958, 13564.660883477993, 14113.153210807384, 12947.870521294666, 12977.41601627948, 13243.536476223286, 13561.593152205449, 13692.315384230948, 13147.474101035852, 13790.586282411543, 13860.653483662989, 13869.306534673427, 13960.720785584028, 10407.479626018518, 10620.582393469878, 10807.35155890649, 10831.187660925305, 10935.945320273666, 10540.683779486628, 11210.607628732956, 11283.266587671775, 11508.53965841357, 11573.305601663928], "value": 7515.517814026876, "unit": "score"}], "name": "dromaeo_css", "value": 7251.339502915681, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 112.0, 111.0, 111.0, 108.0, 109.0, 108.0, 110.0, 109.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 118.0, 119.0, 171.0, 119.0, 118.0, 143.0, 117.0, 159.0, 117.0], "value": 132.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 161.0, 162.0, 161.0, 160.0, 162.0, 160.0, 160.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 76.0, 130.0, 75.0, 76.0, 73.0, 75.0, 107.0, 74.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 111.0, 84.0, 84.0, 84.0, 116.0, 82.0, 83.0, 130.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 54.0, 54.0, 54.0, 55.0, 54.0, 54.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 63.0, 62.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 74.0, 75.0, 80.0, 75.0, 83.0, 75.0, 75.0, 79.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 121.0, 118.0, 121.0, 120.0, 119.0, 131.0, 119.0, 163.0, 128.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 155.0, 159.0, 156.0, 157.0, 156.0, 159.0, 156.0, 155.0, 155.0], "value": 156.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 62.0, 61.0, 62.0, 60.0, 61.0, 62.0, 64.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1474.1, "alertThreshold": 2.0}]} 00:00:14 INFO - Return code: 0 00:00:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:00:14 INFO - # TBPL SUCCESS # 00:00:14 INFO - Running post-action listener: _resource_record_post_action 00:00:14 INFO - ##### 00:00:14 INFO - ##### Finished run-tests step (success) 00:00:14 INFO - ##### 00:00:14 INFO - Running post-run listener: _resource_record_post_run 00:00:14 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 559390720; Read time: 0; Write time: 929272 00:00:14 INFO - TinderboxPrint: CPU usage
13.0% 00:00:14 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 00:00:14 INFO - TinderboxPrint: I/O write bytes / time
559,390,720 / 929,272 00:00:14 INFO - TinderboxPrint: CPU idle
8,284.4 (87.0%) 00:00:14 INFO - TinderboxPrint: CPU user
1,187.6 (12.5%) 00:00:14 INFO - TinderboxPrint: Swap in / out
0 / 0 00:00:14 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 263335936; Read time: 0; Write time: 542460 00:00:14 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 294805504; Read time: 0; Write time: 386760 00:00:14 INFO - Running post-run listener: _upload_blobber_files 00:00:14 INFO - Blob upload gear active. 00:00:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:00:14 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 00:00:14 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'] 00:00:14 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 00:00:15 INFO - (blobuploader) - INFO - Open directory for files ... 00:00:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:00:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:00:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:00:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:00:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:00:19 INFO - (blobuploader) - INFO - Done attempting. 00:00:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:00:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:00:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:00:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:00:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:00:20 INFO - (blobuploader) - INFO - Done attempting. 00:00:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:00:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:00:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:00:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:00:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:00:20 INFO - (blobuploader) - INFO - Done attempting. 00:00:20 INFO - (blobuploader) - INFO - Iteration through files over. 00:00:20 INFO - Return code: 0 00:00:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:00:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:00:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b8887a3844b66b9700d3c058f3e16c1fd7b723360f50a7443cb595d8bb4f58b546ef2bdcf30da8cfba30104af9f47bf62bc1592d6ce510138cedb27b5d20fd0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f749c21b5c10e043fef72d6a23b63773582e96a59378aab8055eb52bc2e4260ea02986903e9875e87cf397b0cb80236328e03fa19f348b9bf1da2f2cab4176bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9af2800c467d0ee162193e66b0f695feb1fe347358512fe4d4fb5b356c5c88e2dd485c605ba68534e94dcb6b3d31264ccf9fb9d15425e0197adfeb896ec26e4"} 00:00:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:00:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:00:20 INFO - Contents: 00:00:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b8887a3844b66b9700d3c058f3e16c1fd7b723360f50a7443cb595d8bb4f58b546ef2bdcf30da8cfba30104af9f47bf62bc1592d6ce510138cedb27b5d20fd0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f749c21b5c10e043fef72d6a23b63773582e96a59378aab8055eb52bc2e4260ea02986903e9875e87cf397b0cb80236328e03fa19f348b9bf1da2f2cab4176bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9af2800c467d0ee162193e66b0f695feb1fe347358512fe4d4fb5b356c5c88e2dd485c605ba68534e94dcb6b3d31264ccf9fb9d15425e0197adfeb896ec26e4"} 00:00:20 INFO - Running post-run listener: copy_logs_to_upload_dir 00:00:20 INFO - Copying logs to upload dir... 00:00:20 INFO - mkdir: /builds/slave/test/build/upload/logs 00:00:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.910627 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-09 00:00:20.781406) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 00:00:20.784974) ========= 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=af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739 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/b8887a3844b66b9700d3c058f3e16c1fd7b723360f50a7443cb595d8bb4f58b546ef2bdcf30da8cfba30104af9f47bf62bc1592d6ce510138cedb27b5d20fd0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f749c21b5c10e043fef72d6a23b63773582e96a59378aab8055eb52bc2e4260ea02986903e9875e87cf397b0cb80236328e03fa19f348b9bf1da2f2cab4176bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9af2800c467d0ee162193e66b0f695feb1fe347358512fe4d4fb5b356c5c88e2dd485c605ba68534e94dcb6b3d31264ccf9fb9d15425e0197adfeb896ec26e4"} build_url:https://queue.taskcluster.net/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/GuK9A80mQHKmHNR3Bz6V9w/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/b8887a3844b66b9700d3c058f3e16c1fd7b723360f50a7443cb595d8bb4f58b546ef2bdcf30da8cfba30104af9f47bf62bc1592d6ce510138cedb27b5d20fd0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f749c21b5c10e043fef72d6a23b63773582e96a59378aab8055eb52bc2e4260ea02986903e9875e87cf397b0cb80236328e03fa19f348b9bf1da2f2cab4176bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9af2800c467d0ee162193e66b0f695feb1fe347358512fe4d4fb5b356c5c88e2dd485c605ba68534e94dcb6b3d31264ccf9fb9d15425e0197adfeb896ec26e4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 00:00:20.810464) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 00:00:20.810811) ========= 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=af724c981e2a0f424dbabf99000001e7-1468046183.830794-437556739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 00:00:20.896268) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 00:00:20.898452) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 00:00:20.898782) ========= ========= Total master_lag: 0.24 =========