builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-021 starttime: 1470337620.52 results: success (0) buildid: 20160804105222 builduid: 06958df2395a4e0f8c6316723072aee0 revision: d912055f8e8ad75d189bd480017fdb5a33ee4d7e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 12:07:00.523806) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 12:07:00.524226) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 12:07:00.524506) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 12:07:00.543618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 12:07:00.544131) ========= 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=df17445c3590ff7897617a0e00000225-1470335713.604542-120191102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 12:07:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 66.9M=0s 2016-08-04 12:07:00 (66.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072633 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 12:07:00.631128) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 12:07:00.631690) ========= 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=df17445c3590ff7897617a0e00000225-1470335713.604542-120191102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017541 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 12:07:00.687648) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 12:07:00.687970) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d912055f8e8ad75d189bd480017fdb5a33ee4d7e --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 d912055f8e8ad75d189bd480017fdb5a33ee4d7e --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=df17445c3590ff7897617a0e00000225-1470335713.604542-120191102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 12:07:00,870 truncating revision to first 12 chars 2016-08-04 12:07:00,870 Setting DEBUG logging. 2016-08-04 12:07:00,870 attempt 1/10 2016-08-04 12:07:00,870 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d912055f8e8a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 12:07:01,174 unpacking tar archive at: fx-team-d912055f8e8a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.745758 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 12:07:01.456259) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 12:07:01.456574) ========= script_repo_revision: d912055f8e8ad75d189bd480017fdb5a33ee4d7e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 12:07:01.456991) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 12:07:01.457290) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 12:07:01.466913) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-04 12:07:01.467238) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=df17445c3590ff7897617a0e00000225-1470335713.604542-120191102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:07:01 INFO - MultiFileLogger online at 20160804 12:07:01 in /builds/slave/test 12:07:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 12:07:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:07:01 INFO - {'append_to_log': False, 12:07:01 INFO - 'base_work_dir': '/builds/slave/test', 12:07:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:07:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:07:01 INFO - 'branch': 'Fx-Team-Non-PGO', 12:07:01 INFO - 'buildbot_json_path': 'buildprops.json', 12:07:01 INFO - 'config_files': ('talos/linux_config.py',), 12:07:01 INFO - 'default_actions': ('clobber', 12:07:01 INFO - 'read-buildbot-config', 12:07:01 INFO - 'download-and-extract', 12:07:01 INFO - 'populate-webroot', 12:07:01 INFO - 'create-virtualenv', 12:07:01 INFO - 'install', 12:07:01 INFO - 'run-tests'), 12:07:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:07:01 INFO - 'download_minidump_stackwalk': True, 12:07:01 INFO - 'download_symbols': 'ondemand', 12:07:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:07:01 INFO - 'tooltool.py': '/tools/tooltool.py', 12:07:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:07:01 INFO - '/tools/misc-python/virtualenv.py')}, 12:07:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:07:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:07:01 INFO - 'installer_path': 'installer.exe', 12:07:01 INFO - 'log_level': 'info', 12:07:01 INFO - 'log_name': 'talos', 12:07:01 INFO - 'log_to_console': True, 12:07:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:07:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:07:01 INFO - 'opt_config_files': (), 12:07:01 INFO - 'pip_index': False, 12:07:01 INFO - 'sps_profile': False, 12:07:01 INFO - 'sps_profile_interval': 0, 12:07:01 INFO - 'suite': 'dromaeojs-e10s', 12:07:01 INFO - 'system_bits': '32', 12:07:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:07:01 INFO - 'title': 'talos-linux64-ix-021', 12:07:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:07:01 INFO - 'use_talos_json': True, 12:07:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:07:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:07:01 INFO - 'work_dir': 'build'} 12:07:01 INFO - [mozharness: 2016-08-04 19:07:01.729777Z] Running clobber step. 12:07:01 INFO - Running pre-action listener: _resource_record_pre_action 12:07:01 INFO - Running main action method: clobber 12:07:01 INFO - rmtree: /builds/slave/test/build 12:07:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:07:02 INFO - Running post-action listener: _resource_record_post_action 12:07:02 INFO - [mozharness: 2016-08-04 19:07:02.185209Z] Finished clobber step (success) 12:07:02 INFO - [mozharness: 2016-08-04 19:07:02.185309Z] Running read-buildbot-config step. 12:07:02 INFO - Running pre-action listener: _resource_record_pre_action 12:07:02 INFO - Running main action method: read_buildbot_config 12:07:02 INFO - Using buildbot properties: 12:07:02 INFO - { 12:07:02 INFO - "project": "", 12:07:02 INFO - "product": "firefox", 12:07:02 INFO - "script_repo_revision": "production", 12:07:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:07:02 INFO - "repository": "", 12:07:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 12:07:02 INFO - "buildid": "20160804105222", 12:07:02 INFO - "pgo_build": "False", 12:07:02 INFO - "basedir": "/builds/slave/test", 12:07:02 INFO - "buildnumber": 1500, 12:07:02 INFO - "slavename": "talos-linux64-ix-021", 12:07:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:07:02 INFO - "platform": "ubuntu64_hw", 12:07:02 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 12:07:02 INFO - "branch": "fx-team", 12:07:02 INFO - "repo_path": "integration/fx-team", 12:07:02 INFO - "revision": "d912055f8e8ad75d189bd480017fdb5a33ee4d7e", 12:07:02 INFO - "stage_platform": "linux64", 12:07:02 INFO - "builduid": "06958df2395a4e0f8c6316723072aee0", 12:07:02 INFO - "slavebuilddir": "test" 12:07:02 INFO - } 12:07:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/N88kVI0aTkWcsRpBziZDww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 12:07:02 INFO - Running post-action listener: _resource_record_post_action 12:07:02 INFO - [mozharness: 2016-08-04 19:07:02.187754Z] Finished read-buildbot-config step (success) 12:07:02 INFO - [mozharness: 2016-08-04 19:07:02.187844Z] Running download-and-extract step. 12:07:02 INFO - Running pre-action listener: _resource_record_pre_action 12:07:02 INFO - Running main action method: download_and_extract 12:07:02 INFO - mkdir: /builds/slave/test/build/tests 12:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:02 INFO - trying https://queue.taskcluster.net/v1/task/N88kVI0aTkWcsRpBziZDww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:07:02 INFO - Downloading https://queue.taskcluster.net/v1/task/N88kVI0aTkWcsRpBziZDww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:07:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N88kVI0aTkWcsRpBziZDww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:07:02 INFO - Downloaded 1361 bytes. 12:07:02 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:07:02 INFO - Using the following test package requirements: 12:07:02 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 12:07:02 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:07:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:07:02 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:07:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:07:02 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:07:02 INFO - u'jsshell-linux-x86_64.zip'], 12:07:02 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:07:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:07:02 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 12:07:02 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:07:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:07:02 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:07:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:07:02 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:07:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:07:02 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:07:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:07:02 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:02 INFO - trying https://queue.taskcluster.net/v1/task/N88kVI0aTkWcsRpBziZDww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:07:02 INFO - Downloading https://queue.taskcluster.net/v1/task/N88kVI0aTkWcsRpBziZDww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:07:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N88kVI0aTkWcsRpBziZDww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:07:03 INFO - Downloaded 20249623 bytes. 12:07:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:07:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:07:04 INFO - Return code: 0 12:07:04 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:04 INFO - trying https://queue.taskcluster.net/v1/task/N88kVI0aTkWcsRpBziZDww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:07:04 INFO - Downloading https://queue.taskcluster.net/v1/task/N88kVI0aTkWcsRpBziZDww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:07:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N88kVI0aTkWcsRpBziZDww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:07:06 INFO - Downloaded 20249623 bytes. 12:07:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:07:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:07:07 INFO - Return code: 0 12:07: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:07 INFO - trying https://queue.taskcluster.net/v1/task/N88kVI0aTkWcsRpBziZDww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 12:07:07 INFO - Downloading https://queue.taskcluster.net/v1/task/N88kVI0aTkWcsRpBziZDww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 12:07:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N88kVI0aTkWcsRpBziZDww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:07:08 INFO - Downloaded 14413723 bytes. 12:07:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:07:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:07:08 INFO - Return code: 0 12:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:08 INFO - trying https://queue.taskcluster.net/v1/task/N88kVI0aTkWcsRpBziZDww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:07:08 INFO - Downloading https://queue.taskcluster.net/v1/task/N88kVI0aTkWcsRpBziZDww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:07:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N88kVI0aTkWcsRpBziZDww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:07:09 INFO - Downloaded 55515866 bytes. 12:07:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N88kVI0aTkWcsRpBziZDww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:07:09 INFO - mkdir: /builds/slave/test/properties 12:07:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:07:09 INFO - Writing to file /builds/slave/test/properties/build_url 12:07:09 INFO - Contents: 12:07:09 INFO - build_url:https://queue.taskcluster.net/v1/task/N88kVI0aTkWcsRpBziZDww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:07:10 INFO - Running post-action listener: _resource_record_post_action 12:07:10 INFO - Running post-action listener: set_extra_try_arguments 12:07:10 INFO - [mozharness: 2016-08-04 19:07:10.431872Z] Finished download-and-extract step (success) 12:07:10 INFO - [mozharness: 2016-08-04 19:07:10.432103Z] Running populate-webroot step. 12:07:10 INFO - Running pre-action listener: _resource_record_pre_action 12:07:10 INFO - Running main action method: populate_webroot 12:07:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:07:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:07:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:07:10 INFO - '--tppagecycles', 12:07:10 INFO - '7'], 12:07:10 INFO - 'tests': ['tsvgm']}}, 12:07:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:07:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:07:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:07:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:07:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:07:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:07:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:07:10 INFO - 'talos_options': ['--disable-e10s'], 12:07:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:07:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:07:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:07:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:07:10 INFO - 'talos_options': ['--disable-e10s'], 12:07:10 INFO - 'tests': ['damp', 'tps']}, 12:07:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:07:10 INFO - 'tests': ['damp', 'tps']}, 12:07:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:07:10 INFO - 'tests': ['dromaeo_dom']}, 12:07:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:07:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:07:10 INFO - 'tests': ['basic_compositor_video']}, 12:07:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:07:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:07:10 INFO - 'tests': ['a11yr', 12:07:10 INFO - 'ts_paint', 12:07:10 INFO - 'tpaint', 12:07:10 INFO - 'sessionrestore', 12:07:10 INFO - 'sessionrestore_no_auto_restore', 12:07:10 INFO - 'tabpaint']}, 12:07:10 INFO - 'other-e10s': {'tests': ['a11yr', 12:07:10 INFO - 'ts_paint', 12:07:10 INFO - 'tpaint', 12:07:10 INFO - 'sessionrestore', 12:07:10 INFO - 'sessionrestore_no_auto_restore', 12:07:10 INFO - 'tabpaint']}, 12:07:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:07:10 INFO - 'ts_paint', 12:07:10 INFO - 'tpaint', 12:07:10 INFO - 'sessionrestore', 12:07:10 INFO - 'sessionrestore_no_auto_restore', 12:07:10 INFO - 'tabpaint']}, 12:07:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:07:10 INFO - 'ts_paint', 12:07:10 INFO - 'tpaint', 12:07:10 INFO - 'sessionrestore', 12:07:10 INFO - 'sessionrestore_no_auto_restore', 12:07:10 INFO - 'tabpaint']}, 12:07:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:07:10 INFO - 'tests': ['a11yr', 12:07:10 INFO - 'ts_paint', 12:07:10 INFO - 'tpaint', 12:07:10 INFO - 'sessionrestore', 12:07:10 INFO - 'sessionrestore_no_auto_restore', 12:07:10 INFO - 'tabpaint']}, 12:07:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:07:10 INFO - 'tests': ['a11yr', 12:07:10 INFO - 'ts_paint', 12:07:10 INFO - 'tpaint', 12:07:10 INFO - 'sessionrestore', 12:07:10 INFO - 'sessionrestore_no_auto_restore', 12:07:10 INFO - 'tabpaint']}, 12:07:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:07:10 INFO - 'tests': ['tsvgx', 12:07:10 INFO - 'tsvgr_opacity', 12:07:10 INFO - 'tart', 12:07:10 INFO - 'tscrollx', 12:07:10 INFO - 'cart']}, 12:07:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:07:10 INFO - 'tsvgr_opacity', 12:07:10 INFO - 'tart', 12:07:10 INFO - 'tscrollx', 12:07:10 INFO - 'cart']}, 12:07:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:07:10 INFO - 'talos_options': ['--disable-e10s'], 12:07:10 INFO - 'tests': ['tp5o']}, 12:07:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:07:10 INFO - 'tests': ['tp5o']}, 12:07:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:07:10 INFO - 'talos_options': ['--disable-e10s', 12:07:10 INFO - '--xperf_path', 12:07:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:07:10 INFO - 'tests': ['tp5n']}, 12:07:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:07:10 INFO - 'talos_options': ['--xperf_path', 12:07:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:07:10 INFO - 'tests': ['tp5n']}}, 12:07:10 INFO - 'talos.zip': {'path': '', 12:07:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:07:10 INFO - Running post-action listener: _resource_record_post_action 12:07:10 INFO - [mozharness: 2016-08-04 19:07:10.448924Z] Finished populate-webroot step (success) 12:07:10 INFO - [mozharness: 2016-08-04 19:07:10.449012Z] Running create-virtualenv step. 12:07:10 INFO - Running pre-action listener: _resource_record_pre_action 12:07:10 INFO - Running main action method: create_virtualenv 12:07:10 INFO - Creating virtualenv /builds/slave/test/build/venv 12:07:10 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 12:07:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:07:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:07:10 INFO - Using real prefix '/usr' 12:07:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:07:11 INFO - Installing distribute.............................................................................................................................................................................................done. 12:07:13 INFO - Installing pip.................done. 12:07:13 INFO - Return code: 0 12:07:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:07: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:07: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:07:13 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 0x1acb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d89570>, '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 0x1d8a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a900>, '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': 'df17445c3590ff7897617a0e00000225-1470335713.604542-120191102', '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 12:07:13 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 12:07:13 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 12:07:13 INFO - Using env: {'DISPLAY': ':0', 12:07:13 INFO - 'HOME': '/home/cltbld', 12:07:13 INFO - 'LANG': 'en_US.UTF-8', 12:07:13 INFO - 'LANGUAGE': 'en_US:en', 12:07:13 INFO - 'LOGNAME': 'cltbld', 12:07:13 INFO - 'MAIL': '/var/mail/cltbld', 12:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:07:13 INFO - 'MOZ_NO_REMOTE': '1', 12:07:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:07:13 INFO - 'NO_EM_RESTART': '1', 12:07:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:07:13 INFO - 'PWD': '/builds/slave/test', 12:07:13 INFO - 'SHELL': '/bin/bash', 12:07:13 INFO - 'SHLVL': '1', 12:07:13 INFO - 'TERM': 'linux', 12:07:13 INFO - 'TMOUT': '86400', 12:07:13 INFO - 'USER': 'cltbld', 12:07:13 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470335713.604542-120191102', 12:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:07:13 INFO - '_': '/tools/buildbot/bin/python'} 12:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:07:13 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 12:07:13 INFO - Cleaning up... 12:07:13 INFO - Return code: 0 12:07:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:07: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:07: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:07:13 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 0x1acb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d89570>, '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 0x1d8a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a900>, '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': 'df17445c3590ff7897617a0e00000225-1470335713.604542-120191102', '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 12:07:13 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 12:07:13 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 12:07:13 INFO - Using env: {'DISPLAY': ':0', 12:07:13 INFO - 'HOME': '/home/cltbld', 12:07:13 INFO - 'LANG': 'en_US.UTF-8', 12:07:13 INFO - 'LANGUAGE': 'en_US:en', 12:07:13 INFO - 'LOGNAME': 'cltbld', 12:07:13 INFO - 'MAIL': '/var/mail/cltbld', 12:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:07:13 INFO - 'MOZ_NO_REMOTE': '1', 12:07:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:07:13 INFO - 'NO_EM_RESTART': '1', 12:07:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:07:13 INFO - 'PWD': '/builds/slave/test', 12:07:13 INFO - 'SHELL': '/bin/bash', 12:07:13 INFO - 'SHLVL': '1', 12:07:13 INFO - 'TERM': 'linux', 12:07:13 INFO - 'TMOUT': '86400', 12:07:13 INFO - 'USER': 'cltbld', 12:07:13 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470335713.604542-120191102', 12:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:07:13 INFO - '_': '/tools/buildbot/bin/python'} 12:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:07:13 INFO - Downloading/unpacking psutil>=3.1.1 12:07:13 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 12:07:13 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 12:07:13 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 12:07:13 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 12:07:13 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 12:07:13 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 12:07:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:07:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:07:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:07:15 INFO - Installing collected packages: psutil 12:07:15 INFO - Running setup.py install for psutil 12:07:15 INFO - building 'psutil._psutil_linux' extension 12:07:15 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 12:07:15 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 12:07:15 INFO - building 'psutil._psutil_posix' extension 12:07:15 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 12:07:15 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 12:07:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:07:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:07:16 INFO - Successfully installed psutil 12:07:16 INFO - Cleaning up... 12:07:16 INFO - Return code: 0 12:07:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:07:16 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:07:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:07:16 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:07:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:07:16 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 0x1acb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d89570>, '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 0x1d8a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a900>, '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': 'df17445c3590ff7897617a0e00000225-1470335713.604542-120191102', '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 12:07:16 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 12:07:16 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 12:07:16 INFO - Using env: {'DISPLAY': ':0', 12:07:16 INFO - 'HOME': '/home/cltbld', 12:07:16 INFO - 'LANG': 'en_US.UTF-8', 12:07:16 INFO - 'LANGUAGE': 'en_US:en', 12:07:16 INFO - 'LOGNAME': 'cltbld', 12:07:16 INFO - 'MAIL': '/var/mail/cltbld', 12:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:07:16 INFO - 'MOZ_NO_REMOTE': '1', 12:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:07:16 INFO - 'NO_EM_RESTART': '1', 12:07:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:07:16 INFO - 'PWD': '/builds/slave/test', 12:07:16 INFO - 'SHELL': '/bin/bash', 12:07:16 INFO - 'SHLVL': '1', 12:07:16 INFO - 'TERM': 'linux', 12:07:16 INFO - 'TMOUT': '86400', 12:07:16 INFO - 'USER': 'cltbld', 12:07:16 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470335713.604542-120191102', 12:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:07:16 INFO - '_': '/tools/buildbot/bin/python'} 12:07:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:07:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:07:16 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 12:07:16 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 12:07:16 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 12:07:16 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 12:07:16 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 12:07:16 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 12:07:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:07:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:07:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:07:18 INFO - Installing collected packages: mozsystemmonitor 12:07:18 INFO - Running setup.py install for mozsystemmonitor 12:07:18 INFO - Successfully installed mozsystemmonitor 12:07:18 INFO - Cleaning up... 12:07:18 INFO - Return code: 0 12:07:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:07:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:07:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:07:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1acb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d89570>, '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 0x1d8a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a900>, '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': 'df17445c3590ff7897617a0e00000225-1470335713.604542-120191102', '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 12:07:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:07:18 INFO - Using env: {'DISPLAY': ':0', 12:07:18 INFO - 'HOME': '/home/cltbld', 12:07:18 INFO - 'LANG': 'en_US.UTF-8', 12:07:18 INFO - 'LANGUAGE': 'en_US:en', 12:07:18 INFO - 'LOGNAME': 'cltbld', 12:07:18 INFO - 'MAIL': '/var/mail/cltbld', 12:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:07:18 INFO - 'MOZ_NO_REMOTE': '1', 12:07:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:07:18 INFO - 'NO_EM_RESTART': '1', 12:07:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:07:18 INFO - 'PWD': '/builds/slave/test', 12:07:18 INFO - 'SHELL': '/bin/bash', 12:07:18 INFO - 'SHLVL': '1', 12:07:18 INFO - 'TERM': 'linux', 12:07:18 INFO - 'TMOUT': '86400', 12:07:18 INFO - 'USER': 'cltbld', 12:07:18 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470335713.604542-120191102', 12:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:07:18 INFO - '_': '/tools/buildbot/bin/python'} 12:07:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:07:18 INFO - Downloading/unpacking jsonschema==2.5.1 12:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:07:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:07:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:07:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:07:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:07:20 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 12:07:20 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 12:07:20 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 12:07:20 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 12:07:20 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 12:07:20 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 12:07:20 INFO - Downloading functools32-3.2.3-2.tar.gz 12:07:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:07:20 INFO - warning: no files found matching '*.txt' 12:07:20 INFO - no previously-included directories found matching 'build' 12:07:20 INFO - no previously-included directories found matching 'dist' 12:07:20 INFO - no previously-included directories found matching '.git*' 12:07:20 INFO - Installing collected packages: jsonschema, functools32 12:07:20 INFO - Running setup.py install for functools32 12:07:20 INFO - warning: no files found matching '*.txt' 12:07:20 INFO - no previously-included directories found matching 'build' 12:07:20 INFO - no previously-included directories found matching 'dist' 12:07:20 INFO - no previously-included directories found matching '.git*' 12:07:20 INFO - Successfully installed jsonschema functools32 12:07:20 INFO - Cleaning up... 12:07:21 INFO - Return code: 0 12:07:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:07: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:07: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:07: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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d89570>, '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 0x1d8a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a900>, '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': 'df17445c3590ff7897617a0e00000225-1470335713.604542-120191102', '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 12:07: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:07: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 functools32==3.2.3-2 12:07:21 INFO - Using env: {'DISPLAY': ':0', 12:07:21 INFO - 'HOME': '/home/cltbld', 12:07:21 INFO - 'LANG': 'en_US.UTF-8', 12:07:21 INFO - 'LANGUAGE': 'en_US:en', 12:07:21 INFO - 'LOGNAME': 'cltbld', 12:07:21 INFO - 'MAIL': '/var/mail/cltbld', 12:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:07:21 INFO - 'MOZ_NO_REMOTE': '1', 12:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:07:21 INFO - 'NO_EM_RESTART': '1', 12:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:07:21 INFO - 'PWD': '/builds/slave/test', 12:07:21 INFO - 'SHELL': '/bin/bash', 12:07:21 INFO - 'SHLVL': '1', 12:07:21 INFO - 'TERM': 'linux', 12:07:21 INFO - 'TMOUT': '86400', 12:07:21 INFO - 'USER': 'cltbld', 12:07:21 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470335713.604542-120191102', 12:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:07:21 INFO - '_': '/tools/buildbot/bin/python'} 12:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:07:21 INFO - Cleaning up... 12:07:21 INFO - Return code: 0 12:07:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:07: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:07: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:07: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', '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 0x1acb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d89570>, '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 0x1d8a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a900>, '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': 'df17445c3590ff7897617a0e00000225-1470335713.604542-120191102', '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 12:07: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:07: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 blobuploader==1.2.4 12:07:21 INFO - Using env: {'DISPLAY': ':0', 12:07:21 INFO - 'HOME': '/home/cltbld', 12:07:21 INFO - 'LANG': 'en_US.UTF-8', 12:07:21 INFO - 'LANGUAGE': 'en_US:en', 12:07:21 INFO - 'LOGNAME': 'cltbld', 12:07:21 INFO - 'MAIL': '/var/mail/cltbld', 12:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:07:21 INFO - 'MOZ_NO_REMOTE': '1', 12:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:07:21 INFO - 'NO_EM_RESTART': '1', 12:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:07:21 INFO - 'PWD': '/builds/slave/test', 12:07:21 INFO - 'SHELL': '/bin/bash', 12:07:21 INFO - 'SHLVL': '1', 12:07:21 INFO - 'TERM': 'linux', 12:07:21 INFO - 'TMOUT': '86400', 12:07:21 INFO - 'USER': 'cltbld', 12:07:21 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470335713.604542-120191102', 12:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:07:21 INFO - '_': '/tools/buildbot/bin/python'} 12:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:07:21 INFO - Downloading/unpacking blobuploader==1.2.4 12:07: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 12:07: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 12:07: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 12:07: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 12:07: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 12:07: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 12:07:23 INFO - Downloading blobuploader-1.2.4.tar.gz 12:07:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:07:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:07:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:07:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:07:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:07:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:07:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:07:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:07:23 INFO - Downloading docopt-0.6.1.tar.gz 12:07:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:07:24 INFO - Installing collected packages: blobuploader, requests, docopt 12:07:24 INFO - Running setup.py install for blobuploader 12:07:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:07:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:07:24 INFO - Running setup.py install for requests 12:07:24 INFO - Running setup.py install for docopt 12:07:24 INFO - Successfully installed blobuploader requests docopt 12:07:24 INFO - Cleaning up... 12:07:24 INFO - Return code: 0 12:07:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:07:24 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:07:24 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:07:24 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 0x1acb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d89570>, '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 0x1d8a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a900>, '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': 'df17445c3590ff7897617a0e00000225-1470335713.604542-120191102', '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 12:07:24 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 12:07:24 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 12:07:24 INFO - Using env: {'DISPLAY': ':0', 12:07:24 INFO - 'HOME': '/home/cltbld', 12:07:24 INFO - 'LANG': 'en_US.UTF-8', 12:07:24 INFO - 'LANGUAGE': 'en_US:en', 12:07:24 INFO - 'LOGNAME': 'cltbld', 12:07:24 INFO - 'MAIL': '/var/mail/cltbld', 12:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:07:24 INFO - 'MOZ_NO_REMOTE': '1', 12:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:07:24 INFO - 'NO_EM_RESTART': '1', 12:07:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:07:24 INFO - 'PWD': '/builds/slave/test', 12:07:24 INFO - 'SHELL': '/bin/bash', 12:07:24 INFO - 'SHLVL': '1', 12:07:24 INFO - 'TERM': 'linux', 12:07:24 INFO - 'TMOUT': '86400', 12:07:24 INFO - 'USER': 'cltbld', 12:07:24 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470335713.604542-120191102', 12:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:07:24 INFO - '_': '/tools/buildbot/bin/python'} 12:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:07:24 INFO - Running setup.py (path:/tmp/pip-MyK0hm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:07:24 INFO - Running setup.py (path:/tmp/pip-mZsXxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:07:25 INFO - Running setup.py (path:/tmp/pip-DDO4RV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:07:25 INFO - Running setup.py (path:/tmp/pip-BQgeVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:07:25 INFO - Running setup.py (path:/tmp/pip-cag3Dk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:07:25 INFO - Running setup.py (path:/tmp/pip-bP0Gll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:07:25 INFO - Running setup.py (path:/tmp/pip-0rf8vP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:07:25 INFO - Running setup.py (path:/tmp/pip-ZgEvp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:07:25 INFO - Running setup.py (path:/tmp/pip-VZ8WFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:07:25 INFO - Running setup.py (path:/tmp/pip-WG_Zn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:07:25 INFO - Running setup.py (path:/tmp/pip-OKkpoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:07:25 INFO - Running setup.py (path:/tmp/pip-1wJe43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:07:25 INFO - Running setup.py (path:/tmp/pip-UJsxsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:07:25 INFO - Running setup.py (path:/tmp/pip-E4xg7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:07:25 INFO - Running setup.py (path:/tmp/pip-MIVqPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:07:26 INFO - Running setup.py (path:/tmp/pip-Oj5LdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:07:26 INFO - Running setup.py (path:/tmp/pip-UV9eeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:07:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:07:26 INFO - Running setup.py install for manifestparser 12:07:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:07:26 INFO - Running setup.py install for mozcrash 12:07:26 INFO - Running setup.py install for mozdebug 12:07:26 INFO - Running setup.py install for mozdevice 12:07:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:07:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:07:26 INFO - Running setup.py install for mozfile 12:07:26 INFO - Running setup.py install for mozhttpd 12:07:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:07:26 INFO - Running setup.py install for mozinfo 12:07:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:07:26 INFO - Running setup.py install for mozInstall 12:07:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:07:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:07:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:07:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:07:26 INFO - Running setup.py install for mozleak 12:07:27 INFO - Running setup.py install for mozlog 12:07:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:07:27 INFO - Running setup.py install for moznetwork 12:07:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:07:27 INFO - Running setup.py install for mozprocess 12:07:27 INFO - Running setup.py install for mozprofile 12:07:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:07:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:07:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:07:27 INFO - Running setup.py install for mozrunner 12:07:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:07:27 INFO - Running setup.py install for mozscreenshot 12:07:27 INFO - Running setup.py install for moztest 12:07:27 INFO - Running setup.py install for mozversion 12:07:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:07:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:07:27 INFO - Cleaning up... 12:07:27 INFO - Return code: 0 12:07:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:07: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:07:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:07: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:07:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:07:27 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 0x1acb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d89570>, '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 0x1d8a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a900>, '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': 'df17445c3590ff7897617a0e00000225-1470335713.604542-120191102', '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 12:07:27 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 12:07:27 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 12:07:27 INFO - Using env: {'DISPLAY': ':0', 12:07:27 INFO - 'HOME': '/home/cltbld', 12:07:27 INFO - 'LANG': 'en_US.UTF-8', 12:07:27 INFO - 'LANGUAGE': 'en_US:en', 12:07:27 INFO - 'LOGNAME': 'cltbld', 12:07:27 INFO - 'MAIL': '/var/mail/cltbld', 12:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:07:27 INFO - 'MOZ_NO_REMOTE': '1', 12:07:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:07:27 INFO - 'NO_EM_RESTART': '1', 12:07:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:07:27 INFO - 'PWD': '/builds/slave/test', 12:07:27 INFO - 'SHELL': '/bin/bash', 12:07:27 INFO - 'SHLVL': '1', 12:07:27 INFO - 'TERM': 'linux', 12:07:27 INFO - 'TMOUT': '86400', 12:07:27 INFO - 'USER': 'cltbld', 12:07:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470335713.604542-120191102', 12:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:07:27 INFO - '_': '/tools/buildbot/bin/python'} 12:07:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:07:28 INFO - Running setup.py (path:/tmp/pip-wqjYA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:07:28 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)) 12:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:07:28 INFO - Running setup.py (path:/tmp/pip-l9RB1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:07:28 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)) 12:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:07:28 INFO - Running setup.py (path:/tmp/pip-1BhEXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:07:28 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)) 12:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:07:28 INFO - Running setup.py (path:/tmp/pip-9jwFir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:07:28 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)) 12:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:07:28 INFO - Running setup.py (path:/tmp/pip-PE9wMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:07:28 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)) 12:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:07:28 INFO - Running setup.py (path:/tmp/pip-WmX78A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:07:28 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)) 12:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:07:28 INFO - Running setup.py (path:/tmp/pip-HTk3zQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:07:28 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)) 12:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:07:28 INFO - Running setup.py (path:/tmp/pip-oshMaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:07:28 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)) 12:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:07:28 INFO - Running setup.py (path:/tmp/pip-OfYWrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:07:28 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)) 12:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:07:28 INFO - Running setup.py (path:/tmp/pip-4yjtvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 12:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:07:28 INFO - Running setup.py (path:/tmp/pip-SRkWpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:07:28 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)) 12:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:07:28 INFO - Running setup.py (path:/tmp/pip-HRBTmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:07:29 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)) 12:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:07:29 INFO - Running setup.py (path:/tmp/pip-DvXnro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:07:29 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)) 12:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:07:29 INFO - Running setup.py (path:/tmp/pip-8uZf_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:07:29 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)) 12:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:07:29 INFO - Running setup.py (path:/tmp/pip-pH4ntG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:07:29 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)) 12:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:07:29 INFO - Running setup.py (path:/tmp/pip-xTuBjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:07:29 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)) 12:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:07:29 INFO - Running setup.py (path:/tmp/pip-b3nlsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:07:29 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)) 12:07:29 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)) 12:07:29 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)) 12:07:29 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)) 12:07:29 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)) 12:07:29 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)) 12:07:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:07: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 12:07: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 12:07: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 12:07: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 12:07: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 12:07: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 12:07:31 INFO - Downloading blessings-1.6.tar.gz 12:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:07:31 INFO - Installing collected packages: blessings 12:07:31 INFO - Running setup.py install for blessings 12:07:31 INFO - Successfully installed blessings 12:07:31 INFO - Cleaning up... 12:07:31 INFO - Return code: 0 12:07:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:07:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:07:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:07:31 INFO - Reading from file tmpfile_stdout 12:07:31 INFO - Current package versions: 12:07:31 INFO - argparse == 1.2.1 12:07:31 INFO - blessings == 1.6 12:07:31 INFO - blobuploader == 1.2.4 12:07:31 INFO - docopt == 0.6.1 12:07:31 INFO - functools32 == 3.2.3-2 12:07:31 INFO - jsonschema == 2.5.1 12:07:31 INFO - manifestparser == 1.1 12:07:31 INFO - mozInstall == 1.12 12:07:31 INFO - mozcrash == 0.17 12:07:31 INFO - mozdebug == 0.1 12:07:31 INFO - mozdevice == 0.48 12:07:31 INFO - mozfile == 1.2 12:07:31 INFO - mozhttpd == 0.7 12:07:31 INFO - mozinfo == 0.9 12:07:31 INFO - mozleak == 0.1 12:07:31 INFO - mozlog == 3.3 12:07:31 INFO - moznetwork == 0.27 12:07:31 INFO - mozprocess == 0.23 12:07:31 INFO - mozprofile == 0.28 12:07:31 INFO - mozrunner == 6.12 12:07:31 INFO - mozscreenshot == 0.1 12:07:31 INFO - mozsystemmonitor == 0.3 12:07:31 INFO - moztest == 0.7 12:07:31 INFO - mozversion == 1.4 12:07:31 INFO - psutil == 3.1.1 12:07:31 INFO - requests == 1.2.3 12:07:31 INFO - wsgiref == 0.1.2 12:07:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:07:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:07:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:07:31 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 0x1acb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d89570>, '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 0x1d8a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a900>, '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': 'df17445c3590ff7897617a0e00000225-1470335713.604542-120191102', '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 12:07:31 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 12:07:31 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 12:07:31 INFO - Using env: {'DISPLAY': ':0', 12:07:31 INFO - 'HOME': '/home/cltbld', 12:07:31 INFO - 'LANG': 'en_US.UTF-8', 12:07:31 INFO - 'LANGUAGE': 'en_US:en', 12:07:31 INFO - 'LOGNAME': 'cltbld', 12:07:31 INFO - 'MAIL': '/var/mail/cltbld', 12:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:07:31 INFO - 'MOZ_NO_REMOTE': '1', 12:07:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:07:31 INFO - 'NO_EM_RESTART': '1', 12:07:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:07:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:07:31 INFO - 'PWD': '/builds/slave/test', 12:07:31 INFO - 'SHELL': '/bin/bash', 12:07:31 INFO - 'SHLVL': '1', 12:07:31 INFO - 'TERM': 'linux', 12:07:31 INFO - 'TMOUT': '86400', 12:07:31 INFO - 'USER': 'cltbld', 12:07:31 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470335713.604542-120191102', 12:07:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:07:31 INFO - '_': '/tools/buildbot/bin/python'} 12:07:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:07:31 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)) 12:07:31 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)) 12:07:31 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)) 12:07:31 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)) 12:07:31 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)) 12:07:31 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)) 12:07:31 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)) 12:07:31 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)) 12:07:31 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)) 12:07:31 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)) 12:07:31 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)) 12:07:31 INFO - Cleaning up... 12:07:31 INFO - Return code: 0 12:07:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:07:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:07:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:07:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d89570>, '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 0x1d8a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a900>, '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': 'df17445c3590ff7897617a0e00000225-1470335713.604542-120191102', '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 12:07:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:07:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:07:31 INFO - Using env: {'DISPLAY': ':0', 12:07:31 INFO - 'HOME': '/home/cltbld', 12:07:31 INFO - 'LANG': 'en_US.UTF-8', 12:07:31 INFO - 'LANGUAGE': 'en_US:en', 12:07:31 INFO - 'LOGNAME': 'cltbld', 12:07:31 INFO - 'MAIL': '/var/mail/cltbld', 12:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:07:31 INFO - 'MOZ_NO_REMOTE': '1', 12:07:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:07:31 INFO - 'NO_EM_RESTART': '1', 12:07:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:07:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:07:31 INFO - 'PWD': '/builds/slave/test', 12:07:31 INFO - 'SHELL': '/bin/bash', 12:07:31 INFO - 'SHLVL': '1', 12:07:31 INFO - 'TERM': 'linux', 12:07:31 INFO - 'TMOUT': '86400', 12:07:31 INFO - 'USER': 'cltbld', 12:07:31 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470335713.604542-120191102', 12:07:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:07:32 INFO - '_': '/tools/buildbot/bin/python'} 12:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:07:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:07:32 INFO - Cleaning up... 12:07:32 INFO - Return code: 0 12:07:32 INFO - Running post-action listener: _resource_record_post_action 12:07:32 INFO - Running post-action listener: _start_resource_monitoring 12:07:32 INFO - Starting resource monitoring. 12:07:32 INFO - [mozharness: 2016-08-04 19:07:32.233941Z] Finished create-virtualenv step (success) 12:07:32 INFO - [mozharness: 2016-08-04 19:07:32.234427Z] Running install step. 12:07:32 INFO - Running pre-action listener: _resource_record_pre_action 12:07:32 INFO - Running main action method: install 12:07:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:07:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:07:32 INFO - Reading from file tmpfile_stdout 12:07:32 INFO - Detecting whether we're running mozinstall >=1.0... 12:07:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:07:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:07:32 INFO - Reading from file tmpfile_stdout 12:07:32 INFO - Output received: 12:07:32 INFO - Usage: mozinstall [options] installer 12:07:32 INFO - Options: 12:07:32 INFO - -h, --help show this help message and exit 12:07:32 INFO - -d DEST, --destination=DEST 12:07:32 INFO - Directory to install application into. [default: 12:07:32 INFO - "/builds/slave/test"] 12:07:32 INFO - --app=APP Application being installed. [default: firefox] 12:07:32 INFO - mkdir: /builds/slave/test/build/application 12:07:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:07:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:07:48 INFO - Reading from file tmpfile_stdout 12:07:48 INFO - Output received: 12:07:48 INFO - /builds/slave/test/build/application/firefox/firefox 12:07:48 INFO - Running post-action listener: _resource_record_post_action 12:07:48 INFO - [mozharness: 2016-08-04 19:07:48.570415Z] Finished install step (success) 12:07:48 INFO - [mozharness: 2016-08-04 19:07:48.570663Z] Running run-tests step. 12:07:48 INFO - Running pre-action listener: _resource_record_pre_action 12:07:48 INFO - Running main action method: run_tests 12:07:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:07:48 INFO - Python 2.7.3 12:07:48 INFO - Return code: 0 12:07:48 INFO - grabbing minidump binary from tooltool 12:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:48 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 0x1d89570>, '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 0x1d8a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:07:48 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 12:07:48 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 12:07:48 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 12:07:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:07:49 INFO - Return code: 0 12:07:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:07:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:07:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:07:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:07:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:07:49 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N88kVI0aTkWcsRpBziZDww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:07:49 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N88kVI0aTkWcsRpBziZDww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:07:49 INFO - Using env: {'DISPLAY': ':0', 12:07:49 INFO - 'HOME': '/home/cltbld', 12:07:49 INFO - 'LANG': 'en_US.UTF-8', 12:07:49 INFO - 'LANGUAGE': 'en_US:en', 12:07:49 INFO - 'LOGNAME': 'cltbld', 12:07:49 INFO - 'MAIL': '/var/mail/cltbld', 12:07:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:07:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:07:49 INFO - 'MOZ_NO_REMOTE': '1', 12:07:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:07:49 INFO - 'NO_EM_RESTART': '1', 12:07:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:07:49 INFO - 'PWD': '/builds/slave/test', 12:07:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:07:49 INFO - 'SHELL': '/bin/bash', 12:07:49 INFO - 'SHLVL': '1', 12:07:49 INFO - 'TERM': 'linux', 12:07:49 INFO - 'TMOUT': '86400', 12:07:49 INFO - 'USER': 'cltbld', 12:07:49 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470335713.604542-120191102', 12:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:07:49 INFO - '_': '/tools/buildbot/bin/python'} 12:07:49 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N88kVI0aTkWcsRpBziZDww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:07:49 INFO - mozversion application_buildid: 20160804105222 12:07:49 INFO - mozversion application_changeset: d912055f8e8ad75d189bd480017fdb5a33ee4d7e 12:07:49 INFO - mozversion application_display_name: Nightly 12:07:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:07:49 INFO - mozversion application_name: Firefox 12:07:49 INFO - mozversion application_remotingname: firefox 12:07:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:07:49 INFO - mozversion application_vendor: Mozilla 12:07:49 INFO - mozversion application_version: 51.0a1 12:07:49 INFO - mozversion platform_buildid: 20160804105222 12:07:49 INFO - mozversion platform_changeset: d912055f8e8ad75d189bd480017fdb5a33ee4d7e 12:07:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:07:49 INFO - mozversion platform_version: 51.0a1 12:07:49 INFO - using testdate: 1470337669 12:07:49 INFO - actual date: 1470337669 12:07:49 INFO - starting webserver on 'localhost:45278' 12:07:49 INFO - SUITE-START | Running 2 tests 12:07:49 INFO - TEST-START | dromaeo_css 12:07:49 INFO - operating with platform_type : linux_ 12:07:49 INFO - Initialising browser for dromaeo_css test... 12:07:49 INFO - TEST-INFO | started process 28839 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzH6n20/profile http://localhost:45278/getInfo.html) 12:07:56 INFO - PROCESS | 28839 | __metrics Screen width/height:1600/1200 12:07:56 INFO - PROCESS | 28839 | colorDepth:24 12:07:56 INFO - PROCESS | 28839 | Browser inner width/height: 1024/697 12:07:56 INFO - PROCESS | 28839 | __metrics 12:07:57 ERROR - PROCESS | 28839 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 12:07:58 INFO - TEST-INFO | 28839: exit 0 12:07:58 INFO - Browser initialized. 12:07:58 INFO - Running cycle 1/1 for dromaeo_css test... 12:07:58 INFO - TEST-INFO | started process 28958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzH6n20/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:08:10 INFO - PROCESS | 28958 | RSS: Main: 161431552 12:08:10 INFO - PROCESS | 28958 | 12:08:59 INFO - PROCESS | 28958 | 1470337739882 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] 12:11:13 INFO - PROCESS | 28958 | Cycle 1(1): loaded http://localhost:45278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45278/tests/dromaeo/cssquery-ext.html) 12:11:14 INFO - PROCESS | 28958 | RSS: Main: 163885056 12:11:14 INFO - PROCESS | 28958 | 12:14:16 INFO - PROCESS | 28958 | Cycle 1(1): loaded http://localhost:45278/tests/dromaeo/cssquery-ext.html (next: http://localhost:45278/tests/dromaeo/cssquery-jquery.html) 12:14:16 INFO - PROCESS | 28958 | RSS: Main: 164868096 12:14:16 INFO - PROCESS | 28958 | 12:17:18 INFO - PROCESS | 28958 | Cycle 1(1): loaded http://localhost:45278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45278/tests/dromaeo/cssquery-mootools.html) 12:17:19 INFO - PROCESS | 28958 | RSS: Main: 168472576 12:17:19 INFO - PROCESS | 28958 | 12:20:21 INFO - PROCESS | 28958 | Cycle 1(1): loaded http://localhost:45278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45278/tests/dromaeo/cssquery-prototype.html) 12:20:22 INFO - PROCESS | 28958 | RSS: Main: 162848768 12:20:22 INFO - PROCESS | 28958 | 12:23:24 INFO - PROCESS | 28958 | Cycle 1(1): loaded http://localhost:45278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45278/tests/dromaeo/cssquery-yui.html) 12:23:25 INFO - PROCESS | 28958 | RSS: Main: 165056512 12:23:25 INFO - PROCESS | 28958 | 12:26:28 INFO - PROCESS | 28958 | Cycle 1(1): loaded http://localhost:45278/tests/dromaeo/cssquery-yui.html (next: http://localhost:45278/tests/dromaeo/cssquery-dojo.html) 12:26:28 INFO - PROCESS | 28958 | RSS: Main: 168185856 12:26:28 INFO - PROCESS | 28958 | 12:26:28 INFO - PROCESS | 28958 | __start_tp_report 12:26:28 INFO - PROCESS | 28958 | _x_x_mozilla_page_load 12:26:28 INFO - PROCESS | 28958 | _x_x_mozilla_page_load_details 12:26:28 INFO - PROCESS | 28958 | |i|pagename|runs| 12:26:28 INFO - PROCESS | 28958 | |0;dojo.html;2673.876971671898;2675.665541807274;2685.785137189025;2693.9865300673496;2713.1996061161967;4720;4877.170880950238;4880.78036488358;4900.16697161483;4936.8518944431635;4755.904881902368;4812.470628230901;4824.734639594821;4831.806727730896;4877.365942427479;4460.442444694413;4491.573300536444;4503;4531.048479819242;4575.93136102957;4490.820367185309;4508.887277818048;4522.208613492642;4534.8639540813665;4590.678652494326;4579.152856721517;4586.243269860469;4590.495045544987;4590.655700822452;4601.792919318622;4329.7618630975285;4406.140802543506;4412.977935110336;4444.066745983348;4504.054148628792;4368.322909948963;4396.89007774805;4410.977945110286;4447.2439685253585;4488.438945131858;4809.446913604946;4818.277258411232;4829.1790395632825;4847.079054979543;4894;5162.380514338266;5201.973990130063;5202.791888324463;5215.035218484592;5218.243354713545;5275.095586805784;5284.471552844723;5290.65610735301;5297;5301.231321458406;4909.337239472697;4915.262710593368;4916.188828843272;4925.088858561177;4937.11131996237;5171.663841850268;5249.291345668286;5267.631265811357;5280.577553795687;5386.622936394493;5095.796168153306;5102.08162530748;5108.591312694975;5118.25785261135;5123.795048198105;5193.091209038479;5201.401838788588;5203.843884683465;5223.2948551945;5247.606429517725;4961.280614310905;4999.700017998932;5075.644704870623;5102.311187989574;5104.285400043997;5082.745862706924;5131.153359695683;5131.358580177478;5135.691858488428;5143.485651434827;4484.663650226246;4494.37078808967;4495.685302028826;4498.5501449854755;4535.523770004168;3785.1861849702445;3812;3907.3748200288387;3922.490076290064;3952.66402355803;4211.220924129046;4455.710378825366;4481.775911204427;4510.887227819331;4520.073384956077;5164.14791559396;5218.452062533379;5222.3472065991755;5231.947680523146;5272.182811664198;4336.3278691802825;4353.847615333448;4406.052698669737;4464.441944756905;4496.437945256843;4685.554872287127;4687.179743544866;4713.175194340976;4748.074125545486;4749.168895443284;4833.637477189154;4870.537298956593;4875.414950205998;4897.216445368724;4939.703617782872;5069.442361340323;5150.124478838531;5183.11886979222;5225.529702326657;5287.048331300402;4825.420949486084;4838.903221935612;4865.683730557503;4919.729414882216;4924.803007879645;5014.548690617862;5058.418281897481;5063.113955057924;5070.746462676778;5112.539871411591;5044.4198917125;5115.718635475085;5206.843794686166;5208.401033881152;5217.191335343028;4981.2030075187795;5061.7469126544265;5075.7969681212335;5079.466656001066;5080.618953578571;5041.924371134362;5058.721770302669;5068.7972481101815;5069.493050694901;5112.488751124858;4803.615710743202;4922.4585295616735;4968.801247950041;4970.627202959865;4991;5106.463821298858;5159.845204643867;5167.715775632376;5183.0670479314085;5203.245529398292;4916.434610019894;4956.950430495649;4962.6774259673;5010.49895010496;5013.348264725708 12:26:28 INFO - PROCESS | 28958 | |1;ext.html;546.4890327543746;549.8872731090127;562.5106157642851;573.7160105747655;582.9038208695569;34057;35090.47364289535;37857.24285514295;38057.42913856294;38107.618923810754;38569.421458678145;39263;39399.212015759666;39426.40860387089;39520.407193892046;7453.739119130818;7747.922520774805;7748.573828439434;7779;7786.688532458695;7672.5012874163;7704.0755109386955;7719.536827790323;7740.071191457033;7756.340711039568;7742.341900938399;7783.571903545303;7789.649465774026;7803.882941755878;7820.960895195516;7709.691612335528;7715.537067775896;7726.343260822837;7728.574928378937;7801.921980780205;7628.618569071524;7702.037245344332;7711.49875258112;7721.150673425918;7726.497777644435;36690.44964325537;36812.44781328282;36935;37030.62969370326;37035.44446833299;2971.435427268812;3152.542881282201;3158.6683398243313;3517.8944631661093;3519.788812671248;29018.27454313638;29245.853770731224;29279.121626351032;29661;30293.848530757205;3213.4858422652264;3279.439974091323;3323.401787678241;3331.983340083308;3355.882544110969;249553;249644;250270;250732;251425;51717.48282517127;52327.73836130871;52379.47620523822;52445.213321800205;52486.475135248926;32249.51625725616;33049;33230.335393292;35219.82390088033;35298;13908.4436622536;13977.231252281223;13989.930050349887;13997;14004;11346.716332091599;11368.374739389414;11431.199816012966;11447.08423326132;11458.312501249951;17827.286908523514;18085.095745212686;18199.54208700343;18237.817621823877;18254;6582.572132811352;6767.593944363354;6939.895901561481;6981.581105133709;6997.265287144878;740.2708332292688;823.7611092783026;841.4614646626164;854.222657381792;928.5542939389131;27322.45355092927;28582.428351432856;28728.569071463946;28810.135695929155;29048.709512905025;926.1664501948165;940.9811803763887;1004.1213937804421;1019.607451131305;1020.2399212586522;14392.35234414454;14611.707765844623;14739.705205896036;15032.542515221561;15107.924460377628;414221;414676;415985;417529;419286;50003;50461.495385046415;50485.49514504808;50680.493195067575;50844;1160.6169963911889;1169.0589075793898;1177;1177.464253764535;1206.8431103956254;26203.475930481665;26671.33321666974;27328.863355683094;27480.725192747817;28156.85921570379;42400.78799605982;42851.357229640955;42855;42870.57129428666;43122.56877431311;358017;358526;359113;359524;360282;24989.625155622318;25035.749642503342;25536.74463255418;25553.872230638728;25621.3594660135;42269.78865105655;42334.5766542343;42674.5732542683;42788.1442371157;43699.56300436955;36018.8199059003;36496.81751591225;36888.26223475569;37191.62808371882;37720.2455950874;36853.815730922244;37204.25591488101;37310.813445932596;37778.62221377751;38349.2330153401;35393.640748486105;35411.291774164885;36041;36249.81875090713;36886.26227475382;27875.581866272427;30304.84847575748;30408.391832163674;32030.359392811548;33503.49744753879;26103.608445872946;26195.869020654776;26262.34344141412;26387;26733 12:26:28 INFO - PROCESS | 28958 | |2;jquery.html;345.23013679494727;357.1428571428571;359.6439524870379;360.4593110334498;373.83924912287705;16172.191390430475;16255.431059912906;17411.73882391765;17464.738028929576;17532.035738034403;16079.276432560533;16139.838601613981;16140.435084772036;16142.7578586321;16219.594510137253;4333.783310834454;4575.359449677047;4603.907921841561;4639.118567472169;4667.206574882278;4542.682012259143;4544.295634176708;4619.953800461986;4652.255639097745;4662.930056049162;4584.77076146193;4597.057603191354;4657.347971284006;4747.85756427306;4782.641301902371;4714.693544919569;4733.077049975256;4764.071006153801;4766.165920963817;4786.880327991793;4597.977010114962;4707.964247865499;4720.693154944952;4722.7402492862875;4734.218853889104;12453.066020048533;12532.248065116122;12620.495180192782;14256.786148207786;16877.578060548585;1772.2025088710004;1810.3211295764088;1919.827215550593;2116.714243577113;2289.210222473244;9283.932347779957;9294.117058879463;9295.860562091506;9304.162625363682;9604.375715578464;1713.323237321251;1715.8884672496247;1748.728947013215;1758.9032603206817;1795.7126859702385;69867;70752.29247707508;70858.2914170862;71302.28697713009;75220.62389688072;8715.869261961076;9266.721998340061;9395.342326037111;9541.141297283279;10017.348872323275;12848.743025139633;12854.742905142031;12876.678083047811;12878.549250776365;12908.741825163632;7180.389666878374;7256.383207427322;7393.297636724503;7483.6258187090425;7509.774706758806;7241.565506069653;7255.274472552808;7340.926590734131;7446.106467223968;7479.925200747923;4016.5380981186954;4023.8189281482405;4026.939595906064;4119.155573107506;4328.696991210648;1702.3020561569697;1702.8382303681378;1704.752810842421;1747.0915124135379;1771.6899542579997;353.16124205013097;361.1242736364306;770.310572038034;770.5068755996055;874.4709450782312;9913.306068575275;10647.574097036188;10648.36109833397;10785.40680262593;11006.889931100586;383.9901060211681;386.31236399208893;390.60939060939063;391.07315661881523;393.5769048273118;5040.873978150576;5790.826275211751;5818.185454036438;5825.097109947965;5963.224780778471;423934;424411;431053;432626;434987;80255.19744802594;82766;83137.58431207805;84941.57529212315;85981.57009215039;400.331446484366;409.1857204163752;414.1427245601576;414.6703370820205;416.28814726816876;9597.424154550748;9823.115919566988;9898.901010989797;9928.205743540644;10137.594496220363;32899.8485053022;36692;37183.19136513963;37215;37870.81064594659;49840;51852.22221666603;52382.73808630933;52463.47536524586;53072.46927530675;7247.383972362198;7313.780586582411;7357.705691772269;7558.848823023619;7773.68905243784;11058.447077646246;12246.75506489883;12552.552252310712;12859.357032148542;13065.150765200231;9267.72196834096;9524.761880953032;9884.505774711091;10213.131883789663;10695.197860160675;10662.626808061681;10836.945815270874;10894.50974706156;10919.727006824893;11016.889831101907;10201.693949181536;10229.795404092025;10402;10491.68524944253;10537.473126343806;7486.401087912845;7668.079830420385;7714.421418393531;7778.88331675014;7920.168382320004;8275.255227029356;9514.19129374011;9700.932897381423;9808.950955245464;10240.948795255976 12:26:28 INFO - PROCESS | 28958 | |3;mootools.html;1357.2806412601321;1400.9019368644192;1461.5396150212682;1660.460350386125;1691.915404229789;6320.367963203677;6751.594904305733;6944.236134025253;7434.145073316577;7471.402287816975;7036.085308909847;7237.601931893743;7272.418206543477;7273.818154546139;7318.780436586898;2127.149140343863;2152.440365504964;2169.197396963126;2171.109844963565;2173.6413491773837;2090.95818083639;2138.508143127082;2161.8702877827304;2166.4150679316576;2169.7070895429074;2128.9893550532224;2135.594237094947;2139.2833400810746;2141.1649456711816;2168.4578855286177;2103.2848831397323;2111.039477037944;2113.355426594888;2113.957720845582;2124.2352753008904;2038.4088614301834;2091.048572899327;2095.057224249079;2122.6285400055085;2126.542793299448;7292.817679558;7364.484486085976;7378.704851805921;7430.14553326369;7439.330460258603;4206.810693518799;4340.696151269412;4358.694891357606;4361.694681372305;4371.27873900806;2748.5877118432195;2819.788515861298;2820.5910143029146;2849.501337265991;2870.512012957802;887.8756974023642;931.8648795924621;932.2262522106636;934.145257089762;956.4404823178448;9648.083432074012;9685.41887486746;9686.32195746298;9706.417614943126;9711.514424278757;3697.2605478904325;3780.1872597391693;3913.412988051815;3977.164795393;3982.2831890259454;8310.8337833243;8356.707515236938;8376.162383761697;8427.95786021066;8478.448900821428;4320.891977700583;4342.0664557119735;4350.978245108818;4354.368616550582;4369.563043695669;3471.8264086796066;3936.6063393660406;3953.2884080865147;3978.3236849735613;4025.1144748155357;3415.2848485454124;3469.392856250146;3548.574171099433;3591.838367273479;3663.798491083016;1144.7824913266452;1150.1833698074295;1151.3207207747303;1164.5109054197258;1171.5899435197612;761.8895260187242;777.0675189772296;788.6819662348596;790.3005839831791;800.8718605023168;4761.880952976203;4776.09254241693;4796.448408433005;4878.829240976549;5058.721770302595;378.85035411012495;383.7313880283813;384.15869246350405;385.5643123270686;392.65250253525835;3466.584009918826;3468.0809585459874;3468.601110872282;3490.5636795400574;3493.615702272748;8283.337333013344;8765.737027889174;8790.604422800989;8803.691870784492;8809.295256379473;8723.476591404537;8747.956260218785;8752.56237188138;8819.514926679094;8826.117388261251;6790.660466976631;6871.278515755874;6958.756443524452;6986.091808065021;6992.790216293621;4777.689450185727;4815.398075240595;4820.493848145894;4890.413150421972;4897.41231052276;8182;8224.588770561568;8269.173082691923;8344.249017588447;8344.707935222481;8273.793155171168;8357.247847693738;8388.832223355377;8453.323734101134;8464.619092140745;5542.224088627515;6090;6195.411435913581;6201.565890387629;6209.285932117864;6893.586384816927;6985.406240469617;6992.230854606091;7018.087648605853;7032.8593428130125;6301.464375528131;6387.744490220339;6407.135036769976;6579.671016449062;6585.473162147113;6105.8168254952425;6157.507399408126;6205.2553693557065;6246.750129994749;6290.968545157245;6058.606190597597;6105.45050945417;6120.785772497941;6177.227846519185;6190.783322583688;3983.3427484464737;4053.61490658387;4144.854930077433;4190.062427446266;4229.344451610005;4142.958570414257;4171.165766846703;4197.958020419756;4206.621404073648;4208.431861698631 12:26:28 INFO - PROCESS | 28958 | |4;prototype.html;284.19430913360634;296.1382377282109;297.40667368599645;300.3122848676531;304.2788591039235;4947.257911313305;5052.16639254523;5054.721990290533;5162.690238585683;5165.948340516594;4971.37857767779;5035.949640503594;5076.771545280462;5077.111505486543;5088.618353623475;4017.156397156586;4029.697772667047;4032.778197199153;4032.8588499402526;4042.5351084625204;3937.370020796673;4018.3771515415156;4036.2331157080207;4038.9394159087637;4047.51429828421;3945.3687410014404;3968.900777480572;3981.7610943343493;3994.3609022556398;3997.480327557428;3940.1922605866016;3941.3052387473517;3973.324534829086;3975.463312452811;3993.860214892494;3370.5786776652917;3494.947575786365;3501.544799176116;3513.191965847869;3537.080359106625;4928.7535623219055;4948.812285051597;4959.404871415417;4988.575971042465;5040.2691609716385;4541.727496350197;4547.727136371828;4559.426997685793;4560.452745670541;4570.3373010913565;5198.766055527511;5305.647059999714;5312.92030619541;5338.9466105339225;5342.385625653061;3745.606711295302;3779.811009449544;3793.070697679086;3794.962050379516;3834.1373191032076;5533.280673512458;5539.639923404966;5556.222128901957;5588.720563971785;5609.80365687199;3718.721095917817;3859.7648752399523;3918.5885482023978;3919.118198405393;3919.980400097981;3909.7458665186673;3912.2762288976633;3919.235749028912;3923.4899463070187;3964.385520244367;4464.923810428167;4495.988402609452;4502.234620114588;4506.594406503365;4512.932306015412;5183.403908550489;5270.868228294324;5272.472752724773;5311.336082989626;5351.785928562892;1356.620146359021;1366;1379.6206043338161;1381.5026590427437;1382.4470211915313;845.146402133837;858.9828203436022;877.8324827978773;878.4421892098436;885.8626912828522;4068.8575899843363;4074.6129117733767;4091.6726661867574;4095.9590404096175;4130.359794231899;4846.854594362175;4869.586085182799;4873.366462359942;4892.143874821963;4902.2156454967035;4037.555868854424;4068.9013966229545;4090.5295890972325;4105;4133.341992336804;2485.8135639827087;2554.7189809120982;2569.601711734684;2576.1627471071974;2607.4394005288955;4536.727796332165;4550.1571863395375;4609;4612.431773197129;4638.675292729544;4894.510548945148;4902.313676085351;4918.975405122951;4954.777035033432;4959.461618340103;4299.3877296014;4522.417153996075;4528.569785870337;4562.8631141065825;4570.052316256063;4810.470848206624;4845.442774081026;4846.95153048465;4847.878803029953;4891.948231130324;4767.163537695066;4799.400074990626;4808.663393562557;4811.49479304668;4852.587530059985;4371.30059190528;4456.777161141995;4487.5063742987595;4490.753008584559;4522.8643140705835;3506.9824650877604;3543.20277937462;3661.41417373219;3753;3846.7114966377076;5376.650517716336;5381.73091345439;5385.569154467712;5400.513953744025;5445.26488924006;5276.39321478035;5278.651000304828;5295.920561191509;5302.681839089667;5320.255164277081;5042.016806722654;5217.399999000164;5223.112070948024;5232.351809180096;5259.894802104013;5144.331236939174;5174.120399532013;5208.5051920067535;5221.738913054256;5247.58019358458;5296.7351632418995;5341.572674186134;5342.065138600807;5349.251104845403;5354.277172581652;4962.925556116589;5237.869053273698;5240.240165175952;5277.997180535686;5284.81503147388 12:26:28 INFO - PROCESS | 28958 | |5;yui.html;608.3369127650859;611.2634275697785;638.6136387485572;678.6878036103392;723.0347486106047;12412.255264684114;13409.463621455154;13445.596632101053;13448.731025379486;13450.327483625817;12687.555935542257;13438.93280533596;13655.931720341408;13677.042607017487;13770.24263665498;770.9383249340053;792.2434075457924;795.4869109424418;796.4982061301372;800.1358532784608;645.951553633477;769.1078349115028;776.5030380556449;791.2522666080556;793.8253584211465;827.2554700769296;830.7175560309494;832.4838600067936;832.8292699996487;835.1398059998212;824.3116997307255;826.4173757500947;827.028241815867;828.7845160258377;830.0869044051525;601.5488383712216;602.8101148138367;602.8281939647179;603.5141710922705;603.6619493083887;12907.935460322733;12997;13015.349232538336;13023.544175953795;13030.869691303154;13335.933320333434;13687.589372318846;13837.446502139903;14123.505677301348;14361.210133442657;10832.566697332177;10960.397178155199;10979.780404391948;11031.83452248217;11122.49948752308;3265.1020969233414;3270.689284517991;3287.9506807397906;3334.283129127225;3344.949825752591;70055.94916076314;70221.64889175573;70418.29581704168;72453;73960.6301968492;10825.35047897113;10919.290246133976;10955.671329860117;11060.944695276472;11071.5571377144;20925.162993480393;20927.68608470874;20927.790722092584;20993.37019889406;21001.579968400853;6777.356151165632;6965.373116419547;7042.718291268292;7075.186353569406;7142.892856607155;3851.8651847185774;3854.094287842355;3863.6817909254223;3876.089119057019;4045.7774822384463;2854.7716182705335;2886.105307354727;2889.0321742216174;2895;2946.6758656547763;486.63241485166986;487.94388645305537;495.0322120254893;503.2953864589531;506.640285397372;442.8494311933958;447.8656403079128;556.2296219735695;594.8512871782054;595.2975488923025;7549.320561149413;7743.186965368555;7794.181610930884;7929.32600728933;8075.071366792777;546.3498436860124;556.8802707417925;559.3343920734394;567.6906086182958;569.4533248081805;3360.5799275090612;3639.927201455956;3839.4432807242792;3854;3863.671587915059;103272;105102.47448762707;105492.39583645793;105507;106812.39781403285;93549;93928.24287028579;94670.5266473677;95280.52359738157;95572;80793;83579;83588;84128.57935710404;84389;7062.858742825218;7240.167380751281;7336.963315183603;7375.668094935633;7433.256674332523;33525.329493410485;34908.82545587256;46467;46861.53138468572;47596;69191.65404172947;71494;72483.63758181175;73496.63251683707;73830.26169738449;10653.414062226651;10764.300320479144;10948.726281842699;11085.27945683528;11375.31748095117;10865.832109703655;11262.887371126184;11420.657380278604;11570.94214528922;11762.58830940913;9312;9370.859437108586;11540.192186546861;12266.938665306974;12275.263484190977;11179.441027948733;11343.716407089889;11394.601188958346;11472.483738231633;12305.876941230474;10997.34015959045;11354.091672666333;11446.656600302003;11641.825372619587;11777.234479758788;9491.667791627537;9689.51552422362;9690.224782017282;10063.14463270601;11168.944155279172;9058.637654493747;9753.414795112316;10109.898901010896;10176.287659863738;10339.276250662682 12:26:28 INFO - PROCESS | 28958 | __end_tp_report 12:26:28 INFO - PROCESS | 28958 | __start_cc_report 12:26:28 INFO - PROCESS | 28958 | _x_x_mozilla_cycle_collect,353 12:26:28 INFO - PROCESS | 28958 | __end_cc_report 12:26:28 INFO - PROCESS | 28958 | __startTimestamp1470338788537__endTimestamp 12:26:28 INFO - PROCESS | 28958 | 12:26:28 INFO - PROCESS | 28958 | ------- Summary: start ------- 12:26:28 INFO - PROCESS | 28958 | Number of tests: 6 12:26:28 INFO - PROCESS | 28958 | 12:26:28 INFO - PROCESS | 28958 | [#0] dojo.html Cycles:165 Average:4799.52 Median:4922.46 stddev:499.42 (10.1%) stddev-sans-first:472.30 12:26:28 INFO - PROCESS | 28958 | Values: 2673.9 2675.7 2685.8 2694.0 2713.2 4720.0 4877.2 4880.8 4900.2 4936.9 4755.9 4812.5 4824.7 4831.8 4877.4 4460.4 4491.6 4503.0 4531.0 4575.9 4490.8 4508.9 4522.2 4534.9 4590.7 4579.2 4586.2 4590.5 4590.7 4601.8 4329.8 4406.1 4413.0 4444.1 4504.1 4368.3 4396.9 4411.0 4447.2 4488.4 4809.4 4818.3 4829.2 4847.1 4894.0 5162.4 5202.0 5202.8 5215.0 5218.2 5275.1 5284.5 5290.7 5297.0 5301.2 4909.3 4915.3 4916.2 4925.1 4937.1 5171.7 5249.3 5267.6 5280.6 5386.6 5095.8 5102.1 5108.6 5118.3 5123.8 5193.1 5201.4 5203.8 5223.3 5247.6 4961.3 4999.7 5075.6 5102.3 5104.3 5082.7 5131.2 5131.4 5135.7 5143.5 4484.7 4494.4 4495.7 4498.6 4535.5 3785.2 3812.0 3907.4 3922.5 3952.7 4211.2 4455.7 4481.8 4510.9 4520.1 5164.1 5218.5 5222.3 5231.9 5272.2 4336.3 4353.8 4406.1 4464.4 4496.4 4685.6 4687.2 4713.2 4748.1 4749.2 4833.6 4870.5 4875.4 4897.2 4939.7 5069.4 5150.1 5183.1 5225.5 5287.0 4825.4 4838.9 4865.7 4919.7 4924.8 5014.5 5058.4 5063.1 5070.7 5112.5 5044.4 5115.7 5206.8 5208.4 5217.2 4981.2 5061.7 5075.8 5079.5 5080.6 5041.9 5058.7 5068.8 5069.5 5112.5 4803.6 4922.5 4968.8 4970.6 4991.0 5106.5 5159.8 5167.7 5183.1 5203.2 4916.4 4957.0 4962.7 5010.5 5013.3 12:26:28 INFO - PROCESS | 28958 | 12:26:28 INFO - PROCESS | 28958 | [#1] ext.html Cycles:180 Average:48683.80 Median:36593.63 stddev:92146.93 (251.8%) stddev-sans-first:92334.55 12:26:28 INFO - PROCESS | 28958 | Values: 546.5 549.9 562.5 573.7 582.9 34057.0 35090.5 37857.2 38057.4 38107.6 38569.4 39263.0 39399.2 39426.4 39520.4 7453.7 7747.9 7748.6 7779.0 7786.7 7672.5 7704.1 7719.5 7740.1 7756.3 7742.3 7783.6 7789.6 7803.9 7821.0 7709.7 7715.5 7726.3 7728.6 7801.9 7628.6 7702.0 7711.5 7721.2 7726.5 36690.4 36812.4 36935.0 37030.6 37035.4 2971.4 3152.5 3158.7 3517.9 3519.8 29018.3 29245.9 29279.1 29661.0 30293.8 3213.5 3279.4 3323.4 3332.0 3355.9 249553.0 249644.0 250270.0 250732.0 251425.0 51717.5 52327.7 52379.5 52445.2 52486.5 32249.5 33049.0 33230.3 35219.8 35298.0 13908.4 13977.2 13989.9 13997.0 14004.0 11346.7 11368.4 11431.2 11447.1 11458.3 17827.3 18085.1 18199.5 18237.8 18254.0 6582.6 6767.6 6939.9 6981.6 6997.3 740.3 823.8 841.5 854.2 928.6 27322.5 28582.4 28728.6 28810.1 29048.7 926.2 941.0 1004.1 1019.6 1020.2 14392.4 14611.7 14739.7 15032.5 15107.9 414221.0 414676.0 415985.0 417529.0 419286.0 50003.0 50461.5 50485.5 50680.5 50844.0 1160.6 1169.1 1177.0 1177.5 1206.8 26203.5 26671.3 27328.9 27480.7 28156.9 42400.8 42851.4 42855.0 42870.6 43122.6 358017.0 358526.0 359113.0 359524.0 360282.0 24989.6 25035.7 25536.7 25553.9 25621.4 42269.8 42334.6 42674.6 42788.1 43699.6 36018.8 36496.8 36888.3 37191.6 37720.2 36853.8 37204.3 37310.8 37778.6 38349.2 35393.6 35411.3 36041.0 36249.8 36886.3 27875.6 30304.8 30408.4 32030.4 33503.5 26103.6 26195.9 26262.3 26387.0 26733.0 12:26:28 INFO - PROCESS | 28958 | 12:26:28 INFO - PROCESS | 28958 | [#2] jquery.html Cycles:180 Average:24858.07 Median:219660.39 stddev:71012.08 (32.3%) stddev-sans-first:71187.44 12:26:28 INFO - PROCESS | 28958 | Values: 345.2 357.1 359.6 360.5 373.8 16172.2 16255.4 17411.7 17464.7 17532.0 16079.3 16139.8 16140.4 16142.8 16219.6 4333.8 4575.4 4603.9 4639.1 4667.2 4542.7 4544.3 4620.0 4652.3 4662.9 4584.8 4597.1 4657.3 4747.9 4782.6 4714.7 4733.1 4764.1 4766.2 4786.9 4598.0 4708.0 4720.7 4722.7 4734.2 12453.1 12532.2 12620.5 14256.8 16877.6 1772.2 1810.3 1919.8 2116.7 2289.2 9283.9 9294.1 9295.9 9304.2 9604.4 1713.3 1715.9 1748.7 1758.9 1795.7 69867.0 70752.3 70858.3 71302.3 75220.6 8715.9 9266.7 9395.3 9541.1 10017.3 12848.7 12854.7 12876.7 12878.5 12908.7 7180.4 7256.4 7393.3 7483.6 7509.8 7241.6 7255.3 7340.9 7446.1 7479.9 4016.5 4023.8 4026.9 4119.2 4328.7 1702.3 1702.8 1704.8 1747.1 1771.7 353.2 361.1 770.3 770.5 874.5 9913.3 10647.6 10648.4 10785.4 11006.9 384.0 386.3 390.6 391.1 393.6 5040.9 5790.8 5818.2 5825.1 5963.2 423934.0 424411.0 431053.0 432626.0 434987.0 80255.2 82766.0 83137.6 84941.6 85981.6 400.3 409.2 414.1 414.7 416.3 9597.4 9823.1 9898.9 9928.2 10137.6 32899.8 36692.0 37183.2 37215.0 37870.8 49840.0 51852.2 52382.7 52463.5 53072.5 7247.4 7313.8 7357.7 7558.8 7773.7 11058.4 12246.8 12552.6 12859.4 13065.2 9267.7 9524.8 9884.5 10213.1 10695.2 10662.6 10836.9 10894.5 10919.7 11016.9 10201.7 10229.8 10402.0 10491.7 10537.5 7486.4 7668.1 7714.4 7778.9 7920.2 8275.3 9514.2 9700.9 9809.0 10240.9 12:26:28 INFO - PROCESS | 28958 | 12:26:28 INFO - PROCESS | 28958 | [#3] mootools.html Cycles:180 Average:4783.63 Median:4849.66 stddev:2633.35 (54.3%) stddev-sans-first:2628.15 12:26:28 INFO - PROCESS | 28958 | Values: 1357.3 1400.9 1461.5 1660.5 1691.9 6320.4 6751.6 6944.2 7434.1 7471.4 7036.1 7237.6 7272.4 7273.8 7318.8 2127.1 2152.4 2169.2 2171.1 2173.6 2091.0 2138.5 2161.9 2166.4 2169.7 2129.0 2135.6 2139.3 2141.2 2168.5 2103.3 2111.0 2113.4 2114.0 2124.2 2038.4 2091.0 2095.1 2122.6 2126.5 7292.8 7364.5 7378.7 7430.1 7439.3 4206.8 4340.7 4358.7 4361.7 4371.3 2748.6 2819.8 2820.6 2849.5 2870.5 887.9 931.9 932.2 934.1 956.4 9648.1 9685.4 9686.3 9706.4 9711.5 3697.3 3780.2 3913.4 3977.2 3982.3 8310.8 8356.7 8376.2 8428.0 8478.4 4320.9 4342.1 4351.0 4354.4 4369.6 3471.8 3936.6 3953.3 3978.3 4025.1 3415.3 3469.4 3548.6 3591.8 3663.8 1144.8 1150.2 1151.3 1164.5 1171.6 761.9 777.1 788.7 790.3 800.9 4761.9 4776.1 4796.4 4878.8 5058.7 378.9 383.7 384.2 385.6 392.7 3466.6 3468.1 3468.6 3490.6 3493.6 8283.3 8765.7 8790.6 8803.7 8809.3 8723.5 8748.0 8752.6 8819.5 8826.1 6790.7 6871.3 6958.8 6986.1 6992.8 4777.7 4815.4 4820.5 4890.4 4897.4 8182.0 8224.6 8269.2 8344.2 8344.7 8273.8 8357.2 8388.8 8453.3 8464.6 5542.2 6090.0 6195.4 6201.6 6209.3 6893.6 6985.4 6992.2 7018.1 7032.9 6301.5 6387.7 6407.1 6579.7 6585.5 6105.8 6157.5 6205.3 6246.8 6291.0 6058.6 6105.5 6120.8 6177.2 6190.8 3983.3 4053.6 4144.9 4190.1 4229.3 4143.0 4171.2 4198.0 4206.6 4208.4 12:26:28 INFO - PROCESS | 28958 | 12:26:28 INFO - PROCESS | 28958 | [#4] prototype.html Cycles:180 Average:4247.93 Median:4570.19 stddev:1227.16 (26.9%) stddev-sans-first:1194.00 12:26:28 INFO - PROCESS | 28958 | Values: 284.2 296.1 297.4 300.3 304.3 4947.3 5052.2 5054.7 5162.7 5165.9 4971.4 5035.9 5076.8 5077.1 5088.6 4017.2 4029.7 4032.8 4032.9 4042.5 3937.4 4018.4 4036.2 4038.9 4047.5 3945.4 3968.9 3981.8 3994.4 3997.5 3940.2 3941.3 3973.3 3975.5 3993.9 3370.6 3494.9 3501.5 3513.2 3537.1 4928.8 4948.8 4959.4 4988.6 5040.3 4541.7 4547.7 4559.4 4560.5 4570.3 5198.8 5305.6 5312.9 5338.9 5342.4 3745.6 3779.8 3793.1 3795.0 3834.1 5533.3 5539.6 5556.2 5588.7 5609.8 3718.7 3859.8 3918.6 3919.1 3920.0 3909.7 3912.3 3919.2 3923.5 3964.4 4464.9 4496.0 4502.2 4506.6 4512.9 5183.4 5270.9 5272.5 5311.3 5351.8 1356.6 1366.0 1379.6 1381.5 1382.4 845.1 859.0 877.8 878.4 885.9 4068.9 4074.6 4091.7 4096.0 4130.4 4846.9 4869.6 4873.4 4892.1 4902.2 4037.6 4068.9 4090.5 4105.0 4133.3 2485.8 2554.7 2569.6 2576.2 2607.4 4536.7 4550.2 4609.0 4612.4 4638.7 4894.5 4902.3 4919.0 4954.8 4959.5 4299.4 4522.4 4528.6 4562.9 4570.1 4810.5 4845.4 4847.0 4847.9 4891.9 4767.2 4799.4 4808.7 4811.5 4852.6 4371.3 4456.8 4487.5 4490.8 4522.9 3507.0 3543.2 3661.4 3753.0 3846.7 5376.7 5381.7 5385.6 5400.5 5445.3 5276.4 5278.7 5295.9 5302.7 5320.3 5042.0 5217.4 5223.1 5232.4 5259.9 5144.3 5174.1 5208.5 5221.7 5247.6 5296.7 5341.6 5342.1 5349.3 5354.3 4962.9 5237.9 5240.2 5278.0 5284.8 12:26:28 INFO - PROCESS | 28958 | 12:26:28 INFO - PROCESS | 28958 | [#5] yui.html Cycles:180 Average:18975.53 Median:445.36 stddev:28239.08 (6340.8%) stddev-sans-first:28284.62 12:26:28 INFO - PROCESS | 28958 | Values: 608.3 611.3 638.6 678.7 723.0 12412.3 13409.5 13445.6 13448.7 13450.3 12687.6 13438.9 13655.9 13677.0 13770.2 770.9 792.2 795.5 796.5 800.1 646.0 769.1 776.5 791.3 793.8 827.3 830.7 832.5 832.8 835.1 824.3 826.4 827.0 828.8 830.1 601.5 602.8 602.8 603.5 603.7 12907.9 12997.0 13015.3 13023.5 13030.9 13335.9 13687.6 13837.4 14123.5 14361.2 10832.6 10960.4 10979.8 11031.8 11122.5 3265.1 3270.7 3288.0 3334.3 3344.9 70055.9 70221.6 70418.3 72453.0 73960.6 10825.4 10919.3 10955.7 11060.9 11071.6 20925.2 20927.7 20927.8 20993.4 21001.6 6777.4 6965.4 7042.7 7075.2 7142.9 3851.9 3854.1 3863.7 3876.1 4045.8 2854.8 2886.1 2889.0 2895.0 2946.7 486.6 487.9 495.0 503.3 506.6 442.8 447.9 556.2 594.9 595.3 7549.3 7743.2 7794.2 7929.3 8075.1 546.3 556.9 559.3 567.7 569.5 3360.6 3639.9 3839.4 3854.0 3863.7 103272.0 105102.5 105492.4 105507.0 106812.4 93549.0 93928.2 94670.5 95280.5 95572.0 80793.0 83579.0 83588.0 84128.6 84389.0 7062.9 7240.2 7337.0 7375.7 7433.3 33525.3 34908.8 46467.0 46861.5 47596.0 69191.7 71494.0 72483.6 73496.6 73830.3 10653.4 10764.3 10948.7 11085.3 11375.3 10865.8 11262.9 11420.7 11570.9 11762.6 9312.0 9370.9 11540.2 12266.9 12275.3 11179.4 11343.7 11394.6 11472.5 12305.9 10997.3 11354.1 11446.7 11641.8 11777.2 9491.7 9689.5 9690.2 10063.1 11168.9 9058.6 9753.4 10109.9 10176.3 10339.3 12:26:28 INFO - PROCESS | 28958 | -------- Summary: end -------- 12:26:28 INFO - PROCESS | 28958 | 12:26:29 INFO - TEST-INFO | 28958: exit 0 12:26:29 INFO - TEST-OK | dromaeo_css | took 1119469ms 12:26:29 INFO - TEST-START | kraken 12:26:29 INFO - operating with platform_type : linux_ 12:26:29 INFO - Initialising browser for kraken test... 12:26:29 INFO - TEST-INFO | started process 29202 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHoxIRZ/profile http://localhost:45278/getInfo.html) 12:26:34 INFO - PROCESS | 29202 | __metrics Screen width/height:1600/1200 12:26:34 INFO - PROCESS | 29202 | colorDepth:24 12:26:34 INFO - PROCESS | 29202 | Browser inner width/height: 1024/697 12:26:34 INFO - PROCESS | 29202 | __metrics 12:26:35 ERROR - PROCESS | 29202 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 12:26:36 INFO - TEST-INFO | 29202: exit 0 12:26:36 INFO - Browser initialized. 12:26:36 INFO - Running cycle 1/1 for kraken test... 12:26:36 INFO - TEST-INFO | started process 29322 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHoxIRZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:26:48 INFO - PROCESS | 29322 | RSS: Main: 161402880 12:26:48 INFO - PROCESS | 29322 | 12:26:51 INFO - PROCESS | 29322 | Cycle 1(1): loaded http://localhost:45278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45278/tests/kraken/driver.html?testName=audio-beat-detection) 12:26:52 INFO - PROCESS | 29322 | RSS: Main: 166670336 12:26:52 INFO - PROCESS | 29322 | 12:26:54 INFO - PROCESS | 29322 | Cycle 1(1): loaded http://localhost:45278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45278/tests/kraken/driver.html?testName=audio-dft) 12:26:55 INFO - PROCESS | 29322 | RSS: Main: 165543936 12:26:55 INFO - PROCESS | 29322 | 12:26:58 INFO - PROCESS | 29322 | Cycle 1(1): loaded http://localhost:45278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45278/tests/kraken/driver.html?testName=audio-fft) 12:26:59 INFO - PROCESS | 29322 | RSS: Main: 161951744 12:26:59 INFO - PROCESS | 29322 | 12:27:01 INFO - PROCESS | 29322 | Cycle 1(1): loaded http://localhost:45278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45278/tests/kraken/driver.html?testName=audio-oscillator) 12:27:01 INFO - PROCESS | 29322 | RSS: Main: 162852864 12:27:01 INFO - PROCESS | 29322 | 12:27:04 INFO - PROCESS | 29322 | Cycle 1(1): loaded http://localhost:45278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:27:04 INFO - PROCESS | 29322 | RSS: Main: 163274752 12:27:04 INFO - PROCESS | 29322 | 12:27:08 INFO - PROCESS | 29322 | Cycle 1(1): loaded http://localhost:45278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45278/tests/kraken/driver.html?testName=imaging-darkroom) 12:27:08 INFO - PROCESS | 29322 | RSS: Main: 163528704 12:27:08 INFO - PROCESS | 29322 | 12:27:12 INFO - PROCESS | 29322 | Cycle 1(1): loaded http://localhost:45278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45278/tests/kraken/driver.html?testName=imaging-desaturate) 12:27:12 INFO - PROCESS | 29322 | RSS: Main: 160002048 12:27:12 INFO - PROCESS | 29322 | 12:27:15 INFO - PROCESS | 29322 | Cycle 1(1): loaded http://localhost:45278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45278/tests/kraken/driver.html?testName=json-parse-financial) 12:27:16 INFO - PROCESS | 29322 | RSS: Main: 162267136 12:27:16 INFO - PROCESS | 29322 | 12:27:18 INFO - PROCESS | 29322 | Cycle 1(1): loaded http://localhost:45278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:27:18 INFO - PROCESS | 29322 | RSS: Main: 162312192 12:27:18 INFO - PROCESS | 29322 | 12:27:20 INFO - PROCESS | 29322 | Cycle 1(1): loaded http://localhost:45278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45278/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:27:21 INFO - PROCESS | 29322 | RSS: Main: 162963456 12:27:21 INFO - PROCESS | 29322 | 12:27:23 INFO - PROCESS | 29322 | Cycle 1(1): loaded http://localhost:45278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:27:24 INFO - PROCESS | 29322 | RSS: Main: 163336192 12:27:24 INFO - PROCESS | 29322 | 12:27:27 INFO - PROCESS | 29322 | Cycle 1(1): loaded http://localhost:45278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:27:27 INFO - PROCESS | 29322 | RSS: Main: 163233792 12:27:27 INFO - PROCESS | 29322 | 12:27:30 INFO - PROCESS | 29322 | Cycle 1(1): loaded http://localhost:45278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:27:31 INFO - PROCESS | 29322 | RSS: Main: 163885056 12:27:31 INFO - PROCESS | 29322 | 12:27:33 INFO - PROCESS | 29322 | Cycle 1(1): loaded http://localhost:45278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45278/tests/kraken/driver.html?testName=ai-astar) 12:27:33 INFO - PROCESS | 29322 | RSS: Main: 164216832 12:27:33 INFO - PROCESS | 29322 | 12:27:33 INFO - PROCESS | 29322 | __start_tp_report 12:27:33 INFO - PROCESS | 29322 | _x_x_mozilla_page_load 12:27:33 INFO - PROCESS | 29322 | _x_x_mozilla_page_load_details 12:27:33 INFO - PROCESS | 29322 | |i|pagename|runs| 12:27:33 INFO - PROCESS | 29322 | |0;ai-astar;109;115;110;115;115;115;114;115;115;114 12:27:33 INFO - PROCESS | 29322 | |1;audio-beat-detection;152;124;150;178;127;149;153;125;183;124 12:27:33 INFO - PROCESS | 29322 | |2;audio-dft;165;164;163;177;162;164;163;163;162;163 12:27:33 INFO - PROCESS | 29322 | |3;audio-fft;76;75;75;168;76;79;77;76;158;76 12:27:33 INFO - PROCESS | 29322 | |4;audio-oscillator;88;86;161;87;87;87;136;86;85;134 12:27:33 INFO - PROCESS | 29322 | |5;imaging-gaussian-blur;120;119;118;119;119;118;118;118;118;118 12:27:33 INFO - PROCESS | 29322 | |6;imaging-darkroom;148;148;149;149;148;149;147;149;149;148 12:27:33 INFO - PROCESS | 29322 | |7;imaging-desaturate;95;96;96;95;97;97;96;96;95;97 12:27:33 INFO - PROCESS | 29322 | |8;json-parse-financial;64;64;65;65;68;64;65;64;65;65 12:27:33 INFO - PROCESS | 29322 | |9;json-stringify-tinderbox;66;67;66;66;67;69;67;66;67;65 12:27:33 INFO - PROCESS | 29322 | |10;stanford-crypto-aes;83;81;85;79;80;80;79;80;87;80 12:27:33 INFO - PROCESS | 29322 | |11;stanford-crypto-ccm;130;135;145;143;139;131;134;147;172;129 12:27:33 INFO - PROCESS | 29322 | |12;stanford-crypto-pbkdf2;169;169;171;172;167;170;168;168;167;171 12:27:33 INFO - PROCESS | 29322 | |13;stanford-crypto-sha256-iterative;69;69;67;67;73;71;67;68;68;70 12:27:33 INFO - PROCESS | 29322 | __end_tp_report 12:27:33 INFO - PROCESS | 29322 | __start_cc_report 12:27:33 INFO - PROCESS | 29322 | _x_x_mozilla_cycle_collect,896 12:27:33 INFO - PROCESS | 29322 | __end_cc_report 12:27:33 INFO - PROCESS | 29322 | __startTimestamp1470338853275__endTimestamp 12:27:33 INFO - PROCESS | 29322 | 12:27:33 INFO - PROCESS | 29322 | ------- Summary: start ------- 12:27:33 INFO - PROCESS | 29322 | Number of tests: 14 12:27:33 INFO - PROCESS | 29322 | 12:27:33 INFO - PROCESS | 29322 | [#0] ai-astar Cycles:10 Average:113.70 Median:115.00 stddev:2.26 (2.0%) stddev-sans-first:1.64 12:27:33 INFO - PROCESS | 29322 | Values: 109.0 115.0 110.0 115.0 115.0 115.0 114.0 115.0 115.0 114.0 12:27:33 INFO - PROCESS | 29322 | 12:27:33 INFO - PROCESS | 29322 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:151.00 stddev:21.78 (14.4%) stddev-sans-first:23.01 12:27:33 INFO - PROCESS | 29322 | Values: 152.0 124.0 150.0 178.0 127.0 149.0 153.0 125.0 183.0 124.0 12:27:33 INFO - PROCESS | 29322 | 12:27:33 INFO - PROCESS | 29322 | [#2] audio-dft Cycles:10 Average:164.60 Median:163.50 stddev:4.45 (2.7%) stddev-sans-first:4.72 12:27:33 INFO - PROCESS | 29322 | Values: 165.0 164.0 163.0 177.0 162.0 164.0 163.0 163.0 162.0 163.0 12:27:33 INFO - PROCESS | 29322 | 12:27:33 INFO - PROCESS | 29322 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.00 stddev:36.67 (48.3%) stddev-sans-first:38.34 12:27:33 INFO - PROCESS | 29322 | Values: 76.0 75.0 75.0 168.0 76.0 79.0 77.0 76.0 158.0 76.0 12:27:33 INFO - PROCESS | 29322 | 12:27:33 INFO - PROCESS | 29322 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:86.50 stddev:28.49 (32.9%) stddev-sans-first:29.64 12:27:33 INFO - PROCESS | 29322 | Values: 88.0 86.0 161.0 87.0 87.0 87.0 136.0 86.0 85.0 134.0 12:27:33 INFO - PROCESS | 29322 | 12:27:33 INFO - PROCESS | 29322 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.50 stddev:0.71 (0.6%) stddev-sans-first:0.50 12:27:33 INFO - PROCESS | 29322 | Values: 120.0 119.0 118.0 119.0 119.0 118.0 118.0 118.0 118.0 118.0 12:27:33 INFO - PROCESS | 29322 | 12:27:33 INFO - PROCESS | 29322 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:149.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 12:27:33 INFO - PROCESS | 29322 | Values: 148.0 148.0 149.0 149.0 148.0 149.0 147.0 149.0 149.0 148.0 12:27:33 INFO - PROCESS | 29322 | 12:27:33 INFO - PROCESS | 29322 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 12:27:33 INFO - PROCESS | 29322 | Values: 95.0 96.0 96.0 95.0 97.0 97.0 96.0 96.0 95.0 97.0 12:27:33 INFO - PROCESS | 29322 | 12:27:33 INFO - PROCESS | 29322 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:1.20 (1.8%) stddev-sans-first:1.22 12:27:33 INFO - PROCESS | 29322 | Values: 64.0 64.0 65.0 65.0 68.0 64.0 65.0 64.0 65.0 65.0 12:27:33 INFO - PROCESS | 29322 | 12:27:33 INFO - PROCESS | 29322 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:1.07 (1.6%) stddev-sans-first:1.12 12:27:33 INFO - PROCESS | 29322 | Values: 66.0 67.0 66.0 66.0 67.0 69.0 67.0 66.0 67.0 65.0 12:27:33 INFO - PROCESS | 29322 | 12:27:33 INFO - PROCESS | 29322 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:80.50 stddev:2.72 (3.4%) stddev-sans-first:2.82 12:27:33 INFO - PROCESS | 29322 | Values: 83.0 81.0 85.0 79.0 80.0 80.0 79.0 80.0 87.0 80.0 12:27:33 INFO - PROCESS | 29322 | 12:27:33 INFO - PROCESS | 29322 | [#11] stanford-crypto-ccm Cycles:10 Average:140.50 Median:141.00 stddev:12.77 (9.1%) stddev-sans-first:12.97 12:27:33 INFO - PROCESS | 29322 | Values: 130.0 135.0 145.0 143.0 139.0 131.0 134.0 147.0 172.0 129.0 12:27:33 INFO - PROCESS | 29322 | 12:27:33 INFO - PROCESS | 29322 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.20 Median:169.50 stddev:1.75 (1.0%) stddev-sans-first:1.86 12:27:33 INFO - PROCESS | 29322 | Values: 169.0 169.0 171.0 172.0 167.0 170.0 168.0 168.0 167.0 171.0 12:27:33 INFO - PROCESS | 29322 | 12:27:33 INFO - PROCESS | 29322 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.97 (2.9%) stddev-sans-first:2.09 12:27:33 INFO - PROCESS | 29322 | Values: 69.0 69.0 67.0 67.0 73.0 71.0 67.0 68.0 68.0 70.0 12:27:33 INFO - PROCESS | 29322 | -------- Summary: end -------- 12:27:33 INFO - PROCESS | 29322 | 12:27:34 INFO - TEST-INFO | 29322: exit 0 12:27:34 INFO - TEST-OK | kraken | took 65113ms 12:27:34 INFO - SUITE-END | took 1184s 12:27:34 INFO - Completed test suite (00:19:45) 12:27:34 INFO - javascript benchmark 12:27:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6229.664523452658, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2673.876971671898, 2675.665541807274, 2685.785137189025, 2693.9865300673496, 2713.1996061161967, 4720.0, 4877.170880950238, 4880.78036488358, 4900.16697161483, 4936.8518944431635, 4755.904881902368, 4812.470628230901, 4824.734639594821, 4831.806727730896, 4877.365942427479, 4460.442444694413, 4491.573300536444, 4503.0, 4531.048479819242, 4575.93136102957, 4490.820367185309, 4508.887277818048, 4522.208613492642, 4534.8639540813665, 4590.678652494326, 4579.152856721517, 4586.243269860469, 4590.495045544987, 4590.655700822452, 4601.792919318622, 4329.7618630975285, 4406.140802543506, 4412.977935110336, 4444.066745983348, 4504.054148628792, 4368.322909948963, 4396.89007774805, 4410.977945110286, 4447.2439685253585, 4488.438945131858, 4809.446913604946, 4818.277258411232, 4829.1790395632825, 4847.079054979543, 4894.0, 5162.380514338266, 5201.973990130063, 5202.791888324463, 5215.035218484592, 5218.243354713545, 5275.095586805784, 5284.471552844723, 5290.65610735301, 5297.0, 5301.231321458406, 4909.337239472697, 4915.262710593368, 4916.188828843272, 4925.088858561177, 4937.11131996237, 5171.663841850268, 5249.291345668286, 5267.631265811357, 5280.577553795687, 5386.622936394493, 5095.796168153306, 5102.08162530748, 5108.591312694975, 5118.25785261135, 5123.795048198105, 5193.091209038479, 5201.401838788588, 5203.843884683465, 5223.2948551945, 5247.606429517725, 4961.280614310905, 4999.700017998932, 5075.644704870623, 5102.311187989574, 5104.285400043997, 5082.745862706924, 5131.153359695683, 5131.358580177478, 5135.691858488428, 5143.485651434827, 4484.663650226246, 4494.37078808967, 4495.685302028826, 4498.5501449854755, 4535.523770004168, 3785.1861849702445, 3812.0, 3907.3748200288387, 3922.490076290064, 3952.66402355803, 4211.220924129046, 4455.710378825366, 4481.775911204427, 4510.887227819331, 4520.073384956077, 5164.14791559396, 5218.452062533379, 5222.3472065991755, 5231.947680523146, 5272.182811664198, 4336.3278691802825, 4353.847615333448, 4406.052698669737, 4464.441944756905, 4496.437945256843, 4685.554872287127, 4687.179743544866, 4713.175194340976, 4748.074125545486, 4749.168895443284, 4833.637477189154, 4870.537298956593, 4875.414950205998, 4897.216445368724, 4939.703617782872, 5069.442361340323, 5150.124478838531, 5183.11886979222, 5225.529702326657, 5287.048331300402, 4825.420949486084, 4838.903221935612, 4865.683730557503, 4919.729414882216, 4924.803007879645, 5014.548690617862, 5058.418281897481, 5063.113955057924, 5070.746462676778, 5112.539871411591, 5044.4198917125, 5115.718635475085, 5206.843794686166, 5208.401033881152, 5217.191335343028, 4981.2030075187795, 5061.7469126544265, 5075.7969681212335, 5079.466656001066, 5080.618953578571, 5041.924371134362, 5058.721770302669, 5068.7972481101815, 5069.493050694901, 5112.488751124858, 4803.615710743202, 4922.4585295616735, 4968.801247950041, 4970.627202959865, 4991.0, 5106.463821298858, 5159.845204643867, 5167.715775632376, 5183.0670479314085, 5203.245529398292, 4916.434610019894, 4956.950430495649, 4962.6774259673, 5010.49895010496, 5013.348264725708], "value": 4767.543723890317, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.4890327543746, 549.8872731090127, 562.5106157642851, 573.7160105747655, 582.9038208695569, 34057.0, 35090.47364289535, 37857.24285514295, 38057.42913856294, 38107.618923810754, 38569.421458678145, 39263.0, 39399.212015759666, 39426.40860387089, 39520.407193892046, 7453.739119130818, 7747.922520774805, 7748.573828439434, 7779.0, 7786.688532458695, 7672.5012874163, 7704.0755109386955, 7719.536827790323, 7740.071191457033, 7756.340711039568, 7742.341900938399, 7783.571903545303, 7789.649465774026, 7803.882941755878, 7820.960895195516, 7709.691612335528, 7715.537067775896, 7726.343260822837, 7728.574928378937, 7801.921980780205, 7628.618569071524, 7702.037245344332, 7711.49875258112, 7721.150673425918, 7726.497777644435, 36690.44964325537, 36812.44781328282, 36935.0, 37030.62969370326, 37035.44446833299, 2971.435427268812, 3152.542881282201, 3158.6683398243313, 3517.8944631661093, 3519.788812671248, 29018.27454313638, 29245.853770731224, 29279.121626351032, 29661.0, 30293.848530757205, 3213.4858422652264, 3279.439974091323, 3323.401787678241, 3331.983340083308, 3355.882544110969, 249553.0, 249644.0, 250270.0, 250732.0, 251425.0, 51717.48282517127, 52327.73836130871, 52379.47620523822, 52445.213321800205, 52486.475135248926, 32249.51625725616, 33049.0, 33230.335393292, 35219.82390088033, 35298.0, 13908.4436622536, 13977.231252281223, 13989.930050349887, 13997.0, 14004.0, 11346.716332091599, 11368.374739389414, 11431.199816012966, 11447.08423326132, 11458.312501249951, 17827.286908523514, 18085.095745212686, 18199.54208700343, 18237.817621823877, 18254.0, 6582.572132811352, 6767.593944363354, 6939.895901561481, 6981.581105133709, 6997.265287144878, 740.2708332292688, 823.7611092783026, 841.4614646626164, 854.222657381792, 928.5542939389131, 27322.45355092927, 28582.428351432856, 28728.569071463946, 28810.135695929155, 29048.709512905025, 926.1664501948165, 940.9811803763887, 1004.1213937804421, 1019.607451131305, 1020.2399212586522, 14392.35234414454, 14611.707765844623, 14739.705205896036, 15032.542515221561, 15107.924460377628, 414221.0, 414676.0, 415985.0, 417529.0, 419286.0, 50003.0, 50461.495385046415, 50485.49514504808, 50680.493195067575, 50844.0, 1160.6169963911889, 1169.0589075793898, 1177.0, 1177.464253764535, 1206.8431103956254, 26203.475930481665, 26671.33321666974, 27328.863355683094, 27480.725192747817, 28156.85921570379, 42400.78799605982, 42851.357229640955, 42855.0, 42870.57129428666, 43122.56877431311, 358017.0, 358526.0, 359113.0, 359524.0, 360282.0, 24989.625155622318, 25035.749642503342, 25536.74463255418, 25553.872230638728, 25621.3594660135, 42269.78865105655, 42334.5766542343, 42674.5732542683, 42788.1442371157, 43699.56300436955, 36018.8199059003, 36496.81751591225, 36888.26223475569, 37191.62808371882, 37720.2455950874, 36853.815730922244, 37204.25591488101, 37310.813445932596, 37778.62221377751, 38349.2330153401, 35393.640748486105, 35411.291774164885, 36041.0, 36249.81875090713, 36886.26227475382, 27875.581866272427, 30304.84847575748, 30408.391832163674, 32030.359392811548, 33503.49744753879, 26103.608445872946, 26195.869020654776, 26262.34344141412, 26387.0, 26733.0], "value": 17287.53307465775, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.23013679494727, 357.1428571428571, 359.6439524870379, 360.4593110334498, 373.83924912287705, 16172.191390430475, 16255.431059912906, 17411.73882391765, 17464.738028929576, 17532.035738034403, 16079.276432560533, 16139.838601613981, 16140.435084772036, 16142.7578586321, 16219.594510137253, 4333.783310834454, 4575.359449677047, 4603.907921841561, 4639.118567472169, 4667.206574882278, 4542.682012259143, 4544.295634176708, 4619.953800461986, 4652.255639097745, 4662.930056049162, 4584.77076146193, 4597.057603191354, 4657.347971284006, 4747.85756427306, 4782.641301902371, 4714.693544919569, 4733.077049975256, 4764.071006153801, 4766.165920963817, 4786.880327991793, 4597.977010114962, 4707.964247865499, 4720.693154944952, 4722.7402492862875, 4734.218853889104, 12453.066020048533, 12532.248065116122, 12620.495180192782, 14256.786148207786, 16877.578060548585, 1772.2025088710004, 1810.3211295764088, 1919.827215550593, 2116.714243577113, 2289.210222473244, 9283.932347779957, 9294.117058879463, 9295.860562091506, 9304.162625363682, 9604.375715578464, 1713.323237321251, 1715.8884672496247, 1748.728947013215, 1758.9032603206817, 1795.7126859702385, 69867.0, 70752.29247707508, 70858.2914170862, 71302.28697713009, 75220.62389688072, 8715.869261961076, 9266.721998340061, 9395.342326037111, 9541.141297283279, 10017.348872323275, 12848.743025139633, 12854.742905142031, 12876.678083047811, 12878.549250776365, 12908.741825163632, 7180.389666878374, 7256.383207427322, 7393.297636724503, 7483.6258187090425, 7509.774706758806, 7241.565506069653, 7255.274472552808, 7340.926590734131, 7446.106467223968, 7479.925200747923, 4016.5380981186954, 4023.8189281482405, 4026.939595906064, 4119.155573107506, 4328.696991210648, 1702.3020561569697, 1702.8382303681378, 1704.752810842421, 1747.0915124135379, 1771.6899542579997, 353.16124205013097, 361.1242736364306, 770.310572038034, 770.5068755996055, 874.4709450782312, 9913.306068575275, 10647.574097036188, 10648.36109833397, 10785.40680262593, 11006.889931100586, 383.9901060211681, 386.31236399208893, 390.60939060939063, 391.07315661881523, 393.5769048273118, 5040.873978150576, 5790.826275211751, 5818.185454036438, 5825.097109947965, 5963.224780778471, 423934.0, 424411.0, 431053.0, 432626.0, 434987.0, 80255.19744802594, 82766.0, 83137.58431207805, 84941.57529212315, 85981.57009215039, 400.331446484366, 409.1857204163752, 414.1427245601576, 414.6703370820205, 416.28814726816876, 9597.424154550748, 9823.115919566988, 9898.901010989797, 9928.205743540644, 10137.594496220363, 32899.8485053022, 36692.0, 37183.19136513963, 37215.0, 37870.81064594659, 49840.0, 51852.22221666603, 52382.73808630933, 52463.47536524586, 53072.46927530675, 7247.383972362198, 7313.780586582411, 7357.705691772269, 7558.848823023619, 7773.68905243784, 11058.447077646246, 12246.75506489883, 12552.552252310712, 12859.357032148542, 13065.150765200231, 9267.72196834096, 9524.761880953032, 9884.505774711091, 10213.131883789663, 10695.197860160675, 10662.626808061681, 10836.945815270874, 10894.50974706156, 10919.727006824893, 11016.889831101907, 10201.693949181536, 10229.795404092025, 10402.0, 10491.68524944253, 10537.473126343806, 7486.401087912845, 7668.079830420385, 7714.421418393531, 7778.88331675014, 7920.168382320004, 8275.255227029356, 9514.19129374011, 9700.932897381423, 9808.950955245464, 10240.948795255976], "value": 7258.580130064914, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.2806412601321, 1400.9019368644192, 1461.5396150212682, 1660.460350386125, 1691.915404229789, 6320.367963203677, 6751.594904305733, 6944.236134025253, 7434.145073316577, 7471.402287816975, 7036.085308909847, 7237.601931893743, 7272.418206543477, 7273.818154546139, 7318.780436586898, 2127.149140343863, 2152.440365504964, 2169.197396963126, 2171.109844963565, 2173.6413491773837, 2090.95818083639, 2138.508143127082, 2161.8702877827304, 2166.4150679316576, 2169.7070895429074, 2128.9893550532224, 2135.594237094947, 2139.2833400810746, 2141.1649456711816, 2168.4578855286177, 2103.2848831397323, 2111.039477037944, 2113.355426594888, 2113.957720845582, 2124.2352753008904, 2038.4088614301834, 2091.048572899327, 2095.057224249079, 2122.6285400055085, 2126.542793299448, 7292.817679558, 7364.484486085976, 7378.704851805921, 7430.14553326369, 7439.330460258603, 4206.810693518799, 4340.696151269412, 4358.694891357606, 4361.694681372305, 4371.27873900806, 2748.5877118432195, 2819.788515861298, 2820.5910143029146, 2849.501337265991, 2870.512012957802, 887.8756974023642, 931.8648795924621, 932.2262522106636, 934.145257089762, 956.4404823178448, 9648.083432074012, 9685.41887486746, 9686.32195746298, 9706.417614943126, 9711.514424278757, 3697.2605478904325, 3780.1872597391693, 3913.412988051815, 3977.164795393, 3982.2831890259454, 8310.8337833243, 8356.707515236938, 8376.162383761697, 8427.95786021066, 8478.448900821428, 4320.891977700583, 4342.0664557119735, 4350.978245108818, 4354.368616550582, 4369.563043695669, 3471.8264086796066, 3936.6063393660406, 3953.2884080865147, 3978.3236849735613, 4025.1144748155357, 3415.2848485454124, 3469.392856250146, 3548.574171099433, 3591.838367273479, 3663.798491083016, 1144.7824913266452, 1150.1833698074295, 1151.3207207747303, 1164.5109054197258, 1171.5899435197612, 761.8895260187242, 777.0675189772296, 788.6819662348596, 790.3005839831791, 800.8718605023168, 4761.880952976203, 4776.09254241693, 4796.448408433005, 4878.829240976549, 5058.721770302595, 378.85035411012495, 383.7313880283813, 384.15869246350405, 385.5643123270686, 392.65250253525835, 3466.584009918826, 3468.0809585459874, 3468.601110872282, 3490.5636795400574, 3493.615702272748, 8283.337333013344, 8765.737027889174, 8790.604422800989, 8803.691870784492, 8809.295256379473, 8723.476591404537, 8747.956260218785, 8752.56237188138, 8819.514926679094, 8826.117388261251, 6790.660466976631, 6871.278515755874, 6958.756443524452, 6986.091808065021, 6992.790216293621, 4777.689450185727, 4815.398075240595, 4820.493848145894, 4890.413150421972, 4897.41231052276, 8182.0, 8224.588770561568, 8269.173082691923, 8344.249017588447, 8344.707935222481, 8273.793155171168, 8357.247847693738, 8388.832223355377, 8453.323734101134, 8464.619092140745, 5542.224088627515, 6090.0, 6195.411435913581, 6201.565890387629, 6209.285932117864, 6893.586384816927, 6985.406240469617, 6992.230854606091, 7018.087648605853, 7032.8593428130125, 6301.464375528131, 6387.744490220339, 6407.135036769976, 6579.671016449062, 6585.473162147113, 6105.8168254952425, 6157.507399408126, 6205.2553693557065, 6246.750129994749, 6290.968545157245, 6058.606190597597, 6105.45050945417, 6120.785772497941, 6177.227846519185, 6190.783322583688, 3983.3427484464737, 4053.61490658387, 4144.854930077433, 4190.062427446266, 4229.344451610005, 4142.958570414257, 4171.165766846703, 4197.958020419756, 4206.621404073648, 4208.431861698631], "value": 3829.755273099223, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.19430913360634, 296.1382377282109, 297.40667368599645, 300.3122848676531, 304.2788591039235, 4947.257911313305, 5052.16639254523, 5054.721990290533, 5162.690238585683, 5165.948340516594, 4971.37857767779, 5035.949640503594, 5076.771545280462, 5077.111505486543, 5088.618353623475, 4017.156397156586, 4029.697772667047, 4032.778197199153, 4032.8588499402526, 4042.5351084625204, 3937.370020796673, 4018.3771515415156, 4036.2331157080207, 4038.9394159087637, 4047.51429828421, 3945.3687410014404, 3968.900777480572, 3981.7610943343493, 3994.3609022556398, 3997.480327557428, 3940.1922605866016, 3941.3052387473517, 3973.324534829086, 3975.463312452811, 3993.860214892494, 3370.5786776652917, 3494.947575786365, 3501.544799176116, 3513.191965847869, 3537.080359106625, 4928.7535623219055, 4948.812285051597, 4959.404871415417, 4988.575971042465, 5040.2691609716385, 4541.727496350197, 4547.727136371828, 4559.426997685793, 4560.452745670541, 4570.3373010913565, 5198.766055527511, 5305.647059999714, 5312.92030619541, 5338.9466105339225, 5342.385625653061, 3745.606711295302, 3779.811009449544, 3793.070697679086, 3794.962050379516, 3834.1373191032076, 5533.280673512458, 5539.639923404966, 5556.222128901957, 5588.720563971785, 5609.80365687199, 3718.721095917817, 3859.7648752399523, 3918.5885482023978, 3919.118198405393, 3919.980400097981, 3909.7458665186673, 3912.2762288976633, 3919.235749028912, 3923.4899463070187, 3964.385520244367, 4464.923810428167, 4495.988402609452, 4502.234620114588, 4506.594406503365, 4512.932306015412, 5183.403908550489, 5270.868228294324, 5272.472752724773, 5311.336082989626, 5351.785928562892, 1356.620146359021, 1366.0, 1379.6206043338161, 1381.5026590427437, 1382.4470211915313, 845.146402133837, 858.9828203436022, 877.8324827978773, 878.4421892098436, 885.8626912828522, 4068.8575899843363, 4074.6129117733767, 4091.6726661867574, 4095.9590404096175, 4130.359794231899, 4846.854594362175, 4869.586085182799, 4873.366462359942, 4892.143874821963, 4902.2156454967035, 4037.555868854424, 4068.9013966229545, 4090.5295890972325, 4105.0, 4133.341992336804, 2485.8135639827087, 2554.7189809120982, 2569.601711734684, 2576.1627471071974, 2607.4394005288955, 4536.727796332165, 4550.1571863395375, 4609.0, 4612.431773197129, 4638.675292729544, 4894.510548945148, 4902.313676085351, 4918.975405122951, 4954.777035033432, 4959.461618340103, 4299.3877296014, 4522.417153996075, 4528.569785870337, 4562.8631141065825, 4570.052316256063, 4810.470848206624, 4845.442774081026, 4846.95153048465, 4847.878803029953, 4891.948231130324, 4767.163537695066, 4799.400074990626, 4808.663393562557, 4811.49479304668, 4852.587530059985, 4371.30059190528, 4456.777161141995, 4487.5063742987595, 4490.753008584559, 4522.8643140705835, 3506.9824650877604, 3543.20277937462, 3661.41417373219, 3753.0, 3846.7114966377076, 5376.650517716336, 5381.73091345439, 5385.569154467712, 5400.513953744025, 5445.26488924006, 5276.39321478035, 5278.651000304828, 5295.920561191509, 5302.681839089667, 5320.255164277081, 5042.016806722654, 5217.399999000164, 5223.112070948024, 5232.351809180096, 5259.894802104013, 5144.331236939174, 5174.120399532013, 5208.5051920067535, 5221.738913054256, 5247.58019358458, 5296.7351632418995, 5341.572674186134, 5342.065138600807, 5349.251104845403, 5354.277172581652, 4962.925556116589, 5237.869053273698, 5240.240165175952, 5277.997180535686, 5284.81503147388], "value": 3857.5672604208426, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.3369127650859, 611.2634275697785, 638.6136387485572, 678.6878036103392, 723.0347486106047, 12412.255264684114, 13409.463621455154, 13445.596632101053, 13448.731025379486, 13450.327483625817, 12687.555935542257, 13438.93280533596, 13655.931720341408, 13677.042607017487, 13770.24263665498, 770.9383249340053, 792.2434075457924, 795.4869109424418, 796.4982061301372, 800.1358532784608, 645.951553633477, 769.1078349115028, 776.5030380556449, 791.2522666080556, 793.8253584211465, 827.2554700769296, 830.7175560309494, 832.4838600067936, 832.8292699996487, 835.1398059998212, 824.3116997307255, 826.4173757500947, 827.028241815867, 828.7845160258377, 830.0869044051525, 601.5488383712216, 602.8101148138367, 602.8281939647179, 603.5141710922705, 603.6619493083887, 12907.935460322733, 12997.0, 13015.349232538336, 13023.544175953795, 13030.869691303154, 13335.933320333434, 13687.589372318846, 13837.446502139903, 14123.505677301348, 14361.210133442657, 10832.566697332177, 10960.397178155199, 10979.780404391948, 11031.83452248217, 11122.49948752308, 3265.1020969233414, 3270.689284517991, 3287.9506807397906, 3334.283129127225, 3344.949825752591, 70055.94916076314, 70221.64889175573, 70418.29581704168, 72453.0, 73960.6301968492, 10825.35047897113, 10919.290246133976, 10955.671329860117, 11060.944695276472, 11071.5571377144, 20925.162993480393, 20927.68608470874, 20927.790722092584, 20993.37019889406, 21001.579968400853, 6777.356151165632, 6965.373116419547, 7042.718291268292, 7075.186353569406, 7142.892856607155, 3851.8651847185774, 3854.094287842355, 3863.6817909254223, 3876.089119057019, 4045.7774822384463, 2854.7716182705335, 2886.105307354727, 2889.0321742216174, 2895.0, 2946.6758656547763, 486.63241485166986, 487.94388645305537, 495.0322120254893, 503.2953864589531, 506.640285397372, 442.8494311933958, 447.8656403079128, 556.2296219735695, 594.8512871782054, 595.2975488923025, 7549.320561149413, 7743.186965368555, 7794.181610930884, 7929.32600728933, 8075.071366792777, 546.3498436860124, 556.8802707417925, 559.3343920734394, 567.6906086182958, 569.4533248081805, 3360.5799275090612, 3639.927201455956, 3839.4432807242792, 3854.0, 3863.671587915059, 103272.0, 105102.47448762707, 105492.39583645793, 105507.0, 106812.39781403285, 93549.0, 93928.24287028579, 94670.5266473677, 95280.52359738157, 95572.0, 80793.0, 83579.0, 83588.0, 84128.57935710404, 84389.0, 7062.858742825218, 7240.167380751281, 7336.963315183603, 7375.668094935633, 7433.256674332523, 33525.329493410485, 34908.82545587256, 46467.0, 46861.53138468572, 47596.0, 69191.65404172947, 71494.0, 72483.63758181175, 73496.63251683707, 73830.26169738449, 10653.414062226651, 10764.300320479144, 10948.726281842699, 11085.27945683528, 11375.31748095117, 10865.832109703655, 11262.887371126184, 11420.657380278604, 11570.94214528922, 11762.58830940913, 9312.0, 9370.859437108586, 11540.192186546861, 12266.938665306974, 12275.263484190977, 11179.441027948733, 11343.716407089889, 11394.601188958346, 11472.483738231633, 12305.876941230474, 10997.34015959045, 11354.091672666333, 11446.656600302003, 11641.825372619587, 11777.234479758788, 9491.667791627537, 9689.51552422362, 9690.224782017282, 10063.14463270601, 11168.944155279172, 9058.637654493747, 9753.414795112316, 10109.898901010896, 10176.287659863738, 10339.276250662682], "value": 6612.636307766438, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 115.0, 110.0, 115.0, 115.0, 115.0, 114.0, 115.0, 115.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 124.0, 150.0, 178.0, 127.0, 149.0, 153.0, 125.0, 183.0, 124.0], "value": 146.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 163.0, 177.0, 162.0, 164.0, 163.0, 163.0, 162.0, 163.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 168.0, 76.0, 79.0, 77.0, 76.0, 158.0, 76.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 161.0, 87.0, 87.0, 87.0, 136.0, 86.0, 85.0, 134.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 119.0, 118.0, 119.0, 119.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 149.0, 148.0, 149.0, 147.0, 149.0, 149.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 97.0, 97.0, 96.0, 96.0, 95.0, 97.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 65.0, 68.0, 64.0, 65.0, 64.0, 65.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 67.0, 69.0, 67.0, 66.0, 67.0, 65.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 85.0, 79.0, 80.0, 80.0, 79.0, 80.0, 87.0, 80.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 135.0, 145.0, 143.0, 139.0, 131.0, 134.0, 147.0, 172.0, 129.0], "value": 140.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 171.0, 172.0, 167.0, 170.0, 168.0, 168.0, 167.0, 171.0], "value": 169.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 67.0, 67.0, 73.0, 71.0, 67.0, 68.0, 68.0, 70.0], "value": 68.9, "unit": "score"}]}]} 12:27:34 INFO - Return code: 0 12:27:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:27:35 ERROR - # TBPL SUCCESS # 12:27:35 INFO - Running post-action listener: _resource_record_post_action 12:27:35 INFO - [mozharness: 2016-08-04 19:27:35.050403Z] Finished run-tests step (success) 12:27:35 INFO - Running post-run listener: _resource_record_post_run 12:27:35 INFO - Total resource usage - Wall time: 1202s; CPU: 14.0%; Read bytes: 12288; Write bytes: 544014336; Read time: 716; Write time: 1851632 12:27:35 INFO - TinderboxPrint: CPU usage
13.6% 12:27:35 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 716 12:27:35 INFO - TinderboxPrint: I/O write bytes / time
544,014,336 / 1,851,632 12:27:35 INFO - TinderboxPrint: CPU idle
8,286.9 (86.4%) 12:27:35 INFO - TinderboxPrint: CPU user
1,226.2 (12.8%) 12:27:35 INFO - TinderboxPrint: Swap in / out
0 / 0 12:27:35 INFO - install - Wall time: 16s; CPU: 20.0%; Read bytes: 4096; Write bytes: 233902080; Read time: 76; Write time: 913648 12:27:35 INFO - run-tests - Wall time: 1186s; CPU: 14.0%; Read bytes: 8192; Write bytes: 308293632; Read time: 640; Write time: 921912 12:27:35 INFO - Running post-run listener: _upload_blobber_files 12:27:35 INFO - Blob upload gear active. 12:27:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:27:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:27:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:27:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:27:36 INFO - (blobuploader) - INFO - Open directory for files ... 12:27:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:27:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:27:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:27:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:27:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:27:44 INFO - (blobuploader) - INFO - Done attempting. 12:27:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:27:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:27:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:27:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:27:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:27:45 INFO - (blobuploader) - INFO - Done attempting. 12:27:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:27:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:27:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:27:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:27:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:27:45 INFO - (blobuploader) - INFO - Done attempting. 12:27:45 INFO - (blobuploader) - INFO - Iteration through files over. 12:27:45 INFO - Return code: 0 12:27:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:27:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:27:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/78b7242294c0c397b4423622586dd8b2b10feeb4b412c999dd22efc1dc5d4cf23369dc08386204d07ed05b1d5de6f25230930602b883dbd3e66e1f31d31f7f3b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cdebd4328cf6481eb95d96f5bff7bf310635a7a4cd32eba1f1de38a1a5214939002c69e9d096cb739668976cd48c73f681e793e2f4a30115936b0669004838e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5def630ba8cf44a41b8eaa2c094d26311de6f3d483965b197f1f2dcb0902ea50638778780b3014253c4d68e246d1669393c8b237c9178872f04e80f75c757a71"} 12:27:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:27:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:27:45 INFO - Contents: 12:27:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/78b7242294c0c397b4423622586dd8b2b10feeb4b412c999dd22efc1dc5d4cf23369dc08386204d07ed05b1d5de6f25230930602b883dbd3e66e1f31d31f7f3b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cdebd4328cf6481eb95d96f5bff7bf310635a7a4cd32eba1f1de38a1a5214939002c69e9d096cb739668976cd48c73f681e793e2f4a30115936b0669004838e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5def630ba8cf44a41b8eaa2c094d26311de6f3d483965b197f1f2dcb0902ea50638778780b3014253c4d68e246d1669393c8b237c9178872f04e80f75c757a71"} 12:27:46 INFO - Running post-run listener: copy_logs_to_upload_dir 12:27:46 INFO - Copying logs to upload dir... 12:27:46 INFO - mkdir: /builds/slave/test/build/upload/logs 12:27:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.435049 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-04 12:27:45.922122) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 12:27:45.925668) ========= 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=df17445c3590ff7897617a0e00000225-1470335713.604542-120191102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/78b7242294c0c397b4423622586dd8b2b10feeb4b412c999dd22efc1dc5d4cf23369dc08386204d07ed05b1d5de6f25230930602b883dbd3e66e1f31d31f7f3b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cdebd4328cf6481eb95d96f5bff7bf310635a7a4cd32eba1f1de38a1a5214939002c69e9d096cb739668976cd48c73f681e793e2f4a30115936b0669004838e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5def630ba8cf44a41b8eaa2c094d26311de6f3d483965b197f1f2dcb0902ea50638778780b3014253c4d68e246d1669393c8b237c9178872f04e80f75c757a71"} build_url:https://queue.taskcluster.net/v1/task/N88kVI0aTkWcsRpBziZDww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011201 build_url: 'https://queue.taskcluster.net/v1/task/N88kVI0aTkWcsRpBziZDww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/78b7242294c0c397b4423622586dd8b2b10feeb4b412c999dd22efc1dc5d4cf23369dc08386204d07ed05b1d5de6f25230930602b883dbd3e66e1f31d31f7f3b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cdebd4328cf6481eb95d96f5bff7bf310635a7a4cd32eba1f1de38a1a5214939002c69e9d096cb739668976cd48c73f681e793e2f4a30115936b0669004838e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5def630ba8cf44a41b8eaa2c094d26311de6f3d483965b197f1f2dcb0902ea50638778780b3014253c4d68e246d1669393c8b237c9178872f04e80f75c757a71"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 12:27:45.958013) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 12:27:45.958776) ========= 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=df17445c3590ff7897617a0e00000225-1470335713.604542-120191102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 12:27:46.041237) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 12:27:46.041581) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 12:27:46.041893) ========= ========= Total master_lag: 0.19 =========