builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1471490280.23 results: success (0) buildid: 20160817173001 builduid: 921c711a151f4d7e983975cc6adec061 revision: 11c94ec980d60a48be403d003798d64269e785ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 20:18:00.226067) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 20:18:00.226573) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 20:18:00.226929) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 20:18:00.244035) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:18:00.244484) ========= 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=17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-17 20:18: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% 46.9M=0s 2016-08-17 20:18:00 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145346 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:18:00.407262) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:18:00.407729) ========= 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=17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015418 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:18:00.460927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:18:00.461787) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 11c94ec980d60a48be403d003798d64269e785ef --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 11c94ec980d60a48be403d003798d64269e785ef --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=17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-17 20:18:00,712 truncating revision to first 12 chars 2016-08-17 20:18:00,712 Setting DEBUG logging. 2016-08-17 20:18:00,712 attempt 1/10 2016-08-17 20:18:00,712 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/11c94ec980d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-17 20:18:01,024 unpacking tar archive at: fx-team-11c94ec980d6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637577 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:18:01.116201) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 20:18:01.116550) ========= script_repo_revision: 11c94ec980d60a48be403d003798d64269e785ef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 20:18:01.117026) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 20:18:01.117384) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 20:18:01.129313) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-17 20:18:01.129652) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:18:01 INFO - MultiFileLogger online at 20160817 20:18:01 in /builds/slave/test 20:18:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:18:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:18:01 INFO - {'append_to_log': False, 20:18:01 INFO - 'base_work_dir': '/builds/slave/test', 20:18:01 INFO - 'blob_upload_branch': 'Fx-Team', 20:18:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:18:01 INFO - 'branch': 'Fx-Team', 20:18:01 INFO - 'buildbot_json_path': 'buildprops.json', 20:18:01 INFO - 'config_files': ('talos/linux_config.py',), 20:18:01 INFO - 'default_actions': ('clobber', 20:18:01 INFO - 'read-buildbot-config', 20:18:01 INFO - 'download-and-extract', 20:18:01 INFO - 'populate-webroot', 20:18:01 INFO - 'create-virtualenv', 20:18:01 INFO - 'install', 20:18:01 INFO - 'run-tests'), 20:18:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:18:01 INFO - 'download_minidump_stackwalk': True, 20:18:01 INFO - 'download_symbols': 'ondemand', 20:18:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:18:01 INFO - 'tooltool.py': '/tools/tooltool.py', 20:18:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:18:01 INFO - '/tools/misc-python/virtualenv.py')}, 20:18:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:18:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:18:01 INFO - 'installer_path': 'installer.exe', 20:18:01 INFO - 'log_level': 'info', 20:18:01 INFO - 'log_name': 'talos', 20:18:01 INFO - 'log_to_console': True, 20:18:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:18:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:18:01 INFO - 'opt_config_files': (), 20:18:01 INFO - 'pip_index': False, 20:18:01 INFO - 'sps_profile': False, 20:18:01 INFO - 'sps_profile_interval': 0, 20:18:01 INFO - 'suite': 'dromaeojs', 20:18:01 INFO - 'system_bits': '32', 20:18:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:18:01 INFO - 'title': 'talos-linux64-ix-009', 20:18:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:18:01 INFO - 'use_talos_json': True, 20:18:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:18:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:18:01 INFO - 'work_dir': 'build'} 20:18:01 INFO - [mozharness: 2016-08-18 03:18:01.471517Z] Running clobber step. 20:18:01 INFO - Running pre-action listener: _resource_record_pre_action 20:18:01 INFO - Running main action method: clobber 20:18:01 INFO - rmtree: /builds/slave/test/build 20:18:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:18:01 INFO - Running post-action listener: _resource_record_post_action 20:18:01 INFO - [mozharness: 2016-08-18 03:18:01.931128Z] Finished clobber step (success) 20:18:01 INFO - [mozharness: 2016-08-18 03:18:01.931229Z] Running read-buildbot-config step. 20:18:01 INFO - Running pre-action listener: _resource_record_pre_action 20:18:01 INFO - Running main action method: read_buildbot_config 20:18:01 INFO - Using buildbot properties: 20:18:01 INFO - { 20:18:01 INFO - "project": "", 20:18:01 INFO - "product": "firefox", 20:18:01 INFO - "script_repo_revision": "production", 20:18:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:18:01 INFO - "repository": "", 20:18:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:18:01 INFO - "buildid": "20160817173001", 20:18:01 INFO - "pgo_build": "True", 20:18:01 INFO - "basedir": "/builds/slave/test", 20:18:01 INFO - "buildnumber": 1476, 20:18:01 INFO - "slavename": "talos-linux64-ix-009", 20:18:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:18:01 INFO - "platform": "ubuntu64_hw", 20:18:01 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:18:01 INFO - "branch": "fx-team", 20:18:01 INFO - "repo_path": "integration/fx-team", 20:18:01 INFO - "revision": "11c94ec980d60a48be403d003798d64269e785ef", 20:18:01 INFO - "stage_platform": "linux64-pgo", 20:18:01 INFO - "builduid": "921c711a151f4d7e983975cc6adec061", 20:18:01 INFO - "slavebuilddir": "test" 20:18:01 INFO - } 20:18:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 20:18:01 INFO - Running post-action listener: _resource_record_post_action 20:18:01 INFO - [mozharness: 2016-08-18 03:18:01.934245Z] Finished read-buildbot-config step (success) 20:18:01 INFO - [mozharness: 2016-08-18 03:18:01.934334Z] Running download-and-extract step. 20:18:01 INFO - Running pre-action listener: _resource_record_pre_action 20:18:01 INFO - Running main action method: download_and_extract 20:18:01 INFO - mkdir: /builds/slave/test/build/tests 20:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:18:01 INFO - trying https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:18:01 INFO - Downloading https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:18:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:18:02 INFO - Downloaded 1361 bytes. 20:18:02 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:18:02 INFO - Using the following test package requirements: 20:18:02 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:18:02 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:18:02 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:18:02 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:02 INFO - u'jsshell-linux-x86_64.zip'], 20:18:02 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:18:02 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:18:02 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:18:02 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:18:02 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:18:02 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:18:02 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:18: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')]} 20:18:02 INFO - trying https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:18:02 INFO - Downloading https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:18:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:18:03 INFO - Downloaded 21908217 bytes. 20:18:03 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 20:18:07 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 20:18: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')]} 20:18:07 INFO - trying https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:18:07 INFO - Downloading https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:18:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:18:08 INFO - Downloaded 21908217 bytes. 20:18:08 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 20:18: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')]} 20:18:13 INFO - trying https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:18:13 INFO - Downloading https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:18:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:18:13 INFO - Downloaded 14413981 bytes. 20:18:13 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 20:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:18:14 INFO - trying https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:18:14 INFO - Downloading https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:18:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:18:15 INFO - Downloaded 59612100 bytes. 20:18:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:18:15 INFO - mkdir: /builds/slave/test/properties 20:18:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:18:15 INFO - Writing to file /builds/slave/test/properties/build_url 20:18:15 INFO - Contents: 20:18:15 INFO - build_url:https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:18:16 INFO - Running post-action listener: _resource_record_post_action 20:18:16 INFO - Running post-action listener: set_extra_try_arguments 20:18:16 INFO - [mozharness: 2016-08-18 03:18:16.008272Z] Finished download-and-extract step (success) 20:18:16 INFO - [mozharness: 2016-08-18 03:18:16.008566Z] Running populate-webroot step. 20:18:16 INFO - Running pre-action listener: _resource_record_pre_action 20:18:16 INFO - Running main action method: populate_webroot 20:18:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:18:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:18:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:18:16 INFO - '--tppagecycles', 20:18:16 INFO - '7'], 20:18:16 INFO - 'tests': ['tsvgm']}}, 20:18:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:18:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:18:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:18:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:18:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:18:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:18:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:16 INFO - 'talos_options': ['--disable-e10s'], 20:18:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:18:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:18:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:16 INFO - 'talos_options': ['--disable-e10s'], 20:18:16 INFO - 'tests': ['damp', 'tps']}, 20:18:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:16 INFO - 'tests': ['damp', 'tps']}, 20:18:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:18:16 INFO - 'tests': ['dromaeo_dom']}, 20:18:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:18:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:18:16 INFO - 'tests': ['basic_compositor_video']}, 20:18:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:18:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:18:16 INFO - 'tests': ['a11yr', 20:18:16 INFO - 'ts_paint', 20:18:16 INFO - 'tpaint', 20:18:16 INFO - 'sessionrestore', 20:18:16 INFO - 'sessionrestore_no_auto_restore', 20:18:16 INFO - 'tabpaint']}, 20:18:16 INFO - 'other-e10s': {'tests': ['a11yr', 20:18:16 INFO - 'ts_paint', 20:18:16 INFO - 'tpaint', 20:18:16 INFO - 'sessionrestore', 20:18:16 INFO - 'sessionrestore_no_auto_restore', 20:18:16 INFO - 'tabpaint']}, 20:18:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:18:16 INFO - 'ts_paint', 20:18:16 INFO - 'tpaint', 20:18:16 INFO - 'sessionrestore', 20:18:16 INFO - 'sessionrestore_no_auto_restore', 20:18:16 INFO - 'tabpaint']}, 20:18:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:18:16 INFO - 'ts_paint', 20:18:16 INFO - 'tpaint', 20:18:16 INFO - 'sessionrestore', 20:18:16 INFO - 'sessionrestore_no_auto_restore', 20:18:16 INFO - 'tabpaint']}, 20:18:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:18:16 INFO - 'tests': ['a11yr', 20:18:16 INFO - 'ts_paint', 20:18:16 INFO - 'tpaint', 20:18:16 INFO - 'sessionrestore', 20:18:16 INFO - 'sessionrestore_no_auto_restore', 20:18:16 INFO - 'tabpaint']}, 20:18:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:18:16 INFO - 'tests': ['a11yr', 20:18:16 INFO - 'ts_paint', 20:18:16 INFO - 'tpaint', 20:18:16 INFO - 'sessionrestore', 20:18:16 INFO - 'sessionrestore_no_auto_restore', 20:18:16 INFO - 'tabpaint']}, 20:18:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:18:16 INFO - 'tests': ['tsvgx', 20:18:16 INFO - 'tsvgr_opacity', 20:18:16 INFO - 'tart', 20:18:16 INFO - 'tscrollx', 20:18:16 INFO - 'cart']}, 20:18:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:18:16 INFO - 'tsvgr_opacity', 20:18:16 INFO - 'tart', 20:18:16 INFO - 'tscrollx', 20:18:16 INFO - 'cart']}, 20:18:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:16 INFO - 'talos_options': ['--disable-e10s'], 20:18:16 INFO - 'tests': ['tp5o']}, 20:18:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:16 INFO - 'tests': ['tp5o']}, 20:18:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:16 INFO - 'talos_options': ['--disable-e10s', 20:18:16 INFO - '--xperf_path', 20:18:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:18:16 INFO - 'tests': ['tp5n']}, 20:18:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:16 INFO - 'talos_options': ['--xperf_path', 20:18:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:18:16 INFO - 'tests': ['tp5n']}}, 20:18:16 INFO - 'talos.zip': {'path': '', 20:18:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:18:16 INFO - Running post-action listener: _resource_record_post_action 20:18:16 INFO - [mozharness: 2016-08-18 03:18:16.027034Z] Finished populate-webroot step (success) 20:18:16 INFO - [mozharness: 2016-08-18 03:18:16.027126Z] Running create-virtualenv step. 20:18:16 INFO - Running pre-action listener: _resource_record_pre_action 20:18:16 INFO - Running main action method: create_virtualenv 20:18:16 INFO - Creating virtualenv /builds/slave/test/build/venv 20:18:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:18:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:18:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:18:16 INFO - Using real prefix '/usr' 20:18:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:18:16 INFO - Installing distribute.............................................................................................................................................................................................done. 20:18:18 INFO - Installing pip.................done. 20:18:18 INFO - Return code: 0 20:18:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:18: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')]} 20:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18: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')]} 20:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0d25c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd10850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0b370>, '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 0xd0e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0ed80>, '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': '17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:18: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', 'pip>=1.5'] in /builds/slave/test/build 20:18: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 pip>=1.5 20:18:18 INFO - Using env: {'DISPLAY': ':0', 20:18:18 INFO - 'HOME': '/home/cltbld', 20:18:18 INFO - 'LANG': 'en_US.UTF-8', 20:18:18 INFO - 'LANGUAGE': 'en_US:en', 20:18:18 INFO - 'LOGNAME': 'cltbld', 20:18:18 INFO - 'MAIL': '/var/mail/cltbld', 20:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:18 INFO - 'MOZ_NO_REMOTE': '1', 20:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:18 INFO - 'NO_EM_RESTART': '1', 20:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:18 INFO - 'PWD': '/builds/slave/test', 20:18:18 INFO - 'SHELL': '/bin/bash', 20:18:18 INFO - 'SHLVL': '1', 20:18:18 INFO - 'TERM': 'linux', 20:18:18 INFO - 'TMOUT': '86400', 20:18:18 INFO - 'USER': 'cltbld', 20:18:18 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709', 20:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:18 INFO - '_': '/tools/buildbot/bin/python'} 20:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:18:18 INFO - Cleaning up... 20:18:18 INFO - Return code: 0 20:18:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:18: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')]} 20:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18: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')]} 20:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18: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', '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 0x7f0d25c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd10850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0b370>, '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 0xd0e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0ed80>, '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': '17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:18: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', 'psutil>=3.1.1'] in /builds/slave/test/build 20:18: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 psutil>=3.1.1 20:18:18 INFO - Using env: {'DISPLAY': ':0', 20:18:18 INFO - 'HOME': '/home/cltbld', 20:18:18 INFO - 'LANG': 'en_US.UTF-8', 20:18:18 INFO - 'LANGUAGE': 'en_US:en', 20:18:18 INFO - 'LOGNAME': 'cltbld', 20:18:18 INFO - 'MAIL': '/var/mail/cltbld', 20:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:18 INFO - 'MOZ_NO_REMOTE': '1', 20:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:18 INFO - 'NO_EM_RESTART': '1', 20:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:18 INFO - 'PWD': '/builds/slave/test', 20:18:18 INFO - 'SHELL': '/bin/bash', 20:18:18 INFO - 'SHLVL': '1', 20:18:18 INFO - 'TERM': 'linux', 20:18:18 INFO - 'TMOUT': '86400', 20:18:18 INFO - 'USER': 'cltbld', 20:18:18 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709', 20:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:18 INFO - '_': '/tools/buildbot/bin/python'} 20:18:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:19 INFO - Downloading/unpacking psutil>=3.1.1 20:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:18:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:18:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:18:20 INFO - Installing collected packages: psutil 20:18:20 INFO - Running setup.py install for psutil 20:18:21 INFO - building 'psutil._psutil_linux' extension 20:18:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:18:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:18:21 INFO - building 'psutil._psutil_posix' extension 20:18:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:18:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:18:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:18:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:18:21 INFO - Successfully installed psutil 20:18:21 INFO - Cleaning up... 20:18:21 INFO - Return code: 0 20:18:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:18: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')]} 20:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18: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')]} 20:18:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0d25c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd10850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0b370>, '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 0xd0e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0ed80>, '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': '17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:18: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:18: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 mozsystemmonitor==0.3 20:18:21 INFO - Using env: {'DISPLAY': ':0', 20:18:21 INFO - 'HOME': '/home/cltbld', 20:18:21 INFO - 'LANG': 'en_US.UTF-8', 20:18:21 INFO - 'LANGUAGE': 'en_US:en', 20:18:21 INFO - 'LOGNAME': 'cltbld', 20:18:21 INFO - 'MAIL': '/var/mail/cltbld', 20:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:21 INFO - 'MOZ_NO_REMOTE': '1', 20:18:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:21 INFO - 'NO_EM_RESTART': '1', 20:18:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:21 INFO - 'PWD': '/builds/slave/test', 20:18:21 INFO - 'SHELL': '/bin/bash', 20:18:21 INFO - 'SHLVL': '1', 20:18:21 INFO - 'TERM': 'linux', 20:18:21 INFO - 'TMOUT': '86400', 20:18:21 INFO - 'USER': 'cltbld', 20:18:21 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709', 20:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:21 INFO - '_': '/tools/buildbot/bin/python'} 20:18:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:18: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 20:18: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 20:18: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 20:18: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 20:18: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 20:18: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 20:18:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:18:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:18:23 INFO - Installing collected packages: mozsystemmonitor 20:18:23 INFO - Running setup.py install for mozsystemmonitor 20:18:23 INFO - Successfully installed mozsystemmonitor 20:18:23 INFO - Cleaning up... 20:18:23 INFO - Return code: 0 20:18:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:18:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:23 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 0x7f0d25c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd10850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0b370>, '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 0xd0e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0ed80>, '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': '17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:18:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:18:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:18:23 INFO - Using env: {'DISPLAY': ':0', 20:18:23 INFO - 'HOME': '/home/cltbld', 20:18:23 INFO - 'LANG': 'en_US.UTF-8', 20:18:23 INFO - 'LANGUAGE': 'en_US:en', 20:18:23 INFO - 'LOGNAME': 'cltbld', 20:18:23 INFO - 'MAIL': '/var/mail/cltbld', 20:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:23 INFO - 'MOZ_NO_REMOTE': '1', 20:18:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:23 INFO - 'NO_EM_RESTART': '1', 20:18:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:23 INFO - 'PWD': '/builds/slave/test', 20:18:23 INFO - 'SHELL': '/bin/bash', 20:18:23 INFO - 'SHLVL': '1', 20:18:23 INFO - 'TERM': 'linux', 20:18:23 INFO - 'TMOUT': '86400', 20:18:23 INFO - 'USER': 'cltbld', 20:18:23 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709', 20:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:23 INFO - '_': '/tools/buildbot/bin/python'} 20:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:24 INFO - Downloading/unpacking jsonschema==2.5.1 20:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:18:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:26 INFO - Downloading functools32-3.2.3-2.tar.gz 20:18:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:18:26 INFO - warning: no files found matching '*.txt' 20:18:26 INFO - no previously-included directories found matching 'build' 20:18:26 INFO - no previously-included directories found matching 'dist' 20:18:26 INFO - no previously-included directories found matching '.git*' 20:18:26 INFO - Installing collected packages: jsonschema, functools32 20:18:26 INFO - Running setup.py install for functools32 20:18:26 INFO - warning: no files found matching '*.txt' 20:18:26 INFO - no previously-included directories found matching 'build' 20:18:26 INFO - no previously-included directories found matching 'dist' 20:18:26 INFO - no previously-included directories found matching '.git*' 20:18:26 INFO - Successfully installed jsonschema functools32 20:18:26 INFO - Cleaning up... 20:18:26 INFO - Return code: 0 20:18:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:18:26 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')]} 20:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:26 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')]} 20:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:26 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 0x7f0d25c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd10850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0b370>, '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 0xd0e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0ed80>, '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': '17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:18:26 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 20:18:26 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 20:18:26 INFO - Using env: {'DISPLAY': ':0', 20:18:26 INFO - 'HOME': '/home/cltbld', 20:18:26 INFO - 'LANG': 'en_US.UTF-8', 20:18:26 INFO - 'LANGUAGE': 'en_US:en', 20:18:26 INFO - 'LOGNAME': 'cltbld', 20:18:26 INFO - 'MAIL': '/var/mail/cltbld', 20:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:26 INFO - 'MOZ_NO_REMOTE': '1', 20:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:26 INFO - 'NO_EM_RESTART': '1', 20:18:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:26 INFO - 'PWD': '/builds/slave/test', 20:18:26 INFO - 'SHELL': '/bin/bash', 20:18:26 INFO - 'SHLVL': '1', 20:18:26 INFO - 'TERM': 'linux', 20:18:26 INFO - 'TMOUT': '86400', 20:18:26 INFO - 'USER': 'cltbld', 20:18:26 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709', 20:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:26 INFO - '_': '/tools/buildbot/bin/python'} 20:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:18:26 INFO - Cleaning up... 20:18:26 INFO - Return code: 0 20:18:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:18:26 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')]} 20:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:26 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')]} 20:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:26 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 0x7f0d25c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd10850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0b370>, '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 0xd0e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0ed80>, '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': '17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:18:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:18:26 INFO - Using env: {'DISPLAY': ':0', 20:18:26 INFO - 'HOME': '/home/cltbld', 20:18:26 INFO - 'LANG': 'en_US.UTF-8', 20:18:26 INFO - 'LANGUAGE': 'en_US:en', 20:18:26 INFO - 'LOGNAME': 'cltbld', 20:18:26 INFO - 'MAIL': '/var/mail/cltbld', 20:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:26 INFO - 'MOZ_NO_REMOTE': '1', 20:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:26 INFO - 'NO_EM_RESTART': '1', 20:18:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:26 INFO - 'PWD': '/builds/slave/test', 20:18:26 INFO - 'SHELL': '/bin/bash', 20:18:26 INFO - 'SHLVL': '1', 20:18:26 INFO - 'TERM': 'linux', 20:18:26 INFO - 'TMOUT': '86400', 20:18:26 INFO - 'USER': 'cltbld', 20:18:26 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709', 20:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:26 INFO - '_': '/tools/buildbot/bin/python'} 20:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:26 INFO - Downloading/unpacking blobuploader==1.2.4 20:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:28 INFO - Downloading blobuploader-1.2.4.tar.gz 20:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:18:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:18:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:18: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 20:18: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 20:18: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 20:18: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 20:18: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 20:18: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 20:18:29 INFO - Downloading docopt-0.6.1.tar.gz 20:18:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:18:29 INFO - Installing collected packages: blobuploader, requests, docopt 20:18:29 INFO - Running setup.py install for blobuploader 20:18:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:18:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:18:29 INFO - Running setup.py install for requests 20:18:29 INFO - Running setup.py install for docopt 20:18:30 INFO - Successfully installed blobuploader requests docopt 20:18:30 INFO - Cleaning up... 20:18:30 INFO - Return code: 0 20:18:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:30 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 0x7f0d25c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd10850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0b370>, '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 0xd0e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0ed80>, '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': '17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:18:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:18:30 INFO - Using env: {'DISPLAY': ':0', 20:18:30 INFO - 'HOME': '/home/cltbld', 20:18:30 INFO - 'LANG': 'en_US.UTF-8', 20:18:30 INFO - 'LANGUAGE': 'en_US:en', 20:18:30 INFO - 'LOGNAME': 'cltbld', 20:18:30 INFO - 'MAIL': '/var/mail/cltbld', 20:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:30 INFO - 'MOZ_NO_REMOTE': '1', 20:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:30 INFO - 'NO_EM_RESTART': '1', 20:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:30 INFO - 'PWD': '/builds/slave/test', 20:18:30 INFO - 'SHELL': '/bin/bash', 20:18:30 INFO - 'SHLVL': '1', 20:18:30 INFO - 'TERM': 'linux', 20:18:30 INFO - 'TMOUT': '86400', 20:18:30 INFO - 'USER': 'cltbld', 20:18:30 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709', 20:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:30 INFO - '_': '/tools/buildbot/bin/python'} 20:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:18:30 INFO - Running setup.py (path:/tmp/pip-aHNRGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:18:30 INFO - Running setup.py (path:/tmp/pip-r3LuzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:18:30 INFO - Running setup.py (path:/tmp/pip-fICpOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:18:30 INFO - Running setup.py (path:/tmp/pip-T3YE_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:18:30 INFO - Running setup.py (path:/tmp/pip-TH7f7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:18:30 INFO - Running setup.py (path:/tmp/pip-3CiLQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:18:30 INFO - Running setup.py (path:/tmp/pip-SMvyNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:18:30 INFO - Running setup.py (path:/tmp/pip-QgQ2Dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:18:30 INFO - Running setup.py (path:/tmp/pip-g9sWs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:18:30 INFO - Running setup.py (path:/tmp/pip-9aKYXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:18:31 INFO - Running setup.py (path:/tmp/pip-8AA0KX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:18:31 INFO - Running setup.py (path:/tmp/pip-v1o1Ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:18:31 INFO - Running setup.py (path:/tmp/pip-1RNZgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:18:31 INFO - Running setup.py (path:/tmp/pip-V8x7hF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:18:31 INFO - Running setup.py (path:/tmp/pip-WIyITt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:18:31 INFO - Running setup.py (path:/tmp/pip-uaLyag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:18:31 INFO - Running setup.py (path:/tmp/pip-_ebsiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:18:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:18:31 INFO - Running setup.py install for manifestparser 20:18:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:18:31 INFO - Running setup.py install for mozcrash 20:18:31 INFO - Running setup.py install for mozdebug 20:18:31 INFO - Running setup.py install for mozdevice 20:18:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:18:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:18:31 INFO - Running setup.py install for mozfile 20:18:32 INFO - Running setup.py install for mozhttpd 20:18:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:18:32 INFO - Running setup.py install for mozinfo 20:18:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:18:32 INFO - Running setup.py install for mozInstall 20:18:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:18:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:18:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:18:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:18:32 INFO - Running setup.py install for mozleak 20:18:32 INFO - Running setup.py install for mozlog 20:18:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:18:32 INFO - Running setup.py install for moznetwork 20:18:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:18:32 INFO - Running setup.py install for mozprocess 20:18:32 INFO - Running setup.py install for mozprofile 20:18:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:18:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:18:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:18:32 INFO - Running setup.py install for mozrunner 20:18:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:18:32 INFO - Running setup.py install for mozscreenshot 20:18:33 INFO - Running setup.py install for moztest 20:18:33 INFO - Running setup.py install for mozversion 20:18:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:18:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:18:33 INFO - Cleaning up... 20:18:33 INFO - Return code: 0 20:18:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:18:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:33 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 0x7f0d25c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd10850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0b370>, '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 0xd0e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0ed80>, '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': '17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:18:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:18:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:18:33 INFO - Using env: {'DISPLAY': ':0', 20:18:33 INFO - 'HOME': '/home/cltbld', 20:18:33 INFO - 'LANG': 'en_US.UTF-8', 20:18:33 INFO - 'LANGUAGE': 'en_US:en', 20:18:33 INFO - 'LOGNAME': 'cltbld', 20:18:33 INFO - 'MAIL': '/var/mail/cltbld', 20:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:33 INFO - 'MOZ_NO_REMOTE': '1', 20:18:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:33 INFO - 'NO_EM_RESTART': '1', 20:18:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:33 INFO - 'PWD': '/builds/slave/test', 20:18:33 INFO - 'SHELL': '/bin/bash', 20:18:33 INFO - 'SHLVL': '1', 20:18:33 INFO - 'TERM': 'linux', 20:18:33 INFO - 'TMOUT': '86400', 20:18:33 INFO - 'USER': 'cltbld', 20:18:33 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709', 20:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:33 INFO - '_': '/tools/buildbot/bin/python'} 20:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:18:33 INFO - Running setup.py (path:/tmp/pip-PGhmL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:18:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:18:33 INFO - Running setup.py (path:/tmp/pip-C2OdlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:18:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:18:33 INFO - Running setup.py (path:/tmp/pip-S1LdCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:18:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:18:33 INFO - Running setup.py (path:/tmp/pip-JvWZUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:18:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:18:33 INFO - Running setup.py (path:/tmp/pip-2TgeIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:18:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:18:33 INFO - Running setup.py (path:/tmp/pip-R3pVc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:18:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:18:33 INFO - Running setup.py (path:/tmp/pip-zBsPRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:18:34 INFO - Running setup.py (path:/tmp/pip-iA9eMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:18:34 INFO - Running setup.py (path:/tmp/pip-L6oswZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:18:34 INFO - Running setup.py (path:/tmp/pip-lQ4aMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:18:34 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)) 20:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:18:34 INFO - Running setup.py (path:/tmp/pip-r1jyKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:18:34 INFO - Running setup.py (path:/tmp/pip-wXsSPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:18:34 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)) 20:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:18:34 INFO - Running setup.py (path:/tmp/pip-V8c2Ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:18:34 INFO - Running setup.py (path:/tmp/pip-vkiJ5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:18:34 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)) 20:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:18:34 INFO - Running setup.py (path:/tmp/pip-AIAPxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:18:34 INFO - Running setup.py (path:/tmp/pip-S3j9JH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:18:34 INFO - Running setup.py (path:/tmp/pip-lm4eYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:18:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:36 INFO - Downloading blessings-1.6.tar.gz 20:18:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:18:36 INFO - Installing collected packages: blessings 20:18:36 INFO - Running setup.py install for blessings 20:18:36 INFO - Successfully installed blessings 20:18:36 INFO - Cleaning up... 20:18:36 INFO - Return code: 0 20:18:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:18:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:18:37 INFO - Reading from file tmpfile_stdout 20:18:37 INFO - Current package versions: 20:18:37 INFO - argparse == 1.2.1 20:18:37 INFO - blessings == 1.6 20:18:37 INFO - blobuploader == 1.2.4 20:18:37 INFO - docopt == 0.6.1 20:18:37 INFO - functools32 == 3.2.3-2 20:18:37 INFO - jsonschema == 2.5.1 20:18:37 INFO - manifestparser == 1.1 20:18:37 INFO - mozInstall == 1.12 20:18:37 INFO - mozcrash == 0.17 20:18:37 INFO - mozdebug == 0.1 20:18:37 INFO - mozdevice == 0.48 20:18:37 INFO - mozfile == 1.2 20:18:37 INFO - mozhttpd == 0.7 20:18:37 INFO - mozinfo == 0.9 20:18:37 INFO - mozleak == 0.1 20:18:37 INFO - mozlog == 3.3 20:18:37 INFO - moznetwork == 0.27 20:18:37 INFO - mozprocess == 0.23 20:18:37 INFO - mozprofile == 0.28 20:18:37 INFO - mozrunner == 6.12 20:18:37 INFO - mozscreenshot == 0.1 20:18:37 INFO - mozsystemmonitor == 0.3 20:18:37 INFO - moztest == 0.7 20:18:37 INFO - mozversion == 1.4 20:18:37 INFO - psutil == 3.1.1 20:18:37 INFO - requests == 1.2.3 20:18:37 INFO - wsgiref == 0.1.2 20:18:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:18:37 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')]} 20:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:37 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')]} 20:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:37 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 0x7f0d25c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd10850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0b370>, '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 0xd0e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0ed80>, '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': '17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:18:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:18:37 INFO - Using env: {'DISPLAY': ':0', 20:18:37 INFO - 'HOME': '/home/cltbld', 20:18:37 INFO - 'LANG': 'en_US.UTF-8', 20:18:37 INFO - 'LANGUAGE': 'en_US:en', 20:18:37 INFO - 'LOGNAME': 'cltbld', 20:18:37 INFO - 'MAIL': '/var/mail/cltbld', 20:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:37 INFO - 'MOZ_NO_REMOTE': '1', 20:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:37 INFO - 'NO_EM_RESTART': '1', 20:18:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:37 INFO - 'PWD': '/builds/slave/test', 20:18:37 INFO - 'SHELL': '/bin/bash', 20:18:37 INFO - 'SHLVL': '1', 20:18:37 INFO - 'TERM': 'linux', 20:18:37 INFO - 'TMOUT': '86400', 20:18:37 INFO - 'USER': 'cltbld', 20:18:37 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709', 20:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:37 INFO - '_': '/tools/buildbot/bin/python'} 20:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:18:37 INFO - Cleaning up... 20:18:37 INFO - Return code: 0 20:18:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:18:37 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')]} 20:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:37 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')]} 20:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:37 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 0x7f0d25c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd10850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0b370>, '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 0xd0e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0ed80>, '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': '17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:18:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:18:37 INFO - Using env: {'DISPLAY': ':0', 20:18:37 INFO - 'HOME': '/home/cltbld', 20:18:37 INFO - 'LANG': 'en_US.UTF-8', 20:18:37 INFO - 'LANGUAGE': 'en_US:en', 20:18:37 INFO - 'LOGNAME': 'cltbld', 20:18:37 INFO - 'MAIL': '/var/mail/cltbld', 20:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:37 INFO - 'MOZ_NO_REMOTE': '1', 20:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:37 INFO - 'NO_EM_RESTART': '1', 20:18:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:37 INFO - 'PWD': '/builds/slave/test', 20:18:37 INFO - 'SHELL': '/bin/bash', 20:18:37 INFO - 'SHLVL': '1', 20:18:37 INFO - 'TERM': 'linux', 20:18:37 INFO - 'TMOUT': '86400', 20:18:37 INFO - 'USER': 'cltbld', 20:18:37 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709', 20:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:37 INFO - '_': '/tools/buildbot/bin/python'} 20:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:18:37 INFO - Cleaning up... 20:18:37 INFO - Return code: 0 20:18:37 INFO - Running post-action listener: _resource_record_post_action 20:18:37 INFO - Running post-action listener: _start_resource_monitoring 20:18:37 INFO - Starting resource monitoring. 20:18:37 INFO - [mozharness: 2016-08-18 03:18:37.597316Z] Finished create-virtualenv step (success) 20:18:37 INFO - [mozharness: 2016-08-18 03:18:37.597972Z] Running install step. 20:18:37 INFO - Running pre-action listener: _resource_record_pre_action 20:18:37 INFO - Running main action method: install 20:18:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:18:37 INFO - Reading from file tmpfile_stdout 20:18:37 INFO - Detecting whether we're running mozinstall >=1.0... 20:18:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:18:37 INFO - Reading from file tmpfile_stdout 20:18:37 INFO - Output received: 20:18:37 INFO - Usage: mozinstall [options] installer 20:18:37 INFO - Options: 20:18:37 INFO - -h, --help show this help message and exit 20:18:37 INFO - -d DEST, --destination=DEST 20:18:37 INFO - Directory to install application into. [default: 20:18:37 INFO - "/builds/slave/test"] 20:18:37 INFO - --app=APP Application being installed. [default: firefox] 20:18:37 INFO - mkdir: /builds/slave/test/build/application 20:18:37 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'] 20:18:37 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 20:18:54 INFO - Reading from file tmpfile_stdout 20:18:54 INFO - Output received: 20:18:54 INFO - /builds/slave/test/build/application/firefox/firefox 20:18:54 INFO - Running post-action listener: _resource_record_post_action 20:18:54 INFO - [mozharness: 2016-08-18 03:18:54.848316Z] Finished install step (success) 20:18:54 INFO - [mozharness: 2016-08-18 03:18:54.848651Z] Running run-tests step. 20:18:54 INFO - Running pre-action listener: _resource_record_pre_action 20:18:54 INFO - Running main action method: run_tests 20:18:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:18:54 INFO - Python 2.7.3 20:18:54 INFO - Return code: 0 20:18:54 INFO - grabbing minidump binary from tooltool 20:18:54 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')]} 20:18:54 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 0xd0b370>, '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 0xd0e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0ed80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:18:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:18:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:18:54 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:18:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:18:54 INFO - Return code: 0 20:18:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:18:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:18:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:18:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:18:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:18:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:18:54 INFO - Using env: {'DISPLAY': ':0', 20:18:54 INFO - 'HOME': '/home/cltbld', 20:18:54 INFO - 'LANG': 'en_US.UTF-8', 20:18:54 INFO - 'LANGUAGE': 'en_US:en', 20:18:54 INFO - 'LOGNAME': 'cltbld', 20:18:54 INFO - 'MAIL': '/var/mail/cltbld', 20:18:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:18:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:54 INFO - 'MOZ_NO_REMOTE': '1', 20:18:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:54 INFO - 'NO_EM_RESTART': '1', 20:18:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:54 INFO - 'PWD': '/builds/slave/test', 20:18:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:18:54 INFO - 'SHELL': '/bin/bash', 20:18:54 INFO - 'SHLVL': '1', 20:18:54 INFO - 'TERM': 'linux', 20:18:54 INFO - 'TMOUT': '86400', 20:18:54 INFO - 'USER': 'cltbld', 20:18:54 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709', 20:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:54 INFO - '_': '/tools/buildbot/bin/python'} 20:18:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:18:55 INFO - mozversion application_buildid: 20160817173001 20:18:55 INFO - mozversion application_changeset: 11c94ec980d60a48be403d003798d64269e785ef 20:18:55 INFO - mozversion application_display_name: Nightly 20:18:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:18:55 INFO - mozversion application_name: Firefox 20:18:55 INFO - mozversion application_remotingname: firefox 20:18:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:18:55 INFO - mozversion application_vendor: Mozilla 20:18:55 INFO - mozversion application_version: 51.0a1 20:18:55 INFO - mozversion platform_buildid: 20160817173001 20:18:55 INFO - mozversion platform_changeset: 11c94ec980d60a48be403d003798d64269e785ef 20:18:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:18:55 INFO - mozversion platform_version: 51.0a1 20:18:55 INFO - using testdate: 1471490335 20:18:55 INFO - actual date: 1471490335 20:18:55 INFO - starting webserver on 'localhost:60769' 20:18:55 INFO - SUITE-START | Running 2 tests 20:18:55 INFO - TEST-START | dromaeo_css 20:18:55 INFO - operating with platform_type : linux_ 20:18:55 INFO - Initialising browser for dromaeo_css test... 20:18:55 INFO - TEST-INFO | started process 8441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjo8ORA/profile http://localhost:60769/getInfo.html) 20:18:59 INFO - PROCESS | 8441 | __metrics Screen width/height:1600/1200 20:18:59 INFO - PROCESS | 8441 | colorDepth:24 20:18:59 INFO - PROCESS | 8441 | Browser inner width/height: 1024/697 20:18:59 INFO - PROCESS | 8441 | __metrics 20:18:59 INFO - PROCESS | 8441 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:18:59 INFO - PROCESS | 8441 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:19:00 INFO - PROCESS | 8441 | console.error: PushService: 20:19:00 INFO - PROCESS | 8441 | stateChangeProcessEnqueue: Error transitioning state 20:19:00 INFO - PROCESS | 8441 | UnknownError 20:19:00 INFO - TEST-INFO | 8441: exit 0 20:19:00 INFO - Browser initialized. 20:19:00 INFO - Running cycle 1/1 for dromaeo_css test... 20:19:00 INFO - TEST-INFO | started process 8523 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjo8ORA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:19:12 INFO - PROCESS | 8523 | RSS: Main: 156139520 20:19:12 INFO - PROCESS | 8523 | 20:20:03 INFO - PROCESS | 8523 | 1471490403940 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:22:13 INFO - PROCESS | 8523 | Cycle 1(1): loaded http://localhost:60769/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60769/tests/dromaeo/cssquery-ext.html) 20:22:14 INFO - PROCESS | 8523 | RSS: Main: 260636672 20:22:14 INFO - PROCESS | 8523 | 20:25:16 INFO - PROCESS | 8523 | Cycle 1(1): loaded http://localhost:60769/tests/dromaeo/cssquery-ext.html (next: http://localhost:60769/tests/dromaeo/cssquery-jquery.html) 20:25:17 INFO - PROCESS | 8523 | RSS: Main: 244547584 20:25:17 INFO - PROCESS | 8523 | 20:28:19 INFO - PROCESS | 8523 | Cycle 1(1): loaded http://localhost:60769/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60769/tests/dromaeo/cssquery-mootools.html) 20:28:19 INFO - PROCESS | 8523 | RSS: Main: 184578048 20:28:19 INFO - PROCESS | 8523 | 20:31:22 INFO - PROCESS | 8523 | Cycle 1(1): loaded http://localhost:60769/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60769/tests/dromaeo/cssquery-prototype.html) 20:31:22 INFO - PROCESS | 8523 | RSS: Main: 183623680 20:31:22 INFO - PROCESS | 8523 | 20:34:25 INFO - PROCESS | 8523 | Cycle 1(1): loaded http://localhost:60769/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60769/tests/dromaeo/cssquery-yui.html) 20:34:26 INFO - PROCESS | 8523 | RSS: Main: 184971264 20:34:26 INFO - PROCESS | 8523 | 20:37:29 INFO - PROCESS | 8523 | Cycle 1(1): loaded http://localhost:60769/tests/dromaeo/cssquery-yui.html (next: http://localhost:60769/tests/dromaeo/cssquery-dojo.html) 20:37:29 INFO - PROCESS | 8523 | RSS: Main: 271183872 20:37:29 INFO - PROCESS | 8523 | 20:37:29 INFO - PROCESS | 8523 | __start_tp_report 20:37:29 INFO - PROCESS | 8523 | _x_x_mozilla_page_load 20:37:29 INFO - PROCESS | 8523 | _x_x_mozilla_page_load_details 20:37:29 INFO - PROCESS | 8523 | |i|pagename|runs| 20:37:29 INFO - PROCESS | 8523 | |0;dojo.html;2983.1945374748834;2996.1760515858136;3000.6699263081073;3002.369502404495;3036.0436462514313;5142.871428214296;5198.584113270938;5199.50604692554;5277.788888444463;5331.946680533193;5202.141646628311;5251.947480525203;5264.1051021326375;5306.124489459235;5350.197470379435;4775.80896764129;4791.6406269529925;4798.256270278095;4804.447488538828;4931.284963680264;4848.393950756155;4876.341693871317;4886.584640305578;4894.9965257122385;4912.017596480719;4722.669413141081;4724.480307166192;4760.880977975578;4766.618670506351;4824.228123500241;4760.357351757538;4768.117898188846;4787.473377928425;4845.224764037773;4866.562009419169;4777.140114779339;4797.9520204797855;4813.3983252093485;4815.3017812417;4845.200541910615;5145.562627176657;5156.819511317123;5183.144781111112;5244.632875698702;5272.472752724735;5681.176229446748;5688.886222275572;5691.800786972436;5697.088465845486;5708.315002199721;5681.346645135821;5712.057510510761;5712.542996560265;5735.0823868181305;5742.425757424266;5119.769610367505;5221.817236396708;5261.500157485071;5262.92105618416;5337.092694241988;5796.014677504834;5801.752623186036;5809.041508151107;5810.970945145332;5813.563982701315;5566.137248726453;5568.9443105568425;5593.776248950077;5613.045782217033;5619.129034999582;5456.91814622781;5566.276384070126;5611.6352437091455;5644.125160600113;5693.089105743061;5649.802256920988;5659.603827732019;5665.235193248941;5686.289213848269;5711.771529138871;5601.159826026129;5611.2144299798065;5641.26663533738;5647;5658.34928983164;4253.851115210953;4260.808263628082;4295.29127693927;4377.430933978626;4413.360062790877;3829.5978922213326;3834.2331533693373;3835.4822099016833;3861.768293902375;3879.049632839972;5287.762050707727;5298.470152984748;5311.097113490716;5336.733163341817;5354.678719276856;5520.696361700145;5528.806491772849;5531.25328080712;5617.848341090067;5623.775048998076;5306.681599103988;5316.0962636351915;5324.893502129936;5345.625806193607;5373.194020896819;4797.2564252540915;4821.566059054702;4823.95176048235;4845.878853028703;4861.392325959255;5719.971400142973;5729.598928075078;5762.1068734346245;5805.36141024487;5806.332271788799;5581.413951535193;5591.496765291144;5597.80407685729;5626.521745651666;5630.831075067755;5778.451047150514;5789.073748200268;5801.970990145022;5807.245058142584;5819.854503637443;5434.456554344534;5458.181272809111;5469.890602188014;5500.779968801203;5507.889842203213;5623.718814059363;5624.718764061862;5629.437056294338;5659.066254068032;5683.431656834284;5409.107497262908;5457.836264912059;5508.283923089973;5510.862228444321;5516.806911758069;5339.73301334924;5361.544268737045;5388.057090009154;5467.890642187054;5527.5577953764405;5442.265294185393;5444.047291723853;5448.782048718007;5496.395396506461;5509.834704958857;5475.534579560782;5476.17857321405;5495.972520137534;5516.14499752539;5521.613487055867;5272.947270527399;5278.419373868948;5326.893462130658;5347.51872331492;5352.304200453916 20:37:29 INFO - PROCESS | 8523 | |1;ext.html;569.5699746691248;586.1442294250392;590.9864582241455;602.3494625804132;611.0986295214559;33189.00432987011;44338.113237735226;45361.77319113408;45391;45472.317915231295;47185;47481;47555;47685;47694.523054769445;9080.137386948229;9232.399894006901;9233.6306547738;9236.584353704066;9240.768980775467;9172.357934944557;9260.490673012982;9262.536873156349;9267.44395336282;9269.907300926972;9308.301877359192;9372.8594071089;9373.109554592304;9378.765530861714;9384.155426011657;9253;9271.536423178813;9295.814083718355;9305.25557955362;9305.674301399486;9064.818703625957;9137.725868223964;9138.268938484905;9139.543022848831;9143;43194.56805431937;43453;43517.34723979143;43577.34633980493;43614.34578481325;3615.1865830188262;3739.6447337503164;3739.8317075731384;4108.281050816125;4317.503487098992;33734;33754.49368259478;34197.65802341994;34985.30029399423;35690.46464303038;4339.349097635349;4381.364702118207;4385.912281754379;4488.955110448919;4647.488776234612;368075;372250;372612;372860;376838.1158094192;36128.63871361253;36993.445098323544;37097.629023709414;61679.6916015426;61980.69009654923;38264.80867595644;38304.42543361852;38439.231215375534;38465;38577.80711096426;14684.265786710836;14810.481633142788;14818.92590537062;14828.923950646918;14864.182469964257;11520;11538.711532211762;11544.653660390202;11545.538178472767;11597.76804463906;8637.827243455096;8671.21959023691;8705.216530512283;8754.168354006359;8820.514871681991;3373.6795004474534;3373.915652108717;3386.1365351835125;3390.118569171984;3468.6704763047974;990.2474119669104;991.8512223166439;1003.8745156855393;1053.5469748008277;1111.5387114347454;33126.33747325088;33250.16874578155;33528.32943341119;33601.15997100092;33632.831835841156;1120.1095129372168;1140.1619809440056;1173.976520469586;1204.3677069538562;1206.8913797758244;17444.91277543604;17500.387486437914;18144.818551814576;18499.445016649523;19529.414117576496;531848;534440;534559;534816;543231;62030;62650.37349626537;62684.37315626785;62822;62823.37176628267;1282.5767496726057;1350.9527166549124;1356.8982326325565;1387.7293927684004;1419.7018626088432;30077;35157.648423515435;35177.82411087928;35515;35607.28785424329;54669;55991;56079;56129.71935140298;56166;492058;497223;497392;498471;498717;35704;44069.77965110154;44610.55389446194;47083.29375059308;47695;50241.24638130358;50403;50535.49464505308;50713.49286507235;50852.74573627256;40762.79618601888;41593.37609935793;41623;42625.57374426216;43444.782776085915;41940.790296048326;43042;43220.13559728851;43495;44030.860251817176;36442.63557364392;42541.787291063345;43196;43207.78396107999;44100.33849492196;33880.3223935515;35437.82281088578;38542.80728596339;38653.226935461695;41388.586114138474;29209.337574664074;29738.553921691626;29836.403271934872;30055.398892022473;30203 20:37:29 INFO - PROCESS | 8523 | |2;jquery.html;363.2353895050918;374.85568056298325;376.74569665475804;391.97256192066567;398.1519363755201;18260.17829197686;20984.37046888594;21019.789802101994;21122.366329010118;21127.260545880898;19319.420417387464;20053.498662533442;20499.487512812186;20606.79393206071;20815.687764683542;4991.251312303166;5494.835154945358;5702;5725.513331366838;5769.278840144982;5658.915116273239;5730.942690573103;5736.455036771521;5739.368669446358;5739.540836733072;5436.809711660093;5534.861628459281;5535.889282214353;5537.695426751527;5714.057180565223;5543.6396634218645;5585.469380408896;5590.413006634286;5592.133219351007;5593.888122237553;4826.131296366652;5016.974915125437;5031.396232452093;5036.219385995177;5044.520770526794;24221.394465138514;24273.514529709482;24287.14994975185;24341.148059818;24464.143754968492;2425.599776036952;2444.4744379958215;2489.074294795384;2534.759197876199;3083.198368424226;14679.853201467955;14711.11733295995;14989.925050374788;15066.698666026728;15472.922635386863;1957.7063440484042;1979.8713083649516;2032.7255820464195;2045.110376986001;2048.354768247997;56537;64396.678016609614;68416;68954;73740.89388659228;9412.67055653049;10323.690289291333;10614.363138211733;10772.569097236179;11031.282966607305;13210.933945330404;13855.930720346536;13938.93030534841;14401.495947641783;14442.638934026734;7806;7863;7986.560739159286;8111.95944020288;8138.715144970016;7236.782896513113;7438.925610743823;7488.438367122488;7611.581363025087;7968.442209045427;4428.269335559597;4522.502524722344;4526.683132180716;4604.171249175113;4642.930356044662;1859.8140185981295;1937.6609093408597;1968.4980330015753;1986.820689928944;2029.9797002030086;895.5566994337845;963.2679163835536;971.4074414607226;991.5686676295834;1026.5996261458038;17272;20275.493112672008;20346.389608311776;20434.897825511074;20625.17499300041;990.1286867556648;1001.1340190734962;1002.6039714312806;1020.6121673763922;1056.271172890703;10426.544975797196;11207.378423700267;11548.538058477734;11584.304941703525;11609.76780464386;480851;481165;481374;481456;484993;96579;96771.51614241884;98314.5084274574;98587.50706246422;102474.48762756288;1009.6163457886104;1023.488255872064;1053.0838170791308;1057.5029736024057;1068.471106802138;18290.176942037375;18582.907085464485;19237.711434328776;19307.4207773767;19533.70699439538;30395.54406683946;32083.83958080288;42440;42643.78678106589;42901.78549107235;56329.71835140798;58076;60947;62067;62099.6895015522;8251.33989280868;8311.916880831115;8661.91338086611;8679.65649274705;8735.868961965449;12509.56216532417;13441;13496.595102146952;13782.517611883535;13828.86171138316;11941.283522988648;11979.221350612183;12201.594153112226;12210.389480526115;12772.169808962388;11817.704557386134;11895.167338286237;11930.463129159036;12164.148509604243;12352.3823808811;12163.513459461523;12457.626271211879;12530.561430349893;12629.431675574437;12632.810507842574;8405.915940840514;8482.57587120629;8507.914920850711;8598.570071496526;8612.741617751477;11029.22795404314;12248.326342050916;12279.2018518796;12430.316332601793;12756.808647870475 20:37:29 INFO - PROCESS | 8523 | |3;mootools.html;1332.2472802866373;1376.3668712392298;1443.3072125379817;1490.7763835424685;1672.4815307254753;7559.58422286774;7628.389728821695;7656.196099409565;8033.236842499968;8034.799130021753;7837.568933708644;7940.920590794105;7942.16607256237;7942.92057079429;7943.76168714938;2037.2665840297554;2247.685324054634;2257.7742225777456;2275.1127060446356;2275.6472746724203;2317.5480781247666;2332.7550607186254;2342.847714898535;2349.283468542094;2363.0665886974634;2297.7587353327913;2307.3078076577044;2330.6620540021686;2331.0559223514506;2348;2236.9217077402213;2297.5060362022164;2301.79283864453;2311.6763653088583;2315.7568455312116;2331.079223706626;2342.6837376954063;2348.56551537966;2349.0721165139844;2349.342184188413;8283.130271321485;8339.332853371716;8345.290650294732;8360.289375403097;8361.03848057475;4795.6882802618065;4908.680935739166;4910.091633047862;4910.410750709902;4917.483664215241;3123.765717571191;3182.984085079583;3298.5546951161527;3303.900882973515;3309.9503507447407;1074.2265568790458;1081.853949716794;1085.2565992295304;1088.9128869690405;1106.3748981825242;11030.613928512463;11060;11109.44452777358;11175.608853690082;11261.831072533918;4250.957490425118;4272.850450234289;4384.232759267179;4424.469063712375;4495.325701144854;9468.14786669203;9554.808903821884;9567.712968610813;9577;9590.952045239868;5011.1481048221885;5022.648414611015;5022.673526220784;5023.899522009539;5026.1204289249235;4077.4699289092823;4133.46264985556;4581.175388430114;4641.071785642885;4641.094986477672;3803.67668748154;3814.084619691254;3879.941800872989;3910.9022274442796;3922.37242041272;1226.2703691303839;1226.7607816475702;1239.7396546725288;1247.731737676404;1247.8377810884708;781.1641543548349;881.5301056941662;912.1243606138049;917.7384445433153;939.7509659940122;5424.918626220609;5501.889962200814;5533.142362933751;5580.693061881554;5687.658740475585;926.8609708543772;950.2350607760819;976.912077912977;980.1032055668983;983.6704703924122;3528.3064129217605;3884.495015648004;3901.395283731026;3976.588311149558;4079.8164082616354;9748.707538773848;10155.644552440777;10159.898401016044;10171.237157213238;10171.28800983924;9551.522423878778;9970.551325190383;9991.550380232908;10153.238507111997;10170.288079834341;7626.389888808882;7746;7815.53106813593;7824.178461261599;7830.491018083806;5493.697846618475;5549.223108764695;5592;5726.914096288642;5914;9286.34995550305;9303.627854885728;9413.152816246571;9419.576119074522;9427.764305892408;8656.091110433314;9078.500682462529;9469;9537.189338905993;9538;7147.642617868982;7317.0487836580905;7372.152202496782;7379;7561.6597253122645;7848.450608457581;7871.48835325702;7947.364210863233;7947.920520794718;8014.398920081134;6902.792916212522;6917.13535808024;6951.548149370275;6975.197852247056;6982.057422247932;7079.858402832017;7097.964510177416;7132.286771322826;7218.639068046682;7242.674079666533;6709.194896612243;6786.728530858711;6792.796216113525;6798.456123510206;6802.897956530557;4708.128996135726;4779.808807647794;4868.099401610713;4886.609071274361;5012.699238045729;4590.196715574828;4669.159551280802;4757.809687612596;4824.662273640812;4897.216445368724 20:37:29 INFO - PROCESS | 8523 | |4;prototype.html;322.36976710530917;322.67893446021196;328.76493307285284;333.2485245770786;338.50578155892396;5186.818461353853;5193.558547523465;5223.3209682741235;5227.817026404067;5232.8691782705455;5074.391073071228;5150.171689050389;5178.404483484401;5183;5206.973965130179;3805.600411956746;3871.1676989447265;3983.741056831311;3989.421533877586;3991.600839916014;4066.861278841929;4084.264832330179;4109.712320137592;4111.444954931091;4139.503259608851;4018.156187200677;4027.6173763492566;4042.7978601069976;4059.330210515276;4068.776217308047;4008.13825027619;4043.413705012786;4067.633912947849;4067.877963661095;4074.0629655179328;3573.356795776759;3595.334863050318;3595.7842529448317;3600.945985810215;3607.260511595117;5017.093504468316;5030.89938201234;5043.67216130954;5062.772175252086;5090.745462726849;4491.7304961702075;4631.073785242931;4641.419822522184;4656.394668693082;4666.300054991779;5335.839924802223;5345.155921207177;5348.304720386363;5351.652142610717;5355.437679043684;3964.3260645690016;3965.246603145422;3976.1848820991627;3977.085270387798;3977.1846771411792;5356.892862142774;5535.197396377543;5618.12918997552;5619.381867994517;5637.774489020434;3994.1412596291357;4016.477857878457;4042.797860106983;4044.2518134145275;4055.168690418457;4085.9387109193385;4087.2438598859308;4093.406456063854;4097.344424892003;4110.856120035784;4654.25531914892;4661.883452913704;4662.603678687282;4663.673542851968;4676.719396836201;5184.48155184486;5419.458054194628;5430.212619170198;5437.021336159451;5450.473867317158;1377.8208832851665;1401.1943132698739;1402.102654301248;1403.6069900427897;1407.5003373802358;837.5351679817638;870.3168013109805;879.55582430872;880.212210071982;884.2086332732168;5095.974520127375;5216.686998780086;5267.473252674702;5278.838655495785;5294.523492885659;5557.110862262019;5579.581531385163;5595.048841696921;5597.188407680864;5616.634918730269;4964.553190212898;5225.346831646044;5259.15853463444;5275.755410422639;5298.735063246822;2891.7542008929477;2902.840343781112;2917.9270518237213;2931.120663800851;2936.456755500239;5709.914351284734;5774.191613174159;5786.669066114817;5791.478766910914;5800.941990580124;5522.873693627982;5640.210370548127;5661.915071273934;5665.725211827305;5678;5730.36965933747;5761.6254943429385;5766.135079738073;5771.7402716877;5794.319647302319;5379.542738867083;5504.669719816824;5536.169574563848;5539.252200952981;5572.526335261386;5466.753996070107;5496.532794712494;5512.732071623469;5521.337439507285;5524.613277070727;5742.483176514133;5765.596408251382;5767.048437008015;5776.249087618583;5804.448577385142;3552.5559305086863;3561.931420573869;3606.93595389366;3632.7457078004286;3681.502997095358;4964.975175124101;4975.477574854733;4991.376077990251;4995.650304478651;5006.924896126634;4881.168922025146;4891.6792466034685;4895.751583346224;4896.788761664894;4917.606591472602;4596.793144308581;4803.423589169322;4861.708297502161;4862.343583616166;4899.681520701143;4842.225243960949;4848.151573474557;4855.490173531728;4867.1969125095375;4873.269009648581;5219.243209734491;5327.334083239595;5352.946470535245;5392.865178370415;5401.623285754255;5286.550643195372;5291.60312976536;5299.284596579412;5310.362756469249;5311.734413279398 20:37:29 INFO - PROCESS | 8523 | |5;yui.html;759.6201899050475;774.469488400446;783.2559068884558;817.21547314578;833.1709948601141;15850.920745396272;17388;17441.476755697317;17480.650386992253;17538.210780514877;15456.381744730226;15597.610059748513;15610.687786244269;15639.843601563982;15655.217239138026;654.0548906829621;791.2008871040262;794.06697130871;796.0566728426804;820.9014918209823;807.5154907055778;807.9757607271791;813.4915677701437;813.556611646651;813.8535063688533;866.1684782608671;870.1820288928419;871.1593312453513;871.5467956662563;871.7079778274285;690.6615758278433;846.9915300847005;865.4504389712515;867.444835305405;867.6659486097898;621.6860485454816;628.6605233174081;628.7422156915643;630.4168644004278;630.4231628060319;15698.215089245492;15714.449994250146;15719.842801571953;15720.29258683362;15737.527874163794;15929.917928632343;16058.43795467153;16481.587960300967;16543.751843722355;17214.741778873326;12793.48826046957;12801;12833.230006199658;13031.609051728463;13192.6701832454;3971.185906889081;4005.919881602381;4047.413125096874;4049.4330793688905;4208.431861698662;80840;81207.59396202982;82000.58999705024;83826;85801.57099214464;11993.460294286779;12043.638690839289;12153.210041347284;12278.815817762741;12282.253912556578;23733.881330593238;23793.881030595083;23963.28110156698;23964.64053039206;23982.7601723984;8613.956930215434;8838.204561589488;8866.246369058703;8920.8661870072;9048.819023619491;4683.812647494062;4749.501302363271;4775.331453596499;4892.605607401873;5072.923906141411;3510.438329867209;3610.6389361064207;3644.599094099647;3648.562172539312;3655.4098966949464;522.9163333866563;628.5537268539388;629.6190804563265;639.8528338482082;662.923763767173;554.8874506614293;620.4292051312804;636.2714691678003;712.3339677401646;734.6473692627462;9942.353747006566;10443.634472793416;10691.572337106429;10869.565217391373;11294;668.0613737698542;689.2418339826152;726.2954933714288;739.4343327354578;750.8573371059481;4583.4041574595085;5023.472535383805;5058.367704036996;5065.898682026339;5068.214426763858;118445.40777296058;122392;124728;126132.08018797253;128173.35913320561;87432.99999999873;89916.10083899208;107972.46013769881;108159;109574;58218;85965.14034859696;86825.5658721715;87044;92447;9811.852822207815;10301.033873752449;10459.843102353623;10680.465976701289;10814.945925270324;50285;50534.241986369496;52229;52301.47698522966;52557.737211313695;69492.30507694859;74822;75160;75477.62261188659;75785;12757.298348590917;12916.095873289156;13110.934445327712;13249.867501324863;13567.457301707822;15054.698906022037;15224.391024358902;15330.846691533388;15605.063696178266;15968.041917484989;13753.931230343784;14281.285935702965;14450.783238251224;14648.545843569373;15554.844451555793;13728.588142355746;14199.787003194753;15044.849551504345;15072.773908391164;15729.606759830638;14048.157110572989;15369.154696491352;15546.37814487408;15567.299471524035;15568.766468502756;10663.4135122569;10903.400312982862;11321.943390282995;11379.54481820718;11839.881601184223;11804.350760708243;11866.644000679993;11960.162788604714;12084.093692972887;12135.453904574139 20:37:29 INFO - PROCESS | 8523 | __end_tp_report 20:37:29 INFO - PROCESS | 8523 | __start_cc_report 20:37:29 INFO - PROCESS | 8523 | _x_x_mozilla_cycle_collect,1002 20:37:29 INFO - PROCESS | 8523 | __end_cc_report 20:37:29 INFO - PROCESS | 8523 | __startTimestamp1471491449265__endTimestamp 20:37:29 INFO - PROCESS | 8523 | 20:37:29 INFO - PROCESS | 8523 | ------- Summary: start ------- 20:37:29 INFO - PROCESS | 8523 | Number of tests: 6 20:37:29 INFO - PROCESS | 8523 | 20:37:29 INFO - PROCESS | 8523 | [#0] dojo.html Cycles:165 Average:5224.80 Median:5388.06 stddev:592.77 (11.0%) stddev-sans-first:567.91 20:37:29 INFO - PROCESS | 8523 | Values: 2983.2 2996.2 3000.7 3002.4 3036.0 5142.9 5198.6 5199.5 5277.8 5331.9 5202.1 5251.9 5264.1 5306.1 5350.2 4775.8 4791.6 4798.3 4804.4 4931.3 4848.4 4876.3 4886.6 4895.0 4912.0 4722.7 4724.5 4760.9 4766.6 4824.2 4760.4 4768.1 4787.5 4845.2 4866.6 4777.1 4798.0 4813.4 4815.3 4845.2 5145.6 5156.8 5183.1 5244.6 5272.5 5681.2 5688.9 5691.8 5697.1 5708.3 5681.3 5712.1 5712.5 5735.1 5742.4 5119.8 5221.8 5261.5 5262.9 5337.1 5796.0 5801.8 5809.0 5811.0 5813.6 5566.1 5568.9 5593.8 5613.0 5619.1 5456.9 5566.3 5611.6 5644.1 5693.1 5649.8 5659.6 5665.2 5686.3 5711.8 5601.2 5611.2 5641.3 5647.0 5658.3 4253.9 4260.8 4295.3 4377.4 4413.4 3829.6 3834.2 3835.5 3861.8 3879.0 5287.8 5298.5 5311.1 5336.7 5354.7 5520.7 5528.8 5531.3 5617.8 5623.8 5306.7 5316.1 5324.9 5345.6 5373.2 4797.3 4821.6 4824.0 4845.9 4861.4 5720.0 5729.6 5762.1 5805.4 5806.3 5581.4 5591.5 5597.8 5626.5 5630.8 5778.5 5789.1 5802.0 5807.2 5819.9 5434.5 5458.2 5469.9 5500.8 5507.9 5623.7 5624.7 5629.4 5659.1 5683.4 5409.1 5457.8 5508.3 5510.9 5516.8 5339.7 5361.5 5388.1 5467.9 5527.6 5442.3 5444.0 5448.8 5496.4 5509.8 5475.5 5476.2 5496.0 5516.1 5521.6 5272.9 5278.4 5326.9 5347.5 5352.3 20:37:29 INFO - PROCESS | 8523 | 20:37:29 INFO - PROCESS | 8523 | [#1] ext.html Cycles:180 Average:62468.51 Median:23892.07 stddev:125730.46 (526.2%) stddev-sans-first:125997.27 20:37:29 INFO - PROCESS | 8523 | Values: 569.6 586.1 591.0 602.3 611.1 33189.0 44338.1 45361.8 45391.0 45472.3 47185.0 47481.0 47555.0 47685.0 47694.5 9080.1 9232.4 9233.6 9236.6 9240.8 9172.4 9260.5 9262.5 9267.4 9269.9 9308.3 9372.9 9373.1 9378.8 9384.2 9253.0 9271.5 9295.8 9305.3 9305.7 9064.8 9137.7 9138.3 9139.5 9143.0 43194.6 43453.0 43517.3 43577.3 43614.3 3615.2 3739.6 3739.8 4108.3 4317.5 33734.0 33754.5 34197.7 34985.3 35690.5 4339.3 4381.4 4385.9 4489.0 4647.5 368075.0 372250.0 372612.0 372860.0 376838.1 36128.6 36993.4 37097.6 61679.7 61980.7 38264.8 38304.4 38439.2 38465.0 38577.8 14684.3 14810.5 14818.9 14828.9 14864.2 11520.0 11538.7 11544.7 11545.5 11597.8 8637.8 8671.2 8705.2 8754.2 8820.5 3373.7 3373.9 3386.1 3390.1 3468.7 990.2 991.9 1003.9 1053.5 1111.5 33126.3 33250.2 33528.3 33601.2 33632.8 1120.1 1140.2 1174.0 1204.4 1206.9 17444.9 17500.4 18144.8 18499.4 19529.4 531848.0 534440.0 534559.0 534816.0 543231.0 62030.0 62650.4 62684.4 62822.0 62823.4 1282.6 1351.0 1356.9 1387.7 1419.7 30077.0 35157.6 35177.8 35515.0 35607.3 54669.0 55991.0 56079.0 56129.7 56166.0 492058.0 497223.0 497392.0 498471.0 498717.0 35704.0 44069.8 44610.6 47083.3 47695.0 50241.2 50403.0 50535.5 50713.5 50852.7 40762.8 41593.4 41623.0 42625.6 43444.8 41940.8 43042.0 43220.1 43495.0 44030.9 36442.6 42541.8 43196.0 43207.8 44100.3 33880.3 35437.8 38542.8 38653.2 41388.6 29209.3 29738.6 29836.4 30055.4 30203.0 20:37:29 INFO - PROCESS | 8523 | 20:37:29 INFO - PROCESS | 8523 | [#2] jquery.html Cycles:180 Average:28783.73 Median:13454.31 stddev:79413.37 (590.2%) stddev-sans-first:79607.48 20:37:29 INFO - PROCESS | 8523 | Values: 363.2 374.9 376.7 392.0 398.2 18260.2 20984.4 21019.8 21122.4 21127.3 19319.4 20053.5 20499.5 20606.8 20815.7 4991.3 5494.8 5702.0 5725.5 5769.3 5658.9 5730.9 5736.5 5739.4 5739.5 5436.8 5534.9 5535.9 5537.7 5714.1 5543.6 5585.5 5590.4 5592.1 5593.9 4826.1 5017.0 5031.4 5036.2 5044.5 24221.4 24273.5 24287.1 24341.1 24464.1 2425.6 2444.5 2489.1 2534.8 3083.2 14679.9 14711.1 14989.9 15066.7 15472.9 1957.7 1979.9 2032.7 2045.1 2048.4 56537.0 64396.7 68416.0 68954.0 73740.9 9412.7 10323.7 10614.4 10772.6 11031.3 13210.9 13855.9 13938.9 14401.5 14442.6 7806.0 7863.0 7986.6 8112.0 8138.7 7236.8 7438.9 7488.4 7611.6 7968.4 4428.3 4522.5 4526.7 4604.2 4642.9 1859.8 1937.7 1968.5 1986.8 2030.0 895.6 963.3 971.4 991.6 1026.6 17272.0 20275.5 20346.4 20434.9 20625.2 990.1 1001.1 1002.6 1020.6 1056.3 10426.5 11207.4 11548.5 11584.3 11609.8 480851.0 481165.0 481374.0 481456.0 484993.0 96579.0 96771.5 98314.5 98587.5 102474.5 1009.6 1023.5 1053.1 1057.5 1068.5 18290.2 18582.9 19237.7 19307.4 19533.7 30395.5 32083.8 42440.0 42643.8 42901.8 56329.7 58076.0 60947.0 62067.0 62099.7 8251.3 8311.9 8661.9 8679.7 8735.9 12509.6 13441.0 13496.6 13782.5 13828.9 11941.3 11979.2 12201.6 12210.4 12772.2 11817.7 11895.2 11930.5 12164.1 12352.4 12163.5 12457.6 12530.6 12629.4 12632.8 8405.9 8482.6 8507.9 8598.6 8612.7 11029.2 12248.3 12279.2 12430.3 12756.8 20:37:29 INFO - PROCESS | 8523 | 20:37:29 INFO - PROCESS | 8523 | [#3] mootools.html Cycles:180 Average:5415.42 Median:5011.92 stddev:2988.69 (59.6%) stddev-sans-first:2981.32 20:37:29 INFO - PROCESS | 8523 | Values: 1332.2 1376.4 1443.3 1490.8 1672.5 7559.6 7628.4 7656.2 8033.2 8034.8 7837.6 7940.9 7942.2 7942.9 7943.8 2037.3 2247.7 2257.8 2275.1 2275.6 2317.5 2332.8 2342.8 2349.3 2363.1 2297.8 2307.3 2330.7 2331.1 2348.0 2236.9 2297.5 2301.8 2311.7 2315.8 2331.1 2342.7 2348.6 2349.1 2349.3 8283.1 8339.3 8345.3 8360.3 8361.0 4795.7 4908.7 4910.1 4910.4 4917.5 3123.8 3183.0 3298.6 3303.9 3310.0 1074.2 1081.9 1085.3 1088.9 1106.4 11030.6 11060.0 11109.4 11175.6 11261.8 4251.0 4272.9 4384.2 4424.5 4495.3 9468.1 9554.8 9567.7 9577.0 9591.0 5011.1 5022.6 5022.7 5023.9 5026.1 4077.5 4133.5 4581.2 4641.1 4641.1 3803.7 3814.1 3879.9 3910.9 3922.4 1226.3 1226.8 1239.7 1247.7 1247.8 781.2 881.5 912.1 917.7 939.8 5424.9 5501.9 5533.1 5580.7 5687.7 926.9 950.2 976.9 980.1 983.7 3528.3 3884.5 3901.4 3976.6 4079.8 9748.7 10155.6 10159.9 10171.2 10171.3 9551.5 9970.6 9991.6 10153.2 10170.3 7626.4 7746.0 7815.5 7824.2 7830.5 5493.7 5549.2 5592.0 5726.9 5914.0 9286.3 9303.6 9413.2 9419.6 9427.8 8656.1 9078.5 9469.0 9537.2 9538.0 7147.6 7317.0 7372.2 7379.0 7561.7 7848.5 7871.5 7947.4 7947.9 8014.4 6902.8 6917.1 6951.5 6975.2 6982.1 7079.9 7098.0 7132.3 7218.6 7242.7 6709.2 6786.7 6792.8 6798.5 6802.9 4708.1 4779.8 4868.1 4886.6 5012.7 4590.2 4669.2 4757.8 4824.7 4897.2 20:37:29 INFO - PROCESS | 8523 | 20:37:29 INFO - PROCESS | 8523 | [#4] prototype.html Cycles:180 Average:4502.45 Median:5012.01 stddev:1317.81 (26.3%) stddev-sans-first:1283.61 20:37:29 INFO - PROCESS | 8523 | Values: 322.4 322.7 328.8 333.2 338.5 5186.8 5193.6 5223.3 5227.8 5232.9 5074.4 5150.2 5178.4 5183.0 5207.0 3805.6 3871.2 3983.7 3989.4 3991.6 4066.9 4084.3 4109.7 4111.4 4139.5 4018.2 4027.6 4042.8 4059.3 4068.8 4008.1 4043.4 4067.6 4067.9 4074.1 3573.4 3595.3 3595.8 3600.9 3607.3 5017.1 5030.9 5043.7 5062.8 5090.7 4491.7 4631.1 4641.4 4656.4 4666.3 5335.8 5345.2 5348.3 5351.7 5355.4 3964.3 3965.2 3976.2 3977.1 3977.2 5356.9 5535.2 5618.1 5619.4 5637.8 3994.1 4016.5 4042.8 4044.3 4055.2 4085.9 4087.2 4093.4 4097.3 4110.9 4654.3 4661.9 4662.6 4663.7 4676.7 5184.5 5419.5 5430.2 5437.0 5450.5 1377.8 1401.2 1402.1 1403.6 1407.5 837.5 870.3 879.6 880.2 884.2 5096.0 5216.7 5267.5 5278.8 5294.5 5557.1 5579.6 5595.0 5597.2 5616.6 4964.6 5225.3 5259.2 5275.8 5298.7 2891.8 2902.8 2917.9 2931.1 2936.5 5709.9 5774.2 5786.7 5791.5 5800.9 5522.9 5640.2 5661.9 5665.7 5678.0 5730.4 5761.6 5766.1 5771.7 5794.3 5379.5 5504.7 5536.2 5539.3 5572.5 5466.8 5496.5 5512.7 5521.3 5524.6 5742.5 5765.6 5767.0 5776.2 5804.4 3552.6 3561.9 3606.9 3632.7 3681.5 4965.0 4975.5 4991.4 4995.7 5006.9 4881.2 4891.7 4895.8 4896.8 4917.6 4596.8 4803.4 4861.7 4862.3 4899.7 4842.2 4848.2 4855.5 4867.2 4873.3 5219.2 5327.3 5352.9 5392.9 5401.6 5286.6 5291.6 5299.3 5310.4 5311.7 20:37:29 INFO - PROCESS | 8523 | 20:37:29 INFO - PROCESS | 8523 | [#5] yui.html Cycles:180 Average:21648.45 Median:3813.30 stddev:30950.94 (811.7%) stddev-sans-first:30998.02 20:37:29 INFO - PROCESS | 8523 | Values: 759.6 774.5 783.3 817.2 833.2 15850.9 17388.0 17441.5 17480.7 17538.2 15456.4 15597.6 15610.7 15639.8 15655.2 654.1 791.2 794.1 796.1 820.9 807.5 808.0 813.5 813.6 813.9 866.2 870.2 871.2 871.5 871.7 690.7 847.0 865.5 867.4 867.7 621.7 628.7 628.7 630.4 630.4 15698.2 15714.4 15719.8 15720.3 15737.5 15929.9 16058.4 16481.6 16543.8 17214.7 12793.5 12801.0 12833.2 13031.6 13192.7 3971.2 4005.9 4047.4 4049.4 4208.4 80840.0 81207.6 82000.6 83826.0 85801.6 11993.5 12043.6 12153.2 12278.8 12282.3 23733.9 23793.9 23963.3 23964.6 23982.8 8614.0 8838.2 8866.2 8920.9 9048.8 4683.8 4749.5 4775.3 4892.6 5072.9 3510.4 3610.6 3644.6 3648.6 3655.4 522.9 628.6 629.6 639.9 662.9 554.9 620.4 636.3 712.3 734.6 9942.4 10443.6 10691.6 10869.6 11294.0 668.1 689.2 726.3 739.4 750.9 4583.4 5023.5 5058.4 5065.9 5068.2 118445.4 122392.0 124728.0 126132.1 128173.4 87433.0 89916.1 107972.5 108159.0 109574.0 58218.0 85965.1 86825.6 87044.0 92447.0 9811.9 10301.0 10459.8 10680.5 10814.9 50285.0 50534.2 52229.0 52301.5 52557.7 69492.3 74822.0 75160.0 75477.6 75785.0 12757.3 12916.1 13110.9 13249.9 13567.5 15054.7 15224.4 15330.8 15605.1 15968.0 13753.9 14281.3 14450.8 14648.5 15554.8 13728.6 14199.8 15044.8 15072.8 15729.6 14048.2 15369.2 15546.4 15567.3 15568.8 10663.4 10903.4 11321.9 11379.5 11839.9 11804.4 11866.6 11960.2 12084.1 12135.5 20:37:29 INFO - PROCESS | 8523 | -------- Summary: end -------- 20:37:29 INFO - PROCESS | 8523 | 20:37:30 INFO - TEST-INFO | 8523: exit 0 20:37:30 INFO - TEST-OK | dromaeo_css | took 1114940ms 20:37:30 INFO - TEST-START | kraken 20:37:30 INFO - operating with platform_type : linux_ 20:37:30 INFO - Initialising browser for kraken test... 20:37:30 INFO - TEST-INFO | started process 8830 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuPSGOf/profile http://localhost:60769/getInfo.html) 20:37:34 INFO - PROCESS | 8830 | __metrics Screen width/height:1600/1200 20:37:34 INFO - PROCESS | 8830 | colorDepth:24 20:37:34 INFO - PROCESS | 8830 | Browser inner width/height: 1024/697 20:37:34 INFO - PROCESS | 8830 | __metrics 20:37:34 INFO - PROCESS | 8830 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:37:34 INFO - PROCESS | 8830 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:37:35 INFO - PROCESS | 8830 | console.error: PushService: 20:37:35 INFO - PROCESS | 8830 | stateChangeProcessEnqueue: Error transitioning state 20:37:35 INFO - PROCESS | 8830 | UnknownError 20:37:35 INFO - TEST-INFO | 8830: exit 0 20:37:35 INFO - Browser initialized. 20:37:35 INFO - Running cycle 1/1 for kraken test... 20:37:35 INFO - TEST-INFO | started process 8912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuPSGOf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:37:47 INFO - PROCESS | 8912 | RSS: Main: 155185152 20:37:47 INFO - PROCESS | 8912 | 20:37:49 INFO - PROCESS | 8912 | Cycle 1(1): loaded http://localhost:60769/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60769/tests/kraken/driver.html?testName=audio-beat-detection) 20:37:50 INFO - PROCESS | 8912 | RSS: Main: 203452416 20:37:50 INFO - PROCESS | 8912 | 20:37:53 INFO - PROCESS | 8912 | Cycle 1(1): loaded http://localhost:60769/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60769/tests/kraken/driver.html?testName=audio-dft) 20:37:53 INFO - PROCESS | 8912 | RSS: Main: 195223552 20:37:53 INFO - PROCESS | 8912 | 20:37:57 INFO - PROCESS | 8912 | Cycle 1(1): loaded http://localhost:60769/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60769/tests/kraken/driver.html?testName=audio-fft) 20:37:57 INFO - PROCESS | 8912 | RSS: Main: 275628032 20:37:57 INFO - PROCESS | 8912 | 20:37:59 INFO - PROCESS | 8912 | Cycle 1(1): loaded http://localhost:60769/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60769/tests/kraken/driver.html?testName=audio-oscillator) 20:38:00 INFO - PROCESS | 8912 | RSS: Main: 185569280 20:38:00 INFO - PROCESS | 8912 | 20:38:02 INFO - PROCESS | 8912 | Cycle 1(1): loaded http://localhost:60769/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60769/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:38:03 INFO - PROCESS | 8912 | RSS: Main: 190447616 20:38:03 INFO - PROCESS | 8912 | 20:38:06 INFO - PROCESS | 8912 | Cycle 1(1): loaded http://localhost:60769/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60769/tests/kraken/driver.html?testName=imaging-darkroom) 20:38:06 INFO - PROCESS | 8912 | RSS: Main: 226971648 20:38:06 INFO - PROCESS | 8912 | 20:38:10 INFO - PROCESS | 8912 | Cycle 1(1): loaded http://localhost:60769/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60769/tests/kraken/driver.html?testName=imaging-desaturate) 20:38:10 INFO - PROCESS | 8912 | RSS: Main: 226844672 20:38:10 INFO - PROCESS | 8912 | 20:38:13 INFO - PROCESS | 8912 | Cycle 1(1): loaded http://localhost:60769/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60769/tests/kraken/driver.html?testName=json-parse-financial) 20:38:14 INFO - PROCESS | 8912 | RSS: Main: 225964032 20:38:14 INFO - PROCESS | 8912 | 20:38:15 INFO - PROCESS | 8912 | Cycle 1(1): loaded http://localhost:60769/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60769/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:38:16 INFO - PROCESS | 8912 | RSS: Main: 188383232 20:38:16 INFO - PROCESS | 8912 | 20:38:18 INFO - PROCESS | 8912 | Cycle 1(1): loaded http://localhost:60769/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60769/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:38:18 INFO - PROCESS | 8912 | RSS: Main: 195727360 20:38:18 INFO - PROCESS | 8912 | 20:38:20 INFO - PROCESS | 8912 | Cycle 1(1): loaded http://localhost:60769/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60769/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:38:21 INFO - PROCESS | 8912 | RSS: Main: 193564672 20:38:21 INFO - PROCESS | 8912 | 20:38:24 INFO - PROCESS | 8912 | Cycle 1(1): loaded http://localhost:60769/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:38:24 INFO - PROCESS | 8912 | RSS: Main: 187957248 20:38:24 INFO - PROCESS | 8912 | 20:38:27 INFO - PROCESS | 8912 | Cycle 1(1): loaded http://localhost:60769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:38:27 INFO - PROCESS | 8912 | RSS: Main: 191578112 20:38:27 INFO - PROCESS | 8912 | 20:38:29 INFO - PROCESS | 8912 | Cycle 1(1): loaded http://localhost:60769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60769/tests/kraken/driver.html?testName=ai-astar) 20:38:29 INFO - PROCESS | 8912 | RSS: Main: 242614272 20:38:29 INFO - PROCESS | 8912 | 20:38:29 INFO - PROCESS | 8912 | __start_tp_report 20:38:29 INFO - PROCESS | 8912 | _x_x_mozilla_page_load 20:38:29 INFO - PROCESS | 8912 | _x_x_mozilla_page_load_details 20:38:29 INFO - PROCESS | 8912 | |i|pagename|runs| 20:38:29 INFO - PROCESS | 8912 | |0;ai-astar;104;112;112;114;107;113;111;111;111;111 20:38:29 INFO - PROCESS | 8912 | |1;audio-beat-detection;146;121;118;180;122;128;149;117;158;120 20:38:29 INFO - PROCESS | 8912 | |2;audio-dft;161;161;161;161;161;161;161;161;161;162 20:38:29 INFO - PROCESS | 8912 | |3;audio-fft;75;76;75;120;75;76;75;75;124;78 20:38:29 INFO - PROCESS | 8912 | |4;audio-oscillator;86;85;123;85;85;85;121;84;85;129 20:38:29 INFO - PROCESS | 8912 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;116;117 20:38:29 INFO - PROCESS | 8912 | |6;imaging-darkroom;146;145;146;146;146;146;145;147;146;146 20:38:29 INFO - PROCESS | 8912 | |7;imaging-desaturate;94;95;94;95;95;95;94;94;95;95 20:38:29 INFO - PROCESS | 8912 | |8;json-parse-financial;52;49;58;50;50;53;60;49;53;51 20:38:29 INFO - PROCESS | 8912 | |9;json-stringify-tinderbox;61;62;62;61;62;62;62;62;62;63 20:38:29 INFO - PROCESS | 8912 | |10;stanford-crypto-aes;80;82;84;79;78;78;78;83;77;82 20:38:29 INFO - PROCESS | 8912 | |11;stanford-crypto-ccm;133;123;122;125;122;127;121;121;152;124 20:38:29 INFO - PROCESS | 8912 | |12;stanford-crypto-pbkdf2;162;164;161;160;162;164;159;165;160;162 20:38:29 INFO - PROCESS | 8912 | |13;stanford-crypto-sha256-iterative;63;64;63;66;68;64;64;64;64;62 20:38:29 INFO - PROCESS | 8912 | __end_tp_report 20:38:29 INFO - PROCESS | 8912 | __start_cc_report 20:38:29 INFO - PROCESS | 8912 | _x_x_mozilla_cycle_collect,1701 20:38:29 INFO - PROCESS | 8912 | __end_cc_report 20:38:29 INFO - PROCESS | 8912 | __startTimestamp1471491509922__endTimestamp 20:38:29 INFO - PROCESS | 8912 | 20:38:29 INFO - PROCESS | 8912 | ------- Summary: start ------- 20:38:29 INFO - PROCESS | 8912 | Number of tests: 14 20:38:29 INFO - PROCESS | 8912 | 20:38:29 INFO - PROCESS | 8912 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.50 stddev:2.95 (2.6%) stddev-sans-first:1.94 20:38:29 INFO - PROCESS | 8912 | Values: 104.0 112.0 112.0 114.0 107.0 113.0 111.0 111.0 111.0 111.0 20:38:29 INFO - PROCESS | 8912 | 20:38:29 INFO - PROCESS | 8912 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:137.00 stddev:21.38 (15.6%) stddev-sans-first:22.37 20:38:29 INFO - PROCESS | 8912 | Values: 146.0 121.0 118.0 180.0 122.0 128.0 149.0 117.0 158.0 120.0 20:38:29 INFO - PROCESS | 8912 | 20:38:29 INFO - PROCESS | 8912 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 20:38:29 INFO - PROCESS | 8912 | Values: 161.0 161.0 161.0 161.0 161.0 161.0 161.0 161.0 161.0 162.0 20:38:29 INFO - PROCESS | 8912 | 20:38:29 INFO - PROCESS | 8912 | [#3] audio-fft Cycles:10 Average:84.90 Median:75.00 stddev:19.60 (26.1%) stddev-sans-first:20.46 20:38:29 INFO - PROCESS | 8912 | Values: 75.0 76.0 75.0 120.0 75.0 76.0 75.0 75.0 124.0 78.0 20:38:29 INFO - PROCESS | 8912 | 20:38:29 INFO - PROCESS | 8912 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:85.00 stddev:19.11 (22.5%) stddev-sans-first:19.86 20:38:29 INFO - PROCESS | 8912 | Values: 86.0 85.0 123.0 85.0 85.0 85.0 121.0 84.0 85.0 129.0 20:38:29 INFO - PROCESS | 8912 | 20:38:29 INFO - PROCESS | 8912 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:38:29 INFO - PROCESS | 8912 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 20:38:29 INFO - PROCESS | 8912 | 20:38:29 INFO - PROCESS | 8912 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 20:38:29 INFO - PROCESS | 8912 | Values: 146.0 145.0 146.0 146.0 146.0 146.0 145.0 147.0 146.0 146.0 20:38:29 INFO - PROCESS | 8912 | 20:38:29 INFO - PROCESS | 8912 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 20:38:29 INFO - PROCESS | 8912 | Values: 94.0 95.0 94.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 20:38:29 INFO - PROCESS | 8912 | 20:38:29 INFO - PROCESS | 8912 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.50 stddev:3.75 (7.1%) stddev-sans-first:3.97 20:38:29 INFO - PROCESS | 8912 | Values: 52.0 49.0 58.0 50.0 50.0 53.0 60.0 49.0 53.0 51.0 20:38:29 INFO - PROCESS | 8912 | 20:38:29 INFO - PROCESS | 8912 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 20:38:29 INFO - PROCESS | 8912 | Values: 61.0 62.0 62.0 61.0 62.0 62.0 62.0 62.0 62.0 63.0 20:38:29 INFO - PROCESS | 8912 | 20:38:29 INFO - PROCESS | 8912 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:81.00 stddev:2.47 (3.0%) stddev-sans-first:2.62 20:38:29 INFO - PROCESS | 8912 | Values: 80.0 82.0 84.0 79.0 78.0 78.0 78.0 83.0 77.0 82.0 20:38:29 INFO - PROCESS | 8912 | 20:38:29 INFO - PROCESS | 8912 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:124.50 stddev:9.50 (7.6%) stddev-sans-first:9.82 20:38:29 INFO - PROCESS | 8912 | Values: 133.0 123.0 122.0 125.0 122.0 127.0 121.0 121.0 152.0 124.0 20:38:29 INFO - PROCESS | 8912 | 20:38:29 INFO - PROCESS | 8912 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:162.00 stddev:1.97 (1.2%) stddev-sans-first:2.09 20:38:29 INFO - PROCESS | 8912 | Values: 162.0 164.0 161.0 160.0 162.0 164.0 159.0 165.0 160.0 162.0 20:38:29 INFO - PROCESS | 8912 | 20:38:29 INFO - PROCESS | 8912 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:1.69 (2.6%) stddev-sans-first:1.73 20:38:29 INFO - PROCESS | 8912 | Values: 63.0 64.0 63.0 66.0 68.0 64.0 64.0 64.0 64.0 62.0 20:38:29 INFO - PROCESS | 8912 | -------- Summary: end -------- 20:38:29 INFO - PROCESS | 8912 | 20:38:30 INFO - TEST-INFO | 8912: exit 0 20:38:30 INFO - TEST-OK | kraken | took 60888ms 20:38:30 INFO - SUITE-END | took 1175s 20:38:31 INFO - Completed test suite (00:19:35) 20:38:31 INFO - javascript benchmark 20:38:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2983.1945374748834, 2996.1760515858136, 3000.6699263081073, 3002.369502404495, 3036.0436462514313, 5142.871428214296, 5198.584113270938, 5199.50604692554, 5277.788888444463, 5331.946680533193, 5202.141646628311, 5251.947480525203, 5264.1051021326375, 5306.124489459235, 5350.197470379435, 4775.80896764129, 4791.6406269529925, 4798.256270278095, 4804.447488538828, 4931.284963680264, 4848.393950756155, 4876.341693871317, 4886.584640305578, 4894.9965257122385, 4912.017596480719, 4722.669413141081, 4724.480307166192, 4760.880977975578, 4766.618670506351, 4824.228123500241, 4760.357351757538, 4768.117898188846, 4787.473377928425, 4845.224764037773, 4866.562009419169, 4777.140114779339, 4797.9520204797855, 4813.3983252093485, 4815.3017812417, 4845.200541910615, 5145.562627176657, 5156.819511317123, 5183.144781111112, 5244.632875698702, 5272.472752724735, 5681.176229446748, 5688.886222275572, 5691.800786972436, 5697.088465845486, 5708.315002199721, 5681.346645135821, 5712.057510510761, 5712.542996560265, 5735.0823868181305, 5742.425757424266, 5119.769610367505, 5221.817236396708, 5261.500157485071, 5262.92105618416, 5337.092694241988, 5796.014677504834, 5801.752623186036, 5809.041508151107, 5810.970945145332, 5813.563982701315, 5566.137248726453, 5568.9443105568425, 5593.776248950077, 5613.045782217033, 5619.129034999582, 5456.91814622781, 5566.276384070126, 5611.6352437091455, 5644.125160600113, 5693.089105743061, 5649.802256920988, 5659.603827732019, 5665.235193248941, 5686.289213848269, 5711.771529138871, 5601.159826026129, 5611.2144299798065, 5641.26663533738, 5647.0, 5658.34928983164, 4253.851115210953, 4260.808263628082, 4295.29127693927, 4377.430933978626, 4413.360062790877, 3829.5978922213326, 3834.2331533693373, 3835.4822099016833, 3861.768293902375, 3879.049632839972, 5287.762050707727, 5298.470152984748, 5311.097113490716, 5336.733163341817, 5354.678719276856, 5520.696361700145, 5528.806491772849, 5531.25328080712, 5617.848341090067, 5623.775048998076, 5306.681599103988, 5316.0962636351915, 5324.893502129936, 5345.625806193607, 5373.194020896819, 4797.2564252540915, 4821.566059054702, 4823.95176048235, 4845.878853028703, 4861.392325959255, 5719.971400142973, 5729.598928075078, 5762.1068734346245, 5805.36141024487, 5806.332271788799, 5581.413951535193, 5591.496765291144, 5597.80407685729, 5626.521745651666, 5630.831075067755, 5778.451047150514, 5789.073748200268, 5801.970990145022, 5807.245058142584, 5819.854503637443, 5434.456554344534, 5458.181272809111, 5469.890602188014, 5500.779968801203, 5507.889842203213, 5623.718814059363, 5624.718764061862, 5629.437056294338, 5659.066254068032, 5683.431656834284, 5409.107497262908, 5457.836264912059, 5508.283923089973, 5510.862228444321, 5516.806911758069, 5339.73301334924, 5361.544268737045, 5388.057090009154, 5467.890642187054, 5527.5577953764405, 5442.265294185393, 5444.047291723853, 5448.782048718007, 5496.395396506461, 5509.834704958857, 5475.534579560782, 5476.17857321405, 5495.972520137534, 5516.14499752539, 5521.613487055867, 5272.947270527399, 5278.419373868948, 5326.893462130658, 5347.51872331492, 5352.304200453916], "value": 5184.414108302359, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.5699746691248, 586.1442294250392, 590.9864582241455, 602.3494625804132, 611.0986295214559, 33189.00432987011, 44338.113237735226, 45361.77319113408, 45391.0, 45472.317915231295, 47185.0, 47481.0, 47555.0, 47685.0, 47694.523054769445, 9080.137386948229, 9232.399894006901, 9233.6306547738, 9236.584353704066, 9240.768980775467, 9172.357934944557, 9260.490673012982, 9262.536873156349, 9267.44395336282, 9269.907300926972, 9308.301877359192, 9372.8594071089, 9373.109554592304, 9378.765530861714, 9384.155426011657, 9253.0, 9271.536423178813, 9295.814083718355, 9305.25557955362, 9305.674301399486, 9064.818703625957, 9137.725868223964, 9138.268938484905, 9139.543022848831, 9143.0, 43194.56805431937, 43453.0, 43517.34723979143, 43577.34633980493, 43614.34578481325, 3615.1865830188262, 3739.6447337503164, 3739.8317075731384, 4108.281050816125, 4317.503487098992, 33734.0, 33754.49368259478, 34197.65802341994, 34985.30029399423, 35690.46464303038, 4339.349097635349, 4381.364702118207, 4385.912281754379, 4488.955110448919, 4647.488776234612, 368075.0, 372250.0, 372612.0, 372860.0, 376838.1158094192, 36128.63871361253, 36993.445098323544, 37097.629023709414, 61679.6916015426, 61980.69009654923, 38264.80867595644, 38304.42543361852, 38439.231215375534, 38465.0, 38577.80711096426, 14684.265786710836, 14810.481633142788, 14818.92590537062, 14828.923950646918, 14864.182469964257, 11520.0, 11538.711532211762, 11544.653660390202, 11545.538178472767, 11597.76804463906, 8637.827243455096, 8671.21959023691, 8705.216530512283, 8754.168354006359, 8820.514871681991, 3373.6795004474534, 3373.915652108717, 3386.1365351835125, 3390.118569171984, 3468.6704763047974, 990.2474119669104, 991.8512223166439, 1003.8745156855393, 1053.5469748008277, 1111.5387114347454, 33126.33747325088, 33250.16874578155, 33528.32943341119, 33601.15997100092, 33632.831835841156, 1120.1095129372168, 1140.1619809440056, 1173.976520469586, 1204.3677069538562, 1206.8913797758244, 17444.91277543604, 17500.387486437914, 18144.818551814576, 18499.445016649523, 19529.414117576496, 531848.0, 534440.0, 534559.0, 534816.0, 543231.0, 62030.0, 62650.37349626537, 62684.37315626785, 62822.0, 62823.37176628267, 1282.5767496726057, 1350.9527166549124, 1356.8982326325565, 1387.7293927684004, 1419.7018626088432, 30077.0, 35157.648423515435, 35177.82411087928, 35515.0, 35607.28785424329, 54669.0, 55991.0, 56079.0, 56129.71935140298, 56166.0, 492058.0, 497223.0, 497392.0, 498471.0, 498717.0, 35704.0, 44069.77965110154, 44610.55389446194, 47083.29375059308, 47695.0, 50241.24638130358, 50403.0, 50535.49464505308, 50713.49286507235, 50852.74573627256, 40762.79618601888, 41593.37609935793, 41623.0, 42625.57374426216, 43444.782776085915, 41940.790296048326, 43042.0, 43220.13559728851, 43495.0, 44030.860251817176, 36442.63557364392, 42541.787291063345, 43196.0, 43207.78396107999, 44100.33849492196, 33880.3223935515, 35437.82281088578, 38542.80728596339, 38653.226935461695, 41388.586114138474, 29209.337574664074, 29738.553921691626, 29836.403271934872, 30055.398892022473, 30203.0], "value": 19743.42929932578, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.2353895050918, 374.85568056298325, 376.74569665475804, 391.97256192066567, 398.1519363755201, 18260.17829197686, 20984.37046888594, 21019.789802101994, 21122.366329010118, 21127.260545880898, 19319.420417387464, 20053.498662533442, 20499.487512812186, 20606.79393206071, 20815.687764683542, 4991.251312303166, 5494.835154945358, 5702.0, 5725.513331366838, 5769.278840144982, 5658.915116273239, 5730.942690573103, 5736.455036771521, 5739.368669446358, 5739.540836733072, 5436.809711660093, 5534.861628459281, 5535.889282214353, 5537.695426751527, 5714.057180565223, 5543.6396634218645, 5585.469380408896, 5590.413006634286, 5592.133219351007, 5593.888122237553, 4826.131296366652, 5016.974915125437, 5031.396232452093, 5036.219385995177, 5044.520770526794, 24221.394465138514, 24273.514529709482, 24287.14994975185, 24341.148059818, 24464.143754968492, 2425.599776036952, 2444.4744379958215, 2489.074294795384, 2534.759197876199, 3083.198368424226, 14679.853201467955, 14711.11733295995, 14989.925050374788, 15066.698666026728, 15472.922635386863, 1957.7063440484042, 1979.8713083649516, 2032.7255820464195, 2045.110376986001, 2048.354768247997, 56537.0, 64396.678016609614, 68416.0, 68954.0, 73740.89388659228, 9412.67055653049, 10323.690289291333, 10614.363138211733, 10772.569097236179, 11031.282966607305, 13210.933945330404, 13855.930720346536, 13938.93030534841, 14401.495947641783, 14442.638934026734, 7806.0, 7863.0, 7986.560739159286, 8111.95944020288, 8138.715144970016, 7236.782896513113, 7438.925610743823, 7488.438367122488, 7611.581363025087, 7968.442209045427, 4428.269335559597, 4522.502524722344, 4526.683132180716, 4604.171249175113, 4642.930356044662, 1859.8140185981295, 1937.6609093408597, 1968.4980330015753, 1986.820689928944, 2029.9797002030086, 895.5566994337845, 963.2679163835536, 971.4074414607226, 991.5686676295834, 1026.5996261458038, 17272.0, 20275.493112672008, 20346.389608311776, 20434.897825511074, 20625.17499300041, 990.1286867556648, 1001.1340190734962, 1002.6039714312806, 1020.6121673763922, 1056.271172890703, 10426.544975797196, 11207.378423700267, 11548.538058477734, 11584.304941703525, 11609.76780464386, 480851.0, 481165.0, 481374.0, 481456.0, 484993.0, 96579.0, 96771.51614241884, 98314.5084274574, 98587.50706246422, 102474.48762756288, 1009.6163457886104, 1023.488255872064, 1053.0838170791308, 1057.5029736024057, 1068.471106802138, 18290.176942037375, 18582.907085464485, 19237.711434328776, 19307.4207773767, 19533.70699439538, 30395.54406683946, 32083.83958080288, 42440.0, 42643.78678106589, 42901.78549107235, 56329.71835140798, 58076.0, 60947.0, 62067.0, 62099.6895015522, 8251.33989280868, 8311.916880831115, 8661.91338086611, 8679.65649274705, 8735.868961965449, 12509.56216532417, 13441.0, 13496.595102146952, 13782.517611883535, 13828.86171138316, 11941.283522988648, 11979.221350612183, 12201.594153112226, 12210.389480526115, 12772.169808962388, 11817.704557386134, 11895.167338286237, 11930.463129159036, 12164.148509604243, 12352.3823808811, 12163.513459461523, 12457.626271211879, 12530.561430349893, 12629.431675574437, 12632.810507842574, 8405.915940840514, 8482.57587120629, 8507.914920850711, 8598.570071496526, 8612.741617751477, 11029.22795404314, 12248.326342050916, 12279.2018518796, 12430.316332601793, 12756.808647870475], "value": 9318.341214338634, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.2472802866373, 1376.3668712392298, 1443.3072125379817, 1490.7763835424685, 1672.4815307254753, 7559.58422286774, 7628.389728821695, 7656.196099409565, 8033.236842499968, 8034.799130021753, 7837.568933708644, 7940.920590794105, 7942.16607256237, 7942.92057079429, 7943.76168714938, 2037.2665840297554, 2247.685324054634, 2257.7742225777456, 2275.1127060446356, 2275.6472746724203, 2317.5480781247666, 2332.7550607186254, 2342.847714898535, 2349.283468542094, 2363.0665886974634, 2297.7587353327913, 2307.3078076577044, 2330.6620540021686, 2331.0559223514506, 2348.0, 2236.9217077402213, 2297.5060362022164, 2301.79283864453, 2311.6763653088583, 2315.7568455312116, 2331.079223706626, 2342.6837376954063, 2348.56551537966, 2349.0721165139844, 2349.342184188413, 8283.130271321485, 8339.332853371716, 8345.290650294732, 8360.289375403097, 8361.03848057475, 4795.6882802618065, 4908.680935739166, 4910.091633047862, 4910.410750709902, 4917.483664215241, 3123.765717571191, 3182.984085079583, 3298.5546951161527, 3303.900882973515, 3309.9503507447407, 1074.2265568790458, 1081.853949716794, 1085.2565992295304, 1088.9128869690405, 1106.3748981825242, 11030.613928512463, 11060.0, 11109.44452777358, 11175.608853690082, 11261.831072533918, 4250.957490425118, 4272.850450234289, 4384.232759267179, 4424.469063712375, 4495.325701144854, 9468.14786669203, 9554.808903821884, 9567.712968610813, 9577.0, 9590.952045239868, 5011.1481048221885, 5022.648414611015, 5022.673526220784, 5023.899522009539, 5026.1204289249235, 4077.4699289092823, 4133.46264985556, 4581.175388430114, 4641.071785642885, 4641.094986477672, 3803.67668748154, 3814.084619691254, 3879.941800872989, 3910.9022274442796, 3922.37242041272, 1226.2703691303839, 1226.7607816475702, 1239.7396546725288, 1247.731737676404, 1247.8377810884708, 781.1641543548349, 881.5301056941662, 912.1243606138049, 917.7384445433153, 939.7509659940122, 5424.918626220609, 5501.889962200814, 5533.142362933751, 5580.693061881554, 5687.658740475585, 926.8609708543772, 950.2350607760819, 976.912077912977, 980.1032055668983, 983.6704703924122, 3528.3064129217605, 3884.495015648004, 3901.395283731026, 3976.588311149558, 4079.8164082616354, 9748.707538773848, 10155.644552440777, 10159.898401016044, 10171.237157213238, 10171.28800983924, 9551.522423878778, 9970.551325190383, 9991.550380232908, 10153.238507111997, 10170.288079834341, 7626.389888808882, 7746.0, 7815.53106813593, 7824.178461261599, 7830.491018083806, 5493.697846618475, 5549.223108764695, 5592.0, 5726.914096288642, 5914.0, 9286.34995550305, 9303.627854885728, 9413.152816246571, 9419.576119074522, 9427.764305892408, 8656.091110433314, 9078.500682462529, 9469.0, 9537.189338905993, 9538.0, 7147.642617868982, 7317.0487836580905, 7372.152202496782, 7379.0, 7561.6597253122645, 7848.450608457581, 7871.48835325702, 7947.364210863233, 7947.920520794718, 8014.398920081134, 6902.792916212522, 6917.13535808024, 6951.548149370275, 6975.197852247056, 6982.057422247932, 7079.858402832017, 7097.964510177416, 7132.286771322826, 7218.639068046682, 7242.674079666533, 6709.194896612243, 6786.728530858711, 6792.796216113525, 6798.456123510206, 6802.897956530557, 4708.128996135726, 4779.808807647794, 4868.099401610713, 4886.609071274361, 5012.699238045729, 4590.196715574828, 4669.159551280802, 4757.809687612596, 4824.662273640812, 4897.216445368724], "value": 4387.596645621193, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.36976710530917, 322.67893446021196, 328.76493307285284, 333.2485245770786, 338.50578155892396, 5186.818461353853, 5193.558547523465, 5223.3209682741235, 5227.817026404067, 5232.8691782705455, 5074.391073071228, 5150.171689050389, 5178.404483484401, 5183.0, 5206.973965130179, 3805.600411956746, 3871.1676989447265, 3983.741056831311, 3989.421533877586, 3991.600839916014, 4066.861278841929, 4084.264832330179, 4109.712320137592, 4111.444954931091, 4139.503259608851, 4018.156187200677, 4027.6173763492566, 4042.7978601069976, 4059.330210515276, 4068.776217308047, 4008.13825027619, 4043.413705012786, 4067.633912947849, 4067.877963661095, 4074.0629655179328, 3573.356795776759, 3595.334863050318, 3595.7842529448317, 3600.945985810215, 3607.260511595117, 5017.093504468316, 5030.89938201234, 5043.67216130954, 5062.772175252086, 5090.745462726849, 4491.7304961702075, 4631.073785242931, 4641.419822522184, 4656.394668693082, 4666.300054991779, 5335.839924802223, 5345.155921207177, 5348.304720386363, 5351.652142610717, 5355.437679043684, 3964.3260645690016, 3965.246603145422, 3976.1848820991627, 3977.085270387798, 3977.1846771411792, 5356.892862142774, 5535.197396377543, 5618.12918997552, 5619.381867994517, 5637.774489020434, 3994.1412596291357, 4016.477857878457, 4042.797860106983, 4044.2518134145275, 4055.168690418457, 4085.9387109193385, 4087.2438598859308, 4093.406456063854, 4097.344424892003, 4110.856120035784, 4654.25531914892, 4661.883452913704, 4662.603678687282, 4663.673542851968, 4676.719396836201, 5184.48155184486, 5419.458054194628, 5430.212619170198, 5437.021336159451, 5450.473867317158, 1377.8208832851665, 1401.1943132698739, 1402.102654301248, 1403.6069900427897, 1407.5003373802358, 837.5351679817638, 870.3168013109805, 879.55582430872, 880.212210071982, 884.2086332732168, 5095.974520127375, 5216.686998780086, 5267.473252674702, 5278.838655495785, 5294.523492885659, 5557.110862262019, 5579.581531385163, 5595.048841696921, 5597.188407680864, 5616.634918730269, 4964.553190212898, 5225.346831646044, 5259.15853463444, 5275.755410422639, 5298.735063246822, 2891.7542008929477, 2902.840343781112, 2917.9270518237213, 2931.120663800851, 2936.456755500239, 5709.914351284734, 5774.191613174159, 5786.669066114817, 5791.478766910914, 5800.941990580124, 5522.873693627982, 5640.210370548127, 5661.915071273934, 5665.725211827305, 5678.0, 5730.36965933747, 5761.6254943429385, 5766.135079738073, 5771.7402716877, 5794.319647302319, 5379.542738867083, 5504.669719816824, 5536.169574563848, 5539.252200952981, 5572.526335261386, 5466.753996070107, 5496.532794712494, 5512.732071623469, 5521.337439507285, 5524.613277070727, 5742.483176514133, 5765.596408251382, 5767.048437008015, 5776.249087618583, 5804.448577385142, 3552.5559305086863, 3561.931420573869, 3606.93595389366, 3632.7457078004286, 3681.502997095358, 4964.975175124101, 4975.477574854733, 4991.376077990251, 4995.650304478651, 5006.924896126634, 4881.168922025146, 4891.6792466034685, 4895.751583346224, 4896.788761664894, 4917.606591472602, 4596.793144308581, 4803.423589169322, 4861.708297502161, 4862.343583616166, 4899.681520701143, 4842.225243960949, 4848.151573474557, 4855.490173531728, 4867.1969125095375, 4873.269009648581, 5219.243209734491, 5327.334083239595, 5352.946470535245, 5392.865178370415, 5401.623285754255, 5286.550643195372, 5291.60312976536, 5299.284596579412, 5310.362756469249, 5311.734413279398], "value": 4083.0164021854234, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.6201899050475, 774.469488400446, 783.2559068884558, 817.21547314578, 833.1709948601141, 15850.920745396272, 17388.0, 17441.476755697317, 17480.650386992253, 17538.210780514877, 15456.381744730226, 15597.610059748513, 15610.687786244269, 15639.843601563982, 15655.217239138026, 654.0548906829621, 791.2008871040262, 794.06697130871, 796.0566728426804, 820.9014918209823, 807.5154907055778, 807.9757607271791, 813.4915677701437, 813.556611646651, 813.8535063688533, 866.1684782608671, 870.1820288928419, 871.1593312453513, 871.5467956662563, 871.7079778274285, 690.6615758278433, 846.9915300847005, 865.4504389712515, 867.444835305405, 867.6659486097898, 621.6860485454816, 628.6605233174081, 628.7422156915643, 630.4168644004278, 630.4231628060319, 15698.215089245492, 15714.449994250146, 15719.842801571953, 15720.29258683362, 15737.527874163794, 15929.917928632343, 16058.43795467153, 16481.587960300967, 16543.751843722355, 17214.741778873326, 12793.48826046957, 12801.0, 12833.230006199658, 13031.609051728463, 13192.6701832454, 3971.185906889081, 4005.919881602381, 4047.413125096874, 4049.4330793688905, 4208.431861698662, 80840.0, 81207.59396202982, 82000.58999705024, 83826.0, 85801.57099214464, 11993.460294286779, 12043.638690839289, 12153.210041347284, 12278.815817762741, 12282.253912556578, 23733.881330593238, 23793.881030595083, 23963.28110156698, 23964.64053039206, 23982.7601723984, 8613.956930215434, 8838.204561589488, 8866.246369058703, 8920.8661870072, 9048.819023619491, 4683.812647494062, 4749.501302363271, 4775.331453596499, 4892.605607401873, 5072.923906141411, 3510.438329867209, 3610.6389361064207, 3644.599094099647, 3648.562172539312, 3655.4098966949464, 522.9163333866563, 628.5537268539388, 629.6190804563265, 639.8528338482082, 662.923763767173, 554.8874506614293, 620.4292051312804, 636.2714691678003, 712.3339677401646, 734.6473692627462, 9942.353747006566, 10443.634472793416, 10691.572337106429, 10869.565217391373, 11294.0, 668.0613737698542, 689.2418339826152, 726.2954933714288, 739.4343327354578, 750.8573371059481, 4583.4041574595085, 5023.472535383805, 5058.367704036996, 5065.898682026339, 5068.214426763858, 118445.40777296058, 122392.0, 124728.0, 126132.08018797253, 128173.35913320561, 87432.99999999873, 89916.10083899208, 107972.46013769881, 108159.0, 109574.0, 58218.0, 85965.14034859696, 86825.5658721715, 87044.0, 92447.0, 9811.852822207815, 10301.033873752449, 10459.843102353623, 10680.465976701289, 10814.945925270324, 50285.0, 50534.241986369496, 52229.0, 52301.47698522966, 52557.737211313695, 69492.30507694859, 74822.0, 75160.0, 75477.62261188659, 75785.0, 12757.298348590917, 12916.095873289156, 13110.934445327712, 13249.867501324863, 13567.457301707822, 15054.698906022037, 15224.391024358902, 15330.846691533388, 15605.063696178266, 15968.041917484989, 13753.931230343784, 14281.285935702965, 14450.783238251224, 14648.545843569373, 15554.844451555793, 13728.588142355746, 14199.787003194753, 15044.849551504345, 15072.773908391164, 15729.606759830638, 14048.157110572989, 15369.154696491352, 15546.37814487408, 15567.299471524035, 15568.766468502756, 10663.4135122569, 10903.400312982862, 11321.943390282995, 11379.54481820718, 11839.881601184223, 11804.350760708243, 11866.644000679993, 11960.162788604714, 12084.093692972887, 12135.453904574139], "value": 7854.883901742148, "unit": "score"}], "name": "dromaeo_css", "value": 7155.547762016857, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 112.0, 114.0, 107.0, 113.0, 111.0, 111.0, 111.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 121.0, 118.0, 180.0, 122.0, 128.0, 149.0, 117.0, 158.0, 120.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 161.0, 161.0, 161.0, 161.0, 161.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 120.0, 75.0, 76.0, 75.0, 75.0, 124.0, 78.0], "value": 84.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 123.0, 85.0, 85.0, 85.0, 121.0, 84.0, 85.0, 129.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 49.0, 58.0, 50.0, 50.0, 53.0, 60.0, 49.0, 53.0, 51.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 84.0, 79.0, 78.0, 78.0, 78.0, 83.0, 77.0, 82.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 123.0, 122.0, 125.0, 122.0, 127.0, 121.0, 121.0, 152.0, 124.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 161.0, 160.0, 162.0, 164.0, 159.0, 165.0, 160.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 66.0, 68.0, 64.0, 64.0, 64.0, 64.0, 62.0], "value": 64.2, "unit": "score"}], "name": "kraken", "value": 1494.2, "alertThreshold": 2.0}]} 20:38:31 INFO - Return code: 0 20:38:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:38:31 INFO - # TBPL SUCCESS # 20:38:31 INFO - Running post-action listener: _resource_record_post_action 20:38:31 INFO - [mozharness: 2016-08-18 03:38:31.246520Z] Finished run-tests step (success) 20:38:31 INFO - Running post-run listener: _resource_record_post_run 20:38:31 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 420294656; Read time: 12; Write time: 416720 20:38:31 INFO - TinderboxPrint: CPU usage
13.0% 20:38:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:38:31 INFO - TinderboxPrint: I/O write bytes / time
420,294,656 / 416,720 20:38:31 INFO - TinderboxPrint: CPU idle
8,283.6 (87.0%) 20:38:31 INFO - TinderboxPrint: CPU user
1,192.3 (12.5%) 20:38:31 INFO - TinderboxPrint: Swap in / out
0 / 0 20:38:31 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 128655360; Read time: 0; Write time: 99852 20:38:31 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 291028992; Read time: 0; Write time: 316796 20:38:31 INFO - Running post-run listener: _upload_blobber_files 20:38:31 INFO - Blob upload gear active. 20:38:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:38:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:38:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:38:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:38:32 INFO - (blobuploader) - INFO - Open directory for files ... 20:38:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:38:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:38:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:38:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:38:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:38:33 INFO - (blobuploader) - INFO - Done attempting. 20:38:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:38:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:38:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:38:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:38:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:38:33 INFO - (blobuploader) - INFO - Done attempting. 20:38:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:38:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:38:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:38:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:38:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:38:37 INFO - (blobuploader) - INFO - Done attempting. 20:38:37 INFO - (blobuploader) - INFO - Iteration through files over. 20:38:37 INFO - Return code: 0 20:38:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:38:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:38:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a0783e27bec445c32967f54733019d3aa77a8a743687b7474776f0a6d44a829bb0ea4c014773113eb47f38d2c7416ab0fbdbd0deccd8bc06c5b22731f92930b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9071754c3279f05c97265ff2165f55299083f2d30991ca588bf291275b2ed98a6b82e9c5a6871305821e1c233be6d62cc4c088d0fa328c715fbd0e5cce6ac667", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c106fbc11ccb05e6b9611d72f332119b438c768ccbacf07fd81a02637219d50a64c6fb0a745db9cf25725adfc34a634ea8fc329b48caaff9bef289e16d12af46"} 20:38:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:38:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:38:37 INFO - Contents: 20:38:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a0783e27bec445c32967f54733019d3aa77a8a743687b7474776f0a6d44a829bb0ea4c014773113eb47f38d2c7416ab0fbdbd0deccd8bc06c5b22731f92930b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9071754c3279f05c97265ff2165f55299083f2d30991ca588bf291275b2ed98a6b82e9c5a6871305821e1c233be6d62cc4c088d0fa328c715fbd0e5cce6ac667", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c106fbc11ccb05e6b9611d72f332119b438c768ccbacf07fd81a02637219d50a64c6fb0a745db9cf25725adfc34a634ea8fc329b48caaff9bef289e16d12af46"} 20:38:37 INFO - Running post-run listener: copy_logs_to_upload_dir 20:38:37 INFO - Copying logs to upload dir... 20:38:37 INFO - mkdir: /builds/slave/test/build/upload/logs 20:38:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.974752 ========= master_lag: 0.89 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-17 20:38:37.997434) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 20:38:38.002056) ========= 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=17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a0783e27bec445c32967f54733019d3aa77a8a743687b7474776f0a6d44a829bb0ea4c014773113eb47f38d2c7416ab0fbdbd0deccd8bc06c5b22731f92930b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9071754c3279f05c97265ff2165f55299083f2d30991ca588bf291275b2ed98a6b82e9c5a6871305821e1c233be6d62cc4c088d0fa328c715fbd0e5cce6ac667", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c106fbc11ccb05e6b9611d72f332119b438c768ccbacf07fd81a02637219d50a64c6fb0a745db9cf25725adfc34a634ea8fc329b48caaff9bef289e16d12af46"} build_url:https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011209 build_url: 'https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a0783e27bec445c32967f54733019d3aa77a8a743687b7474776f0a6d44a829bb0ea4c014773113eb47f38d2c7416ab0fbdbd0deccd8bc06c5b22731f92930b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9071754c3279f05c97265ff2165f55299083f2d30991ca588bf291275b2ed98a6b82e9c5a6871305821e1c233be6d62cc4c088d0fa328c715fbd0e5cce6ac667", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c106fbc11ccb05e6b9611d72f332119b438c768ccbacf07fd81a02637219d50a64c6fb0a745db9cf25725adfc34a634ea8fc329b48caaff9bef289e16d12af46"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 20:38:38.032257) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:38:38.032581) ========= 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=17051fcd5208b27b50bedfeb000001dd-1471490030.981114-1319585709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.28 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:38:38.319316) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 20:38:38.319618) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 20:38:38.319912) ========= ========= Total master_lag: 1.27 =========