builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-004 starttime: 1471627070.9 results: success (0) buildid: 20160819085421 builduid: 9dd094d680e14fd2874887f2b1bb0894 revision: b4f5a80d3533c651b1a754a8f6bc71b0f5ad5ca5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 10:17:50.902171) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 10:17:50.903515) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 10:17:50.904237) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 10:17:50.927706) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 10:17:50.928386) ========= 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=c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-19 10:17:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.9M=0s 2016-08-19 10:17:51 (34.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185394 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 10:17:51.137352) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 10:17:51.137679) ========= 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=c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019143 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 10:17:51.201569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 10:17:51.201903) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b4f5a80d3533c651b1a754a8f6bc71b0f5ad5ca5 --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 b4f5a80d3533c651b1a754a8f6bc71b0f5ad5ca5 --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=c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-19 10:17:51,710 truncating revision to first 12 chars 2016-08-19 10:17:51,710 Setting DEBUG logging. 2016-08-19 10:17:51,710 attempt 1/10 2016-08-19 10:17:51,710 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b4f5a80d3533?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 10:17:52,020 unpacking tar archive at: fx-team-b4f5a80d3533/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644503 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 10:17:51.869567) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 10:17:51.869913) ========= script_repo_revision: b4f5a80d3533c651b1a754a8f6bc71b0f5ad5ca5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 10:17:51.870586) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 10:17:51.871353) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 10:17:51.884368) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 46 secs) (at 2016-08-19 10:17:51.884691) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:17:52 INFO - MultiFileLogger online at 20160819 10:17:52 in /builds/slave/test 10:17:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:17:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:17:52 INFO - {'append_to_log': False, 10:17:52 INFO - 'base_work_dir': '/builds/slave/test', 10:17:52 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:17:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:17:52 INFO - 'branch': 'Fx-Team-Non-PGO', 10:17:52 INFO - 'buildbot_json_path': 'buildprops.json', 10:17:52 INFO - 'config_files': ('talos/linux_config.py',), 10:17:52 INFO - 'default_actions': ('clobber', 10:17:52 INFO - 'read-buildbot-config', 10:17:52 INFO - 'download-and-extract', 10:17:52 INFO - 'populate-webroot', 10:17:52 INFO - 'create-virtualenv', 10:17:52 INFO - 'install', 10:17:52 INFO - 'run-tests'), 10:17:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:17:52 INFO - 'download_minidump_stackwalk': True, 10:17:52 INFO - 'download_symbols': 'ondemand', 10:17:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:17:52 INFO - 'tooltool.py': '/tools/tooltool.py', 10:17:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:17:52 INFO - '/tools/misc-python/virtualenv.py')}, 10:17:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:17:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:17:52 INFO - 'installer_path': 'installer.exe', 10:17:52 INFO - 'log_level': 'info', 10:17:52 INFO - 'log_name': 'talos', 10:17:52 INFO - 'log_to_console': True, 10:17:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:17:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:17:52 INFO - 'opt_config_files': (), 10:17:52 INFO - 'pip_index': False, 10:17:52 INFO - 'sps_profile': False, 10:17:52 INFO - 'sps_profile_interval': 0, 10:17:52 INFO - 'suite': 'dromaeojs', 10:17:52 INFO - 'system_bits': '32', 10:17:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:17:52 INFO - 'title': 'talos-linux64-ix-004', 10:17:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:17:52 INFO - 'use_talos_json': True, 10:17:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:17:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:17:52 INFO - 'work_dir': 'build'} 10:17:52 INFO - [mozharness: 2016-08-19 17:17:52.481971Z] Running clobber step. 10:17:52 INFO - Running pre-action listener: _resource_record_pre_action 10:17:52 INFO - Running main action method: clobber 10:17:52 INFO - rmtree: /builds/slave/test/build 10:17:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:17:52 INFO - Running post-action listener: _resource_record_post_action 10:17:52 INFO - [mozharness: 2016-08-19 17:17:52.958651Z] Finished clobber step (success) 10:17:52 INFO - [mozharness: 2016-08-19 17:17:52.958752Z] Running read-buildbot-config step. 10:17:52 INFO - Running pre-action listener: _resource_record_pre_action 10:17:52 INFO - Running main action method: read_buildbot_config 10:17:52 INFO - Using buildbot properties: 10:17:52 INFO - { 10:17:52 INFO - "project": "", 10:17:52 INFO - "product": "firefox", 10:17:52 INFO - "script_repo_revision": "production", 10:17:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:17:52 INFO - "repository": "", 10:17:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:17:52 INFO - "buildid": "20160819085421", 10:17:52 INFO - "pgo_build": "False", 10:17:52 INFO - "basedir": "/builds/slave/test", 10:17:52 INFO - "buildnumber": 1875, 10:17:52 INFO - "slavename": "talos-linux64-ix-004", 10:17:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:17:52 INFO - "platform": "ubuntu64_hw", 10:17:52 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:17:52 INFO - "branch": "fx-team", 10:17:52 INFO - "repo_path": "integration/fx-team", 10:17:52 INFO - "revision": "b4f5a80d3533c651b1a754a8f6bc71b0f5ad5ca5", 10:17:52 INFO - "stage_platform": "linux64", 10:17:52 INFO - "builduid": "9dd094d680e14fd2874887f2b1bb0894", 10:17:52 INFO - "slavebuilddir": "test" 10:17:52 INFO - } 10:17:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 10:17:52 INFO - Running post-action listener: _resource_record_post_action 10:17:52 INFO - [mozharness: 2016-08-19 17:17:52.961192Z] Finished read-buildbot-config step (success) 10:17:52 INFO - [mozharness: 2016-08-19 17:17:52.961282Z] Running download-and-extract step. 10:17:52 INFO - Running pre-action listener: _resource_record_pre_action 10:17:52 INFO - Running main action method: download_and_extract 10:17:52 INFO - mkdir: /builds/slave/test/build/tests 10:17:52 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')]} 10:17:52 INFO - trying https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:17:52 INFO - Downloading https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/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 10:17:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/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 10:17:53 INFO - Downloaded 1361 bytes. 10:17:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:17:53 INFO - Using the following test package requirements: 10:17:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:17:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:17:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:17:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:17:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:17:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:17:53 INFO - u'jsshell-linux-x86_64.zip'], 10:17:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:17:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:17:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:17:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:17:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:17:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:17:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:17:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:17:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:17:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:17:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:17:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:17:53 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')]} 10:17:53 INFO - trying https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:17:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/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 10:17:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/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 10:17:54 INFO - Downloaded 20328569 bytes. 10:17:54 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 10:17:58 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 10:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:58 INFO - trying https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:17:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/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 10:17:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/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 10:17:59 INFO - Downloaded 20328569 bytes. 10:17:59 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 10:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:04 INFO - trying https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:18:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/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 10:18:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/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 10:18:05 INFO - Downloaded 14413981 bytes. 10:18:05 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 10:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:05 INFO - trying https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:18:05 INFO - Downloading https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/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 10:18:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/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 10:18:37 WARNING - Socket error when accessing https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2: The read operation timed out 10:18:37 INFO - retry: attempt #1 caught exception: The read operation timed out 10:18:37 INFO - retry: Failed, sleeping 30 seconds before retrying 10:19:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/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 #2 10:19:08 INFO - Downloaded 55770331 bytes. 10:19:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:19:08 INFO - mkdir: /builds/slave/test/properties 10:19:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:19:08 INFO - Writing to file /builds/slave/test/properties/build_url 10:19:08 INFO - Contents: 10:19:08 INFO - build_url:https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:19:09 INFO - Running post-action listener: _resource_record_post_action 10:19:09 INFO - Running post-action listener: set_extra_try_arguments 10:19:09 INFO - [mozharness: 2016-08-19 17:19:09.811400Z] Finished download-and-extract step (success) 10:19:09 INFO - [mozharness: 2016-08-19 17:19:09.811627Z] Running populate-webroot step. 10:19:09 INFO - Running pre-action listener: _resource_record_pre_action 10:19:09 INFO - Running main action method: populate_webroot 10:19:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:19:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:19:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:19:09 INFO - '--tppagecycles', 10:19:09 INFO - '7'], 10:19:09 INFO - 'tests': ['tsvgm']}}, 10:19:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:19:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:19:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:19:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:19:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:19:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:19:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:09 INFO - 'talos_options': ['--disable-e10s'], 10:19:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:09 INFO - 'talos_options': ['--disable-e10s'], 10:19:09 INFO - 'tests': ['damp', 'tps']}, 10:19:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:09 INFO - 'tests': ['damp', 'tps']}, 10:19:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:19:09 INFO - 'tests': ['dromaeo_dom']}, 10:19:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:19:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:19:09 INFO - 'tests': ['basic_compositor_video']}, 10:19:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:19:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:19:09 INFO - 'tests': ['a11yr', 10:19:09 INFO - 'ts_paint', 10:19:09 INFO - 'tpaint', 10:19:09 INFO - 'sessionrestore', 10:19:09 INFO - 'sessionrestore_no_auto_restore', 10:19:09 INFO - 'tabpaint']}, 10:19:09 INFO - 'other-e10s': {'tests': ['a11yr', 10:19:09 INFO - 'ts_paint', 10:19:09 INFO - 'tpaint', 10:19:09 INFO - 'sessionrestore', 10:19:09 INFO - 'sessionrestore_no_auto_restore', 10:19:09 INFO - 'tabpaint']}, 10:19:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:19:09 INFO - 'ts_paint', 10:19:09 INFO - 'tpaint', 10:19:09 INFO - 'sessionrestore', 10:19:09 INFO - 'sessionrestore_no_auto_restore', 10:19:09 INFO - 'tabpaint']}, 10:19:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:19:09 INFO - 'ts_paint', 10:19:09 INFO - 'tpaint', 10:19:09 INFO - 'sessionrestore', 10:19:09 INFO - 'sessionrestore_no_auto_restore', 10:19:09 INFO - 'tabpaint']}, 10:19:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:19:09 INFO - 'tests': ['a11yr', 10:19:09 INFO - 'ts_paint', 10:19:09 INFO - 'tpaint', 10:19:09 INFO - 'sessionrestore', 10:19:09 INFO - 'sessionrestore_no_auto_restore', 10:19:09 INFO - 'tabpaint']}, 10:19:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:19:09 INFO - 'tests': ['a11yr', 10:19:09 INFO - 'ts_paint', 10:19:09 INFO - 'tpaint', 10:19:09 INFO - 'sessionrestore', 10:19:09 INFO - 'sessionrestore_no_auto_restore', 10:19:09 INFO - 'tabpaint']}, 10:19:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:19:09 INFO - 'tests': ['tsvgx', 10:19:09 INFO - 'tsvgr_opacity', 10:19:09 INFO - 'tart', 10:19:09 INFO - 'tscrollx', 10:19:09 INFO - 'cart']}, 10:19:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:19:09 INFO - 'tsvgr_opacity', 10:19:09 INFO - 'tart', 10:19:09 INFO - 'tscrollx', 10:19:09 INFO - 'cart']}, 10:19:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:09 INFO - 'talos_options': ['--disable-e10s'], 10:19:09 INFO - 'tests': ['tp5o']}, 10:19:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:09 INFO - 'tests': ['tp5o']}, 10:19:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:09 INFO - 'talos_options': ['--disable-e10s', 10:19:09 INFO - '--xperf_path', 10:19:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:09 INFO - 'tests': ['tp5n']}, 10:19:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:09 INFO - 'talos_options': ['--xperf_path', 10:19:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:09 INFO - 'tests': ['tp5n']}}, 10:19:09 INFO - 'talos.zip': {'path': '', 10:19:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:19:09 INFO - Running post-action listener: _resource_record_post_action 10:19:09 INFO - [mozharness: 2016-08-19 17:19:09.830374Z] Finished populate-webroot step (success) 10:19:09 INFO - [mozharness: 2016-08-19 17:19:09.830462Z] Running create-virtualenv step. 10:19:09 INFO - Running pre-action listener: _resource_record_pre_action 10:19:09 INFO - Running main action method: create_virtualenv 10:19:09 INFO - Creating virtualenv /builds/slave/test/build/venv 10:19:09 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 10:19:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:19:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:19:09 INFO - Using real prefix '/usr' 10:19:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:19:10 INFO - Installing distribute.............................................................................................................................................................................................done. 10:19:12 INFO - Installing pip.................done. 10:19:12 INFO - Return code: 0 10:19:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:12 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 0x7f6ce9615f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2092230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c090>, '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 0x208f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208fe40>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193', '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 10:19:12 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 10:19:12 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 10:19:12 INFO - Using env: {'DISPLAY': ':0', 10:19:12 INFO - 'HOME': '/home/cltbld', 10:19:12 INFO - 'LANG': 'en_US.UTF-8', 10:19:12 INFO - 'LANGUAGE': 'en_US:en', 10:19:12 INFO - 'LOGNAME': 'cltbld', 10:19:12 INFO - 'MAIL': '/var/mail/cltbld', 10:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:12 INFO - 'MOZ_NO_REMOTE': '1', 10:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:12 INFO - 'NO_EM_RESTART': '1', 10:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:12 INFO - 'PWD': '/builds/slave/test', 10:19:12 INFO - 'SHELL': '/bin/bash', 10:19:12 INFO - 'SHLVL': '1', 10:19:12 INFO - 'TERM': 'linux', 10:19:12 INFO - 'TMOUT': '86400', 10:19:12 INFO - 'USER': 'cltbld', 10:19:12 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193', 10:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:12 INFO - '_': '/tools/buildbot/bin/python'} 10:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:12 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 10:19:12 INFO - Cleaning up... 10:19:12 INFO - Return code: 0 10:19:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:12 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 0x7f6ce9615f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2092230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c090>, '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 0x208f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208fe40>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193', '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 10:19:12 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 10:19:12 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 10:19:12 INFO - Using env: {'DISPLAY': ':0', 10:19:12 INFO - 'HOME': '/home/cltbld', 10:19:12 INFO - 'LANG': 'en_US.UTF-8', 10:19:12 INFO - 'LANGUAGE': 'en_US:en', 10:19:12 INFO - 'LOGNAME': 'cltbld', 10:19:12 INFO - 'MAIL': '/var/mail/cltbld', 10:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:12 INFO - 'MOZ_NO_REMOTE': '1', 10:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:12 INFO - 'NO_EM_RESTART': '1', 10:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:12 INFO - 'PWD': '/builds/slave/test', 10:19:12 INFO - 'SHELL': '/bin/bash', 10:19:12 INFO - 'SHLVL': '1', 10:19:12 INFO - 'TERM': 'linux', 10:19:12 INFO - 'TMOUT': '86400', 10:19:12 INFO - 'USER': 'cltbld', 10:19:12 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193', 10:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:12 INFO - '_': '/tools/buildbot/bin/python'} 10:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:12 INFO - Downloading/unpacking psutil>=3.1.1 10:19:12 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 10:19:12 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 10:19:12 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 10:19:12 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 10:19:12 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 10:19:12 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 10:19:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:19:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:14 INFO - Installing collected packages: psutil 10:19:14 INFO - Running setup.py install for psutil 10:19:14 INFO - building 'psutil._psutil_linux' extension 10:19:14 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 10:19:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:19:15 INFO - building 'psutil._psutil_posix' extension 10:19:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:19:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:19:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:15 INFO - Successfully installed psutil 10:19:15 INFO - Cleaning up... 10:19:15 INFO - Return code: 0 10:19:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:15 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 0x7f6ce9615f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2092230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c090>, '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 0x208f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208fe40>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193', '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 10:19:15 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 10:19:15 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 10:19:15 INFO - Using env: {'DISPLAY': ':0', 10:19:15 INFO - 'HOME': '/home/cltbld', 10:19:15 INFO - 'LANG': 'en_US.UTF-8', 10:19:15 INFO - 'LANGUAGE': 'en_US:en', 10:19:15 INFO - 'LOGNAME': 'cltbld', 10:19:15 INFO - 'MAIL': '/var/mail/cltbld', 10:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:15 INFO - 'MOZ_NO_REMOTE': '1', 10:19:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:15 INFO - 'NO_EM_RESTART': '1', 10:19:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:15 INFO - 'PWD': '/builds/slave/test', 10:19:15 INFO - 'SHELL': '/bin/bash', 10:19:15 INFO - 'SHLVL': '1', 10:19:15 INFO - 'TERM': 'linux', 10:19:15 INFO - 'TMOUT': '86400', 10:19:15 INFO - 'USER': 'cltbld', 10:19:15 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193', 10:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:15 INFO - '_': '/tools/buildbot/bin/python'} 10:19:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:19:15 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 10:19:15 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 10:19:15 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 10:19:15 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 10:19:15 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 10:19:15 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 10:19:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:19:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:19:17 INFO - Installing collected packages: mozsystemmonitor 10:19:17 INFO - Running setup.py install for mozsystemmonitor 10:19:17 INFO - Successfully installed mozsystemmonitor 10:19:17 INFO - Cleaning up... 10:19:17 INFO - Return code: 0 10:19:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:19:17 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')]} 10:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:17 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')]} 10:19:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:17 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 0x7f6ce9615f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2092230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c090>, '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 0x208f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208fe40>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193', '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 10:19:17 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 10:19:17 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 10:19:17 INFO - Using env: {'DISPLAY': ':0', 10:19:17 INFO - 'HOME': '/home/cltbld', 10:19:17 INFO - 'LANG': 'en_US.UTF-8', 10:19:17 INFO - 'LANGUAGE': 'en_US:en', 10:19:17 INFO - 'LOGNAME': 'cltbld', 10:19:17 INFO - 'MAIL': '/var/mail/cltbld', 10:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:17 INFO - 'MOZ_NO_REMOTE': '1', 10:19:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:17 INFO - 'NO_EM_RESTART': '1', 10:19:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:17 INFO - 'PWD': '/builds/slave/test', 10:19:17 INFO - 'SHELL': '/bin/bash', 10:19:17 INFO - 'SHLVL': '1', 10:19:17 INFO - 'TERM': 'linux', 10:19:17 INFO - 'TMOUT': '86400', 10:19:17 INFO - 'USER': 'cltbld', 10:19:17 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193', 10:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:17 INFO - '_': '/tools/buildbot/bin/python'} 10:19:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:17 INFO - Downloading/unpacking jsonschema==2.5.1 10:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:19:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19:19 INFO - Downloading functools32-3.2.3-2.tar.gz 10:19:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:19:20 INFO - warning: no files found matching '*.txt' 10:19:20 INFO - no previously-included directories found matching 'build' 10:19:20 INFO - no previously-included directories found matching 'dist' 10:19:20 INFO - no previously-included directories found matching '.git*' 10:19:20 INFO - Installing collected packages: jsonschema, functools32 10:19:20 INFO - Running setup.py install for functools32 10:19:20 INFO - warning: no files found matching '*.txt' 10:19:20 INFO - no previously-included directories found matching 'build' 10:19:20 INFO - no previously-included directories found matching 'dist' 10:19:20 INFO - no previously-included directories found matching '.git*' 10:19:20 INFO - Successfully installed jsonschema functools32 10:19:20 INFO - Cleaning up... 10:19:20 INFO - Return code: 0 10:19:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6ce9615f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2092230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c090>, '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 0x208f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208fe40>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193', '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 10:19:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:19:20 INFO - Using env: {'DISPLAY': ':0', 10:19:20 INFO - 'HOME': '/home/cltbld', 10:19:20 INFO - 'LANG': 'en_US.UTF-8', 10:19:20 INFO - 'LANGUAGE': 'en_US:en', 10:19:20 INFO - 'LOGNAME': 'cltbld', 10:19:20 INFO - 'MAIL': '/var/mail/cltbld', 10:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:20 INFO - 'MOZ_NO_REMOTE': '1', 10:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:20 INFO - 'NO_EM_RESTART': '1', 10:19:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:20 INFO - 'PWD': '/builds/slave/test', 10:19:20 INFO - 'SHELL': '/bin/bash', 10:19:20 INFO - 'SHLVL': '1', 10:19:20 INFO - 'TERM': 'linux', 10:19:20 INFO - 'TMOUT': '86400', 10:19:20 INFO - 'USER': 'cltbld', 10:19:20 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193', 10:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:20 INFO - '_': '/tools/buildbot/bin/python'} 10:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:19:20 INFO - Cleaning up... 10:19:20 INFO - Return code: 0 10:19:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6ce9615f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2092230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c090>, '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 0x208f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208fe40>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193', '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 10:19:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:19:20 INFO - Using env: {'DISPLAY': ':0', 10:19:20 INFO - 'HOME': '/home/cltbld', 10:19:20 INFO - 'LANG': 'en_US.UTF-8', 10:19:20 INFO - 'LANGUAGE': 'en_US:en', 10:19:20 INFO - 'LOGNAME': 'cltbld', 10:19:20 INFO - 'MAIL': '/var/mail/cltbld', 10:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:20 INFO - 'MOZ_NO_REMOTE': '1', 10:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:20 INFO - 'NO_EM_RESTART': '1', 10:19:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:20 INFO - 'PWD': '/builds/slave/test', 10:19:20 INFO - 'SHELL': '/bin/bash', 10:19:20 INFO - 'SHLVL': '1', 10:19:20 INFO - 'TERM': 'linux', 10:19:20 INFO - 'TMOUT': '86400', 10:19:20 INFO - 'USER': 'cltbld', 10:19:20 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193', 10:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:20 INFO - '_': '/tools/buildbot/bin/python'} 10:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:20 INFO - Downloading/unpacking blobuploader==1.2.4 10:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:22 INFO - Downloading blobuploader-1.2.4.tar.gz 10:19:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:19:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:19:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:23 INFO - Downloading docopt-0.6.1.tar.gz 10:19:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:19:23 INFO - Installing collected packages: blobuploader, requests, docopt 10:19:23 INFO - Running setup.py install for blobuploader 10:19:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:19:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:19:23 INFO - Running setup.py install for requests 10:19:23 INFO - Running setup.py install for docopt 10:19:23 INFO - Successfully installed blobuploader requests docopt 10:19:23 INFO - Cleaning up... 10:19:23 INFO - Return code: 0 10:19:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:23 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 0x7f6ce9615f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2092230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c090>, '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 0x208f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208fe40>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193', '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 10:19:23 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 10:19:23 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 10:19:23 INFO - Using env: {'DISPLAY': ':0', 10:19:23 INFO - 'HOME': '/home/cltbld', 10:19:23 INFO - 'LANG': 'en_US.UTF-8', 10:19:23 INFO - 'LANGUAGE': 'en_US:en', 10:19:23 INFO - 'LOGNAME': 'cltbld', 10:19:23 INFO - 'MAIL': '/var/mail/cltbld', 10:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:23 INFO - 'MOZ_NO_REMOTE': '1', 10:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:23 INFO - 'NO_EM_RESTART': '1', 10:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:23 INFO - 'PWD': '/builds/slave/test', 10:19:23 INFO - 'SHELL': '/bin/bash', 10:19:23 INFO - 'SHLVL': '1', 10:19:23 INFO - 'TERM': 'linux', 10:19:23 INFO - 'TMOUT': '86400', 10:19:23 INFO - 'USER': 'cltbld', 10:19:23 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193', 10:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:23 INFO - '_': '/tools/buildbot/bin/python'} 10:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:19:24 INFO - Running setup.py (path:/tmp/pip-A3wggI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:19:24 INFO - Running setup.py (path:/tmp/pip-_mQBZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:19:24 INFO - Running setup.py (path:/tmp/pip-iK3lRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:19:24 INFO - Running setup.py (path:/tmp/pip-FY9DEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:19:24 INFO - Running setup.py (path:/tmp/pip-_gq0xm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:19:24 INFO - Running setup.py (path:/tmp/pip-pZHx8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:19:24 INFO - Running setup.py (path:/tmp/pip-uz6KB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:19:24 INFO - Running setup.py (path:/tmp/pip-YK1fkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:19:24 INFO - Running setup.py (path:/tmp/pip-Pa_gb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:19:24 INFO - Running setup.py (path:/tmp/pip-qjTh7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:19:24 INFO - Running setup.py (path:/tmp/pip-JqiZQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:19:24 INFO - Running setup.py (path:/tmp/pip-T7ikyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:19:24 INFO - Running setup.py (path:/tmp/pip-2tTUJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:19:25 INFO - Running setup.py (path:/tmp/pip-SdWyyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:25 INFO - Running setup.py (path:/tmp/pip-3OCzIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:19:25 INFO - Running setup.py (path:/tmp/pip-sXmTHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:19:25 INFO - Running setup.py (path:/tmp/pip-KwUjjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:19:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:19:25 INFO - Running setup.py install for manifestparser 10:19:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:19:25 INFO - Running setup.py install for mozcrash 10:19:25 INFO - Running setup.py install for mozdebug 10:19:25 INFO - Running setup.py install for mozdevice 10:19:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:19:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:19:25 INFO - Running setup.py install for mozfile 10:19:25 INFO - Running setup.py install for mozhttpd 10:19:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:19:25 INFO - Running setup.py install for mozinfo 10:19:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:19:26 INFO - Running setup.py install for mozInstall 10:19:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:19:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:19:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:19:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:19:26 INFO - Running setup.py install for mozleak 10:19:26 INFO - Running setup.py install for mozlog 10:19:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:19:26 INFO - Running setup.py install for moznetwork 10:19:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:19:26 INFO - Running setup.py install for mozprocess 10:19:26 INFO - Running setup.py install for mozprofile 10:19:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:19:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:19:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:19:26 INFO - Running setup.py install for mozrunner 10:19:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:19:26 INFO - Running setup.py install for mozscreenshot 10:19:26 INFO - Running setup.py install for moztest 10:19:27 INFO - Running setup.py install for mozversion 10:19:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:19:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:19:27 INFO - Cleaning up... 10:19:27 INFO - Return code: 0 10:19:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ce9615f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2092230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c090>, '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 0x208f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208fe40>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193', '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 10:19:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:19:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:19:27 INFO - Using env: {'DISPLAY': ':0', 10:19:27 INFO - 'HOME': '/home/cltbld', 10:19:27 INFO - 'LANG': 'en_US.UTF-8', 10:19:27 INFO - 'LANGUAGE': 'en_US:en', 10:19:27 INFO - 'LOGNAME': 'cltbld', 10:19:27 INFO - 'MAIL': '/var/mail/cltbld', 10:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:27 INFO - 'MOZ_NO_REMOTE': '1', 10:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:27 INFO - 'NO_EM_RESTART': '1', 10:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:27 INFO - 'PWD': '/builds/slave/test', 10:19:27 INFO - 'SHELL': '/bin/bash', 10:19:27 INFO - 'SHLVL': '1', 10:19:27 INFO - 'TERM': 'linux', 10:19:27 INFO - 'TMOUT': '86400', 10:19:27 INFO - 'USER': 'cltbld', 10:19:27 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193', 10:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:27 INFO - '_': '/tools/buildbot/bin/python'} 10:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:19:27 INFO - Running setup.py (path:/tmp/pip-UW_zms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:19:27 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)) 10:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:19:27 INFO - Running setup.py (path:/tmp/pip-71ZQyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:19:27 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)) 10:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:19:27 INFO - Running setup.py (path:/tmp/pip-Pk8dg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:19:27 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)) 10:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:19:27 INFO - Running setup.py (path:/tmp/pip-ch_5Oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:19:27 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)) 10:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:19:27 INFO - Running setup.py (path:/tmp/pip-bRKQ3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:19:27 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)) 10:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:19:27 INFO - Running setup.py (path:/tmp/pip-Msh0f0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:19:27 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)) 10:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:19:27 INFO - Running setup.py (path:/tmp/pip-BHZ1td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:19:27 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)) 10:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:19:27 INFO - Running setup.py (path:/tmp/pip-0zC1Vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:19:27 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)) 10:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:19:27 INFO - Running setup.py (path:/tmp/pip-x0AyKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:19:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:19:28 INFO - Running setup.py (path:/tmp/pip-5ulKdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:19:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:19:28 INFO - Running setup.py (path:/tmp/pip-QmyuRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:19:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:19:28 INFO - Running setup.py (path:/tmp/pip-23cwje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:19:28 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)) 10:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:19:28 INFO - Running setup.py (path:/tmp/pip-0bXWx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:19:28 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)) 10:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:19:28 INFO - Running setup.py (path:/tmp/pip-PKK1Ei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:19:28 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)) 10:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:28 INFO - Running setup.py (path:/tmp/pip-qeXqxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:28 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)) 10:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:19:28 INFO - Running setup.py (path:/tmp/pip-xxLeHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:19:28 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)) 10:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:19:28 INFO - Running setup.py (path:/tmp/pip-CQx_4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:19:28 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)) 10:19:28 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)) 10:19:28 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)) 10:19:28 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)) 10:19:28 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)) 10:19:28 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)) 10:19:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19:30 INFO - Downloading blessings-1.6.tar.gz 10:19:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:19:30 INFO - Installing collected packages: blessings 10:19:30 INFO - Running setup.py install for blessings 10:19:30 INFO - Successfully installed blessings 10:19:30 INFO - Cleaning up... 10:19:30 INFO - Return code: 0 10:19:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:19:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:19:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:19:30 INFO - Reading from file tmpfile_stdout 10:19:30 INFO - Current package versions: 10:19:30 INFO - argparse == 1.2.1 10:19:30 INFO - blessings == 1.6 10:19:30 INFO - blobuploader == 1.2.4 10:19:30 INFO - docopt == 0.6.1 10:19:30 INFO - functools32 == 3.2.3-2 10:19:30 INFO - jsonschema == 2.5.1 10:19:30 INFO - manifestparser == 1.1 10:19:30 INFO - mozInstall == 1.12 10:19:30 INFO - mozcrash == 0.17 10:19:30 INFO - mozdebug == 0.1 10:19:30 INFO - mozdevice == 0.48 10:19:30 INFO - mozfile == 1.2 10:19:30 INFO - mozhttpd == 0.7 10:19:30 INFO - mozinfo == 0.9 10:19:30 INFO - mozleak == 0.1 10:19:30 INFO - mozlog == 3.3 10:19:30 INFO - moznetwork == 0.27 10:19:30 INFO - mozprocess == 0.23 10:19:30 INFO - mozprofile == 0.28 10:19:30 INFO - mozrunner == 6.12 10:19:30 INFO - mozscreenshot == 0.1 10:19:30 INFO - mozsystemmonitor == 0.3 10:19:30 INFO - moztest == 0.7 10:19:30 INFO - mozversion == 1.4 10:19:30 INFO - psutil == 3.1.1 10:19:30 INFO - requests == 1.2.3 10:19:30 INFO - wsgiref == 0.1.2 10:19:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:30 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 0x7f6ce9615f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2092230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c090>, '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 0x208f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208fe40>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193', '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 10:19:30 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 10:19:30 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 10:19:30 INFO - Using env: {'DISPLAY': ':0', 10:19:30 INFO - 'HOME': '/home/cltbld', 10:19:30 INFO - 'LANG': 'en_US.UTF-8', 10:19:30 INFO - 'LANGUAGE': 'en_US:en', 10:19:30 INFO - 'LOGNAME': 'cltbld', 10:19:30 INFO - 'MAIL': '/var/mail/cltbld', 10:19:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:30 INFO - 'MOZ_NO_REMOTE': '1', 10:19:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:30 INFO - 'NO_EM_RESTART': '1', 10:19:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:30 INFO - 'PWD': '/builds/slave/test', 10:19:30 INFO - 'SHELL': '/bin/bash', 10:19:30 INFO - 'SHLVL': '1', 10:19:30 INFO - 'TERM': 'linux', 10:19:30 INFO - 'TMOUT': '86400', 10:19:30 INFO - 'USER': 'cltbld', 10:19:30 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193', 10:19:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:30 INFO - '_': '/tools/buildbot/bin/python'} 10:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:19:31 INFO - Cleaning up... 10:19:31 INFO - Return code: 0 10:19:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:19:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ce9615f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2092230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c090>, '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 0x208f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208fe40>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193', '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 10:19:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:19:31 INFO - Using env: {'DISPLAY': ':0', 10:19:31 INFO - 'HOME': '/home/cltbld', 10:19:31 INFO - 'LANG': 'en_US.UTF-8', 10:19:31 INFO - 'LANGUAGE': 'en_US:en', 10:19:31 INFO - 'LOGNAME': 'cltbld', 10:19:31 INFO - 'MAIL': '/var/mail/cltbld', 10:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:31 INFO - 'MOZ_NO_REMOTE': '1', 10:19:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:31 INFO - 'NO_EM_RESTART': '1', 10:19:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:31 INFO - 'PWD': '/builds/slave/test', 10:19:31 INFO - 'SHELL': '/bin/bash', 10:19:31 INFO - 'SHLVL': '1', 10:19:31 INFO - 'TERM': 'linux', 10:19:31 INFO - 'TMOUT': '86400', 10:19:31 INFO - 'USER': 'cltbld', 10:19:31 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193', 10:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:31 INFO - '_': '/tools/buildbot/bin/python'} 10:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:19:31 INFO - Cleaning up... 10:19:31 INFO - Return code: 0 10:19:31 INFO - Running post-action listener: _resource_record_post_action 10:19:31 INFO - Running post-action listener: _start_resource_monitoring 10:19:31 INFO - Starting resource monitoring. 10:19:31 INFO - [mozharness: 2016-08-19 17:19:31.437409Z] Finished create-virtualenv step (success) 10:19:31 INFO - [mozharness: 2016-08-19 17:19:31.437865Z] Running install step. 10:19:31 INFO - Running pre-action listener: _resource_record_pre_action 10:19:31 INFO - Running main action method: install 10:19:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:19:31 INFO - Reading from file tmpfile_stdout 10:19:31 INFO - Detecting whether we're running mozinstall >=1.0... 10:19:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:19:31 INFO - Reading from file tmpfile_stdout 10:19:31 INFO - Output received: 10:19:31 INFO - Usage: mozinstall [options] installer 10:19:31 INFO - Options: 10:19:31 INFO - -h, --help show this help message and exit 10:19:31 INFO - -d DEST, --destination=DEST 10:19:31 INFO - Directory to install application into. [default: 10:19:31 INFO - "/builds/slave/test"] 10:19:31 INFO - --app=APP Application being installed. [default: firefox] 10:19:31 INFO - mkdir: /builds/slave/test/build/application 10:19:31 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'] 10:19:31 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 10:19:47 INFO - Reading from file tmpfile_stdout 10:19:47 INFO - Output received: 10:19:47 INFO - /builds/slave/test/build/application/firefox/firefox 10:19:47 INFO - Running post-action listener: _resource_record_post_action 10:19:47 INFO - [mozharness: 2016-08-19 17:19:47.824375Z] Finished install step (success) 10:19:47 INFO - [mozharness: 2016-08-19 17:19:47.824628Z] Running run-tests step. 10:19:47 INFO - Running pre-action listener: _resource_record_pre_action 10:19:47 INFO - Running main action method: run_tests 10:19:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:19:47 INFO - Python 2.7.3 10:19:47 INFO - Return code: 0 10:19:47 INFO - grabbing minidump binary from tooltool 10:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:47 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 0x208c090>, '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 0x208f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208fe40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:19:47 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 10:19:47 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 10:19:47 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 10:19:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:19:47 INFO - Return code: 0 10:19:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:19:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:19:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:19:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:19:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:19:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 10:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 10:19:47 INFO - Using env: {'DISPLAY': ':0', 10:19:47 INFO - 'HOME': '/home/cltbld', 10:19:47 INFO - 'LANG': 'en_US.UTF-8', 10:19:47 INFO - 'LANGUAGE': 'en_US:en', 10:19:47 INFO - 'LOGNAME': 'cltbld', 10:19:47 INFO - 'MAIL': '/var/mail/cltbld', 10:19:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:19:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:47 INFO - 'MOZ_NO_REMOTE': '1', 10:19:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:19:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:47 INFO - 'NO_EM_RESTART': '1', 10:19:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:47 INFO - 'PWD': '/builds/slave/test', 10:19:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:19:47 INFO - 'SHELL': '/bin/bash', 10:19:47 INFO - 'SHLVL': '1', 10:19:47 INFO - 'TERM': 'linux', 10:19:47 INFO - 'TMOUT': '86400', 10:19:47 INFO - 'USER': 'cltbld', 10:19:47 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193', 10:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:47 INFO - '_': '/tools/buildbot/bin/python'} 10:19:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 10:19:48 INFO - mozversion application_buildid: 20160819085421 10:19:48 INFO - mozversion application_changeset: b4f5a80d3533c651b1a754a8f6bc71b0f5ad5ca5 10:19:48 INFO - mozversion application_display_name: Nightly 10:19:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:19:48 INFO - mozversion application_name: Firefox 10:19:48 INFO - mozversion application_remotingname: firefox 10:19:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:19:48 INFO - mozversion application_vendor: Mozilla 10:19:48 INFO - mozversion application_version: 51.0a1 10:19:48 INFO - mozversion platform_buildid: 20160819085421 10:19:48 INFO - mozversion platform_changeset: b4f5a80d3533c651b1a754a8f6bc71b0f5ad5ca5 10:19:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:19:48 INFO - mozversion platform_version: 51.0a1 10:19:48 INFO - using testdate: 1471627188 10:19:48 INFO - actual date: 1471627188 10:19:48 INFO - starting webserver on 'localhost:56847' 10:19:48 INFO - SUITE-START | Running 2 tests 10:19:48 INFO - TEST-START | dromaeo_css 10:19:48 INFO - operating with platform_type : linux_ 10:19:48 INFO - Initialising browser for dromaeo_css test... 10:19:48 INFO - TEST-INFO | started process 17279 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfsKM4V/profile http://localhost:56847/getInfo.html) 10:19:52 INFO - PROCESS | 17279 | __metrics Screen width/height:1600/1200 10:19:52 INFO - PROCESS | 17279 | colorDepth:24 10:19:52 INFO - PROCESS | 17279 | Browser inner width/height: 1024/697 10:19:52 INFO - PROCESS | 17279 | __metrics 10:19:52 INFO - PROCESS | 17279 | 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" 10:19:52 INFO - PROCESS | 17279 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:19:53 INFO - PROCESS | 17279 | console.error: PushService: 10:19:53 INFO - PROCESS | 17279 | stateChangeProcessEnqueue: Error transitioning state 10:19:53 INFO - PROCESS | 17279 | UnknownError 10:19:54 INFO - TEST-INFO | 17279: exit 0 10:19:54 INFO - Browser initialized. 10:19:54 INFO - Running cycle 1/1 for dromaeo_css test... 10:19:54 INFO - TEST-INFO | started process 17362 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfsKM4V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:20:06 INFO - PROCESS | 17362 | RSS: Main: 156921856 10:20:06 INFO - PROCESS | 17362 | 10:20:57 INFO - PROCESS | 17362 | 1471627257245 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] 10:23:09 INFO - PROCESS | 17362 | Cycle 1(1): loaded http://localhost:56847/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56847/tests/dromaeo/cssquery-ext.html) 10:23:11 INFO - PROCESS | 17362 | RSS: Main: 242262016 10:23:11 INFO - PROCESS | 17362 | 10:26:13 INFO - PROCESS | 17362 | Cycle 1(1): loaded http://localhost:56847/tests/dromaeo/cssquery-ext.html (next: http://localhost:56847/tests/dromaeo/cssquery-jquery.html) 10:26:14 INFO - PROCESS | 17362 | RSS: Main: 245448704 10:26:14 INFO - PROCESS | 17362 | 10:29:16 INFO - PROCESS | 17362 | Cycle 1(1): loaded http://localhost:56847/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56847/tests/dromaeo/cssquery-mootools.html) 10:29:17 INFO - PROCESS | 17362 | RSS: Main: 188780544 10:29:17 INFO - PROCESS | 17362 | 10:32:19 INFO - PROCESS | 17362 | Cycle 1(1): loaded http://localhost:56847/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56847/tests/dromaeo/cssquery-prototype.html) 10:32:19 INFO - PROCESS | 17362 | RSS: Main: 217419776 10:32:19 INFO - PROCESS | 17362 | 10:35:23 INFO - PROCESS | 17362 | Cycle 1(1): loaded http://localhost:56847/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56847/tests/dromaeo/cssquery-yui.html) 10:35:23 INFO - PROCESS | 17362 | RSS: Main: 190185472 10:35:23 INFO - PROCESS | 17362 | 10:38:26 INFO - PROCESS | 17362 | Cycle 1(1): loaded http://localhost:56847/tests/dromaeo/cssquery-yui.html (next: http://localhost:56847/tests/dromaeo/cssquery-dojo.html) 10:38:27 INFO - PROCESS | 17362 | RSS: Main: 277651456 10:38:27 INFO - PROCESS | 17362 | 10:38:27 INFO - PROCESS | 17362 | __start_tp_report 10:38:27 INFO - PROCESS | 17362 | _x_x_mozilla_page_load 10:38:27 INFO - PROCESS | 17362 | _x_x_mozilla_page_load_details 10:38:27 INFO - PROCESS | 17362 | |i|pagename|runs| 10:38:27 INFO - PROCESS | 17362 | |0;dojo.html;2592.46854394849;2623.2654856640147;2636.459525797212;2643.207037888632;2645.0477827981936;4593.816247350102;4597.88505287368;4678.625709943205;4752.263399173129;4757.119932812432;4655.697379670319;4666.673332866701;4695.225287827513;4702.741349225791;4715.2455607102875;4307.138572285539;4310.676699247553;4381.846635367763;4388.626966707834;4444.511103778582;4397.142557201347;4413.227685155101;4435.4899186593475;4437.445319335083;4438.156750217465;4206.074663574009;4246.808893599765;4344.500382456026;4358.585934336233;4396.20868243716;4253.085586598865;4288.678349123797;4288.892777680552;4310.849120280775;4383.539728328511;4335.219660461115;4340.283853164224;4344.6089851913475;4346.304591265382;4349.108432771274;4515.954840451586;4611.492735799059;4712.128256272601;4766;4768.499307572724;4919.7540122993705;4998.925016124761;5007.2489126630935;5010.899782004376;5017.974910125463;5017.724025178613;5018.623603229736;5022.447530771612;5028.7737051832755;5048.268001139851;4628.375169352094;4694.131585656664;4724.055188962221;4732.550407711227;4756.381670382828;5211.5830733541225;5225.16397376418;5231.084560201949;5236.450172731885;5237.921431178535;5023.321851550067;5032.72320022395;5038.042771873405;5039.546440820343;5041.924371134362;4913.901721965541;4979.726115063634;5053.0399224147295;5112.182050871843;5112.488751124858;5057.494250574913;5060.468650791688;5066.620003499752;5078.568321692624;5084.847454576368;5063.620228482879;5068.315777370008;5072.847814565569;5078.314427552307;5081.8475445736685;4141.275276826544;4182.895427614273;4194.832206711759;4302.096559722493;4310.418093557392;3696.057505336122;3735.701143908481;3752.3058234226755;3771.5097037384962;3796.962030379716;4334.111507141029;4345.804438800262;4346.587074228007;4353.194658988097;4360.694751367374;4940.086084074458;4956.504349565014;5095.439501654815;5096.719680417613;5097.719625420564;4256.233877902007;4315.611594956406;4320.611144996966;4327.545607711208;4330.956690433119;4557.1797076526545;4562.110388474282;4564.680472366969;4567.063751930847;4567.2920697291975;4603.125406172817;4692.812287508462;4795.664303498791;4804.903901922012;4808.543188397097;4996.425411077773;5067.7212753297445;5089.51649593288;5100.311457953128;5103.260027295947;4776.808927642995;4782.402199725035;4794.041191761592;4796.616270698406;4805.567498925114;4874.171390863491;4916.631252656137;4999.725015124203;5013.423456302572;5013.724245166551;5006.824761133343;5093.286939828353;5099.592032637454;5106.846794596168;5122.078025955215;4954.826581069645;4975.253711943237;4975.5522003019905;4980.377452818398;4986.825461108844;4781.880452988703;4869.513048695102;4948.282499037691;4955.083309587738;4966.602671786176;4818.951810481991;4904.239842824368;4928.728919909439;4931.13705101613;4932.8520144395725;5013.699178049329;5015.423226329019;5027.2207807789855;5029.59763218949;5032.3206367139965;4689.226277664147;4744.976275118603;4917.58200552957;4919.286703428054;4926.285688575208 10:38:27 INFO - PROCESS | 17362 | |1;ext.html;562.9268195134633;563.4872266237725;565.1692012741271;570.7374607680468;577.4600748300342;38547.22905541887;40528.59471405289;40666.186676266494;43796.3430548542;43890;39462.80268598653;40055.79972100143;40145.19709605806;40166;40202.7989860051;7483.812904677386;7685.961570192141;7697.076350837908;7713.5757533335645;7730.458867879251;7573.621318934059;7683;7703.730369437071;7707.267809558083;7711.344535714443;7680.769576912701;7728.922710772877;7737.883931741;7742.109657389416;7743;7654.961725191394;7661.578613176273;7699.884501732478;7713.537187768724;7716.807079822993;7503.174650788409;7574.8485030299635;7586.734464293779;7588.241175882367;7592.696292148307;37256.254874902625;37549.81225093884;37745.81127094347;37823;37824;2938;3066.861991210401;3187.0438868339406;3298.967010329914;3444.225049363898;28711.282217944718;29196.562051569243;29898;29987.850060749774;30003.099907002827;3394.4555227371734;3402.795832250073;3408;3424.931501369959;3488.773229740084;245716;245759;245798;246034;246746.9999999982;29735.40529189404;49159;49464;49538;49564.25653615199;29554.556681649792;29622.555661665094;29635.369279836763;29645.555316670267;29646.258843529085;11275.097992160607;11358.26171298863;11361.204715669988;11368.147388945863;11375.886241137649;9295.442273463614;9354.345195836226;9363.4381937084;9363.485008324471;9469.053094690476;7578.280063393969;7627.237276272328;7668.80827979305;7687.769366919001;7694.576798276036;3062.647795503501;3097.519884417919;3097.969020309813;3122.1414111119625;3128.8086152124706;823.6952327638812;852.8720691896265;893.0712059458091;941.430434587065;970.8786401699788;25284.620730689054;26054.73945260523;26573.468530629278;26739.732602674114;26788.866055669987;933.696548621687;938.5776400619612;947.9052094790466;960.9759756006156;1072.6406653771073;14044.227567483682;14203;14329.57011289663;14370.353334099991;14540.41838326455;292510;295047;295752;296193;296822;44043.55956440459;44660.776696116314;44682.77658611686;44715.776421117684;44858.999999999345;1057.8360354144966;1138.584416687903;1146.2091157101572;1149.5286932357694;1194.3371428857067;25929.6110558338;28450.57324140098;28731.281717956383;29154.271143221587;29256.268593284487;39826.80086599549;40288.19423611453;40292.59707402888;40318.39522407225;40333;281350;283058;283744;283989;284015;22092.447688807908;24018.51962960696;24878.875605621855;24913.750862491142;24930;39857.40213896852;39922.401163983144;40000.799995999834;40391.192176155724;40465.79767101146;33938.06083935252;34068.14829629279;34183.82908085443;34308.65691343055;34362.656373435944;34755.652443476254;35068.64931350654;35419.29161416809;35474.290514190085;35477.29045419129;33657.15857103592;34642.133946651535;34787.65212347844;34867.302653947285;34869.47695784616;30218.2445438857;31805;31928.36143277168;32081;32234.677653224106;23890.40273993164;23912.880435598407;24351.51296974086;24551.897873701993;24802.25593232206 10:38:27 INFO - PROCESS | 17362 | |2;jquery.html;347.93911065563555;367.5644361431703;370.1578907984335;372.98881033568983;388.8017111273252;12827.615171544858;15792.210389480522;16494.83505164948;17081.14594270288;17130.229139688712;13024.479020839155;13485.46058157675;13774.380152893118;14290.785638215435;14377.712445751078;4421.292593185091;4720.126776546342;4872.853814385574;4884.096442158194;5299.33758280215;5101.285819985205;5184.844454666366;5186.636935414523;5186.974065129669;5194.506521880416;4791.329213910055;4852.830150944717;5167.354080739908;5169.87075323118;5171.844844654666;4751.287306903975;4809.038192361541;4815.398075240595;4815.5906747926465;4819.301201325806;4580.427446569179;4622.375979242793;4664.603508701764;4684.695494792828;4687.273472611751;20781.376558703265;20782.5843483131;20840;20896.47758806027;20990;1813.4559632110445;1853.3420635674277;1859.2748827957107;1893.4982229709137;1949.3761996161234;8994.546050605493;9549.809003819884;9769.071938165864;12274.631761047094;12937.48250069996;1713.271859459737;1728.5419363868584;1737.652469506104;1766.4877185616285;1799.4151900632216;66440.3355966439;68413;68670.3132968669;70110.2988970114;71885.6405717968;9837.163841073589;9897.703068907944;9958.551865166084;10130;10178.541965611565;13819.930900345435;13856.653583660489;13857.722845543032;13880.93059534696;13882.93058534721;6651.201855777241;6754.527183097136;6904.896426553606;7030.437564994891;7032.261612530713;6234.314225435199;6265.339684983483;6397.232332120176;6405.551611387252;6451;4297.5702429756775;4306.892327691833;4307.90362956803;4388.802503887333;4427.911441771146;1769.2480695704273;1819.4723530176366;1828.570285982793;1834.6972749496451;1876.4800511585659;623.7317953280042;807.834393949239;859.5229647545672;918.8759517465056;950.50098698184;16544;16577.088260145567;17117.743233851503;17400.39098631542;17835.375761848532;804.4449329962307;805.2683322053055;807.2250639386137;807.5114555693838;836.0385556609947;7722.652480638385;9279.211267042378;9568.95215523918;9672.854907176397;9809.264305177141;370254;370534;371984;380150;383489;69424;77035;77607.61196194096;78803;79877.20122798698;904.9864252036093;914.1681070226063;941.2187884056217;941.2328951904176;942.6370847223868;14926.77609835875;15000.924995374953;15565.76651350208;15775;15875;37107.814460927526;37340.626593733716;37627.24745505129;38101.809490952364;38540.42189367218;50437;50721.49278507168;51475;52164.47835521748;52186;6561.737530498726;7501.549907005598;7672.578008209602;7831.530108193527;7842.098158711821;8882.511461869659;11111.555537778722;11264.94367528157;11878.940605296919;11991.340476273539;9797.559109840216;9889.85165222508;10012.39925604466;10487.37075775456;10576.894231057899;9833.459159746282;9916.454594997344;10130.898691012995;10156.949215253877;10399.012093851072;9392.906070939476;10007.449590272605;10320.174386048948;10334.379937203792;10402.219833512669;7475.252474752481;7584.431167662337;7635.350995165251;7787.143414224318;7986.3610911128135;9214.539273036187;9386.487134409505;9899.455529945923;9977.700668979942;10297.794044118926 10:38:27 INFO - PROCESS | 17362 | |3;mootools.html;1320.2474589483995;1376.36687123923;1394.2331717555348;1587.2936543238263;1639.5163426789088;7245.927540724591;7872.37021038317;7887.329576985956;7892.526448413099;7895.526268423891;6684.398404143626;7246.420286377091;7418.183999760022;7504.024476818006;7656;2195.242641288753;2215.2357436684397;2217.1463986365284;2218.5562887422498;2227.376334626307;2139.0588141217813;2154.450615093157;2188.4310079379397;2195.374318319279;2198.9450263743374;2130.4141361125658;2132.040581738216;2136.0494579911947;2148.785121487854;2172.880491572963;2138;2141.239859849762;2144.281665642012;2144.8069673729283;2145.410012246629;2127.0322003488377;2155.5904378168257;2160.7839216078264;2170.2078741259484;2171.945701357479;7630.8855367169535;7631.084269887649;7699.769006929801;7722.189170137167;7748.7675369739;4195.077083041726;4279.229738647043;4332.28517294646;4332.458442694663;4334.024844410014;2788.177487641151;2878.280429892527;2903.056506635352;2907.4039821836473;2917.6352955880516;860.1828263150032;935.7894473743421;959.1463597398321;960.4717405426987;974.3179774158118;10350.327228730184;10394.272400931937;10395.116415104725;10441.47792610374;10488.685339439753;3825.407061905409;4033.253848038122;4117.476533682557;4118.794060296973;4191.2874811281545;8923.643054277756;8923.73228803137;8934.151255630704;8941.105889411137;8946.239569636524;4294.677899157576;4295.4201182839915;4299.656027517791;4304.268274393361;4304.397384366192;3442.7590068695454;3727.105494681311;3885.708571857122;3885.8445662173763;3888.0862997195636;3457.844397002141;3506.0891813961452;3578.3380074686265;3601.891943241707;3630.1832087780567;1112.4548971004149;1120.1430905357408;1120.5376983037215;1127.1208457403238;1135.0635725526474;795.4670370851543;795.7334293011905;798.5049269452976;801.3789313282252;814.2630919018297;4954.133026720309;5107.821226257063;5166.509181627739;5166.535011848877;5323.1216849219445;392.66231041304457;394.52065740125886;403.0427734131438;412.0317254452014;415.91265834174555;3556.395412779834;3558.964410355915;3592.1199306170156;3594.5506811648543;3641.7997010164167;8935.955320223356;9223.939246986549;9297.116773906468;9346.439213647203;9360.391574547633;9092.136247056518;9205.401648892801;9234.907650923538;9268.397554158959;9274.350795444254;6588.571742836701;6706.853806781881;6786.796396108125;6806.863862722717;6815.045893574805;5040.798368065236;5106.055379754757;5118.181091025567;5119.488051195;5137.33214682089;8329.708460203863;8552.529610871214;8568.271696905833;8577.571121444027;8641.8703719443;8615.439996400213;8736;8835.55822208874;8974.057723939153;8983.326250531367;5611.438856114356;6254.2807577129215;6317.241930968129;6390.137331460193;6400.135981642418;7198.316159964795;7372.778816635509;7437.739679111205;7467.477276590804;7488.138864030706;6134.294556125924;6198.411150940653;6329.177206963065;6358.809235722936;6403.07155462446;6232.906506402498;6272.059191121369;6272.560920735505;6298.02380631003;6312.5581209314905;5774.191613174243;5867.20792692981;5871.559633027455;5875.177475153397;5884.087966365049;4270.252705776539;4301.44081269433;4392.714473559208;4465.843695470643;4557.612602928655;4359.128174365203;4371.278739008155;4396.978015110032;4522.525134860793;4647.697899636512 10:38:27 INFO - PROCESS | 17362 | |4;prototype.html;274.98350098994075;291.92118128105415;292.23288866724846;297.9806312589682;306.2359413263906;4792.976035119824;4860.295257187706;4879.926801097987;4890.437599676038;4895.118878601855;4577.816887324503;4697.5302469753005;4699.506551812054;4703.553162449571;4814.325994360784;3655.817209139546;3677.816109194543;3689.114612492996;3725.8137093145233;3781.6218378162102;3775.905602359949;3784.9053773655605;3794.1083845296334;3800.7909564973916;3800.9809950950207;3670.4310831821113;3745.7826206482864;3773.3962565989445;3777.1312598102454;3778.2254637799324;3757.7745335279697;3762.830672619739;3766.5291838520184;3768.2463507298376;3777.5466943966626;3314.4090836398423;3314.685104915029;3318.104111889776;3322.601287845474;3336.4995250712586;4708.95291047092;4716.52834716529;4724.9682636466305;4728.432588089451;4739.834105806315;4128.823285363657;4286.678499112579;4300.9139817203795;4313.956860431418;4326.415933848922;5024.773885175139;5039;5040.621953353513;5053.5957123430035;5053.646244762868;3637.290728307981;3637.9818100909592;3641.326354624403;3643.2531331077066;3645.76302540334;5134.409542902539;5262.789628356138;5271.156614941629;5306.3632364116165;5309.681419114865;3707.1102935295335;3717.888463346104;3720.330340538729;3726.4969229153717;3728.440733889938;3784.7161462890394;3785.280796648628;3813.142043040349;3814.6948244140403;3823.5794062653085;4298.742075475481;4317.870463886088;4332.588404101605;4346.326664234292;4357.7385356878685;4940.258961155783;5008.524190201925;5043.268726034705;5064.670796398296;5074.264231686385;1304.5368894042479;1319.7096638739463;1323.6095351871222;1326.423005992377;1326.7877139657608;845.5687599324266;851.3402113362071;881.0704706534667;892.7589550821242;902.9322800789967;4438.356438316426;4440.3339499074755;4447.3773671685985;4463.218936686132;4480.708753930984;5206.7917283309;5215.113430716788;5217.6694942789345;5220;5224.268602395668;4245.3844192591905;4426.9778651106535;4429.49060857999;4445.777711114431;4506.436695413074;2784.721527847199;2785.763210127162;2791.67895691998;2793.69269380368;2798.9300267493068;4913.484084171182;4915.459299477055;4929.309896614477;4936.259561065869;4964.684358644962;5123.820666276737;5350.491703288181;5372.677639341652;5378.166384210375;5405.594580406485;4926.729029903389;4967.838990039344;4974.1543937530705;4974.32846565709;4980.352554168007;5269.077911365419;5279.155335146358;5280.260763493037;5284;5292.338457692788;4884.853454396374;5125.513076257749;5149.536541711264;5162.793488260428;5188.870278243074;4960.404751429852;4984.352034235671;4984.775685094252;4984.950150498448;4985.277134815504;3672.908177295589;3690.3726366518295;3691.4093745000673;3713.832877520464;3716.1267102230413;5158.948410515997;5254.527092561535;5293.247511294028;5296.655717378358;5341.97329013368;5085.796568137233;5100.107481190703;5102.107131251942;5108.66793658411;5118.667286626357;5090.312807770903;5098.235264710175;5117.565006974449;5123.948760512347;5137.200225876832;4902.166631672696;5024.4975502450925;5037.244413338029;5041.470645582308;5047.369078865142;4923.286123511999;4956.628252880976;5133.255677926754;5140.665856719302;5143.097054090011;5013.122703526796;5017.623678224075;5022.372203474566;5024.145895197898;5035.697858128524 10:38:27 INFO - PROCESS | 17362 | |5;yui.html;634.8641272101577;640.1965533255765;672.885609446394;685.4927353758219;727.4362369163894;12092.274463532183;12729.745405091893;12775.744485110292;12796.424160912758;13023.153495022816;13488.66278343042;13654.863451365483;13666.726665466686;13697.520586779465;13750.58748237552;621.2327775197627;636.068160145387;748.9513181643176;757.5644004697293;757.9166291707908;744.601638123604;760.3233122520961;767.4742801181209;767.8349154931716;769.542122437149;811.5009269299397;811.6023148657144;811.8782182672617;812.0296245986019;813.5078277642001;645.3030726815028;698.6541661877352;807.2411932783165;808.6603626476865;808.9029316482001;577.137179916024;581.4941001328871;582.8921649494857;588.7262422973338;588.8822235552864;13643.863561364458;13857.722845543032;13863.168209907337;13879.444822207099;13887.58337249884;13396.196228226338;13409.46362145513;13675.589732307948;14379.928100359535;14529.491467798682;10897.455127243686;11022.173336999756;11093.778124437466;11110.333379997226;11196.216264861463;3273.3597276659834;3278.0821370016433;3295.555100061509;3308.123347312964;3320.0371892151247;63488.68255658738;64157.679211603645;64818.67590662016;65554.34445655577;66312.66843665799;10981.231313807957;10993.175511836644;11031.338119712844;11094.833577496343;11270.182454386404;20265;20511.4872128198;20556.79443205549;20579.8971005144;20671.689924651142;7082.504224704221;7197.604131772803;7199.244079371695;7204.3155900189395;7232.312930271616;3639.927201455956;3643.9635603644156;3735.6451137141926;3796.6583007529457;3826.1391186982705;3012.2469382654335;3115.2523394385184;3119.0798714378857;3124.562561241428;3126.8436578171454;498.49651851630114;513.7482633509628;514.2671692837691;544.8365490352878;568.2811243776625;497.350957001117;561.3011800308642;578.8003138917067;580.9390014048464;590.1973316289842;7417.369523590447;7897.763067107996;8002.679892804339;8043.919560804317;8495.617697203641;542.1921337207532;550.2763865516832;551.0907003444349;572.0503963420701;580.8722081142142;3684.1710615111388;4033.5361433434946;4043.353063509824;4080.6123418275215;4126.154138401621;56185.438145618835;76502.6174869122;79253.60373198097;79981.60009199916;89288;74260;77947.61026194833;82852.58573707093;83159.58420207982;83455.58272208722;63647;72438.2756172442;73059;76435;77881.22118778853;8377.162283771575;8824.735257942271;8887.244584210155;8930.508822014852;9075.273978081606;43843.56156438395;44748.55251447444;44821.103577927606;46184.53815461802;47325;56324.718376409495;60308.396916032034;61192;63688.363116368244;67229.32770672231;11638.41807909618;11813.173077884465;12389.504419823106;12448.875511244772;12644.051696123011;12313.26120432777;12642.051846111395;13038.739225215253;13325.200487970753;13474.730505390033;11329.263597866442;11525.135614828754;11774.587889423829;11822.881771182178;11948.820767688318;12182.634520964386;12296.323702196465;12854.376816761409;12951.870481295067;13094.803577946528;11724.941375293069;12234.021278297536;12421.503139874665;12728.23630582168;12847.229166250056;10147.594096236067;10229.641962531276;10638.361698298128;10687.358758474516;10800.567977280822;9278.95360523193;9964.501774911081;10028.448435335835;10036.548355323883;10073.748156295858 10:38:27 INFO - PROCESS | 17362 | __end_tp_report 10:38:27 INFO - PROCESS | 17362 | __start_cc_report 10:38:27 INFO - PROCESS | 17362 | _x_x_mozilla_cycle_collect,1047 10:38:27 INFO - PROCESS | 17362 | __end_cc_report 10:38:27 INFO - PROCESS | 17362 | __startTimestamp1471628307135__endTimestamp 10:38:27 INFO - PROCESS | 17362 | 10:38:27 INFO - PROCESS | 17362 | ------- Summary: start ------- 10:38:27 INFO - PROCESS | 17362 | Number of tests: 6 10:38:27 INFO - PROCESS | 17362 | 10:38:27 INFO - PROCESS | 17362 | [#0] dojo.html Cycles:165 Average:4670.15 Median:4794.04 stddev:497.50 (10.4%) stddev-sans-first:471.58 10:38:27 INFO - PROCESS | 17362 | Values: 2592.5 2623.3 2636.5 2643.2 2645.0 4593.8 4597.9 4678.6 4752.3 4757.1 4655.7 4666.7 4695.2 4702.7 4715.2 4307.1 4310.7 4381.8 4388.6 4444.5 4397.1 4413.2 4435.5 4437.4 4438.2 4206.1 4246.8 4344.5 4358.6 4396.2 4253.1 4288.7 4288.9 4310.8 4383.5 4335.2 4340.3 4344.6 4346.3 4349.1 4516.0 4611.5 4712.1 4766.0 4768.5 4919.8 4998.9 5007.2 5010.9 5018.0 5017.7 5018.6 5022.4 5028.8 5048.3 4628.4 4694.1 4724.1 4732.6 4756.4 5211.6 5225.2 5231.1 5236.5 5237.9 5023.3 5032.7 5038.0 5039.5 5041.9 4913.9 4979.7 5053.0 5112.2 5112.5 5057.5 5060.5 5066.6 5078.6 5084.8 5063.6 5068.3 5072.8 5078.3 5081.8 4141.3 4182.9 4194.8 4302.1 4310.4 3696.1 3735.7 3752.3 3771.5 3797.0 4334.1 4345.8 4346.6 4353.2 4360.7 4940.1 4956.5 5095.4 5096.7 5097.7 4256.2 4315.6 4320.6 4327.5 4331.0 4557.2 4562.1 4564.7 4567.1 4567.3 4603.1 4692.8 4795.7 4804.9 4808.5 4996.4 5067.7 5089.5 5100.3 5103.3 4776.8 4782.4 4794.0 4796.6 4805.6 4874.2 4916.6 4999.7 5013.4 5013.7 5006.8 5093.3 5099.6 5106.8 5122.1 4954.8 4975.3 4975.6 4980.4 4986.8 4781.9 4869.5 4948.3 4955.1 4966.6 4819.0 4904.2 4928.7 4931.1 4932.9 5013.7 5015.4 5027.2 5029.6 5032.3 4689.2 4745.0 4917.6 4919.3 4926.3 10:38:27 INFO - PROCESS | 17362 | 10:38:27 INFO - PROCESS | 17362 | [#1] ext.html Cycles:180 Average:41839.09 Median:34868.39 stddev:72241.53 (207.2%) stddev-sans-first:72377.71 10:38:27 INFO - PROCESS | 17362 | Values: 562.9 563.5 565.2 570.7 577.5 38547.2 40528.6 40666.2 43796.3 43890.0 39462.8 40055.8 40145.2 40166.0 40202.8 7483.8 7686.0 7697.1 7713.6 7730.5 7573.6 7683.0 7703.7 7707.3 7711.3 7680.8 7728.9 7737.9 7742.1 7743.0 7655.0 7661.6 7699.9 7713.5 7716.8 7503.2 7574.8 7586.7 7588.2 7592.7 37256.3 37549.8 37745.8 37823.0 37824.0 2938.0 3066.9 3187.0 3299.0 3444.2 28711.3 29196.6 29898.0 29987.9 30003.1 3394.5 3402.8 3408.0 3424.9 3488.8 245716.0 245759.0 245798.0 246034.0 246747.0 29735.4 49159.0 49464.0 49538.0 49564.3 29554.6 29622.6 29635.4 29645.6 29646.3 11275.1 11358.3 11361.2 11368.1 11375.9 9295.4 9354.3 9363.4 9363.5 9469.1 7578.3 7627.2 7668.8 7687.8 7694.6 3062.6 3097.5 3098.0 3122.1 3128.8 823.7 852.9 893.1 941.4 970.9 25284.6 26054.7 26573.5 26739.7 26788.9 933.7 938.6 947.9 961.0 1072.6 14044.2 14203.0 14329.6 14370.4 14540.4 292510.0 295047.0 295752.0 296193.0 296822.0 44043.6 44660.8 44682.8 44715.8 44859.0 1057.8 1138.6 1146.2 1149.5 1194.3 25929.6 28450.6 28731.3 29154.3 29256.3 39826.8 40288.2 40292.6 40318.4 40333.0 281350.0 283058.0 283744.0 283989.0 284015.0 22092.4 24018.5 24878.9 24913.8 24930.0 39857.4 39922.4 40000.8 40391.2 40465.8 33938.1 34068.1 34183.8 34308.7 34362.7 34755.7 35068.6 35419.3 35474.3 35477.3 33657.2 34642.1 34787.7 34867.3 34869.5 30218.2 31805.0 31928.4 32081.0 32234.7 23890.4 23912.9 24351.5 24551.9 24802.3 10:38:27 INFO - PROCESS | 17362 | 10:38:27 INFO - PROCESS | 17362 | [#2] jquery.html Cycles:180 Average:23711.96 Median:4735.71 stddev:62115.67 (1311.6%) stddev-sans-first:62265.15 10:38:27 INFO - PROCESS | 17362 | Values: 347.9 367.6 370.2 373.0 388.8 12827.6 15792.2 16494.8 17081.1 17130.2 13024.5 13485.5 13774.4 14290.8 14377.7 4421.3 4720.1 4872.9 4884.1 5299.3 5101.3 5184.8 5186.6 5187.0 5194.5 4791.3 4852.8 5167.4 5169.9 5171.8 4751.3 4809.0 4815.4 4815.6 4819.3 4580.4 4622.4 4664.6 4684.7 4687.3 20781.4 20782.6 20840.0 20896.5 20990.0 1813.5 1853.3 1859.3 1893.5 1949.4 8994.5 9549.8 9769.1 12274.6 12937.5 1713.3 1728.5 1737.7 1766.5 1799.4 66440.3 68413.0 68670.3 70110.3 71885.6 9837.2 9897.7 9958.6 10130.0 10178.5 13819.9 13856.7 13857.7 13880.9 13882.9 6651.2 6754.5 6904.9 7030.4 7032.3 6234.3 6265.3 6397.2 6405.6 6451.0 4297.6 4306.9 4307.9 4388.8 4427.9 1769.2 1819.5 1828.6 1834.7 1876.5 623.7 807.8 859.5 918.9 950.5 16544.0 16577.1 17117.7 17400.4 17835.4 804.4 805.3 807.2 807.5 836.0 7722.7 9279.2 9569.0 9672.9 9809.3 370254.0 370534.0 371984.0 380150.0 383489.0 69424.0 77035.0 77607.6 78803.0 79877.2 905.0 914.2 941.2 941.2 942.6 14926.8 15000.9 15565.8 15775.0 15875.0 37107.8 37340.6 37627.2 38101.8 38540.4 50437.0 50721.5 51475.0 52164.5 52186.0 6561.7 7501.5 7672.6 7831.5 7842.1 8882.5 11111.6 11264.9 11878.9 11991.3 9797.6 9889.9 10012.4 10487.4 10576.9 9833.5 9916.5 10130.9 10156.9 10399.0 9392.9 10007.4 10320.2 10334.4 10402.2 7475.3 7584.4 7635.4 7787.1 7986.4 9214.5 9386.5 9899.5 9977.7 10297.8 10:38:27 INFO - PROCESS | 17362 | 10:38:27 INFO - PROCESS | 17362 | [#3] mootools.html Cycles:180 Average:4937.75 Median:4997.47 stddev:2786.02 (55.7%) stddev-sans-first:2780.57 10:38:27 INFO - PROCESS | 17362 | Values: 1320.2 1376.4 1394.2 1587.3 1639.5 7245.9 7872.4 7887.3 7892.5 7895.5 6684.4 7246.4 7418.2 7504.0 7656.0 2195.2 2215.2 2217.1 2218.6 2227.4 2139.1 2154.5 2188.4 2195.4 2198.9 2130.4 2132.0 2136.0 2148.8 2172.9 2138.0 2141.2 2144.3 2144.8 2145.4 2127.0 2155.6 2160.8 2170.2 2171.9 7630.9 7631.1 7699.8 7722.2 7748.8 4195.1 4279.2 4332.3 4332.5 4334.0 2788.2 2878.3 2903.1 2907.4 2917.6 860.2 935.8 959.1 960.5 974.3 10350.3 10394.3 10395.1 10441.5 10488.7 3825.4 4033.3 4117.5 4118.8 4191.3 8923.6 8923.7 8934.2 8941.1 8946.2 4294.7 4295.4 4299.7 4304.3 4304.4 3442.8 3727.1 3885.7 3885.8 3888.1 3457.8 3506.1 3578.3 3601.9 3630.2 1112.5 1120.1 1120.5 1127.1 1135.1 795.5 795.7 798.5 801.4 814.3 4954.1 5107.8 5166.5 5166.5 5323.1 392.7 394.5 403.0 412.0 415.9 3556.4 3559.0 3592.1 3594.6 3641.8 8936.0 9223.9 9297.1 9346.4 9360.4 9092.1 9205.4 9234.9 9268.4 9274.4 6588.6 6706.9 6786.8 6806.9 6815.0 5040.8 5106.1 5118.2 5119.5 5137.3 8329.7 8552.5 8568.3 8577.6 8641.9 8615.4 8736.0 8835.6 8974.1 8983.3 5611.4 6254.3 6317.2 6390.1 6400.1 7198.3 7372.8 7437.7 7467.5 7488.1 6134.3 6198.4 6329.2 6358.8 6403.1 6232.9 6272.1 6272.6 6298.0 6312.6 5774.2 5867.2 5871.6 5875.2 5884.1 4270.3 4301.4 4392.7 4465.8 4557.6 4359.1 4371.3 4397.0 4522.5 4647.7 10:38:27 INFO - PROCESS | 17362 | 10:38:27 INFO - PROCESS | 17362 | [#4] prototype.html Cycles:180 Average:4220.40 Median:4837.31 stddev:1224.40 (25.3%) stddev-sans-first:1191.49 10:38:27 INFO - PROCESS | 17362 | Values: 275.0 291.9 292.2 298.0 306.2 4793.0 4860.3 4879.9 4890.4 4895.1 4577.8 4697.5 4699.5 4703.6 4814.3 3655.8 3677.8 3689.1 3725.8 3781.6 3775.9 3784.9 3794.1 3800.8 3801.0 3670.4 3745.8 3773.4 3777.1 3778.2 3757.8 3762.8 3766.5 3768.2 3777.5 3314.4 3314.7 3318.1 3322.6 3336.5 4709.0 4716.5 4725.0 4728.4 4739.8 4128.8 4286.7 4300.9 4314.0 4326.4 5024.8 5039.0 5040.6 5053.6 5053.6 3637.3 3638.0 3641.3 3643.3 3645.8 5134.4 5262.8 5271.2 5306.4 5309.7 3707.1 3717.9 3720.3 3726.5 3728.4 3784.7 3785.3 3813.1 3814.7 3823.6 4298.7 4317.9 4332.6 4346.3 4357.7 4940.3 5008.5 5043.3 5064.7 5074.3 1304.5 1319.7 1323.6 1326.4 1326.8 845.6 851.3 881.1 892.8 902.9 4438.4 4440.3 4447.4 4463.2 4480.7 5206.8 5215.1 5217.7 5220.0 5224.3 4245.4 4427.0 4429.5 4445.8 4506.4 2784.7 2785.8 2791.7 2793.7 2798.9 4913.5 4915.5 4929.3 4936.3 4964.7 5123.8 5350.5 5372.7 5378.2 5405.6 4926.7 4967.8 4974.2 4974.3 4980.4 5269.1 5279.2 5280.3 5284.0 5292.3 4884.9 5125.5 5149.5 5162.8 5188.9 4960.4 4984.4 4984.8 4985.0 4985.3 3672.9 3690.4 3691.4 3713.8 3716.1 5158.9 5254.5 5293.2 5296.7 5342.0 5085.8 5100.1 5102.1 5108.7 5118.7 5090.3 5098.2 5117.6 5123.9 5137.2 4902.2 5024.5 5037.2 5041.5 5047.4 4923.3 4956.6 5133.3 5140.7 5143.1 5013.1 5017.6 5022.4 5024.1 5035.7 10:38:27 INFO - PROCESS | 17362 | 10:38:27 INFO - PROCESS | 17362 | [#5] yui.html Cycles:180 Average:17340.59 Median:45502.82 stddev:23397.96 (51.4%) stddev-sans-first:23429.97 10:38:27 INFO - PROCESS | 17362 | Values: 634.9 640.2 672.9 685.5 727.4 12092.3 12729.7 12775.7 12796.4 13023.2 13488.7 13654.9 13666.7 13697.5 13750.6 621.2 636.1 749.0 757.6 757.9 744.6 760.3 767.5 767.8 769.5 811.5 811.6 811.9 812.0 813.5 645.3 698.7 807.2 808.7 808.9 577.1 581.5 582.9 588.7 588.9 13643.9 13857.7 13863.2 13879.4 13887.6 13396.2 13409.5 13675.6 14379.9 14529.5 10897.5 11022.2 11093.8 11110.3 11196.2 3273.4 3278.1 3295.6 3308.1 3320.0 63488.7 64157.7 64818.7 65554.3 66312.7 10981.2 10993.2 11031.3 11094.8 11270.2 20265.0 20511.5 20556.8 20579.9 20671.7 7082.5 7197.6 7199.2 7204.3 7232.3 3639.9 3644.0 3735.6 3796.7 3826.1 3012.2 3115.3 3119.1 3124.6 3126.8 498.5 513.7 514.3 544.8 568.3 497.4 561.3 578.8 580.9 590.2 7417.4 7897.8 8002.7 8043.9 8495.6 542.2 550.3 551.1 572.1 580.9 3684.2 4033.5 4043.4 4080.6 4126.2 56185.4 76502.6 79253.6 79981.6 89288.0 74260.0 77947.6 82852.6 83159.6 83455.6 63647.0 72438.3 73059.0 76435.0 77881.2 8377.2 8824.7 8887.2 8930.5 9075.3 43843.6 44748.6 44821.1 46184.5 47325.0 56324.7 60308.4 61192.0 63688.4 67229.3 11638.4 11813.2 12389.5 12448.9 12644.1 12313.3 12642.1 13038.7 13325.2 13474.7 11329.3 11525.1 11774.6 11822.9 11948.8 12182.6 12296.3 12854.4 12951.9 13094.8 11724.9 12234.0 12421.5 12728.2 12847.2 10147.6 10229.6 10638.4 10687.4 10800.6 9279.0 9964.5 10028.4 10036.5 10073.7 10:38:27 INFO - PROCESS | 17362 | -------- Summary: end -------- 10:38:27 INFO - PROCESS | 17362 | 10:38:27 INFO - TEST-INFO | 17362: exit 0 10:38:27 INFO - TEST-OK | dromaeo_css | took 1119838ms 10:38:27 INFO - TEST-START | kraken 10:38:27 INFO - operating with platform_type : linux_ 10:38:27 INFO - Initialising browser for kraken test... 10:38:27 INFO - TEST-INFO | started process 17662 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4NHNHf/profile http://localhost:56847/getInfo.html) 10:38:32 INFO - PROCESS | 17662 | __metrics Screen width/height:1600/1200 10:38:32 INFO - PROCESS | 17662 | colorDepth:24 10:38:32 INFO - PROCESS | 17662 | Browser inner width/height: 1024/697 10:38:32 INFO - PROCESS | 17662 | __metrics 10:38:32 INFO - PROCESS | 17662 | 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" 10:38:32 INFO - PROCESS | 17662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:38:33 INFO - PROCESS | 17662 | console.error: PushService: 10:38:33 INFO - PROCESS | 17662 | stateChangeProcessEnqueue: Error transitioning state 10:38:33 INFO - PROCESS | 17662 | UnknownError 10:38:33 INFO - TEST-INFO | 17662: exit 0 10:38:33 INFO - Browser initialized. 10:38:33 INFO - Running cycle 1/1 for kraken test... 10:38:33 INFO - TEST-INFO | started process 17743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4NHNHf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:38:45 INFO - PROCESS | 17743 | RSS: Main: 157360128 10:38:45 INFO - PROCESS | 17743 | 10:38:48 INFO - PROCESS | 17743 | Cycle 1(1): loaded http://localhost:56847/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56847/tests/kraken/driver.html?testName=audio-beat-detection) 10:38:49 INFO - PROCESS | 17743 | RSS: Main: 212836352 10:38:49 INFO - PROCESS | 17743 | 10:38:52 INFO - PROCESS | 17743 | Cycle 1(1): loaded http://localhost:56847/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56847/tests/kraken/driver.html?testName=audio-dft) 10:38:52 INFO - PROCESS | 17743 | RSS: Main: 191213568 10:38:52 INFO - PROCESS | 17743 | 10:38:56 INFO - PROCESS | 17743 | Cycle 1(1): loaded http://localhost:56847/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56847/tests/kraken/driver.html?testName=audio-fft) 10:38:56 INFO - PROCESS | 17743 | RSS: Main: 269914112 10:38:56 INFO - PROCESS | 17743 | 10:38:58 INFO - PROCESS | 17743 | Cycle 1(1): loaded http://localhost:56847/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56847/tests/kraken/driver.html?testName=audio-oscillator) 10:38:59 INFO - PROCESS | 17743 | RSS: Main: 180625408 10:38:59 INFO - PROCESS | 17743 | 10:39:01 INFO - PROCESS | 17743 | Cycle 1(1): loaded http://localhost:56847/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56847/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:39:02 INFO - PROCESS | 17743 | RSS: Main: 184651776 10:39:02 INFO - PROCESS | 17743 | 10:39:05 INFO - PROCESS | 17743 | Cycle 1(1): loaded http://localhost:56847/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56847/tests/kraken/driver.html?testName=imaging-darkroom) 10:39:06 INFO - PROCESS | 17743 | RSS: Main: 221458432 10:39:06 INFO - PROCESS | 17743 | 10:39:09 INFO - PROCESS | 17743 | Cycle 1(1): loaded http://localhost:56847/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56847/tests/kraken/driver.html?testName=imaging-desaturate) 10:39:10 INFO - PROCESS | 17743 | RSS: Main: 214835200 10:39:10 INFO - PROCESS | 17743 | 10:39:13 INFO - PROCESS | 17743 | Cycle 1(1): loaded http://localhost:56847/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56847/tests/kraken/driver.html?testName=json-parse-financial) 10:39:13 INFO - PROCESS | 17743 | RSS: Main: 217632768 10:39:13 INFO - PROCESS | 17743 | 10:39:15 INFO - PROCESS | 17743 | Cycle 1(1): loaded http://localhost:56847/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56847/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:39:16 INFO - PROCESS | 17743 | RSS: Main: 181587968 10:39:16 INFO - PROCESS | 17743 | 10:39:18 INFO - PROCESS | 17743 | Cycle 1(1): loaded http://localhost:56847/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56847/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:39:18 INFO - PROCESS | 17743 | RSS: Main: 188444672 10:39:18 INFO - PROCESS | 17743 | 10:39:20 INFO - PROCESS | 17743 | Cycle 1(1): loaded http://localhost:56847/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56847/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:39:21 INFO - PROCESS | 17743 | RSS: Main: 193691648 10:39:21 INFO - PROCESS | 17743 | 10:39:24 INFO - PROCESS | 17743 | Cycle 1(1): loaded http://localhost:56847/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56847/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:39:24 INFO - PROCESS | 17743 | RSS: Main: 188137472 10:39:24 INFO - PROCESS | 17743 | 10:39:27 INFO - PROCESS | 17743 | Cycle 1(1): loaded http://localhost:56847/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56847/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:39:28 INFO - PROCESS | 17743 | RSS: Main: 192245760 10:39:28 INFO - PROCESS | 17743 | 10:39:30 INFO - PROCESS | 17743 | Cycle 1(1): loaded http://localhost:56847/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56847/tests/kraken/driver.html?testName=ai-astar) 10:39:30 INFO - PROCESS | 17743 | RSS: Main: 242851840 10:39:30 INFO - PROCESS | 17743 | 10:39:30 INFO - PROCESS | 17743 | __start_tp_report 10:39:30 INFO - PROCESS | 17743 | _x_x_mozilla_page_load 10:39:30 INFO - PROCESS | 17743 | _x_x_mozilla_page_load_details 10:39:30 INFO - PROCESS | 17743 | |i|pagename|runs| 10:39:30 INFO - PROCESS | 17743 | |0;ai-astar;106;115;118;115;114;116;115;115;116;117 10:39:30 INFO - PROCESS | 17743 | |1;audio-beat-detection;152;121;123;186;127;129;148;122;157;122 10:39:30 INFO - PROCESS | 17743 | |2;audio-dft;161;161;161;163;161;160;161;161;161;159 10:39:30 INFO - PROCESS | 17743 | |3;audio-fft;76;78;75;118;76;76;74;77;120;80 10:39:30 INFO - PROCESS | 17743 | |4;audio-oscillator;88;87;123;86;86;86;118;86;86;136 10:39:30 INFO - PROCESS | 17743 | |5;imaging-gaussian-blur;116;116;116;116;117;117;117;116;116;117 10:39:30 INFO - PROCESS | 17743 | |6;imaging-darkroom;147;147;146;147;146;146;146;146;146;147 10:39:30 INFO - PROCESS | 17743 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 10:39:30 INFO - PROCESS | 17743 | |8;json-parse-financial;63;63;63;64;64;66;64;64;63;63 10:39:30 INFO - PROCESS | 17743 | |9;json-stringify-tinderbox;65;66;65;65;67;65;65;66;65;65 10:39:30 INFO - PROCESS | 17743 | |10;stanford-crypto-aes;83;83;83;83;84;84;82;83;83;82 10:39:30 INFO - PROCESS | 17743 | |11;stanford-crypto-ccm;150;133;133;136;141;132;140;133;160;133 10:39:30 INFO - PROCESS | 17743 | |12;stanford-crypto-pbkdf2;176;173;170;174;174;173;176;176;170;171 10:39:30 INFO - PROCESS | 17743 | |13;stanford-crypto-sha256-iterative;71;79;72;70;70;69;68;69;68;67 10:39:30 INFO - PROCESS | 17743 | __end_tp_report 10:39:30 INFO - PROCESS | 17743 | __start_cc_report 10:39:30 INFO - PROCESS | 17743 | _x_x_mozilla_cycle_collect,1934 10:39:30 INFO - PROCESS | 17743 | __end_cc_report 10:39:30 INFO - PROCESS | 17743 | __startTimestamp1471628370595__endTimestamp 10:39:30 INFO - PROCESS | 17743 | 10:39:30 INFO - PROCESS | 17743 | ------- Summary: start ------- 10:39:30 INFO - PROCESS | 17743 | Number of tests: 14 10:39:30 INFO - PROCESS | 17743 | 10:39:30 INFO - PROCESS | 17743 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.50 stddev:3.27 (2.8%) stddev-sans-first:1.22 10:39:30 INFO - PROCESS | 17743 | Values: 106.0 115.0 118.0 115.0 114.0 116.0 115.0 115.0 116.0 117.0 10:39:30 INFO - PROCESS | 17743 | 10:39:30 INFO - PROCESS | 17743 | [#1] audio-beat-detection Cycles:10 Average:138.70 Median:138.50 stddev:21.56 (15.6%) stddev-sans-first:22.33 10:39:30 INFO - PROCESS | 17743 | Values: 152.0 121.0 123.0 186.0 127.0 129.0 148.0 122.0 157.0 122.0 10:39:30 INFO - PROCESS | 17743 | 10:39:30 INFO - PROCESS | 17743 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 10:39:30 INFO - PROCESS | 17743 | Values: 161.0 161.0 161.0 163.0 161.0 160.0 161.0 161.0 161.0 159.0 10:39:30 INFO - PROCESS | 17743 | 10:39:30 INFO - PROCESS | 17743 | [#3] audio-fft Cycles:10 Average:85.00 Median:76.00 stddev:18.00 (23.7%) stddev-sans-first:18.79 10:39:30 INFO - PROCESS | 17743 | Values: 76.0 78.0 75.0 118.0 76.0 76.0 74.0 77.0 120.0 80.0 10:39:30 INFO - PROCESS | 17743 | 10:39:30 INFO - PROCESS | 17743 | [#4] audio-oscillator Cycles:10 Average:98.20 Median:86.00 stddev:19.46 (22.6%) stddev-sans-first:20.29 10:39:30 INFO - PROCESS | 17743 | Values: 88.0 87.0 123.0 86.0 86.0 86.0 118.0 86.0 86.0 136.0 10:39:30 INFO - PROCESS | 17743 | 10:39:30 INFO - PROCESS | 17743 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:39:30 INFO - PROCESS | 17743 | Values: 116.0 116.0 116.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 10:39:30 INFO - PROCESS | 17743 | 10:39:30 INFO - PROCESS | 17743 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:39:30 INFO - PROCESS | 17743 | Values: 147.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 10:39:30 INFO - PROCESS | 17743 | 10:39:30 INFO - PROCESS | 17743 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 10:39:30 INFO - PROCESS | 17743 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 10:39:30 INFO - PROCESS | 17743 | 10:39:30 INFO - PROCESS | 17743 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:64.00 stddev:0.95 (1.5%) stddev-sans-first:0.97 10:39:30 INFO - PROCESS | 17743 | Values: 63.0 63.0 63.0 64.0 64.0 66.0 64.0 64.0 63.0 63.0 10:39:30 INFO - PROCESS | 17743 | 10:39:30 INFO - PROCESS | 17743 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 10:39:30 INFO - PROCESS | 17743 | Values: 65.0 66.0 65.0 65.0 67.0 65.0 65.0 66.0 65.0 65.0 10:39:30 INFO - PROCESS | 17743 | 10:39:30 INFO - PROCESS | 17743 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 10:39:30 INFO - PROCESS | 17743 | Values: 83.0 83.0 83.0 83.0 84.0 84.0 82.0 83.0 83.0 82.0 10:39:30 INFO - PROCESS | 17743 | 10:39:30 INFO - PROCESS | 17743 | [#11] stanford-crypto-ccm Cycles:10 Average:139.10 Median:138.00 stddev:9.24 (6.7%) stddev-sans-first:8.92 10:39:30 INFO - PROCESS | 17743 | Values: 150.0 133.0 133.0 136.0 141.0 132.0 140.0 133.0 160.0 133.0 10:39:30 INFO - PROCESS | 17743 | 10:39:30 INFO - PROCESS | 17743 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.30 Median:174.00 stddev:2.36 (1.4%) stddev-sans-first:2.29 10:39:30 INFO - PROCESS | 17743 | Values: 176.0 173.0 170.0 174.0 174.0 173.0 176.0 176.0 170.0 171.0 10:39:30 INFO - PROCESS | 17743 | 10:39:30 INFO - PROCESS | 17743 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.00 stddev:3.40 (4.9%) stddev-sans-first:3.60 10:39:30 INFO - PROCESS | 17743 | Values: 71.0 79.0 72.0 70.0 70.0 69.0 68.0 69.0 68.0 67.0 10:39:30 INFO - PROCESS | 17743 | -------- Summary: end -------- 10:39:30 INFO - PROCESS | 17743 | 10:39:31 INFO - TEST-INFO | 17743: exit 0 10:39:31 INFO - TEST-OK | kraken | took 63759ms 10:39:31 INFO - SUITE-END | took 1183s 10:39:31 INFO - Completed test suite (00:19:43) 10:39:31 INFO - javascript benchmark 10:39:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2592.46854394849, 2623.2654856640147, 2636.459525797212, 2643.207037888632, 2645.0477827981936, 4593.816247350102, 4597.88505287368, 4678.625709943205, 4752.263399173129, 4757.119932812432, 4655.697379670319, 4666.673332866701, 4695.225287827513, 4702.741349225791, 4715.2455607102875, 4307.138572285539, 4310.676699247553, 4381.846635367763, 4388.626966707834, 4444.511103778582, 4397.142557201347, 4413.227685155101, 4435.4899186593475, 4437.445319335083, 4438.156750217465, 4206.074663574009, 4246.808893599765, 4344.500382456026, 4358.585934336233, 4396.20868243716, 4253.085586598865, 4288.678349123797, 4288.892777680552, 4310.849120280775, 4383.539728328511, 4335.219660461115, 4340.283853164224, 4344.6089851913475, 4346.304591265382, 4349.108432771274, 4515.954840451586, 4611.492735799059, 4712.128256272601, 4766.0, 4768.499307572724, 4919.7540122993705, 4998.925016124761, 5007.2489126630935, 5010.899782004376, 5017.974910125463, 5017.724025178613, 5018.623603229736, 5022.447530771612, 5028.7737051832755, 5048.268001139851, 4628.375169352094, 4694.131585656664, 4724.055188962221, 4732.550407711227, 4756.381670382828, 5211.5830733541225, 5225.16397376418, 5231.084560201949, 5236.450172731885, 5237.921431178535, 5023.321851550067, 5032.72320022395, 5038.042771873405, 5039.546440820343, 5041.924371134362, 4913.901721965541, 4979.726115063634, 5053.0399224147295, 5112.182050871843, 5112.488751124858, 5057.494250574913, 5060.468650791688, 5066.620003499752, 5078.568321692624, 5084.847454576368, 5063.620228482879, 5068.315777370008, 5072.847814565569, 5078.314427552307, 5081.8475445736685, 4141.275276826544, 4182.895427614273, 4194.832206711759, 4302.096559722493, 4310.418093557392, 3696.057505336122, 3735.701143908481, 3752.3058234226755, 3771.5097037384962, 3796.962030379716, 4334.111507141029, 4345.804438800262, 4346.587074228007, 4353.194658988097, 4360.694751367374, 4940.086084074458, 4956.504349565014, 5095.439501654815, 5096.719680417613, 5097.719625420564, 4256.233877902007, 4315.611594956406, 4320.611144996966, 4327.545607711208, 4330.956690433119, 4557.1797076526545, 4562.110388474282, 4564.680472366969, 4567.063751930847, 4567.2920697291975, 4603.125406172817, 4692.812287508462, 4795.664303498791, 4804.903901922012, 4808.543188397097, 4996.425411077773, 5067.7212753297445, 5089.51649593288, 5100.311457953128, 5103.260027295947, 4776.808927642995, 4782.402199725035, 4794.041191761592, 4796.616270698406, 4805.567498925114, 4874.171390863491, 4916.631252656137, 4999.725015124203, 5013.423456302572, 5013.724245166551, 5006.824761133343, 5093.286939828353, 5099.592032637454, 5106.846794596168, 5122.078025955215, 4954.826581069645, 4975.253711943237, 4975.5522003019905, 4980.377452818398, 4986.825461108844, 4781.880452988703, 4869.513048695102, 4948.282499037691, 4955.083309587738, 4966.602671786176, 4818.951810481991, 4904.239842824368, 4928.728919909439, 4931.13705101613, 4932.8520144395725, 5013.699178049329, 5015.423226329019, 5027.2207807789855, 5029.59763218949, 5032.3206367139965, 4689.226277664147, 4744.976275118603, 4917.58200552957, 4919.286703428054, 4926.285688575208], "value": 4637.983523539715, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.9268195134633, 563.4872266237725, 565.1692012741271, 570.7374607680468, 577.4600748300342, 38547.22905541887, 40528.59471405289, 40666.186676266494, 43796.3430548542, 43890.0, 39462.80268598653, 40055.79972100143, 40145.19709605806, 40166.0, 40202.7989860051, 7483.812904677386, 7685.961570192141, 7697.076350837908, 7713.5757533335645, 7730.458867879251, 7573.621318934059, 7683.0, 7703.730369437071, 7707.267809558083, 7711.344535714443, 7680.769576912701, 7728.922710772877, 7737.883931741, 7742.109657389416, 7743.0, 7654.961725191394, 7661.578613176273, 7699.884501732478, 7713.537187768724, 7716.807079822993, 7503.174650788409, 7574.8485030299635, 7586.734464293779, 7588.241175882367, 7592.696292148307, 37256.254874902625, 37549.81225093884, 37745.81127094347, 37823.0, 37824.0, 2938.0, 3066.861991210401, 3187.0438868339406, 3298.967010329914, 3444.225049363898, 28711.282217944718, 29196.562051569243, 29898.0, 29987.850060749774, 30003.099907002827, 3394.4555227371734, 3402.795832250073, 3408.0, 3424.931501369959, 3488.773229740084, 245716.0, 245759.0, 245798.0, 246034.0, 246746.9999999982, 29735.40529189404, 49159.0, 49464.0, 49538.0, 49564.25653615199, 29554.556681649792, 29622.555661665094, 29635.369279836763, 29645.555316670267, 29646.258843529085, 11275.097992160607, 11358.26171298863, 11361.204715669988, 11368.147388945863, 11375.886241137649, 9295.442273463614, 9354.345195836226, 9363.4381937084, 9363.485008324471, 9469.053094690476, 7578.280063393969, 7627.237276272328, 7668.80827979305, 7687.769366919001, 7694.576798276036, 3062.647795503501, 3097.519884417919, 3097.969020309813, 3122.1414111119625, 3128.8086152124706, 823.6952327638812, 852.8720691896265, 893.0712059458091, 941.430434587065, 970.8786401699788, 25284.620730689054, 26054.73945260523, 26573.468530629278, 26739.732602674114, 26788.866055669987, 933.696548621687, 938.5776400619612, 947.9052094790466, 960.9759756006156, 1072.6406653771073, 14044.227567483682, 14203.0, 14329.57011289663, 14370.353334099991, 14540.41838326455, 292510.0, 295047.0, 295752.0, 296193.0, 296822.0, 44043.55956440459, 44660.776696116314, 44682.77658611686, 44715.776421117684, 44858.999999999345, 1057.8360354144966, 1138.584416687903, 1146.2091157101572, 1149.5286932357694, 1194.3371428857067, 25929.6110558338, 28450.57324140098, 28731.281717956383, 29154.271143221587, 29256.268593284487, 39826.80086599549, 40288.19423611453, 40292.59707402888, 40318.39522407225, 40333.0, 281350.0, 283058.0, 283744.0, 283989.0, 284015.0, 22092.447688807908, 24018.51962960696, 24878.875605621855, 24913.750862491142, 24930.0, 39857.40213896852, 39922.401163983144, 40000.799995999834, 40391.192176155724, 40465.79767101146, 33938.06083935252, 34068.14829629279, 34183.82908085443, 34308.65691343055, 34362.656373435944, 34755.652443476254, 35068.64931350654, 35419.29161416809, 35474.290514190085, 35477.29045419129, 33657.15857103592, 34642.133946651535, 34787.65212347844, 34867.302653947285, 34869.47695784616, 30218.2445438857, 31805.0, 31928.36143277168, 32081.0, 32234.677653224106, 23890.40273993164, 23912.880435598407, 24351.51296974086, 24551.897873701993, 24802.25593232206], "value": 15743.826992233086, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.93911065563555, 367.5644361431703, 370.1578907984335, 372.98881033568983, 388.8017111273252, 12827.615171544858, 15792.210389480522, 16494.83505164948, 17081.14594270288, 17130.229139688712, 13024.479020839155, 13485.46058157675, 13774.380152893118, 14290.785638215435, 14377.712445751078, 4421.292593185091, 4720.126776546342, 4872.853814385574, 4884.096442158194, 5299.33758280215, 5101.285819985205, 5184.844454666366, 5186.636935414523, 5186.974065129669, 5194.506521880416, 4791.329213910055, 4852.830150944717, 5167.354080739908, 5169.87075323118, 5171.844844654666, 4751.287306903975, 4809.038192361541, 4815.398075240595, 4815.5906747926465, 4819.301201325806, 4580.427446569179, 4622.375979242793, 4664.603508701764, 4684.695494792828, 4687.273472611751, 20781.376558703265, 20782.5843483131, 20840.0, 20896.47758806027, 20990.0, 1813.4559632110445, 1853.3420635674277, 1859.2748827957107, 1893.4982229709137, 1949.3761996161234, 8994.546050605493, 9549.809003819884, 9769.071938165864, 12274.631761047094, 12937.48250069996, 1713.271859459737, 1728.5419363868584, 1737.652469506104, 1766.4877185616285, 1799.4151900632216, 66440.3355966439, 68413.0, 68670.3132968669, 70110.2988970114, 71885.6405717968, 9837.163841073589, 9897.703068907944, 9958.551865166084, 10130.0, 10178.541965611565, 13819.930900345435, 13856.653583660489, 13857.722845543032, 13880.93059534696, 13882.93058534721, 6651.201855777241, 6754.527183097136, 6904.896426553606, 7030.437564994891, 7032.261612530713, 6234.314225435199, 6265.339684983483, 6397.232332120176, 6405.551611387252, 6451.0, 4297.5702429756775, 4306.892327691833, 4307.90362956803, 4388.802503887333, 4427.911441771146, 1769.2480695704273, 1819.4723530176366, 1828.570285982793, 1834.6972749496451, 1876.4800511585659, 623.7317953280042, 807.834393949239, 859.5229647545672, 918.8759517465056, 950.50098698184, 16544.0, 16577.088260145567, 17117.743233851503, 17400.39098631542, 17835.375761848532, 804.4449329962307, 805.2683322053055, 807.2250639386137, 807.5114555693838, 836.0385556609947, 7722.652480638385, 9279.211267042378, 9568.95215523918, 9672.854907176397, 9809.264305177141, 370254.0, 370534.0, 371984.0, 380150.0, 383489.0, 69424.0, 77035.0, 77607.61196194096, 78803.0, 79877.20122798698, 904.9864252036093, 914.1681070226063, 941.2187884056217, 941.2328951904176, 942.6370847223868, 14926.77609835875, 15000.924995374953, 15565.76651350208, 15775.0, 15875.0, 37107.814460927526, 37340.626593733716, 37627.24745505129, 38101.809490952364, 38540.42189367218, 50437.0, 50721.49278507168, 51475.0, 52164.47835521748, 52186.0, 6561.737530498726, 7501.549907005598, 7672.578008209602, 7831.530108193527, 7842.098158711821, 8882.511461869659, 11111.555537778722, 11264.94367528157, 11878.940605296919, 11991.340476273539, 9797.559109840216, 9889.85165222508, 10012.39925604466, 10487.37075775456, 10576.894231057899, 9833.459159746282, 9916.454594997344, 10130.898691012995, 10156.949215253877, 10399.012093851072, 9392.906070939476, 10007.449590272605, 10320.174386048948, 10334.379937203792, 10402.219833512669, 7475.252474752481, 7584.431167662337, 7635.350995165251, 7787.143414224318, 7986.3610911128135, 9214.539273036187, 9386.487134409505, 9899.455529945923, 9977.700668979942, 10297.794044118926], "value": 7983.895201192364, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.2474589483995, 1376.36687123923, 1394.2331717555348, 1587.2936543238263, 1639.5163426789088, 7245.927540724591, 7872.37021038317, 7887.329576985956, 7892.526448413099, 7895.526268423891, 6684.398404143626, 7246.420286377091, 7418.183999760022, 7504.024476818006, 7656.0, 2195.242641288753, 2215.2357436684397, 2217.1463986365284, 2218.5562887422498, 2227.376334626307, 2139.0588141217813, 2154.450615093157, 2188.4310079379397, 2195.374318319279, 2198.9450263743374, 2130.4141361125658, 2132.040581738216, 2136.0494579911947, 2148.785121487854, 2172.880491572963, 2138.0, 2141.239859849762, 2144.281665642012, 2144.8069673729283, 2145.410012246629, 2127.0322003488377, 2155.5904378168257, 2160.7839216078264, 2170.2078741259484, 2171.945701357479, 7630.8855367169535, 7631.084269887649, 7699.769006929801, 7722.189170137167, 7748.7675369739, 4195.077083041726, 4279.229738647043, 4332.28517294646, 4332.458442694663, 4334.024844410014, 2788.177487641151, 2878.280429892527, 2903.056506635352, 2907.4039821836473, 2917.6352955880516, 860.1828263150032, 935.7894473743421, 959.1463597398321, 960.4717405426987, 974.3179774158118, 10350.327228730184, 10394.272400931937, 10395.116415104725, 10441.47792610374, 10488.685339439753, 3825.407061905409, 4033.253848038122, 4117.476533682557, 4118.794060296973, 4191.2874811281545, 8923.643054277756, 8923.73228803137, 8934.151255630704, 8941.105889411137, 8946.239569636524, 4294.677899157576, 4295.4201182839915, 4299.656027517791, 4304.268274393361, 4304.397384366192, 3442.7590068695454, 3727.105494681311, 3885.708571857122, 3885.8445662173763, 3888.0862997195636, 3457.844397002141, 3506.0891813961452, 3578.3380074686265, 3601.891943241707, 3630.1832087780567, 1112.4548971004149, 1120.1430905357408, 1120.5376983037215, 1127.1208457403238, 1135.0635725526474, 795.4670370851543, 795.7334293011905, 798.5049269452976, 801.3789313282252, 814.2630919018297, 4954.133026720309, 5107.821226257063, 5166.509181627739, 5166.535011848877, 5323.1216849219445, 392.66231041304457, 394.52065740125886, 403.0427734131438, 412.0317254452014, 415.91265834174555, 3556.395412779834, 3558.964410355915, 3592.1199306170156, 3594.5506811648543, 3641.7997010164167, 8935.955320223356, 9223.939246986549, 9297.116773906468, 9346.439213647203, 9360.391574547633, 9092.136247056518, 9205.401648892801, 9234.907650923538, 9268.397554158959, 9274.350795444254, 6588.571742836701, 6706.853806781881, 6786.796396108125, 6806.863862722717, 6815.045893574805, 5040.798368065236, 5106.055379754757, 5118.181091025567, 5119.488051195, 5137.33214682089, 8329.708460203863, 8552.529610871214, 8568.271696905833, 8577.571121444027, 8641.8703719443, 8615.439996400213, 8736.0, 8835.55822208874, 8974.057723939153, 8983.326250531367, 5611.438856114356, 6254.2807577129215, 6317.241930968129, 6390.137331460193, 6400.135981642418, 7198.316159964795, 7372.778816635509, 7437.739679111205, 7467.477276590804, 7488.138864030706, 6134.294556125924, 6198.411150940653, 6329.177206963065, 6358.809235722936, 6403.07155462446, 6232.906506402498, 6272.059191121369, 6272.560920735505, 6298.02380631003, 6312.5581209314905, 5774.191613174243, 5867.20792692981, 5871.559633027455, 5875.177475153397, 5884.087966365049, 4270.252705776539, 4301.44081269433, 4392.714473559208, 4465.843695470643, 4557.612602928655, 4359.128174365203, 4371.278739008155, 4396.978015110032, 4522.525134860793, 4647.697899636512], "value": 3923.728319138539, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.98350098994075, 291.92118128105415, 292.23288866724846, 297.9806312589682, 306.2359413263906, 4792.976035119824, 4860.295257187706, 4879.926801097987, 4890.437599676038, 4895.118878601855, 4577.816887324503, 4697.5302469753005, 4699.506551812054, 4703.553162449571, 4814.325994360784, 3655.817209139546, 3677.816109194543, 3689.114612492996, 3725.8137093145233, 3781.6218378162102, 3775.905602359949, 3784.9053773655605, 3794.1083845296334, 3800.7909564973916, 3800.9809950950207, 3670.4310831821113, 3745.7826206482864, 3773.3962565989445, 3777.1312598102454, 3778.2254637799324, 3757.7745335279697, 3762.830672619739, 3766.5291838520184, 3768.2463507298376, 3777.5466943966626, 3314.4090836398423, 3314.685104915029, 3318.104111889776, 3322.601287845474, 3336.4995250712586, 4708.95291047092, 4716.52834716529, 4724.9682636466305, 4728.432588089451, 4739.834105806315, 4128.823285363657, 4286.678499112579, 4300.9139817203795, 4313.956860431418, 4326.415933848922, 5024.773885175139, 5039.0, 5040.621953353513, 5053.5957123430035, 5053.646244762868, 3637.290728307981, 3637.9818100909592, 3641.326354624403, 3643.2531331077066, 3645.76302540334, 5134.409542902539, 5262.789628356138, 5271.156614941629, 5306.3632364116165, 5309.681419114865, 3707.1102935295335, 3717.888463346104, 3720.330340538729, 3726.4969229153717, 3728.440733889938, 3784.7161462890394, 3785.280796648628, 3813.142043040349, 3814.6948244140403, 3823.5794062653085, 4298.742075475481, 4317.870463886088, 4332.588404101605, 4346.326664234292, 4357.7385356878685, 4940.258961155783, 5008.524190201925, 5043.268726034705, 5064.670796398296, 5074.264231686385, 1304.5368894042479, 1319.7096638739463, 1323.6095351871222, 1326.423005992377, 1326.7877139657608, 845.5687599324266, 851.3402113362071, 881.0704706534667, 892.7589550821242, 902.9322800789967, 4438.356438316426, 4440.3339499074755, 4447.3773671685985, 4463.218936686132, 4480.708753930984, 5206.7917283309, 5215.113430716788, 5217.6694942789345, 5220.0, 5224.268602395668, 4245.3844192591905, 4426.9778651106535, 4429.49060857999, 4445.777711114431, 4506.436695413074, 2784.721527847199, 2785.763210127162, 2791.67895691998, 2793.69269380368, 2798.9300267493068, 4913.484084171182, 4915.459299477055, 4929.309896614477, 4936.259561065869, 4964.684358644962, 5123.820666276737, 5350.491703288181, 5372.677639341652, 5378.166384210375, 5405.594580406485, 4926.729029903389, 4967.838990039344, 4974.1543937530705, 4974.32846565709, 4980.352554168007, 5269.077911365419, 5279.155335146358, 5280.260763493037, 5284.0, 5292.338457692788, 4884.853454396374, 5125.513076257749, 5149.536541711264, 5162.793488260428, 5188.870278243074, 4960.404751429852, 4984.352034235671, 4984.775685094252, 4984.950150498448, 4985.277134815504, 3672.908177295589, 3690.3726366518295, 3691.4093745000673, 3713.832877520464, 3716.1267102230413, 5158.948410515997, 5254.527092561535, 5293.247511294028, 5296.655717378358, 5341.97329013368, 5085.796568137233, 5100.107481190703, 5102.107131251942, 5108.66793658411, 5118.667286626357, 5090.312807770903, 5098.235264710175, 5117.565006974449, 5123.948760512347, 5137.200225876832, 4902.166631672696, 5024.4975502450925, 5037.244413338029, 5041.470645582308, 5047.369078865142, 4923.286123511999, 4956.628252880976, 5133.255677926754, 5140.665856719302, 5143.097054090011, 5013.122703526796, 5017.623678224075, 5022.372203474566, 5024.145895197898, 5035.697858128524], "value": 3830.381595829093, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.8641272101577, 640.1965533255765, 672.885609446394, 685.4927353758219, 727.4362369163894, 12092.274463532183, 12729.745405091893, 12775.744485110292, 12796.424160912758, 13023.153495022816, 13488.66278343042, 13654.863451365483, 13666.726665466686, 13697.520586779465, 13750.58748237552, 621.2327775197627, 636.068160145387, 748.9513181643176, 757.5644004697293, 757.9166291707908, 744.601638123604, 760.3233122520961, 767.4742801181209, 767.8349154931716, 769.542122437149, 811.5009269299397, 811.6023148657144, 811.8782182672617, 812.0296245986019, 813.5078277642001, 645.3030726815028, 698.6541661877352, 807.2411932783165, 808.6603626476865, 808.9029316482001, 577.137179916024, 581.4941001328871, 582.8921649494857, 588.7262422973338, 588.8822235552864, 13643.863561364458, 13857.722845543032, 13863.168209907337, 13879.444822207099, 13887.58337249884, 13396.196228226338, 13409.46362145513, 13675.589732307948, 14379.928100359535, 14529.491467798682, 10897.455127243686, 11022.173336999756, 11093.778124437466, 11110.333379997226, 11196.216264861463, 3273.3597276659834, 3278.0821370016433, 3295.555100061509, 3308.123347312964, 3320.0371892151247, 63488.68255658738, 64157.679211603645, 64818.67590662016, 65554.34445655577, 66312.66843665799, 10981.231313807957, 10993.175511836644, 11031.338119712844, 11094.833577496343, 11270.182454386404, 20265.0, 20511.4872128198, 20556.79443205549, 20579.8971005144, 20671.689924651142, 7082.504224704221, 7197.604131772803, 7199.244079371695, 7204.3155900189395, 7232.312930271616, 3639.927201455956, 3643.9635603644156, 3735.6451137141926, 3796.6583007529457, 3826.1391186982705, 3012.2469382654335, 3115.2523394385184, 3119.0798714378857, 3124.562561241428, 3126.8436578171454, 498.49651851630114, 513.7482633509628, 514.2671692837691, 544.8365490352878, 568.2811243776625, 497.350957001117, 561.3011800308642, 578.8003138917067, 580.9390014048464, 590.1973316289842, 7417.369523590447, 7897.763067107996, 8002.679892804339, 8043.919560804317, 8495.617697203641, 542.1921337207532, 550.2763865516832, 551.0907003444349, 572.0503963420701, 580.8722081142142, 3684.1710615111388, 4033.5361433434946, 4043.353063509824, 4080.6123418275215, 4126.154138401621, 56185.438145618835, 76502.6174869122, 79253.60373198097, 79981.60009199916, 89288.0, 74260.0, 77947.61026194833, 82852.58573707093, 83159.58420207982, 83455.58272208722, 63647.0, 72438.2756172442, 73059.0, 76435.0, 77881.22118778853, 8377.162283771575, 8824.735257942271, 8887.244584210155, 8930.508822014852, 9075.273978081606, 43843.56156438395, 44748.55251447444, 44821.103577927606, 46184.53815461802, 47325.0, 56324.718376409495, 60308.396916032034, 61192.0, 63688.363116368244, 67229.32770672231, 11638.41807909618, 11813.173077884465, 12389.504419823106, 12448.875511244772, 12644.051696123011, 12313.26120432777, 12642.051846111395, 13038.739225215253, 13325.200487970753, 13474.730505390033, 11329.263597866442, 11525.135614828754, 11774.587889423829, 11822.881771182178, 11948.820767688318, 12182.634520964386, 12296.323702196465, 12854.376816761409, 12951.870481295067, 13094.803577946528, 11724.941375293069, 12234.021278297536, 12421.503139874665, 12728.23630582168, 12847.229166250056, 10147.594096236067, 10229.641962531276, 10638.361698298128, 10687.358758474516, 10800.567977280822, 9278.95360523193, 9964.501774911081, 10028.448435335835, 10036.548355323883, 10073.748156295858], "value": 6610.326467697732, "unit": "score"}], "name": "dromaeo_css", "value": 6220.2920961690315, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 118.0, 115.0, 114.0, 116.0, 115.0, 115.0, 116.0, 117.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 121.0, 123.0, 186.0, 127.0, 129.0, 148.0, 122.0, 157.0, 122.0], "value": 138.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 163.0, 161.0, 160.0, 161.0, 161.0, 161.0, 159.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 75.0, 118.0, 76.0, 76.0, 74.0, 77.0, 120.0, 80.0], "value": 85.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 123.0, 86.0, 86.0, 86.0, 118.0, 86.0, 86.0, 136.0], "value": 98.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 64.0, 64.0, 66.0, 64.0, 64.0, 63.0, 63.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 67.0, 65.0, 65.0, 66.0, 65.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 83.0, 84.0, 84.0, 82.0, 83.0, 83.0, 82.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 133.0, 133.0, 136.0, 141.0, 132.0, 140.0, 133.0, 160.0, 133.0], "value": 139.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 173.0, 170.0, 174.0, 174.0, 173.0, 176.0, 176.0, 170.0, 171.0], "value": 173.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 79.0, 72.0, 70.0, 70.0, 69.0, 68.0, 69.0, 68.0, 67.0], "value": 70.3, "unit": "score"}], "name": "kraken", "value": 1550.1999999999998, "alertThreshold": 2.0}]} 10:39:31 INFO - Return code: 0 10:39:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:39:31 INFO - # TBPL SUCCESS # 10:39:31 INFO - Running post-action listener: _resource_record_post_action 10:39:31 INFO - [mozharness: 2016-08-19 17:39:31.913506Z] Finished run-tests step (success) 10:39:31 INFO - Running post-run listener: _resource_record_post_run 10:39:31 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296972288; Read time: 20; Write time: 187388 10:39:31 INFO - TinderboxPrint: CPU usage
13.0% 10:39:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 10:39:31 INFO - TinderboxPrint: I/O write bytes / time
296,972,288 / 187,388 10:39:31 INFO - TinderboxPrint: CPU idle
8,336.5 (87.0%) 10:39:31 INFO - TinderboxPrint: CPU user
1,198.4 (12.5%) 10:39:31 INFO - TinderboxPrint: Swap in / out
0 / 0 10:39:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 15392768; Read time: 0; Write time: 3252 10:39:32 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 281579520; Read time: 0; Write time: 184136 10:39:32 INFO - Running post-run listener: _upload_blobber_files 10:39:32 INFO - Blob upload gear active. 10:39:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:39:32 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 10:39:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:39:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:39:32 INFO - (blobuploader) - INFO - Open directory for files ... 10:39:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:39:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:39:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:33 INFO - (blobuploader) - INFO - Done attempting. 10:39:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:39:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:39:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:34 INFO - (blobuploader) - INFO - Done attempting. 10:39:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:39:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:39:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:38 INFO - (blobuploader) - INFO - Done attempting. 10:39:38 INFO - (blobuploader) - INFO - Iteration through files over. 10:39:38 INFO - Return code: 0 10:39:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:39:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:39:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/567867ee099067f3161ed8e3ce730fa869ddd5a495ed99ea9a6253c99cde751929a1b28c084977ed29c46bf6f6a943bd902ce47648a527439bfcca7ee0e691b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/da99c72f4aa80556f80391db51d4023c7b1e29561c541ddfba8280fb8edb5a25d1d63e4558e367bd82b8be685efe948e66ace814abc4d62ff3dfd06c29b554d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aaf146bee192c87e7efa1a6d28b8eb1cfba394f4e3bddd480303662cefce297b45d3f49cf9b026abbcf4ef81f5ac232a5f956762f0b1b37a2f8fb9db6985672b"} 10:39:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:39:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:39:38 INFO - Contents: 10:39:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/567867ee099067f3161ed8e3ce730fa869ddd5a495ed99ea9a6253c99cde751929a1b28c084977ed29c46bf6f6a943bd902ce47648a527439bfcca7ee0e691b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/da99c72f4aa80556f80391db51d4023c7b1e29561c541ddfba8280fb8edb5a25d1d63e4558e367bd82b8be685efe948e66ace814abc4d62ff3dfd06c29b554d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aaf146bee192c87e7efa1a6d28b8eb1cfba394f4e3bddd480303662cefce297b45d3f49cf9b026abbcf4ef81f5ac232a5f956762f0b1b37a2f8fb9db6985672b"} 10:39:38 INFO - Running post-run listener: copy_logs_to_upload_dir 10:39:38 INFO - Copying logs to upload dir... 10:39:38 INFO - mkdir: /builds/slave/test/build/upload/logs 10:39:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1306.372782 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 46 secs) (at 2016-08-19 10:39:38.271908) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 10:39:38.275393) ========= 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=c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/567867ee099067f3161ed8e3ce730fa869ddd5a495ed99ea9a6253c99cde751929a1b28c084977ed29c46bf6f6a943bd902ce47648a527439bfcca7ee0e691b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/da99c72f4aa80556f80391db51d4023c7b1e29561c541ddfba8280fb8edb5a25d1d63e4558e367bd82b8be685efe948e66ace814abc4d62ff3dfd06c29b554d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aaf146bee192c87e7efa1a6d28b8eb1cfba394f4e3bddd480303662cefce297b45d3f49cf9b026abbcf4ef81f5ac232a5f956762f0b1b37a2f8fb9db6985672b"} build_url:https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011213 build_url: 'https://queue.taskcluster.net/v1/task/Gk_L1gfSQ5yQU8cm3aXw1g/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-Non-PGO/sha512/567867ee099067f3161ed8e3ce730fa869ddd5a495ed99ea9a6253c99cde751929a1b28c084977ed29c46bf6f6a943bd902ce47648a527439bfcca7ee0e691b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/da99c72f4aa80556f80391db51d4023c7b1e29561c541ddfba8280fb8edb5a25d1d63e4558e367bd82b8be685efe948e66ace814abc4d62ff3dfd06c29b554d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aaf146bee192c87e7efa1a6d28b8eb1cfba394f4e3bddd480303662cefce297b45d3f49cf9b026abbcf4ef81f5ac232a5f956762f0b1b37a2f8fb9db6985672b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 10:39:38.300028) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 10:39:38.300309) ========= 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=c6927cf182745ad25b1d38b9000001fe-1471626789.114161-1859915193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004631 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 10:39:38.383032) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 10:39:38.383378) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 10:39:38.383694) ========= ========= Total master_lag: 0.20 =========