builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1468229523.59 results: success (0) buildid: 20160711010827 builduid: b4451fd79b08490c92abd273c7187717 revision: 1de829f2f1f03e23ca0159bee473d36b9989e62b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 02:32:03.590413) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 02:32:03.590903) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 02:32:03.591236) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 02:32:03.613701) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 02:32:03.614096) ========= 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=8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 02:32:04-- 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% 46.8M=0s 2016-07-11 02:32:04 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135392 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 02:32:03.774390) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 02:32:03.774729) ========= 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=8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.107567 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 02:32:03.893754) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-11 02:32:03.894123) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1de829f2f1f03e23ca0159bee473d36b9989e62b --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 1de829f2f1f03e23ca0159bee473d36b9989e62b --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=8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 02:32:04,378 truncating revision to first 12 chars 2016-07-11 02:32:04,378 Setting DEBUG logging. 2016-07-11 02:32:04,378 attempt 1/10 2016-07-11 02:32:04,378 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1de829f2f1f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 02:32:05,271 unpacking tar archive at: fx-team-1de829f2f1f0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.249561 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-11 02:32:05.157941) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 02:32:05.158296) ========= script_repo_revision: 1de829f2f1f03e23ca0159bee473d36b9989e62b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 02:32:05.158723) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 02:32:05.159000) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 02:32:05.168478) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 43 secs) (at 2016-07-11 02:32:05.168804) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:32:05 INFO - MultiFileLogger online at 20160711 02:32:05 in /builds/slave/test 02:32:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:32:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:32:05 INFO - {'append_to_log': False, 02:32:05 INFO - 'base_work_dir': '/builds/slave/test', 02:32:05 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:32:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:32:05 INFO - 'branch': 'Fx-Team-Non-PGO', 02:32:05 INFO - 'buildbot_json_path': 'buildprops.json', 02:32:05 INFO - 'config_files': ('talos/linux_config.py',), 02:32:05 INFO - 'default_actions': ('clobber', 02:32:05 INFO - 'read-buildbot-config', 02:32:05 INFO - 'download-and-extract', 02:32:05 INFO - 'populate-webroot', 02:32:05 INFO - 'create-virtualenv', 02:32:05 INFO - 'install', 02:32:05 INFO - 'run-tests'), 02:32:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:32:05 INFO - 'download_minidump_stackwalk': True, 02:32:05 INFO - 'download_symbols': 'ondemand', 02:32:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:32:05 INFO - 'tooltool.py': '/tools/tooltool.py', 02:32:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:32:05 INFO - '/tools/misc-python/virtualenv.py')}, 02:32:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:32:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:32:05 INFO - 'installer_path': 'installer.exe', 02:32:05 INFO - 'log_level': 'info', 02:32:05 INFO - 'log_name': 'talos', 02:32:05 INFO - 'log_to_console': True, 02:32:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:32:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:32:05 INFO - 'opt_config_files': (), 02:32:05 INFO - 'pip_index': False, 02:32:05 INFO - 'sps_profile': False, 02:32:05 INFO - 'sps_profile_interval': 0, 02:32:05 INFO - 'suite': 'dromaeojs', 02:32:05 INFO - 'system_bits': '32', 02:32:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:32:05 INFO - 'title': 'talos-linux64-ix-001', 02:32:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:32:05 INFO - 'use_talos_json': True, 02:32:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:32:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:32:05 INFO - 'work_dir': 'build'} 02:32:05 INFO - ##### 02:32:05 INFO - ##### Running clobber step. 02:32:05 INFO - ##### 02:32:05 INFO - Running pre-action listener: _resource_record_pre_action 02:32:05 INFO - Running main action method: clobber 02:32:05 INFO - rmtree: /builds/slave/test/build 02:32:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:32:06 INFO - Running post-action listener: _resource_record_post_action 02:32:06 INFO - ##### 02:32:06 INFO - ##### Finished clobber step (success) 02:32:06 INFO - ##### 02:32:06 INFO - ##### 02:32:06 INFO - ##### Running read-buildbot-config step. 02:32:06 INFO - ##### 02:32:06 INFO - Running pre-action listener: _resource_record_pre_action 02:32:06 INFO - Running main action method: read_buildbot_config 02:32:06 INFO - Using buildbot properties: 02:32:06 INFO - { 02:32:06 INFO - "project": "", 02:32:06 INFO - "product": "firefox", 02:32:06 INFO - "script_repo_revision": "production", 02:32:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:32:06 INFO - "repository": "", 02:32:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:32:06 INFO - "buildid": "20160711010827", 02:32:06 INFO - "pgo_build": "False", 02:32:06 INFO - "basedir": "/builds/slave/test", 02:32:06 INFO - "buildnumber": 1797, 02:32:06 INFO - "slavename": "talos-linux64-ix-001", 02:32:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:32:06 INFO - "platform": "ubuntu64_hw", 02:32:06 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:32:06 INFO - "branch": "fx-team", 02:32:06 INFO - "repo_path": "integration/fx-team", 02:32:06 INFO - "revision": "1de829f2f1f03e23ca0159bee473d36b9989e62b", 02:32:06 INFO - "stage_platform": "linux64", 02:32:06 INFO - "builduid": "b4451fd79b08490c92abd273c7187717", 02:32:06 INFO - "slavebuilddir": "test" 02:32:06 INFO - } 02:32:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:32:06 INFO - Running post-action listener: _resource_record_post_action 02:32:06 INFO - ##### 02:32:06 INFO - ##### Finished read-buildbot-config step (success) 02:32:06 INFO - ##### 02:32:06 INFO - ##### 02:32:06 INFO - ##### Running download-and-extract step. 02:32:06 INFO - ##### 02:32:06 INFO - Running pre-action listener: _resource_record_pre_action 02:32:06 INFO - Running main action method: download_and_extract 02:32:06 INFO - mkdir: /builds/slave/test/build/tests 02:32: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')]} 02:32:06 INFO - https://queue.taskcluster.net/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:32:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:32:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:32:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:32:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:32:07 INFO - Downloaded 1361 bytes. 02:32:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:32:07 INFO - Using the following test package requirements: 02:32:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:32:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:32:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:32:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:07 INFO - u'jsshell-linux-x86_64.zip'], 02:32:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:32:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:32:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:32:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:32:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:32:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:32:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:07 INFO - https://queue.taskcluster.net/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:32:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:32:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:32:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:32:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:32:08 INFO - Downloaded 22735150 bytes. 02:32:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:32:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:32:10 INFO - Return code: 0 02:32:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:10 INFO - https://queue.taskcluster.net/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:32:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:32:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:32:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:32:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:32:11 INFO - Downloaded 22735150 bytes. 02:32:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:32:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:32:12 INFO - Return code: 0 02:32: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')]} 02:32:12 INFO - https://queue.taskcluster.net/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:32:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:32:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:32:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:32:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:32:13 INFO - Downloaded 14403333 bytes. 02:32:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:32:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:32:13 INFO - Return code: 0 02:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:13 INFO - https://queue.taskcluster.net/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:32:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:32:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:32:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:32:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:32:46 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2: The read operation timed out 02:32:46 INFO - retry: attempt #1 caught exception: The read operation timed out 02:32:46 INFO - retry: Failed, sleeping 30 seconds before retrying 02:33:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOI6Ot6wQhuGehkkWS-OaA/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 #2 02:33:17 INFO - Downloaded 56659644 bytes. 02:33:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:33:17 INFO - mkdir: /builds/slave/test/properties 02:33:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:33:17 INFO - Writing to file /builds/slave/test/properties/build_url 02:33:17 INFO - Contents: 02:33:17 INFO - build_url:https://queue.taskcluster.net/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:33:18 INFO - Running post-action listener: _resource_record_post_action 02:33:18 INFO - Running post-action listener: set_extra_try_arguments 02:33:18 INFO - ##### 02:33:18 INFO - ##### Finished download-and-extract step (success) 02:33:18 INFO - ##### 02:33:18 INFO - ##### 02:33:18 INFO - ##### Running populate-webroot step. 02:33:18 INFO - ##### 02:33:18 INFO - Running pre-action listener: _resource_record_pre_action 02:33:18 INFO - Running main action method: populate_webroot 02:33:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:33:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:33:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:33:18 INFO - '--tppagecycles', 02:33:18 INFO - '7'], 02:33:18 INFO - 'tests': ['tsvgm']}}, 02:33:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:33:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:33:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:33:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:33:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:33:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:33:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:18 INFO - 'talos_options': ['--disable-e10s'], 02:33:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:33:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:33:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:18 INFO - 'talos_options': ['--disable-e10s'], 02:33:18 INFO - 'tests': ['damp', 'tps']}, 02:33:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:18 INFO - 'tests': ['damp', 'tps']}, 02:33:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:33:18 INFO - 'tests': ['dromaeo_dom']}, 02:33:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:33:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:33:18 INFO - 'tests': ['basic_compositor_video']}, 02:33:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:33:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:33:18 INFO - 'tests': ['a11yr', 02:33:18 INFO - 'ts_paint', 02:33:18 INFO - 'tpaint', 02:33:18 INFO - 'sessionrestore', 02:33:18 INFO - 'sessionrestore_no_auto_restore', 02:33:18 INFO - 'tabpaint']}, 02:33:18 INFO - 'other-e10s': {'tests': ['a11yr', 02:33:18 INFO - 'ts_paint', 02:33:18 INFO - 'tpaint', 02:33:18 INFO - 'sessionrestore', 02:33:18 INFO - 'sessionrestore_no_auto_restore', 02:33:18 INFO - 'tabpaint']}, 02:33:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:33:18 INFO - 'ts_paint', 02:33:18 INFO - 'tpaint', 02:33:18 INFO - 'sessionrestore', 02:33:18 INFO - 'sessionrestore_no_auto_restore', 02:33:18 INFO - 'tabpaint']}, 02:33:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:33:18 INFO - 'ts_paint', 02:33:18 INFO - 'tpaint', 02:33:18 INFO - 'sessionrestore', 02:33:18 INFO - 'sessionrestore_no_auto_restore', 02:33:18 INFO - 'tabpaint']}, 02:33:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:33:18 INFO - 'tests': ['a11yr', 02:33:18 INFO - 'ts_paint', 02:33:18 INFO - 'tpaint', 02:33:18 INFO - 'sessionrestore', 02:33:18 INFO - 'sessionrestore_no_auto_restore', 02:33:18 INFO - 'tabpaint']}, 02:33:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:33:18 INFO - 'tests': ['a11yr', 02:33:18 INFO - 'ts_paint', 02:33:18 INFO - 'tpaint', 02:33:18 INFO - 'sessionrestore', 02:33:18 INFO - 'sessionrestore_no_auto_restore', 02:33:18 INFO - 'tabpaint']}, 02:33:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:33:18 INFO - 'tests': ['tsvgx', 02:33:18 INFO - 'tsvgr_opacity', 02:33:18 INFO - 'tart', 02:33:18 INFO - 'tscrollx', 02:33:18 INFO - 'cart']}, 02:33:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:33:18 INFO - 'tsvgr_opacity', 02:33:18 INFO - 'tart', 02:33:18 INFO - 'tscrollx', 02:33:18 INFO - 'cart']}, 02:33:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:18 INFO - 'talos_options': ['--disable-e10s'], 02:33:18 INFO - 'tests': ['tp5o']}, 02:33:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:18 INFO - 'tests': ['tp5o']}, 02:33:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:18 INFO - 'talos_options': ['--disable-e10s', 02:33:18 INFO - '--xperf_path', 02:33:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:33:18 INFO - 'tests': ['tp5n']}, 02:33:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:18 INFO - 'talos_options': ['--xperf_path', 02:33:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:33:18 INFO - 'tests': ['tp5n']}}, 02:33:18 INFO - 'talos.zip': {'path': '', 02:33:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:33:18 INFO - Running post-action listener: _resource_record_post_action 02:33:18 INFO - ##### 02:33:18 INFO - ##### Finished populate-webroot step (success) 02:33:18 INFO - ##### 02:33:18 INFO - ##### 02:33:18 INFO - ##### Running create-virtualenv step. 02:33:18 INFO - ##### 02:33:18 INFO - Running pre-action listener: _resource_record_pre_action 02:33:18 INFO - Running main action method: create_virtualenv 02:33:18 INFO - Creating virtualenv /builds/slave/test/build/venv 02:33:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:33:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:33:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:33:18 INFO - Using real prefix '/usr' 02:33:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:33:19 INFO - Installing distribute.............................................................................................................................................................................................done. 02:33:21 INFO - Installing pip.................done. 02:33:21 INFO - Return code: 0 02:33:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111c3b0>, '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 0x111d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111d740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:33:21 INFO - Using env: {'DISPLAY': ':0', 02:33:21 INFO - 'HOME': '/home/cltbld', 02:33:21 INFO - 'LANG': 'en_US.UTF-8', 02:33:21 INFO - 'LANGUAGE': 'en_US:en', 02:33:21 INFO - 'LOGNAME': 'cltbld', 02:33:21 INFO - 'MAIL': '/var/mail/cltbld', 02:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:21 INFO - 'MOZ_NO_REMOTE': '1', 02:33:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:21 INFO - 'NO_EM_RESTART': '1', 02:33:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:21 INFO - 'PWD': '/builds/slave/test', 02:33:21 INFO - 'SHELL': '/bin/bash', 02:33:21 INFO - 'SHLVL': '1', 02:33:21 INFO - 'TERM': 'linux', 02:33:21 INFO - 'TMOUT': '86400', 02:33:21 INFO - 'USER': 'cltbld', 02:33:21 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491', 02:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:21 INFO - '_': '/tools/buildbot/bin/python'} 02:33:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:33:21 INFO - Cleaning up... 02:33:21 INFO - Return code: 0 02:33:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe5d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111c3b0>, '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 0x111d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111d740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:33:21 INFO - Using env: {'DISPLAY': ':0', 02:33:21 INFO - 'HOME': '/home/cltbld', 02:33:21 INFO - 'LANG': 'en_US.UTF-8', 02:33:21 INFO - 'LANGUAGE': 'en_US:en', 02:33:21 INFO - 'LOGNAME': 'cltbld', 02:33:21 INFO - 'MAIL': '/var/mail/cltbld', 02:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:21 INFO - 'MOZ_NO_REMOTE': '1', 02:33:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:21 INFO - 'NO_EM_RESTART': '1', 02:33:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:21 INFO - 'PWD': '/builds/slave/test', 02:33:21 INFO - 'SHELL': '/bin/bash', 02:33:21 INFO - 'SHLVL': '1', 02:33:21 INFO - 'TERM': 'linux', 02:33:21 INFO - 'TMOUT': '86400', 02:33:21 INFO - 'USER': 'cltbld', 02:33:21 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491', 02:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:21 INFO - '_': '/tools/buildbot/bin/python'} 02:33:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:21 INFO - Downloading/unpacking psutil>=3.1.1 02:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:33:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:33:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:33:23 INFO - Installing collected packages: psutil 02:33:23 INFO - Running setup.py install for psutil 02:33:23 INFO - building 'psutil._psutil_linux' extension 02:33:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:33:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:33:24 INFO - building 'psutil._psutil_posix' extension 02:33:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:33:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:33:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:33:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:33:25 INFO - Successfully installed psutil 02:33:25 INFO - Cleaning up... 02:33:25 INFO - Return code: 0 02:33:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111c3b0>, '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 0x111d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111d740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:33:25 INFO - Using env: {'DISPLAY': ':0', 02:33:25 INFO - 'HOME': '/home/cltbld', 02:33:25 INFO - 'LANG': 'en_US.UTF-8', 02:33:25 INFO - 'LANGUAGE': 'en_US:en', 02:33:25 INFO - 'LOGNAME': 'cltbld', 02:33:25 INFO - 'MAIL': '/var/mail/cltbld', 02:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:25 INFO - 'MOZ_NO_REMOTE': '1', 02:33:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:25 INFO - 'NO_EM_RESTART': '1', 02:33:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:25 INFO - 'PWD': '/builds/slave/test', 02:33:25 INFO - 'SHELL': '/bin/bash', 02:33:25 INFO - 'SHLVL': '1', 02:33:25 INFO - 'TERM': 'linux', 02:33:25 INFO - 'TMOUT': '86400', 02:33:25 INFO - 'USER': 'cltbld', 02:33:25 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491', 02:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:25 INFO - '_': '/tools/buildbot/bin/python'} 02:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:33:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:33:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:33:27 INFO - Installing collected packages: mozsystemmonitor 02:33:27 INFO - Running setup.py install for mozsystemmonitor 02:33:27 INFO - Successfully installed mozsystemmonitor 02:33:27 INFO - Cleaning up... 02:33:27 INFO - Return code: 0 02:33:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:33:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111c3b0>, '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 0x111d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111d740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:33:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:33:27 INFO - Using env: {'DISPLAY': ':0', 02:33:27 INFO - 'HOME': '/home/cltbld', 02:33:27 INFO - 'LANG': 'en_US.UTF-8', 02:33:27 INFO - 'LANGUAGE': 'en_US:en', 02:33:27 INFO - 'LOGNAME': 'cltbld', 02:33:27 INFO - 'MAIL': '/var/mail/cltbld', 02:33:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:27 INFO - 'MOZ_NO_REMOTE': '1', 02:33:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:27 INFO - 'NO_EM_RESTART': '1', 02:33:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:27 INFO - 'PWD': '/builds/slave/test', 02:33:27 INFO - 'SHELL': '/bin/bash', 02:33:27 INFO - 'SHLVL': '1', 02:33:27 INFO - 'TERM': 'linux', 02:33:27 INFO - 'TMOUT': '86400', 02:33:27 INFO - 'USER': 'cltbld', 02:33:27 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491', 02:33:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:27 INFO - '_': '/tools/buildbot/bin/python'} 02:33:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:27 INFO - Downloading/unpacking jsonschema==2.5.1 02:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:33:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:29 INFO - Downloading functools32-3.2.3-2.tar.gz 02:33:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:33:29 INFO - warning: no files found matching '*.txt' 02:33:29 INFO - no previously-included directories found matching 'build' 02:33:29 INFO - no previously-included directories found matching 'dist' 02:33:29 INFO - no previously-included directories found matching '.git*' 02:33:29 INFO - Installing collected packages: jsonschema, functools32 02:33:30 INFO - Running setup.py install for functools32 02:33:30 INFO - warning: no files found matching '*.txt' 02:33:30 INFO - no previously-included directories found matching 'build' 02:33:30 INFO - no previously-included directories found matching 'dist' 02:33:30 INFO - no previously-included directories found matching '.git*' 02:33:30 INFO - Successfully installed jsonschema functools32 02:33:30 INFO - Cleaning up... 02:33:30 INFO - Return code: 0 02:33:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111c3b0>, '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 0x111d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111d740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:33:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:33:30 INFO - Using env: {'DISPLAY': ':0', 02:33:30 INFO - 'HOME': '/home/cltbld', 02:33:30 INFO - 'LANG': 'en_US.UTF-8', 02:33:30 INFO - 'LANGUAGE': 'en_US:en', 02:33:30 INFO - 'LOGNAME': 'cltbld', 02:33:30 INFO - 'MAIL': '/var/mail/cltbld', 02:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:30 INFO - 'MOZ_NO_REMOTE': '1', 02:33:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:30 INFO - 'NO_EM_RESTART': '1', 02:33:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:30 INFO - 'PWD': '/builds/slave/test', 02:33:30 INFO - 'SHELL': '/bin/bash', 02:33:30 INFO - 'SHLVL': '1', 02:33:30 INFO - 'TERM': 'linux', 02:33:30 INFO - 'TMOUT': '86400', 02:33:30 INFO - 'USER': 'cltbld', 02:33:30 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491', 02:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:30 INFO - '_': '/tools/buildbot/bin/python'} 02:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:30 INFO - Downloading/unpacking blobuploader==1.2.4 02:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:32 INFO - Downloading blobuploader-1.2.4.tar.gz 02:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:33:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:33:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:32 INFO - Downloading docopt-0.6.1.tar.gz 02:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:33:33 INFO - Installing collected packages: blobuploader, requests, docopt 02:33:33 INFO - Running setup.py install for blobuploader 02:33:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:33:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:33:33 INFO - Running setup.py install for requests 02:33:33 INFO - Running setup.py install for docopt 02:33:33 INFO - Successfully installed blobuploader requests docopt 02:33:33 INFO - Cleaning up... 02:33:33 INFO - Return code: 0 02:33:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111c3b0>, '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 0x111d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111d740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:33:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:33:33 INFO - Using env: {'DISPLAY': ':0', 02:33:33 INFO - 'HOME': '/home/cltbld', 02:33:33 INFO - 'LANG': 'en_US.UTF-8', 02:33:33 INFO - 'LANGUAGE': 'en_US:en', 02:33:33 INFO - 'LOGNAME': 'cltbld', 02:33:33 INFO - 'MAIL': '/var/mail/cltbld', 02:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:33 INFO - 'MOZ_NO_REMOTE': '1', 02:33:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:33 INFO - 'NO_EM_RESTART': '1', 02:33:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:33 INFO - 'PWD': '/builds/slave/test', 02:33:33 INFO - 'SHELL': '/bin/bash', 02:33:33 INFO - 'SHLVL': '1', 02:33:33 INFO - 'TERM': 'linux', 02:33:33 INFO - 'TMOUT': '86400', 02:33:33 INFO - 'USER': 'cltbld', 02:33:33 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491', 02:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:33 INFO - '_': '/tools/buildbot/bin/python'} 02:33:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:33 INFO - Running setup.py (path:/tmp/pip-szipSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:33 INFO - Running setup.py (path:/tmp/pip-OE09rF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:33 INFO - Running setup.py (path:/tmp/pip-EfCXSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:34 INFO - Running setup.py (path:/tmp/pip-UPLrqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:34 INFO - Running setup.py (path:/tmp/pip-GnhN4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:34 INFO - Running setup.py (path:/tmp/pip-lUKLGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:34 INFO - Running setup.py (path:/tmp/pip-aNvBHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:34 INFO - Running setup.py (path:/tmp/pip-fZnkFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:34 INFO - Running setup.py (path:/tmp/pip-GJbwY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:34 INFO - Running setup.py (path:/tmp/pip-mj25z9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:34 INFO - Running setup.py (path:/tmp/pip-oeuG32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:34 INFO - Running setup.py (path:/tmp/pip-oFJU9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:34 INFO - Running setup.py (path:/tmp/pip-ikdoKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:34 INFO - Running setup.py (path:/tmp/pip-lx6jwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:34 INFO - Running setup.py (path:/tmp/pip-WC9iF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:34 INFO - Running setup.py (path:/tmp/pip-fTqFPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:34 INFO - Running setup.py (path:/tmp/pip-pwJxBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:33:35 INFO - Running setup.py install for manifestparser 02:33:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:33:35 INFO - Running setup.py install for mozcrash 02:33:35 INFO - Running setup.py install for mozdebug 02:33:35 INFO - Running setup.py install for mozdevice 02:33:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:33:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:33:35 INFO - Running setup.py install for mozfile 02:33:35 INFO - Running setup.py install for mozhttpd 02:33:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:33:35 INFO - Running setup.py install for mozinfo 02:33:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:33:35 INFO - Running setup.py install for mozInstall 02:33:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:33:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:33:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:33:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:33:35 INFO - Running setup.py install for mozleak 02:33:35 INFO - Running setup.py install for mozlog 02:33:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:33:36 INFO - Running setup.py install for moznetwork 02:33:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:33:36 INFO - Running setup.py install for mozprocess 02:33:36 INFO - Running setup.py install for mozprofile 02:33:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:33:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:33:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:33:36 INFO - Running setup.py install for mozrunner 02:33:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:33:36 INFO - Running setup.py install for mozscreenshot 02:33:36 INFO - Running setup.py install for moztest 02:33:36 INFO - Running setup.py install for mozversion 02:33:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:33:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:33:36 INFO - Cleaning up... 02:33:36 INFO - Return code: 0 02:33:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111c3b0>, '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 0x111d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111d740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:33:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:33:36 INFO - Using env: {'DISPLAY': ':0', 02:33:36 INFO - 'HOME': '/home/cltbld', 02:33:36 INFO - 'LANG': 'en_US.UTF-8', 02:33:36 INFO - 'LANGUAGE': 'en_US:en', 02:33:36 INFO - 'LOGNAME': 'cltbld', 02:33:36 INFO - 'MAIL': '/var/mail/cltbld', 02:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:36 INFO - 'MOZ_NO_REMOTE': '1', 02:33:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:36 INFO - 'NO_EM_RESTART': '1', 02:33:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:36 INFO - 'PWD': '/builds/slave/test', 02:33:36 INFO - 'SHELL': '/bin/bash', 02:33:36 INFO - 'SHLVL': '1', 02:33:36 INFO - 'TERM': 'linux', 02:33:36 INFO - 'TMOUT': '86400', 02:33:36 INFO - 'USER': 'cltbld', 02:33:36 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491', 02:33:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:36 INFO - '_': '/tools/buildbot/bin/python'} 02:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:37 INFO - Running setup.py (path:/tmp/pip-kEJ9Zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:37 INFO - Running setup.py (path:/tmp/pip-HzAJhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:37 INFO - Running setup.py (path:/tmp/pip-jv5WXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:37 INFO - Running setup.py (path:/tmp/pip-FSpTMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:37 INFO - Running setup.py (path:/tmp/pip-NyknVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:37 INFO - Running setup.py (path:/tmp/pip-4Yvhzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:37 INFO - Running setup.py (path:/tmp/pip-faxcb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:37 INFO - Running setup.py (path:/tmp/pip-TBhU4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:37 INFO - Running setup.py (path:/tmp/pip-LPD01L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:37 INFO - Running setup.py (path:/tmp/pip-L8bgzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:37 INFO - Running setup.py (path:/tmp/pip-cK5wpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:37 INFO - Running setup.py (path:/tmp/pip-3t135O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:37 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)) 02:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:37 INFO - Running setup.py (path:/tmp/pip-X0iQ6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:38 INFO - Running setup.py (path:/tmp/pip-AehLze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:38 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)) 02:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:38 INFO - Running setup.py (path:/tmp/pip-4sfjvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:38 INFO - Running setup.py (path:/tmp/pip-C4YEqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:38 INFO - Running setup.py (path:/tmp/pip-4pFpHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:33:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:40 INFO - Downloading blessings-1.6.tar.gz 02:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:33:40 INFO - Installing collected packages: blessings 02:33:40 INFO - Running setup.py install for blessings 02:33:40 INFO - Successfully installed blessings 02:33:40 INFO - Cleaning up... 02:33:40 INFO - Return code: 0 02:33:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:33:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:40 INFO - Reading from file tmpfile_stdout 02:33:40 INFO - Current package versions: 02:33:40 INFO - argparse == 1.2.1 02:33:40 INFO - blessings == 1.6 02:33:40 INFO - blobuploader == 1.2.4 02:33:40 INFO - docopt == 0.6.1 02:33:40 INFO - functools32 == 3.2.3-2 02:33:40 INFO - jsonschema == 2.5.1 02:33:40 INFO - manifestparser == 1.1 02:33:40 INFO - mozInstall == 1.12 02:33:40 INFO - mozcrash == 0.17 02:33:40 INFO - mozdebug == 0.1 02:33:40 INFO - mozdevice == 0.48 02:33:40 INFO - mozfile == 1.2 02:33:40 INFO - mozhttpd == 0.7 02:33:40 INFO - mozinfo == 0.9 02:33:40 INFO - mozleak == 0.1 02:33:40 INFO - mozlog == 3.2 02:33:40 INFO - moznetwork == 0.27 02:33:40 INFO - mozprocess == 0.23 02:33:40 INFO - mozprofile == 0.28 02:33:40 INFO - mozrunner == 6.12 02:33:40 INFO - mozscreenshot == 0.1 02:33:40 INFO - mozsystemmonitor == 0.3 02:33:40 INFO - moztest == 0.7 02:33:40 INFO - mozversion == 1.4 02:33:40 INFO - psutil == 3.1.1 02:33:40 INFO - requests == 1.2.3 02:33:40 INFO - wsgiref == 0.1.2 02:33:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111c3b0>, '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 0x111d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111d740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:33:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:33:40 INFO - Using env: {'DISPLAY': ':0', 02:33:40 INFO - 'HOME': '/home/cltbld', 02:33:40 INFO - 'LANG': 'en_US.UTF-8', 02:33:40 INFO - 'LANGUAGE': 'en_US:en', 02:33:40 INFO - 'LOGNAME': 'cltbld', 02:33:40 INFO - 'MAIL': '/var/mail/cltbld', 02:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:40 INFO - 'MOZ_NO_REMOTE': '1', 02:33:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:40 INFO - 'NO_EM_RESTART': '1', 02:33:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:40 INFO - 'PWD': '/builds/slave/test', 02:33:40 INFO - 'SHELL': '/bin/bash', 02:33:40 INFO - 'SHLVL': '1', 02:33:40 INFO - 'TERM': 'linux', 02:33:40 INFO - 'TMOUT': '86400', 02:33:40 INFO - 'USER': 'cltbld', 02:33:40 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491', 02:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:40 INFO - '_': '/tools/buildbot/bin/python'} 02:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:33:41 INFO - Cleaning up... 02:33:41 INFO - Return code: 0 02:33:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111c3b0>, '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 0x111d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111d740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:33:41 INFO - Using env: {'DISPLAY': ':0', 02:33:41 INFO - 'HOME': '/home/cltbld', 02:33:41 INFO - 'LANG': 'en_US.UTF-8', 02:33:41 INFO - 'LANGUAGE': 'en_US:en', 02:33:41 INFO - 'LOGNAME': 'cltbld', 02:33:41 INFO - 'MAIL': '/var/mail/cltbld', 02:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:41 INFO - 'MOZ_NO_REMOTE': '1', 02:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:41 INFO - 'NO_EM_RESTART': '1', 02:33:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:41 INFO - 'PWD': '/builds/slave/test', 02:33:41 INFO - 'SHELL': '/bin/bash', 02:33:41 INFO - 'SHLVL': '1', 02:33:41 INFO - 'TERM': 'linux', 02:33:41 INFO - 'TMOUT': '86400', 02:33:41 INFO - 'USER': 'cltbld', 02:33:41 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491', 02:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:41 INFO - '_': '/tools/buildbot/bin/python'} 02:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:33:41 INFO - Cleaning up... 02:33:41 INFO - Return code: 0 02:33:41 INFO - Running post-action listener: _resource_record_post_action 02:33:41 INFO - Running post-action listener: _start_resource_monitoring 02:33:41 INFO - Starting resource monitoring. 02:33:41 INFO - ##### 02:33:41 INFO - ##### Finished create-virtualenv step (success) 02:33:41 INFO - ##### 02:33:41 INFO - ##### 02:33:41 INFO - ##### Running install step. 02:33:41 INFO - ##### 02:33:41 INFO - Running pre-action listener: _resource_record_pre_action 02:33:41 INFO - Running main action method: install 02:33:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:41 INFO - Reading from file tmpfile_stdout 02:33:41 INFO - Detecting whether we're running mozinstall >=1.0... 02:33:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:33:41 INFO - Reading from file tmpfile_stdout 02:33:41 INFO - Output received: 02:33:41 INFO - Usage: mozinstall [options] installer 02:33:41 INFO - Options: 02:33:41 INFO - -h, --help show this help message and exit 02:33:41 INFO - -d DEST, --destination=DEST 02:33:41 INFO - Directory to install application into. [default: 02:33:41 INFO - "/builds/slave/test"] 02:33:41 INFO - --app=APP Application being installed. [default: firefox] 02:33:41 INFO - mkdir: /builds/slave/test/build/application 02:33:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:33:57 INFO - Reading from file tmpfile_stdout 02:33:57 INFO - Output received: 02:33:57 INFO - /builds/slave/test/build/application/firefox/firefox 02:33:57 INFO - Running post-action listener: _resource_record_post_action 02:33:57 INFO - ##### 02:33:57 INFO - ##### Finished install step (success) 02:33:57 INFO - ##### 02:33:57 INFO - ##### 02:33:57 INFO - ##### Running run-tests step. 02:33:57 INFO - ##### 02:33:57 INFO - Running pre-action listener: _resource_record_pre_action 02:33:57 INFO - Running main action method: run_tests 02:33:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:33:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:33:57 INFO - Python 2.7.3 02:33:57 INFO - Return code: 0 02:33:57 INFO - grabbing minidump binary from tooltool 02:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:57 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 0x111c3b0>, '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 0x111d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111d740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:33:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:33:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:33:57 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:33:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:33:58 INFO - Return code: 0 02:33:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:33:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:33:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:33:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:33:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:33:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:33:58 INFO - Using env: {'DISPLAY': ':0', 02:33:58 INFO - 'HOME': '/home/cltbld', 02:33:58 INFO - 'LANG': 'en_US.UTF-8', 02:33:58 INFO - 'LANGUAGE': 'en_US:en', 02:33:58 INFO - 'LOGNAME': 'cltbld', 02:33:58 INFO - 'MAIL': '/var/mail/cltbld', 02:33:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:33:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:33:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:58 INFO - 'MOZ_NO_REMOTE': '1', 02:33:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:33:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:58 INFO - 'NO_EM_RESTART': '1', 02:33:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:58 INFO - 'PWD': '/builds/slave/test', 02:33:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:33:58 INFO - 'SHELL': '/bin/bash', 02:33:58 INFO - 'SHLVL': '1', 02:33:58 INFO - 'TERM': 'linux', 02:33:58 INFO - 'TMOUT': '86400', 02:33:58 INFO - 'USER': 'cltbld', 02:33:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491', 02:33:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:58 INFO - '_': '/tools/buildbot/bin/python'} 02:33:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:33:58 INFO - mozversion application_buildid: 20160711010827 02:33:58 INFO - mozversion application_changeset: 1de829f2f1f03e23ca0159bee473d36b9989e62b 02:33:58 INFO - mozversion application_display_name: Nightly 02:33:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:33:58 INFO - mozversion application_name: Firefox 02:33:58 INFO - mozversion application_remotingname: firefox 02:33:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:33:58 INFO - mozversion application_vendor: Mozilla 02:33:58 INFO - mozversion application_version: 50.0a1 02:33:58 INFO - mozversion platform_buildid: 20160711010827 02:33:58 INFO - mozversion platform_changeset: 1de829f2f1f03e23ca0159bee473d36b9989e62b 02:33:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:33:58 INFO - mozversion platform_version: 50.0a1 02:33:58 INFO - using testdate: 1468229638 02:33:58 INFO - actual date: 1468229638 02:33:58 INFO - starting webserver on 'localhost:51420' 02:33:58 INFO - SUITE-START | Running 2 tests 02:33:58 INFO - TEST-START | dromaeo_css 02:33:58 INFO - operating with platform_type : linux_ 02:33:58 INFO - Initialising browser for dromaeo_css test... 02:33:58 INFO - TEST-INFO | started process 3294 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpARBTmu/profile http://localhost:51420/getInfo.html) 02:34:03 INFO - PROCESS | 3294 | __metrics Screen width/height:1600/1200 02:34:03 INFO - PROCESS | 3294 | colorDepth:24 02:34:03 INFO - PROCESS | 3294 | Browser inner width/height: 1024/697 02:34:03 INFO - PROCESS | 3294 | __metrics 02:34:04 INFO - PROCESS | 3294 | 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" 02:34:04 INFO - PROCESS | 3294 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:34:05 INFO - TEST-INFO | 3294: exit 0 02:34:05 INFO - Browser initialized. 02:34:05 INFO - Running cycle 1/1 for dromaeo_css test... 02:34:05 INFO - TEST-INFO | started process 3376 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpARBTmu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:34:17 INFO - PROCESS | 3376 | RSS: Main: 159031296 02:34:17 INFO - PROCESS | 3376 | 02:35:08 INFO - PROCESS | 3376 | 1468229708159 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:37:20 INFO - PROCESS | 3376 | Cycle 1(1): loaded http://localhost:51420/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51420/tests/dromaeo/cssquery-ext.html) 02:37:21 INFO - PROCESS | 3376 | RSS: Main: 270684160 02:37:21 INFO - PROCESS | 3376 | 02:40:24 INFO - PROCESS | 3376 | Cycle 1(1): loaded http://localhost:51420/tests/dromaeo/cssquery-ext.html (next: http://localhost:51420/tests/dromaeo/cssquery-jquery.html) 02:40:25 INFO - PROCESS | 3376 | RSS: Main: 255287296 02:40:25 INFO - PROCESS | 3376 | 02:43:27 INFO - PROCESS | 3376 | Cycle 1(1): loaded http://localhost:51420/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51420/tests/dromaeo/cssquery-mootools.html) 02:43:28 INFO - PROCESS | 3376 | RSS: Main: 241672192 02:43:28 INFO - PROCESS | 3376 | 02:46:30 INFO - PROCESS | 3376 | Cycle 1(1): loaded http://localhost:51420/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51420/tests/dromaeo/cssquery-prototype.html) 02:46:31 INFO - PROCESS | 3376 | RSS: Main: 241369088 02:46:31 INFO - PROCESS | 3376 | 02:49:34 INFO - PROCESS | 3376 | Cycle 1(1): loaded http://localhost:51420/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51420/tests/dromaeo/cssquery-yui.html) 02:49:34 INFO - PROCESS | 3376 | RSS: Main: 222576640 02:49:34 INFO - PROCESS | 3376 | 02:52:37 INFO - PROCESS | 3376 | Cycle 1(1): loaded http://localhost:51420/tests/dromaeo/cssquery-yui.html (next: http://localhost:51420/tests/dromaeo/cssquery-dojo.html) 02:52:37 INFO - PROCESS | 3376 | RSS: Main: 284323840 02:52:37 INFO - PROCESS | 3376 | 02:52:37 INFO - PROCESS | 3376 | __start_tp_report 02:52:37 INFO - PROCESS | 3376 | _x_x_mozilla_page_load 02:52:37 INFO - PROCESS | 3376 | _x_x_mozilla_page_load_details 02:52:37 INFO - PROCESS | 3376 | |i|pagename|runs| 02:52:37 INFO - PROCESS | 3376 | |0;dojo.html;2538.974610253897;2547.8089143314255;2573.819832611717;2584.728603496633;2587.9094231701883;4441;4517.390152329434;4566.429196350457;4578.771061446927;4588.541145885414;4525.049739554689;4566.817327306904;4581.31280307954;4587.357769912207;4618.19181643212;4160.5423403425675;4204.369344598319;4233.894152646178;4258.318669012959;4332.350147477888;4228.7462752234815;4300.6774491913075;4304.074623955848;4319.913601727963;4327.632151267146;4094.9385759213783;4138.606832350922;4144.896377590554;4207.957920420818;4223.514295855985;4150.522689890671;4159.729617574848;4166.979165104185;4214.072903961154;4228.365745138254;4213.262679031157;4217.072244106292;4222.915541689149;4269.146170765828;4270.274053410896;4453.710508816916;4521.480029796583;4583.175028494869;4591.288350305708;4631.305304204363;4923.704577725348;4935.555799977983;4937.827176048857;4941.283513890502;4942.950570494321;4943.629227807929;4955.256711493269;4967.279744437073;4970.403551573834;4976.701397916137;4493.977530112361;4556.430446194226;4606.769661516911;4608.539146085364;4656.348111264358;5070.340855688737;5082.263071854561;5084.059449001872;5088.6946783193125;5089.923651145235;4878.414590249122;4878.43897951733;4879.26810978349;4887.04702583;4892.19278818998;4757.14371413142;4833.806647734122;4898.191798353232;4905.190643543847;4910.140725373046;4838.7338696371335;4855.247436647325;4856.247281671346;4858.489858564871;4892.510748925079;4681.976590117028;4822.324874517571;4829;4838.250071238964;4881.487443818419;4061.472008638858;4088.1210539733506;4122.484689413824;4128.02991297045;4142.337226043818;3605.7115430765475;3606.206634540397;3609.873654422135;3610.6389361064207;3641.253543023674;4235.745855248695;4256.59562341577;4260.446142001582;4263.87208383749;4301.096769678403;4769.260764581495;4833.468318484964;4849.927251091236;4881.243407271879;4906.386701662293;4265.3601959705675;4273.252180868336;4287.421198138274;4288.957110428918;4328.718633288826;4290.871273861789;4428.7121337112985;4430.734155950653;4468.843590474317;4472.038511719931;4605.055963527536;4660.673752837404;4672.626189904868;4673.7429441381055;4681.297805329228;4929.383827021622;4932.605391568738;4939.086269040239;4939.456659767495;4965.627577931597;4544.909101818012;4649.5815376616265;4665.533446655308;4669.603083737785;4714.57568818808;4760.428748550196;4792.305115758265;4813.085513752376;4816.470188279357;4824.6863953842885;4852.2479015752615;4884;4889.853304400874;4895.216765317532;4948.134076536664;4631.351610774427;4675.555822196886;4740.715557066587;4761.119192949315;4808.495108013608;4702.388689470484;4726.787294571684;4745.240761478147;4748.715077095385;4792.185328494234;4675.579197872208;4685.929711054268;4689.179393606173;4728.787204575871;4732.763361831826;4674.5325467452985;4729.763511824463;4763.7141771493825;4772.308015337826;4812.951870481251;4677.579017888406;4695.22528782747;4697.882552936067;4732.124556956974;4747.311639812277 02:52:37 INFO - PROCESS | 3376 | |1;ext.html;571.42571715426;581.1457157977774;581.7236812514057;584.6813486649776;588.3880764005435;26769.464610707797;27084.052058177967;38952;42258.36612450812;43323;39612.207755844865;40163.598364016354;40212.19575608486;40262.7986860066;40280;7814.882776758353;7958.323542498894;7960.363170946311;7968.362530997506;7969.601519923981;7414.1473730520875;9990.150837178848;10209.183265338756;10252.179825613934;10536.578536858517;10125.89874101257;10183.6944891653;10232.386056836576;10246.436445995467;10255.333403328797;10133.6959891203;10191.94904025475;10203.183745300357;10215.131713804298;10217;10077;10119.645812396604;10162.03460671235;10170.389776613427;10172.694819155437;38071.23857522862;38452.23095538101;38466.61533384658;38492.615073849185;38580.421293680614;2848.757855582278;2901.8984335548366;3015.9246018849485;3154.779165458419;3348.581248541019;28884.711152888412;29351.85324073387;29580.112596622137;30019.849900750574;30497;3441.2257242120572;3447.413939630269;3463.290025544757;3559.75081744278;3584.982075089608;262034;263249;264721;264777;264895.6755216231;50245.49754502408;50899;50912;50942.74528627333;50998.49001510011;53971.19043214355;53973.190402144;54004.72997634987;54024.729876350364;54105.18842217291;13915.512957046658;14048.859511404755;14069.507567235098;14075.155490670593;14082.85917140836;10612.840807387895;10617.628383006559;10634.680959571226;10657.307275027099;10677.786444271227;14535.273236338353;15257.923710381378;15298.847011529742;15382.307796148976;15554.688906221812;5491.203775452617;5579.6652200868075;5681.659100453986;5682.488576028178;5736.627119237236;822.3051521464353;907.6913849291273;933.6918816790443;1030.8711411073616;1031.6956497833007;26074.73925260761;27393.45213095727;27715;27756.30609234785;27834.721652783617;810.3881569415172;933.421278807144;943.5738852051248;975.8877729061248;997.0727223682045;13382.197068175747;14050.60255411009;14109.858901410855;14479.638009049648;14566.563003109924;364521;366132;370878;370962;371103;48330.516694833306;48444.51555484471;48505.51494485081;48505.75747121242;48547;1041.3647674918293;1157.5774842182711;1170.4615876696644;1179.220597983461;1181.261711430356;27778;28932.710672893;29020;29144.854275728485;29465.263368415963;40675.3898691514;41197.382039268836;41205;41262.79368603138;41302;293706;299312;299863;300092;301900;30476;31720.206994825316;31728.682713173497;33991.32017359688;34096;35902.820485897406;40688;40827.7958610205;41404.58595414007;41524.79237603793;34520.309593807484;35096;35119.824400877835;35661.28677426489;35730.464043039894;35283.11792205215;35332.470012949314;35775.28449431049;35808.820955895055;36090.63909360978;33889.3222135551;35377.29245415026;35411.82294088513;35690.286194275446;35843.10392240215;30374.84812575923;31427.214319641276;31721.206969825016;31888.521672174473;31961.36077278488;24595.754042459346;24754.257372278862;24799.62800557957;24878.502429951663;25033.74966250314 02:52:37 INFO - PROCESS | 3376 | |2;jquery.html;361.41992102675204;371.59867343269264;371.6784980991442;379.9601041890603;388.39604415134454;16492.422765203206;17519.562010949718;18461;18486.35297764577;18487.445376638723;10959.945200274007;16310.266038028287;17104.401345952894;17133.74299385507;17617.207225674843;4683.672142950003;4822.565969062784;4880.267959806022;4884.047610715912;4888.511148885119;3406.965930340702;3567.3222087803233;4742.81028758851;5284.656497327681;5580.497755202031;5612.07400778871;5617.887642247153;5652.604317697763;5654.151877218409;5667.263255776764;5151.974240128794;5440.455954404548;5440.537554307889;5512.6692398456225;5616.297962754656;3336.215989242526;4981.078500477423;5236.476352364771;5271.5782737381305;5322.467753224685;12395.380230988505;12510.249385036926;12575.371231438392;15590.532284031497;21803.890980545155;1768.478298901827;1851.6111616560538;1953.5311525233983;1971.540975126951;2467.124170919316;9107.499087550248;9133.543322833832;9670.903290967071;11883.405829708567;13118.87358774675;1703.3186725309974;1722.483255023488;1794.6410717856481;1815.7548730921421;1820.6631773121883;69067;71767;74378.25621743822;74968.25031749667;76541.61729191375;8507.829843403097;8801.779955501035;9186.494742789211;9236.261099112055;10003.899961000443;11943.462544185533;11995.64013079609;12017.278963262232;12062.396880156133;12076.879231207751;6616.66916654175;6724.966375168093;6750.459963202932;6771.119754431991;6779.322067793181;6613.875641141018;6683;6751.358620931003;6752.5948443093575;6789.25318214996;3790.33669107905;3796.52543432071;3798.1074447504816;3800.0689830991582;3867.187890542961;1549.3570168379997;1633.3140081165939;1647.1681800690574;1776.2983621469705;1832.1755210155484;853.5988085599759;855.3285670748432;872.31959071924;875.2341701011615;904.5929331800585;16952.660946780994;17189.7421538677;17300.134993250285;17310.134493275287;17879.37422190217;888.3293113699245;892.7321803458937;903.9954800225956;906.6781292641149;912.9680461183826;9678.128968392737;9810.148635598862;9821.459819709842;9847.901520984698;10010.799784004279;357498;358963;359364;360411;360619;59259;83293;83705.58147209225;83760.58119709362;83800.58099709585;876.9912300877037;878.0911756332166;890.9198172164537;896.0188593490118;897.1521911793424;15216.63050325476;15406.38374465009;15764.132972686153;15892.68214635724;16104.114273715059;37770.244595108496;38685.41971870368;39078.6092139075;39204.41193382045;40311.79844100761;55339.72330138324;55915.16127258013;58138;58151;58369.12446313224;7142.928570714226;7318.487705860539;7384.409247260313;7397.630118494161;7519.436042296959;10681.8931810684;10700.069313793507;11656;11669.76660466803;11957.581484647995;9612.51937403141;10101.646442374482;10144.79710405773;10231.334963227366;10394.844077338998;9646.517674116407;9781.755456113655;9801.85297220528;9842.704718858446;10064.69805905824;5454.754536045967;7534.54792712439;9974.451405172786;10384.169266458815;10611.31026483276;7570.9242907570215;7686.192949740421;7689.961550192437;7741.535507869546;7813.3749300057;9104.499252541174;9654.855177172207;10021.5490302938;10212.591496340063;10219.7445063874 02:52:37 INFO - PROCESS | 3376 | |3;mootools.html;1100.4002818463937;1388.8194534710485;1413.6183230527756;1525.504211131382;1707.4792188382546;6510.25132109807;7450.962745186273;7674.386049116058;7678.0786305643405;7792.571408572526;7595.544267343963;7732.690692372313;7733.265339792711;7746.728864489744;7749.341305988998;1849.5468610190455;1936.9515762105918;1941.5922656242205;2194.3636345459836;2238.250186187621;1971.4381401300632;2112.6830975353664;2204.360735386736;2204.526026904215;2209.856359336638;2182.7271591051117;2194.429448343434;2208.039502816272;2208.624533829253;2210.6794514795347;1785.3751187084417;2107.926222582202;2108.5677436125634;2118.078635793435;2120.713703650003;2084.7602525709585;2170.739511258659;2186.464316242531;2196.8242540596716;2198.5932602468592;7805.336546393563;7834.921650783476;7850.882236766453;7855.607219639052;7870.212978702084;4456.420665313489;4575.931361029588;4582.747948862811;4590.724556526619;4591.8392856249875;2781.1656503049003;2788.7908406869565;2873.928151796201;2902.4195160967893;2913.300807806111;905.0994260710635;908.6774195160755;923.1230331185401;939.7979434421563;943.580106852451;10557.47212639365;10580.36517808934;10589.629362972259;10594.576216951313;10607.15142788575;4087.9182416351505;4115.1975364803575;4284.014676624394;4285;4288.699791014599;9033.638654453749;9046.095390460901;9064.320175986828;9065.365424420228;9069.18377346042;4611.654125940568;4614.4693360264;4618.65360097994;4621.676482646182;4622.884427889329;3612.259486805199;3714.53568303962;4205.852795152155;4205.894852628648;4207.558206388347;3561.198730285717;3617.855285788539;3678.8712395066577;3690.1881586051563;3695.833687484016;1159.8434211381525;1163.1973937982764;1176.2824676947055;1180.1031216275692;1190.4523918997186;724.478375569589;732.0848938826467;734.889766535024;744.6611791634793;746.8207630168829;4838.080764654705;4914.066327397783;4935.605151587864;4957.752112394366;5028.446870844205;387.3666555182241;403.8808551477321;406.3620116417256;409.36752717052224;410.51764177092394;3349.4804164650513;3367.0067330137667;3417.7778444401533;3432.1591210153174;3465.0297916583395;8945.552722363856;9155.45067295951;9258.166764991049;9274.211692006254;9350.532473376305;9300.441973481478;9322.394044387092;9353.625854965725;9378;9413.341066125306;6914.446844252448;6916.619585922823;7056.470764692669;7063.752768653175;7069.08101946754;4797.95202047989;4800.423949126127;4828.082664293773;4837.975810120927;4843.104025755247;8606.612702428281;8631.13688631157;8646.524441155796;8646.697365592174;8816.779580510538;8702.347323950855;8764.21122099014;9020;9023.639054437748;9038.502882341534;6274.027525733519;6491.935080649133;6515.924872396191;6555.6066636002;6561.40947314744;6960.338767817049;6985.965070174617;7028.929710702828;7042.683079261343;7050.2597227292445;6225.750969961151;6289.842753931189;6505.60966342021;6540.149780528501;6635.4359879410795;6461.418472337512;6470.611763294218;6518.543701940818;6559.147310849559;6618.305077966744;5620.156976453564;5731;5770.6249093808765;5776.162456443876;5864.9413505866105;4265.552117027667;4286.61420472159;4318.050028993616;4321.459817522809;4343.370211319278;4086.81609327575;4149.25313443583;4164.167166566759;4259.063006138645;4283.7001409901 02:52:37 INFO - PROCESS | 3376 | |4;prototype.html;292.4385180453529;294.2423260105229;302.5129541438283;305.0543315721263;305.11972958016116;4786.186348320785;4790.568848803607;4813.3983252093485;4823.204171311738;4844.563989240967;4677.625789936806;4720.504347043562;4753.120672675549;4753.263244197146;4776.593989510896;3755.3428150073764;3756.3050835595504;3757.2297678975883;3764.5294338207655;3770.9057273568105;3759.755615884959;3768.2840260350445;3770.396736522157;3775.339315619756;3780.9432858507143;3640.908977275576;3735.962640373589;3745.4381842723674;3750;3750.2499500099952;3716.2195938852874;3728.1984373359724;3743.2513497300647;3758.004128905842;3758.4738136660753;3316.6351701312838;3319.7012268895915;3327.4676051831834;3327.88352407667;3329.6836800503916;4672.976635116836;4675.345451636774;4679.625629949596;4681.7190968542;4682.859514214579;3997.900052498682;4203.138356636912;4217.388478670576;4238.766867822269;4280.250956082673;4997.201007637248;5005.699658020494;5012.418604418727;5013.095023890898;5013.273075404082;3555.702168708429;3563.465480177968;3566.1084728817796;3568.7323450741037;3575.8212089395424;4687.414073240845;4884.242942343907;5202.817901373472;5242.161254199348;5244.318238628992;3524.84138213781;3579.9439165446256;3602.9099272518397;3609.5668519777796;3612.945805812915;3644.489771432002;3652.5251717276583;3656.5794933582447;3661.4141737322434;3668.816559172031;3978.3833505806647;3988.0029992501873;4104.42538044674;4106.425100485934;4167.229062623424;4893.7063776173545;4900.681455705368;4903.156169421727;4936.185529387611;4937.679050861682;1222.9816552751715;1231.4581584102966;1240.3860089255877;1245.265293476853;1246.3145270101588;782.7338704840381;816.2653611749473;820.971266005687;830.3149901331426;830.8421399933993;3965.5836137205756;4024.4164596133396;4043.6158564936286;4052.128792309609;4058.411530328086;4562.543745625478;4570.908581828345;4573.242241108241;4583.381243532147;4606.055758569485;3994.9201015979515;4028.6504021152655;4043.332850079763;4044.6966477513715;4048.655864251513;2289.8511596746157;2432.3189506938083;2441.3042282949273;2444.4255599934;2448.824564209154;4301.569843015736;4348.869533913924;4354.974936654471;4368.257396242647;4382.342648602671;4652.860414187579;4663.883402914887;4677.46209185948;4678.461976872703;5036.7733451994745;4614.238650622677;4859.586935110485;4879.731614761222;4889.339939108318;4897.583705385082;5110.014188932639;5127.948720512896;5171.741412929414;5200.97399513;5211.583073354198;4786.2581299898575;4982.402111746469;5046.823361182341;5097.362829646294;5110.642255042111;4857.8299759508245;4865.537773911473;4878.536539028786;4879.34128892595;4879.707217566957;3604.711008509563;3607.5310209672575;3615.5661320641693;3620.9094772630897;3623.728220383429;4902.264660300983;5143.5113664201845;5144.614153938544;5149.510796474329;5150.9742451289;4948.331975183304;4963.70217786934;4981.501849814989;4998.475464983215;5003.799848006039;4955.752212389438;4959.801607935787;4965.4786247444945;4966.255061740768;4968.975155124202;4687.953120468752;4886.193778026728;4889.853304400874;4906.852794416173;4920.803167873388;5046.057267951938;5048.924266135938;5066.468020857904;5074.264231686311;5098.362704661918;4925.2023011599795;4938.308636790924;4938.456769755396;4939.333190019445;4979.452260251442 02:52:37 INFO - PROCESS | 3376 | |5;yui.html;591.1044767177725;602.0457574744031;655.2006552006553;665.3213722003557;681.9931800681992;12767.80848287274;12808.167469114513;13341.933290333547;13353.59939201823;13367;11828.349440780754;11848.11139164564;11947.163698541106;11948.7610247795;11957.402129893513;624.2290770897937;743.8772602520578;769.4844454215674;796.7888509544975;800.1998001998002;672.532589850052;685.0101603183402;686.1388956859134;686.5811854768588;687.1410736579276;829.4401279136589;831.5592735850009;832.7709879783048;832.9208725171129;833.0336809301211;643.8100760275706;724.4240828541323;781.3827076609472;830.3149901331395;830.4228561150003;555.3474667265947;556.5519756595938;557.3200695151908;557.4119304134136;557.6013150597342;12962.546310879168;12986.675333116653;13007.804882926668;13060.151090179108;13104.606861794162;11471.426428678617;12423.813642795365;12831.935840320739;12875.806862897063;13032.609021729364;11193.552257909674;11340.262882912584;11439.714007149805;11601.593944211912;11971.042316614738;4104.958950410517;4153.2173443792735;4183.142455796555;4192.538820729717;4210.915781684349;54156;60303.69848150775;61255.693721531556;61389.386106138816;61507.38492615061;10716.571337146426;11017.83473247886;11058.723531911766;11065.612703555336;11280.492377843017;18990.90504547496;19170.233190672217;19224.32714855001;19236.03819809004;19260;6599.934000659932;6659.367360100783;6682.866342673216;6737.326267373322;7036.577805331696;3483.304811557283;3632.1124705858906;3678.448232765053;3819.3125237457525;3888.7277890547957;2637.485690290375;2749.9037533686223;2761.2268564801484;2764.7926405519265;2766.792490563216;517.2525700363014;528.3791544934686;531.4074806590623;532.3239485852945;533.754472942443;443.74262927501974;455.6241101091613;520.9635325527177;530.7850320620155;552.7402121003122;7678.308952194329;7833.64748586315;8028.919710802934;8058.879116813252;8115.715949941724;556.4352182534731;558.6787597131665;566.224272746332;567.0869899461863;571.948524632785;3575.2313252650806;3677.558692956809;3816.46569480273;3861.1698484825897;3875.476810630585;68917.65541172262;93931.53034234785;97082;100478.4976075115;101174.49412752889;86045.569772152;86537.1346286529;87011.56494217488;87475;88526;74723.25276747163;74822.62588687021;74904.99999999891;75186.24813751903;75358.62320688361;6991.161060672752;7143.392811610864;7172.390346820579;7197.100362454693;7289.890651640336;43716;44492.77753611211;46476.767616161706;46951.765241173576;46967;64993.35006649873;65461.67269163624;65751;65833.67083164553;67456;9405.24758019343;9414.95292523533;9564.234861211226;9654;9779.168770654574;10849.620263290746;11121.332720036824;11132.833007504732;11132.944335278271;11135.109191264517;9688.854667179858;9754.22120091923;9778.07108324708;9826.606935722491;9839.220280678843;9427.292953028687;9619.53829386687;9678.336183813548;9694.6122155113;9846.556904939152;9572.090651388107;9839.612529278676;9951.601935922772;9977.800443991226;10137.949310253696;8019.398545109024;8026.879596805936;8178.83642327162;8258.04658181594;8308.5430301334;8188.2630563249595;8339.499630022217;8422.24199822019;8437.493750374997;8600.870986935326 02:52:37 INFO - PROCESS | 3376 | __end_tp_report 02:52:37 INFO - PROCESS | 3376 | __start_cc_report 02:52:37 INFO - PROCESS | 3376 | _x_x_mozilla_cycle_collect,1140 02:52:37 INFO - PROCESS | 3376 | __end_cc_report 02:52:37 INFO - PROCESS | 3376 | __startTimestamp1468230757797__endTimestamp 02:52:37 INFO - PROCESS | 3376 | 02:52:37 INFO - PROCESS | 3376 | ------- Summary: start ------- 02:52:37 INFO - PROCESS | 3376 | Number of tests: 6 02:52:37 INFO - PROCESS | 3376 | 02:52:37 INFO - PROCESS | 3376 | [#0] dojo.html Cycles:165 Average:4528.86 Median:4672.63 stddev:472.70 (10.1%) stddev-sans-first:447.63 02:52:37 INFO - PROCESS | 3376 | Values: 2539.0 2547.8 2573.8 2584.7 2587.9 4441.0 4517.4 4566.4 4578.8 4588.5 4525.0 4566.8 4581.3 4587.4 4618.2 4160.5 4204.4 4233.9 4258.3 4332.4 4228.7 4300.7 4304.1 4319.9 4327.6 4094.9 4138.6 4144.9 4208.0 4223.5 4150.5 4159.7 4167.0 4214.1 4228.4 4213.3 4217.1 4222.9 4269.1 4270.3 4453.7 4521.5 4583.2 4591.3 4631.3 4923.7 4935.6 4937.8 4941.3 4943.0 4943.6 4955.3 4967.3 4970.4 4976.7 4494.0 4556.4 4606.8 4608.5 4656.3 5070.3 5082.3 5084.1 5088.7 5089.9 4878.4 4878.4 4879.3 4887.0 4892.2 4757.1 4833.8 4898.2 4905.2 4910.1 4838.7 4855.2 4856.2 4858.5 4892.5 4682.0 4822.3 4829.0 4838.3 4881.5 4061.5 4088.1 4122.5 4128.0 4142.3 3605.7 3606.2 3609.9 3610.6 3641.3 4235.7 4256.6 4260.4 4263.9 4301.1 4769.3 4833.5 4849.9 4881.2 4906.4 4265.4 4273.3 4287.4 4289.0 4328.7 4290.9 4428.7 4430.7 4468.8 4472.0 4605.1 4660.7 4672.6 4673.7 4681.3 4929.4 4932.6 4939.1 4939.5 4965.6 4544.9 4649.6 4665.5 4669.6 4714.6 4760.4 4792.3 4813.1 4816.5 4824.7 4852.2 4884.0 4889.9 4895.2 4948.1 4631.4 4675.6 4740.7 4761.1 4808.5 4702.4 4726.8 4745.2 4748.7 4792.2 4675.6 4685.9 4689.2 4728.8 4732.8 4674.5 4729.8 4763.7 4772.3 4813.0 4677.6 4695.2 4697.9 4732.1 4747.3 02:52:37 INFO - PROCESS | 3376 | 02:52:37 INFO - PROCESS | 3376 | [#1] ext.html Cycles:180 Average:46637.81 Median:33940.32 stddev:82288.82 (242.5%) stddev-sans-first:82446.97 02:52:37 INFO - PROCESS | 3376 | Values: 571.4 581.1 581.7 584.7 588.4 26769.5 27084.1 38952.0 42258.4 43323.0 39612.2 40163.6 40212.2 40262.8 40280.0 7814.9 7958.3 7960.4 7968.4 7969.6 7414.1 9990.2 10209.2 10252.2 10536.6 10125.9 10183.7 10232.4 10246.4 10255.3 10133.7 10191.9 10203.2 10215.1 10217.0 10077.0 10119.6 10162.0 10170.4 10172.7 38071.2 38452.2 38466.6 38492.6 38580.4 2848.8 2901.9 3015.9 3154.8 3348.6 28884.7 29351.9 29580.1 30019.8 30497.0 3441.2 3447.4 3463.3 3559.8 3585.0 262034.0 263249.0 264721.0 264777.0 264895.7 50245.5 50899.0 50912.0 50942.7 50998.5 53971.2 53973.2 54004.7 54024.7 54105.2 13915.5 14048.9 14069.5 14075.2 14082.9 10612.8 10617.6 10634.7 10657.3 10677.8 14535.3 15257.9 15298.8 15382.3 15554.7 5491.2 5579.7 5681.7 5682.5 5736.6 822.3 907.7 933.7 1030.9 1031.7 26074.7 27393.5 27715.0 27756.3 27834.7 810.4 933.4 943.6 975.9 997.1 13382.2 14050.6 14109.9 14479.6 14566.6 364521.0 366132.0 370878.0 370962.0 371103.0 48330.5 48444.5 48505.5 48505.8 48547.0 1041.4 1157.6 1170.5 1179.2 1181.3 27778.0 28932.7 29020.0 29144.9 29465.3 40675.4 41197.4 41205.0 41262.8 41302.0 293706.0 299312.0 299863.0 300092.0 301900.0 30476.0 31720.2 31728.7 33991.3 34096.0 35902.8 40688.0 40827.8 41404.6 41524.8 34520.3 35096.0 35119.8 35661.3 35730.5 35283.1 35332.5 35775.3 35808.8 36090.6 33889.3 35377.3 35411.8 35690.3 35843.1 30374.8 31427.2 31721.2 31888.5 31961.4 24595.8 24754.3 24799.6 24878.5 25033.7 02:52:37 INFO - PROCESS | 3376 | 02:52:37 INFO - PROCESS | 3376 | [#2] jquery.html Cycles:180 Average:23524.94 Median:4882.16 stddev:59881.53 (1226.5%) stddev-sans-first:60024.25 02:52:37 INFO - PROCESS | 3376 | Values: 361.4 371.6 371.7 380.0 388.4 16492.4 17519.6 18461.0 18486.4 18487.4 10959.9 16310.3 17104.4 17133.7 17617.2 4683.7 4822.6 4880.3 4884.0 4888.5 3407.0 3567.3 4742.8 5284.7 5580.5 5612.1 5617.9 5652.6 5654.2 5667.3 5152.0 5440.5 5440.5 5512.7 5616.3 3336.2 4981.1 5236.5 5271.6 5322.5 12395.4 12510.2 12575.4 15590.5 21803.9 1768.5 1851.6 1953.5 1971.5 2467.1 9107.5 9133.5 9670.9 11883.4 13118.9 1703.3 1722.5 1794.6 1815.8 1820.7 69067.0 71767.0 74378.3 74968.3 76541.6 8507.8 8801.8 9186.5 9236.3 10003.9 11943.5 11995.6 12017.3 12062.4 12076.9 6616.7 6725.0 6750.5 6771.1 6779.3 6613.9 6683.0 6751.4 6752.6 6789.3 3790.3 3796.5 3798.1 3800.1 3867.2 1549.4 1633.3 1647.2 1776.3 1832.2 853.6 855.3 872.3 875.2 904.6 16952.7 17189.7 17300.1 17310.1 17879.4 888.3 892.7 904.0 906.7 913.0 9678.1 9810.1 9821.5 9847.9 10010.8 357498.0 358963.0 359364.0 360411.0 360619.0 59259.0 83293.0 83705.6 83760.6 83800.6 877.0 878.1 890.9 896.0 897.2 15216.6 15406.4 15764.1 15892.7 16104.1 37770.2 38685.4 39078.6 39204.4 40311.8 55339.7 55915.2 58138.0 58151.0 58369.1 7142.9 7318.5 7384.4 7397.6 7519.4 10681.9 10700.1 11656.0 11669.8 11957.6 9612.5 10101.6 10144.8 10231.3 10394.8 9646.5 9781.8 9801.9 9842.7 10064.7 5454.8 7534.5 9974.5 10384.2 10611.3 7570.9 7686.2 7690.0 7741.5 7813.4 9104.5 9654.9 10021.5 10212.6 10219.7 02:52:37 INFO - PROCESS | 3376 | 02:52:37 INFO - PROCESS | 3376 | [#3] mootools.html Cycles:180 Average:4965.40 Median:4799.19 stddev:2831.30 (59.0%) stddev-sans-first:2824.34 02:52:37 INFO - PROCESS | 3376 | Values: 1100.4 1388.8 1413.6 1525.5 1707.5 6510.3 7451.0 7674.4 7678.1 7792.6 7595.5 7732.7 7733.3 7746.7 7749.3 1849.5 1937.0 1941.6 2194.4 2238.3 1971.4 2112.7 2204.4 2204.5 2209.9 2182.7 2194.4 2208.0 2208.6 2210.7 1785.4 2107.9 2108.6 2118.1 2120.7 2084.8 2170.7 2186.5 2196.8 2198.6 7805.3 7834.9 7850.9 7855.6 7870.2 4456.4 4575.9 4582.7 4590.7 4591.8 2781.2 2788.8 2873.9 2902.4 2913.3 905.1 908.7 923.1 939.8 943.6 10557.5 10580.4 10589.6 10594.6 10607.2 4087.9 4115.2 4284.0 4285.0 4288.7 9033.6 9046.1 9064.3 9065.4 9069.2 4611.7 4614.5 4618.7 4621.7 4622.9 3612.3 3714.5 4205.9 4205.9 4207.6 3561.2 3617.9 3678.9 3690.2 3695.8 1159.8 1163.2 1176.3 1180.1 1190.5 724.5 732.1 734.9 744.7 746.8 4838.1 4914.1 4935.6 4957.8 5028.4 387.4 403.9 406.4 409.4 410.5 3349.5 3367.0 3417.8 3432.2 3465.0 8945.6 9155.5 9258.2 9274.2 9350.5 9300.4 9322.4 9353.6 9378.0 9413.3 6914.4 6916.6 7056.5 7063.8 7069.1 4798.0 4800.4 4828.1 4838.0 4843.1 8606.6 8631.1 8646.5 8646.7 8816.8 8702.3 8764.2 9020.0 9023.6 9038.5 6274.0 6491.9 6515.9 6555.6 6561.4 6960.3 6986.0 7028.9 7042.7 7050.3 6225.8 6289.8 6505.6 6540.1 6635.4 6461.4 6470.6 6518.5 6559.1 6618.3 5620.2 5731.0 5770.6 5776.2 5864.9 4265.6 4286.6 4318.1 4321.5 4343.4 4086.8 4149.3 4164.2 4259.1 4283.7 02:52:37 INFO - PROCESS | 3376 | 02:52:37 INFO - PROCESS | 3376 | [#4] prototype.html Cycles:180 Average:4068.87 Median:4633.55 stddev:1189.30 (25.7%) stddev-sans-first:1158.37 02:52:37 INFO - PROCESS | 3376 | Values: 292.4 294.2 302.5 305.1 305.1 4786.2 4790.6 4813.4 4823.2 4844.6 4677.6 4720.5 4753.1 4753.3 4776.6 3755.3 3756.3 3757.2 3764.5 3770.9 3759.8 3768.3 3770.4 3775.3 3780.9 3640.9 3736.0 3745.4 3750.0 3750.2 3716.2 3728.2 3743.3 3758.0 3758.5 3316.6 3319.7 3327.5 3327.9 3329.7 4673.0 4675.3 4679.6 4681.7 4682.9 3997.9 4203.1 4217.4 4238.8 4280.3 4997.2 5005.7 5012.4 5013.1 5013.3 3555.7 3563.5 3566.1 3568.7 3575.8 4687.4 4884.2 5202.8 5242.2 5244.3 3524.8 3579.9 3602.9 3609.6 3612.9 3644.5 3652.5 3656.6 3661.4 3668.8 3978.4 3988.0 4104.4 4106.4 4167.2 4893.7 4900.7 4903.2 4936.2 4937.7 1223.0 1231.5 1240.4 1245.3 1246.3 782.7 816.3 821.0 830.3 830.8 3965.6 4024.4 4043.6 4052.1 4058.4 4562.5 4570.9 4573.2 4583.4 4606.1 3994.9 4028.7 4043.3 4044.7 4048.7 2289.9 2432.3 2441.3 2444.4 2448.8 4301.6 4348.9 4355.0 4368.3 4382.3 4652.9 4663.9 4677.5 4678.5 5036.8 4614.2 4859.6 4879.7 4889.3 4897.6 5110.0 5127.9 5171.7 5201.0 5211.6 4786.3 4982.4 5046.8 5097.4 5110.6 4857.8 4865.5 4878.5 4879.3 4879.7 3604.7 3607.5 3615.6 3620.9 3623.7 4902.3 5143.5 5144.6 5149.5 5151.0 4948.3 4963.7 4981.5 4998.5 5003.8 4955.8 4959.8 4965.5 4966.3 4969.0 4688.0 4886.2 4889.9 4906.9 4920.8 5046.1 5048.9 5066.5 5074.3 5098.4 4925.2 4938.3 4938.5 4939.3 4979.5 02:52:37 INFO - PROCESS | 3376 | 02:52:37 INFO - PROCESS | 3376 | [#5] yui.html Cycles:180 Average:17406.16 Median:30452.87 stddev:25402.94 (83.4%) stddev-sans-first:25442.82 02:52:37 INFO - PROCESS | 3376 | Values: 591.1 602.0 655.2 665.3 682.0 12767.8 12808.2 13341.9 13353.6 13367.0 11828.3 11848.1 11947.2 11948.8 11957.4 624.2 743.9 769.5 796.8 800.2 672.5 685.0 686.1 686.6 687.1 829.4 831.6 832.8 832.9 833.0 643.8 724.4 781.4 830.3 830.4 555.3 556.6 557.3 557.4 557.6 12962.5 12986.7 13007.8 13060.2 13104.6 11471.4 12423.8 12831.9 12875.8 13032.6 11193.6 11340.3 11439.7 11601.6 11971.0 4105.0 4153.2 4183.1 4192.5 4210.9 54156.0 60303.7 61255.7 61389.4 61507.4 10716.6 11017.8 11058.7 11065.6 11280.5 18990.9 19170.2 19224.3 19236.0 19260.0 6599.9 6659.4 6682.9 6737.3 7036.6 3483.3 3632.1 3678.4 3819.3 3888.7 2637.5 2749.9 2761.2 2764.8 2766.8 517.3 528.4 531.4 532.3 533.8 443.7 455.6 521.0 530.8 552.7 7678.3 7833.6 8028.9 8058.9 8115.7 556.4 558.7 566.2 567.1 571.9 3575.2 3677.6 3816.5 3861.2 3875.5 68917.7 93931.5 97082.0 100478.5 101174.5 86045.6 86537.1 87011.6 87475.0 88526.0 74723.3 74822.6 74905.0 75186.2 75358.6 6991.2 7143.4 7172.4 7197.1 7289.9 43716.0 44492.8 46476.8 46951.8 46967.0 64993.4 65461.7 65751.0 65833.7 67456.0 9405.2 9415.0 9564.2 9654.0 9779.2 10849.6 11121.3 11132.8 11132.9 11135.1 9688.9 9754.2 9778.1 9826.6 9839.2 9427.3 9619.5 9678.3 9694.6 9846.6 9572.1 9839.6 9951.6 9977.8 10137.9 8019.4 8026.9 8178.8 8258.0 8308.5 8188.3 8339.5 8422.2 8437.5 8600.9 02:52:37 INFO - PROCESS | 3376 | -------- Summary: end -------- 02:52:37 INFO - PROCESS | 3376 | 02:52:38 INFO - TEST-INFO | 3376: exit 0 02:52:38 INFO - TEST-OK | dromaeo_css | took 1120293ms 02:52:38 INFO - TEST-START | kraken 02:52:38 INFO - operating with platform_type : linux_ 02:52:38 INFO - Initialising browser for kraken test... 02:52:38 INFO - TEST-INFO | started process 3614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNVR2IJ/profile http://localhost:51420/getInfo.html) 02:52:42 INFO - PROCESS | 3614 | __metrics Screen width/height:1600/1200 02:52:42 INFO - PROCESS | 3614 | colorDepth:24 02:52:42 INFO - PROCESS | 3614 | Browser inner width/height: 1024/697 02:52:42 INFO - PROCESS | 3614 | __metrics 02:52:43 INFO - PROCESS | 3614 | 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" 02:52:43 INFO - PROCESS | 3614 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:52:44 INFO - TEST-INFO | 3614: exit 0 02:52:44 INFO - Browser initialized. 02:52:44 INFO - Running cycle 1/1 for kraken test... 02:52:44 INFO - TEST-INFO | started process 3693 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNVR2IJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:52:56 INFO - PROCESS | 3693 | RSS: Main: 159375360 02:52:56 INFO - PROCESS | 3693 | 02:52:59 INFO - PROCESS | 3693 | Cycle 1(1): loaded http://localhost:51420/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51420/tests/kraken/driver.html?testName=audio-beat-detection) 02:53:00 INFO - PROCESS | 3693 | RSS: Main: 216928256 02:53:00 INFO - PROCESS | 3693 | 02:53:02 INFO - PROCESS | 3693 | Cycle 1(1): loaded http://localhost:51420/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51420/tests/kraken/driver.html?testName=audio-dft) 02:53:03 INFO - PROCESS | 3693 | RSS: Main: 203984896 02:53:03 INFO - PROCESS | 3693 | 02:53:06 INFO - PROCESS | 3693 | Cycle 1(1): loaded http://localhost:51420/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51420/tests/kraken/driver.html?testName=audio-fft) 02:53:07 INFO - PROCESS | 3693 | RSS: Main: 270897152 02:53:07 INFO - PROCESS | 3693 | 02:53:09 INFO - PROCESS | 3693 | Cycle 1(1): loaded http://localhost:51420/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51420/tests/kraken/driver.html?testName=audio-oscillator) 02:53:09 INFO - PROCESS | 3693 | RSS: Main: 181346304 02:53:09 INFO - PROCESS | 3693 | 02:53:12 INFO - PROCESS | 3693 | Cycle 1(1): loaded http://localhost:51420/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51420/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:53:12 INFO - PROCESS | 3693 | RSS: Main: 186269696 02:53:12 INFO - PROCESS | 3693 | 02:53:15 INFO - PROCESS | 3693 | Cycle 1(1): loaded http://localhost:51420/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51420/tests/kraken/driver.html?testName=imaging-darkroom) 02:53:16 INFO - PROCESS | 3693 | RSS: Main: 222068736 02:53:16 INFO - PROCESS | 3693 | 02:53:19 INFO - PROCESS | 3693 | Cycle 1(1): loaded http://localhost:51420/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51420/tests/kraken/driver.html?testName=imaging-desaturate) 02:53:20 INFO - PROCESS | 3693 | RSS: Main: 222265344 02:53:20 INFO - PROCESS | 3693 | 02:53:23 INFO - PROCESS | 3693 | Cycle 1(1): loaded http://localhost:51420/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51420/tests/kraken/driver.html?testName=json-parse-financial) 02:53:24 INFO - PROCESS | 3693 | RSS: Main: 222953472 02:53:24 INFO - PROCESS | 3693 | 02:53:25 INFO - PROCESS | 3693 | Cycle 1(1): loaded http://localhost:51420/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51420/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:53:26 INFO - PROCESS | 3693 | RSS: Main: 210731008 02:53:26 INFO - PROCESS | 3693 | 02:53:28 INFO - PROCESS | 3693 | Cycle 1(1): loaded http://localhost:51420/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51420/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:53:28 INFO - PROCESS | 3693 | RSS: Main: 214716416 02:53:28 INFO - PROCESS | 3693 | 02:53:31 INFO - PROCESS | 3693 | Cycle 1(1): loaded http://localhost:51420/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51420/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:53:31 INFO - PROCESS | 3693 | RSS: Main: 214867968 02:53:31 INFO - PROCESS | 3693 | 02:53:34 INFO - PROCESS | 3693 | Cycle 1(1): loaded http://localhost:51420/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51420/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:53:35 INFO - PROCESS | 3693 | RSS: Main: 225652736 02:53:35 INFO - PROCESS | 3693 | 02:53:38 INFO - PROCESS | 3693 | Cycle 1(1): loaded http://localhost:51420/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51420/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:53:38 INFO - PROCESS | 3693 | RSS: Main: 227115008 02:53:38 INFO - PROCESS | 3693 | 02:53:40 INFO - PROCESS | 3693 | Cycle 1(1): loaded http://localhost:51420/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51420/tests/kraken/driver.html?testName=ai-astar) 02:53:40 INFO - PROCESS | 3693 | RSS: Main: 269254656 02:53:40 INFO - PROCESS | 3693 | 02:53:40 INFO - PROCESS | 3693 | __start_tp_report 02:53:40 INFO - PROCESS | 3693 | _x_x_mozilla_page_load 02:53:40 INFO - PROCESS | 3693 | _x_x_mozilla_page_load_details 02:53:40 INFO - PROCESS | 3693 | |i|pagename|runs| 02:53:40 INFO - PROCESS | 3693 | |0;ai-astar;104;114;113;114;116;113;113;114;114;114 02:53:40 INFO - PROCESS | 3693 | |1;audio-beat-detection;148;124;125;180;126;123;143;122;168;125 02:53:40 INFO - PROCESS | 3693 | |2;audio-dft;162;160;160;159;160;162;161;162;160;161 02:53:40 INFO - PROCESS | 3693 | |3;audio-fft;75;76;77;123;75;76;76;78;108;75 02:53:40 INFO - PROCESS | 3693 | |4;audio-oscillator;85;85;120;85;86;85;124;85;85;127 02:53:40 INFO - PROCESS | 3693 | |5;imaging-gaussian-blur;116;118;118;117;117;116;117;118;117;117 02:53:40 INFO - PROCESS | 3693 | |6;imaging-darkroom;147;147;146;146;146;148;146;146;147;146 02:53:40 INFO - PROCESS | 3693 | |7;imaging-desaturate;94;94;95;95;96;94;96;95;94;96 02:53:40 INFO - PROCESS | 3693 | |8;json-parse-financial;63;63;62;63;63;63;66;64;64;63 02:53:40 INFO - PROCESS | 3693 | |9;json-stringify-tinderbox;64;65;65;74;64;64;64;64;65;64 02:53:40 INFO - PROCESS | 3693 | |10;stanford-crypto-aes;77;78;87;88;83;78;78;79;88;82 02:53:40 INFO - PROCESS | 3693 | |11;stanford-crypto-ccm;148;129;143;138;128;132;129;130;184;132 02:53:40 INFO - PROCESS | 3693 | |12;stanford-crypto-pbkdf2;164;166;171;167;168;171;165;165;168;165 02:53:40 INFO - PROCESS | 3693 | |13;stanford-crypto-sha256-iterative;67;67;67;68;71;70;67;67;66;66 02:53:40 INFO - PROCESS | 3693 | __end_tp_report 02:53:40 INFO - PROCESS | 3693 | __start_cc_report 02:53:40 INFO - PROCESS | 3693 | _x_x_mozilla_cycle_collect,1869 02:53:40 INFO - PROCESS | 3693 | __end_cc_report 02:53:40 INFO - PROCESS | 3693 | __startTimestamp1468230820632__endTimestamp 02:53:40 INFO - PROCESS | 3693 | 02:53:40 INFO - PROCESS | 3693 | ------- Summary: start ------- 02:53:40 INFO - PROCESS | 3693 | Number of tests: 14 02:53:40 INFO - PROCESS | 3693 | 02:53:40 INFO - PROCESS | 3693 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:3.25 (2.8%) stddev-sans-first:0.93 02:53:40 INFO - PROCESS | 3693 | Values: 104.0 114.0 113.0 114.0 116.0 113.0 113.0 114.0 114.0 114.0 02:53:40 INFO - PROCESS | 3693 | 02:53:40 INFO - PROCESS | 3693 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:134.50 stddev:20.94 (15.6%) stddev-sans-first:21.92 02:53:40 INFO - PROCESS | 3693 | Values: 148.0 124.0 125.0 180.0 126.0 123.0 143.0 122.0 168.0 125.0 02:53:40 INFO - PROCESS | 3693 | 02:53:40 INFO - PROCESS | 3693 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.01 02:53:40 INFO - PROCESS | 3693 | Values: 162.0 160.0 160.0 159.0 160.0 162.0 161.0 162.0 160.0 161.0 02:53:40 INFO - PROCESS | 3693 | 02:53:40 INFO - PROCESS | 3693 | [#3] audio-fft Cycles:10 Average:83.90 Median:76.00 stddev:17.05 (22.4%) stddev-sans-first:17.78 02:53:40 INFO - PROCESS | 3693 | Values: 75.0 76.0 77.0 123.0 75.0 76.0 76.0 78.0 108.0 75.0 02:53:40 INFO - PROCESS | 3693 | 02:53:40 INFO - PROCESS | 3693 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:85.00 stddev:18.68 (22.0%) stddev-sans-first:19.33 02:53:40 INFO - PROCESS | 3693 | Values: 85.0 85.0 120.0 85.0 86.0 85.0 124.0 85.0 85.0 127.0 02:53:40 INFO - PROCESS | 3693 | 02:53:40 INFO - PROCESS | 3693 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.67 02:53:40 INFO - PROCESS | 3693 | Values: 116.0 118.0 118.0 117.0 117.0 116.0 117.0 118.0 117.0 117.0 02:53:40 INFO - PROCESS | 3693 | 02:53:40 INFO - PROCESS | 3693 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 02:53:40 INFO - PROCESS | 3693 | Values: 147.0 147.0 146.0 146.0 146.0 148.0 146.0 146.0 147.0 146.0 02:53:40 INFO - PROCESS | 3693 | 02:53:40 INFO - PROCESS | 3693 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 02:53:40 INFO - PROCESS | 3693 | Values: 94.0 94.0 95.0 95.0 96.0 94.0 96.0 95.0 94.0 96.0 02:53:40 INFO - PROCESS | 3693 | 02:53:40 INFO - PROCESS | 3693 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:63.00 stddev:1.07 (1.7%) stddev-sans-first:1.13 02:53:40 INFO - PROCESS | 3693 | Values: 63.0 63.0 62.0 63.0 63.0 63.0 66.0 64.0 64.0 63.0 02:53:40 INFO - PROCESS | 3693 | 02:53:40 INFO - PROCESS | 3693 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:64.50 stddev:3.09 (4.8%) stddev-sans-first:3.24 02:53:40 INFO - PROCESS | 3693 | Values: 64.0 65.0 65.0 74.0 64.0 64.0 64.0 64.0 65.0 64.0 02:53:40 INFO - PROCESS | 3693 | 02:53:40 INFO - PROCESS | 3693 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.50 stddev:4.47 (5.4%) stddev-sans-first:4.39 02:53:40 INFO - PROCESS | 3693 | Values: 77.0 78.0 87.0 88.0 83.0 78.0 78.0 79.0 88.0 82.0 02:53:40 INFO - PROCESS | 3693 | 02:53:40 INFO - PROCESS | 3693 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:135.00 stddev:17.07 (12.6%) stddev-sans-first:17.81 02:53:40 INFO - PROCESS | 3693 | Values: 148.0 129.0 143.0 138.0 128.0 132.0 129.0 130.0 184.0 132.0 02:53:40 INFO - PROCESS | 3693 | 02:53:40 INFO - PROCESS | 3693 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:167.50 stddev:2.49 (1.5%) stddev-sans-first:2.40 02:53:40 INFO - PROCESS | 3693 | Values: 164.0 166.0 171.0 167.0 168.0 171.0 165.0 165.0 168.0 165.0 02:53:40 INFO - PROCESS | 3693 | 02:53:40 INFO - PROCESS | 3693 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.00 stddev:1.65 (2.5%) stddev-sans-first:1.73 02:53:40 INFO - PROCESS | 3693 | Values: 67.0 67.0 67.0 68.0 71.0 70.0 67.0 67.0 66.0 66.0 02:53:40 INFO - PROCESS | 3693 | -------- Summary: end -------- 02:53:40 INFO - PROCESS | 3693 | 02:53:41 INFO - TEST-INFO | 3693: exit 0 02:53:41 INFO - TEST-OK | kraken | took 63114ms 02:53:41 INFO - SUITE-END | took 1183s 02:53:41 INFO - Completed test suite (00:19:43) 02:53:41 INFO - javascript benchmark 02:53:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2538.974610253897, 2547.8089143314255, 2573.819832611717, 2584.728603496633, 2587.9094231701883, 4441.0, 4517.390152329434, 4566.429196350457, 4578.771061446927, 4588.541145885414, 4525.049739554689, 4566.817327306904, 4581.31280307954, 4587.357769912207, 4618.19181643212, 4160.5423403425675, 4204.369344598319, 4233.894152646178, 4258.318669012959, 4332.350147477888, 4228.7462752234815, 4300.6774491913075, 4304.074623955848, 4319.913601727963, 4327.632151267146, 4094.9385759213783, 4138.606832350922, 4144.896377590554, 4207.957920420818, 4223.514295855985, 4150.522689890671, 4159.729617574848, 4166.979165104185, 4214.072903961154, 4228.365745138254, 4213.262679031157, 4217.072244106292, 4222.915541689149, 4269.146170765828, 4270.274053410896, 4453.710508816916, 4521.480029796583, 4583.175028494869, 4591.288350305708, 4631.305304204363, 4923.704577725348, 4935.555799977983, 4937.827176048857, 4941.283513890502, 4942.950570494321, 4943.629227807929, 4955.256711493269, 4967.279744437073, 4970.403551573834, 4976.701397916137, 4493.977530112361, 4556.430446194226, 4606.769661516911, 4608.539146085364, 4656.348111264358, 5070.340855688737, 5082.263071854561, 5084.059449001872, 5088.6946783193125, 5089.923651145235, 4878.414590249122, 4878.43897951733, 4879.26810978349, 4887.04702583, 4892.19278818998, 4757.14371413142, 4833.806647734122, 4898.191798353232, 4905.190643543847, 4910.140725373046, 4838.7338696371335, 4855.247436647325, 4856.247281671346, 4858.489858564871, 4892.510748925079, 4681.976590117028, 4822.324874517571, 4829.0, 4838.250071238964, 4881.487443818419, 4061.472008638858, 4088.1210539733506, 4122.484689413824, 4128.02991297045, 4142.337226043818, 3605.7115430765475, 3606.206634540397, 3609.873654422135, 3610.6389361064207, 3641.253543023674, 4235.745855248695, 4256.59562341577, 4260.446142001582, 4263.87208383749, 4301.096769678403, 4769.260764581495, 4833.468318484964, 4849.927251091236, 4881.243407271879, 4906.386701662293, 4265.3601959705675, 4273.252180868336, 4287.421198138274, 4288.957110428918, 4328.718633288826, 4290.871273861789, 4428.7121337112985, 4430.734155950653, 4468.843590474317, 4472.038511719931, 4605.055963527536, 4660.673752837404, 4672.626189904868, 4673.7429441381055, 4681.297805329228, 4929.383827021622, 4932.605391568738, 4939.086269040239, 4939.456659767495, 4965.627577931597, 4544.909101818012, 4649.5815376616265, 4665.533446655308, 4669.603083737785, 4714.57568818808, 4760.428748550196, 4792.305115758265, 4813.085513752376, 4816.470188279357, 4824.6863953842885, 4852.2479015752615, 4884.0, 4889.853304400874, 4895.216765317532, 4948.134076536664, 4631.351610774427, 4675.555822196886, 4740.715557066587, 4761.119192949315, 4808.495108013608, 4702.388689470484, 4726.787294571684, 4745.240761478147, 4748.715077095385, 4792.185328494234, 4675.579197872208, 4685.929711054268, 4689.179393606173, 4728.787204575871, 4732.763361831826, 4674.5325467452985, 4729.763511824463, 4763.7141771493825, 4772.308015337826, 4812.951870481251, 4677.579017888406, 4695.22528782747, 4697.882552936067, 4732.124556956974, 4747.311639812277], "value": 4498.755227103974, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.42571715426, 581.1457157977774, 581.7236812514057, 584.6813486649776, 588.3880764005435, 26769.464610707797, 27084.052058177967, 38952.0, 42258.36612450812, 43323.0, 39612.207755844865, 40163.598364016354, 40212.19575608486, 40262.7986860066, 40280.0, 7814.882776758353, 7958.323542498894, 7960.363170946311, 7968.362530997506, 7969.601519923981, 7414.1473730520875, 9990.150837178848, 10209.183265338756, 10252.179825613934, 10536.578536858517, 10125.89874101257, 10183.6944891653, 10232.386056836576, 10246.436445995467, 10255.333403328797, 10133.6959891203, 10191.94904025475, 10203.183745300357, 10215.131713804298, 10217.0, 10077.0, 10119.645812396604, 10162.03460671235, 10170.389776613427, 10172.694819155437, 38071.23857522862, 38452.23095538101, 38466.61533384658, 38492.615073849185, 38580.421293680614, 2848.757855582278, 2901.8984335548366, 3015.9246018849485, 3154.779165458419, 3348.581248541019, 28884.711152888412, 29351.85324073387, 29580.112596622137, 30019.849900750574, 30497.0, 3441.2257242120572, 3447.413939630269, 3463.290025544757, 3559.75081744278, 3584.982075089608, 262034.0, 263249.0, 264721.0, 264777.0, 264895.6755216231, 50245.49754502408, 50899.0, 50912.0, 50942.74528627333, 50998.49001510011, 53971.19043214355, 53973.190402144, 54004.72997634987, 54024.729876350364, 54105.18842217291, 13915.512957046658, 14048.859511404755, 14069.507567235098, 14075.155490670593, 14082.85917140836, 10612.840807387895, 10617.628383006559, 10634.680959571226, 10657.307275027099, 10677.786444271227, 14535.273236338353, 15257.923710381378, 15298.847011529742, 15382.307796148976, 15554.688906221812, 5491.203775452617, 5579.6652200868075, 5681.659100453986, 5682.488576028178, 5736.627119237236, 822.3051521464353, 907.6913849291273, 933.6918816790443, 1030.8711411073616, 1031.6956497833007, 26074.73925260761, 27393.45213095727, 27715.0, 27756.30609234785, 27834.721652783617, 810.3881569415172, 933.421278807144, 943.5738852051248, 975.8877729061248, 997.0727223682045, 13382.197068175747, 14050.60255411009, 14109.858901410855, 14479.638009049648, 14566.563003109924, 364521.0, 366132.0, 370878.0, 370962.0, 371103.0, 48330.516694833306, 48444.51555484471, 48505.51494485081, 48505.75747121242, 48547.0, 1041.3647674918293, 1157.5774842182711, 1170.4615876696644, 1179.220597983461, 1181.261711430356, 27778.0, 28932.710672893, 29020.0, 29144.854275728485, 29465.263368415963, 40675.3898691514, 41197.382039268836, 41205.0, 41262.79368603138, 41302.0, 293706.0, 299312.0, 299863.0, 300092.0, 301900.0, 30476.0, 31720.206994825316, 31728.682713173497, 33991.32017359688, 34096.0, 35902.820485897406, 40688.0, 40827.7958610205, 41404.58595414007, 41524.79237603793, 34520.309593807484, 35096.0, 35119.824400877835, 35661.28677426489, 35730.464043039894, 35283.11792205215, 35332.470012949314, 35775.28449431049, 35808.820955895055, 36090.63909360978, 33889.3222135551, 35377.29245415026, 35411.82294088513, 35690.286194275446, 35843.10392240215, 30374.84812575923, 31427.214319641276, 31721.206969825016, 31888.521672174473, 31961.36077278488, 24595.754042459346, 24754.257372278862, 24799.62800557957, 24878.502429951663, 25033.74966250314], "value": 17702.11818546977, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.41992102675204, 371.59867343269264, 371.6784980991442, 379.9601041890603, 388.39604415134454, 16492.422765203206, 17519.562010949718, 18461.0, 18486.35297764577, 18487.445376638723, 10959.945200274007, 16310.266038028287, 17104.401345952894, 17133.74299385507, 17617.207225674843, 4683.672142950003, 4822.565969062784, 4880.267959806022, 4884.047610715912, 4888.511148885119, 3406.965930340702, 3567.3222087803233, 4742.81028758851, 5284.656497327681, 5580.497755202031, 5612.07400778871, 5617.887642247153, 5652.604317697763, 5654.151877218409, 5667.263255776764, 5151.974240128794, 5440.455954404548, 5440.537554307889, 5512.6692398456225, 5616.297962754656, 3336.215989242526, 4981.078500477423, 5236.476352364771, 5271.5782737381305, 5322.467753224685, 12395.380230988505, 12510.249385036926, 12575.371231438392, 15590.532284031497, 21803.890980545155, 1768.478298901827, 1851.6111616560538, 1953.5311525233983, 1971.540975126951, 2467.124170919316, 9107.499087550248, 9133.543322833832, 9670.903290967071, 11883.405829708567, 13118.87358774675, 1703.3186725309974, 1722.483255023488, 1794.6410717856481, 1815.7548730921421, 1820.6631773121883, 69067.0, 71767.0, 74378.25621743822, 74968.25031749667, 76541.61729191375, 8507.829843403097, 8801.779955501035, 9186.494742789211, 9236.261099112055, 10003.899961000443, 11943.462544185533, 11995.64013079609, 12017.278963262232, 12062.396880156133, 12076.879231207751, 6616.66916654175, 6724.966375168093, 6750.459963202932, 6771.119754431991, 6779.322067793181, 6613.875641141018, 6683.0, 6751.358620931003, 6752.5948443093575, 6789.25318214996, 3790.33669107905, 3796.52543432071, 3798.1074447504816, 3800.0689830991582, 3867.187890542961, 1549.3570168379997, 1633.3140081165939, 1647.1681800690574, 1776.2983621469705, 1832.1755210155484, 853.5988085599759, 855.3285670748432, 872.31959071924, 875.2341701011615, 904.5929331800585, 16952.660946780994, 17189.7421538677, 17300.134993250285, 17310.134493275287, 17879.37422190217, 888.3293113699245, 892.7321803458937, 903.9954800225956, 906.6781292641149, 912.9680461183826, 9678.128968392737, 9810.148635598862, 9821.459819709842, 9847.901520984698, 10010.799784004279, 357498.0, 358963.0, 359364.0, 360411.0, 360619.0, 59259.0, 83293.0, 83705.58147209225, 83760.58119709362, 83800.58099709585, 876.9912300877037, 878.0911756332166, 890.9198172164537, 896.0188593490118, 897.1521911793424, 15216.63050325476, 15406.38374465009, 15764.132972686153, 15892.68214635724, 16104.114273715059, 37770.244595108496, 38685.41971870368, 39078.6092139075, 39204.41193382045, 40311.79844100761, 55339.72330138324, 55915.16127258013, 58138.0, 58151.0, 58369.12446313224, 7142.928570714226, 7318.487705860539, 7384.409247260313, 7397.630118494161, 7519.436042296959, 10681.8931810684, 10700.069313793507, 11656.0, 11669.76660466803, 11957.581484647995, 9612.51937403141, 10101.646442374482, 10144.79710405773, 10231.334963227366, 10394.844077338998, 9646.517674116407, 9781.755456113655, 9801.85297220528, 9842.704718858446, 10064.69805905824, 5454.754536045967, 7534.54792712439, 9974.451405172786, 10384.169266458815, 10611.31026483276, 7570.9242907570215, 7686.192949740421, 7689.961550192437, 7741.535507869546, 7813.3749300057, 9104.499252541174, 9654.855177172207, 10021.5490302938, 10212.591496340063, 10219.7445063874], "value": 7978.399463850418, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1100.4002818463937, 1388.8194534710485, 1413.6183230527756, 1525.504211131382, 1707.4792188382546, 6510.25132109807, 7450.962745186273, 7674.386049116058, 7678.0786305643405, 7792.571408572526, 7595.544267343963, 7732.690692372313, 7733.265339792711, 7746.728864489744, 7749.341305988998, 1849.5468610190455, 1936.9515762105918, 1941.5922656242205, 2194.3636345459836, 2238.250186187621, 1971.4381401300632, 2112.6830975353664, 2204.360735386736, 2204.526026904215, 2209.856359336638, 2182.7271591051117, 2194.429448343434, 2208.039502816272, 2208.624533829253, 2210.6794514795347, 1785.3751187084417, 2107.926222582202, 2108.5677436125634, 2118.078635793435, 2120.713703650003, 2084.7602525709585, 2170.739511258659, 2186.464316242531, 2196.8242540596716, 2198.5932602468592, 7805.336546393563, 7834.921650783476, 7850.882236766453, 7855.607219639052, 7870.212978702084, 4456.420665313489, 4575.931361029588, 4582.747948862811, 4590.724556526619, 4591.8392856249875, 2781.1656503049003, 2788.7908406869565, 2873.928151796201, 2902.4195160967893, 2913.300807806111, 905.0994260710635, 908.6774195160755, 923.1230331185401, 939.7979434421563, 943.580106852451, 10557.47212639365, 10580.36517808934, 10589.629362972259, 10594.576216951313, 10607.15142788575, 4087.9182416351505, 4115.1975364803575, 4284.014676624394, 4285.0, 4288.699791014599, 9033.638654453749, 9046.095390460901, 9064.320175986828, 9065.365424420228, 9069.18377346042, 4611.654125940568, 4614.4693360264, 4618.65360097994, 4621.676482646182, 4622.884427889329, 3612.259486805199, 3714.53568303962, 4205.852795152155, 4205.894852628648, 4207.558206388347, 3561.198730285717, 3617.855285788539, 3678.8712395066577, 3690.1881586051563, 3695.833687484016, 1159.8434211381525, 1163.1973937982764, 1176.2824676947055, 1180.1031216275692, 1190.4523918997186, 724.478375569589, 732.0848938826467, 734.889766535024, 744.6611791634793, 746.8207630168829, 4838.080764654705, 4914.066327397783, 4935.605151587864, 4957.752112394366, 5028.446870844205, 387.3666555182241, 403.8808551477321, 406.3620116417256, 409.36752717052224, 410.51764177092394, 3349.4804164650513, 3367.0067330137667, 3417.7778444401533, 3432.1591210153174, 3465.0297916583395, 8945.552722363856, 9155.45067295951, 9258.166764991049, 9274.211692006254, 9350.532473376305, 9300.441973481478, 9322.394044387092, 9353.625854965725, 9378.0, 9413.341066125306, 6914.446844252448, 6916.619585922823, 7056.470764692669, 7063.752768653175, 7069.08101946754, 4797.95202047989, 4800.423949126127, 4828.082664293773, 4837.975810120927, 4843.104025755247, 8606.612702428281, 8631.13688631157, 8646.524441155796, 8646.697365592174, 8816.779580510538, 8702.347323950855, 8764.21122099014, 9020.0, 9023.639054437748, 9038.502882341534, 6274.027525733519, 6491.935080649133, 6515.924872396191, 6555.6066636002, 6561.40947314744, 6960.338767817049, 6985.965070174617, 7028.929710702828, 7042.683079261343, 7050.2597227292445, 6225.750969961151, 6289.842753931189, 6505.60966342021, 6540.149780528501, 6635.4359879410795, 6461.418472337512, 6470.611763294218, 6518.543701940818, 6559.147310849559, 6618.305077966744, 5620.156976453564, 5731.0, 5770.6249093808765, 5776.162456443876, 5864.9413505866105, 4265.552117027667, 4286.61420472159, 4318.050028993616, 4321.459817522809, 4343.370211319278, 4086.81609327575, 4149.25313443583, 4164.167166566759, 4259.063006138645, 4283.7001409901], "value": 3922.08699401866, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.4385180453529, 294.2423260105229, 302.5129541438283, 305.0543315721263, 305.11972958016116, 4786.186348320785, 4790.568848803607, 4813.3983252093485, 4823.204171311738, 4844.563989240967, 4677.625789936806, 4720.504347043562, 4753.120672675549, 4753.263244197146, 4776.593989510896, 3755.3428150073764, 3756.3050835595504, 3757.2297678975883, 3764.5294338207655, 3770.9057273568105, 3759.755615884959, 3768.2840260350445, 3770.396736522157, 3775.339315619756, 3780.9432858507143, 3640.908977275576, 3735.962640373589, 3745.4381842723674, 3750.0, 3750.2499500099952, 3716.2195938852874, 3728.1984373359724, 3743.2513497300647, 3758.004128905842, 3758.4738136660753, 3316.6351701312838, 3319.7012268895915, 3327.4676051831834, 3327.88352407667, 3329.6836800503916, 4672.976635116836, 4675.345451636774, 4679.625629949596, 4681.7190968542, 4682.859514214579, 3997.900052498682, 4203.138356636912, 4217.388478670576, 4238.766867822269, 4280.250956082673, 4997.201007637248, 5005.699658020494, 5012.418604418727, 5013.095023890898, 5013.273075404082, 3555.702168708429, 3563.465480177968, 3566.1084728817796, 3568.7323450741037, 3575.8212089395424, 4687.414073240845, 4884.242942343907, 5202.817901373472, 5242.161254199348, 5244.318238628992, 3524.84138213781, 3579.9439165446256, 3602.9099272518397, 3609.5668519777796, 3612.945805812915, 3644.489771432002, 3652.5251717276583, 3656.5794933582447, 3661.4141737322434, 3668.816559172031, 3978.3833505806647, 3988.0029992501873, 4104.42538044674, 4106.425100485934, 4167.229062623424, 4893.7063776173545, 4900.681455705368, 4903.156169421727, 4936.185529387611, 4937.679050861682, 1222.9816552751715, 1231.4581584102966, 1240.3860089255877, 1245.265293476853, 1246.3145270101588, 782.7338704840381, 816.2653611749473, 820.971266005687, 830.3149901331426, 830.8421399933993, 3965.5836137205756, 4024.4164596133396, 4043.6158564936286, 4052.128792309609, 4058.411530328086, 4562.543745625478, 4570.908581828345, 4573.242241108241, 4583.381243532147, 4606.055758569485, 3994.9201015979515, 4028.6504021152655, 4043.332850079763, 4044.6966477513715, 4048.655864251513, 2289.8511596746157, 2432.3189506938083, 2441.3042282949273, 2444.4255599934, 2448.824564209154, 4301.569843015736, 4348.869533913924, 4354.974936654471, 4368.257396242647, 4382.342648602671, 4652.860414187579, 4663.883402914887, 4677.46209185948, 4678.461976872703, 5036.7733451994745, 4614.238650622677, 4859.586935110485, 4879.731614761222, 4889.339939108318, 4897.583705385082, 5110.014188932639, 5127.948720512896, 5171.741412929414, 5200.97399513, 5211.583073354198, 4786.2581299898575, 4982.402111746469, 5046.823361182341, 5097.362829646294, 5110.642255042111, 4857.8299759508245, 4865.537773911473, 4878.536539028786, 4879.34128892595, 4879.707217566957, 3604.711008509563, 3607.5310209672575, 3615.5661320641693, 3620.9094772630897, 3623.728220383429, 4902.264660300983, 5143.5113664201845, 5144.614153938544, 5149.510796474329, 5150.9742451289, 4948.331975183304, 4963.70217786934, 4981.501849814989, 4998.475464983215, 5003.799848006039, 4955.752212389438, 4959.801607935787, 4965.4786247444945, 4966.255061740768, 4968.975155124202, 4687.953120468752, 4886.193778026728, 4889.853304400874, 4906.852794416173, 4920.803167873388, 5046.057267951938, 5048.924266135938, 5066.468020857904, 5074.264231686311, 5098.362704661918, 4925.2023011599795, 4938.308636790924, 4938.456769755396, 4939.333190019445, 4979.452260251442], "value": 3691.6305893293543, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.1044767177725, 602.0457574744031, 655.2006552006553, 665.3213722003557, 681.9931800681992, 12767.80848287274, 12808.167469114513, 13341.933290333547, 13353.59939201823, 13367.0, 11828.349440780754, 11848.11139164564, 11947.163698541106, 11948.7610247795, 11957.402129893513, 624.2290770897937, 743.8772602520578, 769.4844454215674, 796.7888509544975, 800.1998001998002, 672.532589850052, 685.0101603183402, 686.1388956859134, 686.5811854768588, 687.1410736579276, 829.4401279136589, 831.5592735850009, 832.7709879783048, 832.9208725171129, 833.0336809301211, 643.8100760275706, 724.4240828541323, 781.3827076609472, 830.3149901331395, 830.4228561150003, 555.3474667265947, 556.5519756595938, 557.3200695151908, 557.4119304134136, 557.6013150597342, 12962.546310879168, 12986.675333116653, 13007.804882926668, 13060.151090179108, 13104.606861794162, 11471.426428678617, 12423.813642795365, 12831.935840320739, 12875.806862897063, 13032.609021729364, 11193.552257909674, 11340.262882912584, 11439.714007149805, 11601.593944211912, 11971.042316614738, 4104.958950410517, 4153.2173443792735, 4183.142455796555, 4192.538820729717, 4210.915781684349, 54156.0, 60303.69848150775, 61255.693721531556, 61389.386106138816, 61507.38492615061, 10716.571337146426, 11017.83473247886, 11058.723531911766, 11065.612703555336, 11280.492377843017, 18990.90504547496, 19170.233190672217, 19224.32714855001, 19236.03819809004, 19260.0, 6599.934000659932, 6659.367360100783, 6682.866342673216, 6737.326267373322, 7036.577805331696, 3483.304811557283, 3632.1124705858906, 3678.448232765053, 3819.3125237457525, 3888.7277890547957, 2637.485690290375, 2749.9037533686223, 2761.2268564801484, 2764.7926405519265, 2766.792490563216, 517.2525700363014, 528.3791544934686, 531.4074806590623, 532.3239485852945, 533.754472942443, 443.74262927501974, 455.6241101091613, 520.9635325527177, 530.7850320620155, 552.7402121003122, 7678.308952194329, 7833.64748586315, 8028.919710802934, 8058.879116813252, 8115.715949941724, 556.4352182534731, 558.6787597131665, 566.224272746332, 567.0869899461863, 571.948524632785, 3575.2313252650806, 3677.558692956809, 3816.46569480273, 3861.1698484825897, 3875.476810630585, 68917.65541172262, 93931.53034234785, 97082.0, 100478.4976075115, 101174.49412752889, 86045.569772152, 86537.1346286529, 87011.56494217488, 87475.0, 88526.0, 74723.25276747163, 74822.62588687021, 74904.99999999891, 75186.24813751903, 75358.62320688361, 6991.161060672752, 7143.392811610864, 7172.390346820579, 7197.100362454693, 7289.890651640336, 43716.0, 44492.77753611211, 46476.767616161706, 46951.765241173576, 46967.0, 64993.35006649873, 65461.67269163624, 65751.0, 65833.67083164553, 67456.0, 9405.24758019343, 9414.95292523533, 9564.234861211226, 9654.0, 9779.168770654574, 10849.620263290746, 11121.332720036824, 11132.833007504732, 11132.944335278271, 11135.109191264517, 9688.854667179858, 9754.22120091923, 9778.07108324708, 9826.606935722491, 9839.220280678843, 9427.292953028687, 9619.53829386687, 9678.336183813548, 9694.6122155113, 9846.556904939152, 9572.090651388107, 9839.612529278676, 9951.601935922772, 9977.800443991226, 10137.949310253696, 8019.398545109024, 8026.879596805936, 8178.83642327162, 8258.04658181594, 8308.5430301334, 8188.2630563249595, 8339.499630022217, 8422.24199822019, 8437.493750374997, 8600.870986935326], "value": 6263.111357741443, "unit": "score"}], "name": "dromaeo_css", "value": 6214.91913901151, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 113.0, 114.0, 116.0, 113.0, 113.0, 114.0, 114.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 124.0, 125.0, 180.0, 126.0, 123.0, 143.0, 122.0, 168.0, 125.0], "value": 138.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 159.0, 160.0, 162.0, 161.0, 162.0, 160.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 123.0, 75.0, 76.0, 76.0, 78.0, 108.0, 75.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 120.0, 85.0, 86.0, 85.0, 124.0, 85.0, 85.0, 127.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 118.0, 117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 148.0, 146.0, 146.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 96.0, 94.0, 96.0, 95.0, 94.0, 96.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 63.0, 63.0, 63.0, 66.0, 64.0, 64.0, 63.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 74.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 87.0, 88.0, 83.0, 78.0, 78.0, 79.0, 88.0, 82.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 129.0, 143.0, 138.0, 128.0, 132.0, 129.0, 130.0, 184.0, 132.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 171.0, 167.0, 168.0, 171.0, 165.0, 165.0, 168.0, 165.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 68.0, 71.0, 70.0, 67.0, 67.0, 66.0, 66.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1535.4999999999998, "alertThreshold": 2.0}]} 02:53:41 INFO - Return code: 0 02:53:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:53:41 INFO - # TBPL SUCCESS # 02:53:41 INFO - Running post-action listener: _resource_record_post_action 02:53:41 INFO - ##### 02:53:41 INFO - ##### Finished run-tests step (success) 02:53:41 INFO - ##### 02:53:41 INFO - Running post-run listener: _resource_record_post_run 02:53:42 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 10203136; Write bytes: 434302976; Read time: 2196; Write time: 361276 02:53:42 INFO - TinderboxPrint: CPU usage
13.0% 02:53:42 INFO - TinderboxPrint: I/O read bytes / time
10,203,136 / 2,196 02:53:42 INFO - TinderboxPrint: I/O write bytes / time
434,302,976 / 361,276 02:53:42 INFO - TinderboxPrint: CPU idle
8,330.4 (87.0%) 02:53:42 INFO - TinderboxPrint: CPU user
1,203.3 (12.6%) 02:53:42 INFO - TinderboxPrint: Swap in / out
0 / 0 02:53:42 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106471424; Read time: 0; Write time: 85244 02:53:42 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 7974912; Write bytes: 327831552; Read time: 2068; Write time: 276032 02:53:42 INFO - Running post-run listener: _upload_blobber_files 02:53:42 INFO - Blob upload gear active. 02:53:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:53:42 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:53:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:53:42 INFO - (blobuploader) - INFO - Open directory for files ... 02:53:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:53:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:53:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:46 INFO - (blobuploader) - INFO - Done attempting. 02:53:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:53:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:53:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:47 INFO - (blobuploader) - INFO - Done attempting. 02:53:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:53:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:53:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:48 INFO - (blobuploader) - INFO - Done attempting. 02:53:48 INFO - (blobuploader) - INFO - Iteration through files over. 02:53:48 INFO - Return code: 0 02:53:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:53:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:53:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b662303dd6bb9c638b3eb2631b17d111f59aa997a4a9c5beff45e0115f64c4bd715977bbf58835cf27a52640dbec6f37be3fea174233fda43529538f7b73ae40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/879bad99bf75020f5e13c45176bb7d75c54a7f0bc9b43a79969118c6f52a1472e19e1de7fd36c7c1839b3432641a1834674694bef8eeca859b157bec1cd891bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a83ce5348154911d55f3e8e0f2f065adefa586123857a156d89d07e9686312a7b633ea7bea135d72cd3592ee05fd68ce77f79dbbf6d71b2f25c4e5ae3fca525"} 02:53:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:53:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:53:48 INFO - Contents: 02:53:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b662303dd6bb9c638b3eb2631b17d111f59aa997a4a9c5beff45e0115f64c4bd715977bbf58835cf27a52640dbec6f37be3fea174233fda43529538f7b73ae40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/879bad99bf75020f5e13c45176bb7d75c54a7f0bc9b43a79969118c6f52a1472e19e1de7fd36c7c1839b3432641a1834674694bef8eeca859b157bec1cd891bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a83ce5348154911d55f3e8e0f2f065adefa586123857a156d89d07e9686312a7b633ea7bea135d72cd3592ee05fd68ce77f79dbbf6d71b2f25c4e5ae3fca525"} 02:53:48 INFO - Running post-run listener: copy_logs_to_upload_dir 02:53:48 INFO - Copying logs to upload dir... 02:53:48 INFO - mkdir: /builds/slave/test/build/upload/logs 02:53:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1302.935697 ========= master_lag: 0.52 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 43 secs) (at 2016-07-11 02:53:48.623725) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 02:53:48.627688) ========= 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=8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b662303dd6bb9c638b3eb2631b17d111f59aa997a4a9c5beff45e0115f64c4bd715977bbf58835cf27a52640dbec6f37be3fea174233fda43529538f7b73ae40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/879bad99bf75020f5e13c45176bb7d75c54a7f0bc9b43a79969118c6f52a1472e19e1de7fd36c7c1839b3432641a1834674694bef8eeca859b157bec1cd891bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a83ce5348154911d55f3e8e0f2f065adefa586123857a156d89d07e9686312a7b633ea7bea135d72cd3592ee05fd68ce77f79dbbf6d71b2f25c4e5ae3fca525"} build_url:https://queue.taskcluster.net/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011162 build_url: 'https://queue.taskcluster.net/v1/task/OOI6Ot6wQhuGehkkWS-OaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b662303dd6bb9c638b3eb2631b17d111f59aa997a4a9c5beff45e0115f64c4bd715977bbf58835cf27a52640dbec6f37be3fea174233fda43529538f7b73ae40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/879bad99bf75020f5e13c45176bb7d75c54a7f0bc9b43a79969118c6f52a1472e19e1de7fd36c7c1839b3432641a1834674694bef8eeca859b157bec1cd891bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a83ce5348154911d55f3e8e0f2f065adefa586123857a156d89d07e9686312a7b633ea7bea135d72cd3592ee05fd68ce77f79dbbf6d71b2f25c4e5ae3fca525"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 02:53:48.657760) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 02:53:48.658546) ========= 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=8887e36bb8e381bfd44124ac000001a8-1468229522.918719-682202491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004435 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 02:53:48.740720) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 02:53:48.741104) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 02:53:48.741481) ========= ========= Total master_lag: 0.67 =========