builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1471987150.08 results: success (0) buildid: 20160823113035 builduid: eef621d86ad847eda10a4e9eb12ca50a revision: 6e17a469a1b137c535adee7e476f86ee9dfcc071 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 14:19:10.081887) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 14:19:10.082389) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 14:19:10.082663) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 14:19:10.110166) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 14:19:10.110517) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-23 14:19:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 59.5K=0.2s 2016-08-23 14:19:10 (59.5 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.382766 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 14:19:10.508727) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 14:19:10.509090) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016642 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 14:19:10.559419) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 14:19:10.559822) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6e17a469a1b137c535adee7e476f86ee9dfcc071 --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 6e17a469a1b137c535adee7e476f86ee9dfcc071 --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=7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-23 14:19:10,949 truncating revision to first 12 chars 2016-08-23 14:19:10,950 Setting DEBUG logging. 2016-08-23 14:19:10,950 attempt 1/10 2016-08-23 14:19:10,950 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6e17a469a1b1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-23 14:19:11,237 unpacking tar archive at: fx-team-6e17a469a1b1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.589327 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 14:19:11.163211) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 14:19:11.163540) ========= script_repo_revision: 6e17a469a1b137c535adee7e476f86ee9dfcc071 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 14:19:11.163975) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 14:19:11.164272) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 14:19:11.172926) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-23 14:19:11.173296) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:19:11 INFO - MultiFileLogger online at 20160823 14:19:11 in /builds/slave/test 14:19:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:19:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:19:11 INFO - {'append_to_log': False, 14:19:11 INFO - 'base_work_dir': '/builds/slave/test', 14:19:11 INFO - 'blob_upload_branch': 'Fx-Team', 14:19:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:19:11 INFO - 'branch': 'Fx-Team', 14:19:11 INFO - 'buildbot_json_path': 'buildprops.json', 14:19:11 INFO - 'config_files': ('talos/linux_config.py',), 14:19:11 INFO - 'default_actions': ('clobber', 14:19:11 INFO - 'read-buildbot-config', 14:19:11 INFO - 'download-and-extract', 14:19:11 INFO - 'populate-webroot', 14:19:11 INFO - 'create-virtualenv', 14:19:11 INFO - 'install', 14:19:11 INFO - 'run-tests'), 14:19:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:19:11 INFO - 'download_minidump_stackwalk': True, 14:19:11 INFO - 'download_symbols': 'ondemand', 14:19:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:19:11 INFO - 'tooltool.py': '/tools/tooltool.py', 14:19:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:19:11 INFO - '/tools/misc-python/virtualenv.py')}, 14:19:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:19:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:19:11 INFO - 'installer_path': 'installer.exe', 14:19:11 INFO - 'log_level': 'info', 14:19:11 INFO - 'log_name': 'talos', 14:19:11 INFO - 'log_to_console': True, 14:19:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:19:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:19:11 INFO - 'opt_config_files': (), 14:19:11 INFO - 'pip_index': False, 14:19:11 INFO - 'sps_profile': False, 14:19:11 INFO - 'sps_profile_interval': 0, 14:19:11 INFO - 'suite': 'dromaeojs', 14:19:11 INFO - 'system_bits': '32', 14:19:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:19:11 INFO - 'title': 'talos-linux64-ix-005', 14:19:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:19:11 INFO - 'use_talos_json': True, 14:19:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:19:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:19:11 INFO - 'work_dir': 'build'} 14:19:11 INFO - [mozharness: 2016-08-23 21:19:11.748655Z] Running clobber step. 14:19:11 INFO - Running pre-action listener: _resource_record_pre_action 14:19:11 INFO - Running main action method: clobber 14:19:11 INFO - rmtree: /builds/slave/test/build 14:19:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:19:12 INFO - Running post-action listener: _resource_record_post_action 14:19:12 INFO - [mozharness: 2016-08-23 21:19:12.490161Z] Finished clobber step (success) 14:19:12 INFO - [mozharness: 2016-08-23 21:19:12.490260Z] Running read-buildbot-config step. 14:19:12 INFO - Running pre-action listener: _resource_record_pre_action 14:19:12 INFO - Running main action method: read_buildbot_config 14:19:12 INFO - Using buildbot properties: 14:19:12 INFO - { 14:19:12 INFO - "project": "", 14:19:12 INFO - "product": "firefox", 14:19:12 INFO - "script_repo_revision": "production", 14:19:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:19:12 INFO - "repository": "", 14:19:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:19:12 INFO - "buildid": "20160823113035", 14:19:12 INFO - "pgo_build": "True", 14:19:12 INFO - "basedir": "/builds/slave/test", 14:19:12 INFO - "buildnumber": 1004, 14:19:12 INFO - "slavename": "talos-linux64-ix-005", 14:19:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:19:12 INFO - "platform": "ubuntu64_hw", 14:19:12 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:19:12 INFO - "branch": "fx-team", 14:19:12 INFO - "repo_path": "integration/fx-team", 14:19:12 INFO - "revision": "6e17a469a1b137c535adee7e476f86ee9dfcc071", 14:19:12 INFO - "stage_platform": "linux64-pgo", 14:19:12 INFO - "builduid": "eef621d86ad847eda10a4e9eb12ca50a", 14:19:12 INFO - "slavebuilddir": "test" 14:19:12 INFO - } 14:19:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/LB11U0A_QnO3IpL1biu6mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 14:19:12 INFO - Running post-action listener: _resource_record_post_action 14:19:12 INFO - [mozharness: 2016-08-23 21:19:12.492670Z] Finished read-buildbot-config step (success) 14:19:12 INFO - [mozharness: 2016-08-23 21:19:12.492758Z] Running download-and-extract step. 14:19:12 INFO - Running pre-action listener: _resource_record_pre_action 14:19:12 INFO - Running main action method: download_and_extract 14:19:12 INFO - mkdir: /builds/slave/test/build/tests 14: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')]} 14:19:12 INFO - trying https://queue.taskcluster.net/v1/task/LB11U0A_QnO3IpL1biu6mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:19:12 INFO - Downloading https://queue.taskcluster.net/v1/task/LB11U0A_QnO3IpL1biu6mg/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 14:19:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LB11U0A_QnO3IpL1biu6mg/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 14:19:13 INFO - Downloaded 1361 bytes. 14:19:13 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:19:13 INFO - Using the following test package requirements: 14:19:13 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:19:13 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:19:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:19:13 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:19:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:19:13 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:19:13 INFO - u'jsshell-linux-x86_64.zip'], 14:19:13 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:19:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:19:13 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:19:13 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:19:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:19:13 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:19:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:19:13 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:19:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:19:13 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:19:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:19:13 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:13 INFO - trying https://queue.taskcluster.net/v1/task/LB11U0A_QnO3IpL1biu6mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:19:13 INFO - Downloading https://queue.taskcluster.net/v1/task/LB11U0A_QnO3IpL1biu6mg/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 14:19:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LB11U0A_QnO3IpL1biu6mg/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 14:19:13 INFO - Downloaded 21914758 bytes. 14:19:13 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 14:19:18 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 14:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:18 INFO - trying https://queue.taskcluster.net/v1/task/LB11U0A_QnO3IpL1biu6mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:19:18 INFO - Downloading https://queue.taskcluster.net/v1/task/LB11U0A_QnO3IpL1biu6mg/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 14:19:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LB11U0A_QnO3IpL1biu6mg/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 14:19:19 INFO - Downloaded 21914758 bytes. 14:19:19 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 14:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:26 INFO - trying https://queue.taskcluster.net/v1/task/LB11U0A_QnO3IpL1biu6mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 14:19:26 INFO - Downloading https://queue.taskcluster.net/v1/task/LB11U0A_QnO3IpL1biu6mg/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 14:19:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LB11U0A_QnO3IpL1biu6mg/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 14:19:26 INFO - Downloaded 14413981 bytes. 14:19:26 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 14: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')]} 14:19:27 INFO - trying https://queue.taskcluster.net/v1/task/LB11U0A_QnO3IpL1biu6mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:19:27 INFO - Downloading https://queue.taskcluster.net/v1/task/LB11U0A_QnO3IpL1biu6mg/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 14:19:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LB11U0A_QnO3IpL1biu6mg/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 14:19:28 INFO - Downloaded 59734754 bytes. 14:19:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LB11U0A_QnO3IpL1biu6mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:19:28 INFO - mkdir: /builds/slave/test/properties 14:19:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:19:28 INFO - Writing to file /builds/slave/test/properties/build_url 14:19:28 INFO - Contents: 14:19:28 INFO - build_url:https://queue.taskcluster.net/v1/task/LB11U0A_QnO3IpL1biu6mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:19:28 INFO - Running post-action listener: _resource_record_post_action 14:19:28 INFO - Running post-action listener: set_extra_try_arguments 14:19:28 INFO - [mozharness: 2016-08-23 21:19:28.942956Z] Finished download-and-extract step (success) 14:19:28 INFO - [mozharness: 2016-08-23 21:19:28.943175Z] Running populate-webroot step. 14:19:28 INFO - Running pre-action listener: _resource_record_pre_action 14:19:28 INFO - Running main action method: populate_webroot 14:19:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:19:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:19:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:19:28 INFO - '--tppagecycles', 14:19:28 INFO - '7'], 14:19:28 INFO - 'tests': ['tsvgm']}}, 14:19:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:19:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:19:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:19:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:19:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:19:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:19:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:19:28 INFO - 'talos_options': ['--disable-e10s'], 14:19:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:19:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:19:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:19:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:19:28 INFO - 'talos_options': ['--disable-e10s'], 14:19:28 INFO - 'tests': ['damp', 'tps']}, 14:19:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:19:28 INFO - 'tests': ['damp', 'tps']}, 14:19:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:19:28 INFO - 'tests': ['dromaeo_dom']}, 14:19:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:19:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:19:28 INFO - 'tests': ['basic_compositor_video']}, 14:19:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:19:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:19:28 INFO - 'tests': ['a11yr', 14:19:28 INFO - 'ts_paint', 14:19:28 INFO - 'tpaint', 14:19:28 INFO - 'sessionrestore', 14:19:28 INFO - 'sessionrestore_no_auto_restore', 14:19:28 INFO - 'tabpaint']}, 14:19:28 INFO - 'other-e10s': {'tests': ['a11yr', 14:19:28 INFO - 'ts_paint', 14:19:28 INFO - 'tpaint', 14:19:28 INFO - 'sessionrestore', 14:19:28 INFO - 'sessionrestore_no_auto_restore', 14:19:28 INFO - 'tabpaint']}, 14:19:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:19:28 INFO - 'ts_paint', 14:19:28 INFO - 'tpaint', 14:19:28 INFO - 'sessionrestore', 14:19:28 INFO - 'sessionrestore_no_auto_restore', 14:19:28 INFO - 'tabpaint']}, 14:19:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:19:28 INFO - 'ts_paint', 14:19:28 INFO - 'tpaint', 14:19:28 INFO - 'sessionrestore', 14:19:28 INFO - 'sessionrestore_no_auto_restore', 14:19:28 INFO - 'tabpaint']}, 14:19:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:19:28 INFO - 'tests': ['a11yr', 14:19:28 INFO - 'ts_paint', 14:19:28 INFO - 'tpaint', 14:19:28 INFO - 'sessionrestore', 14:19:28 INFO - 'sessionrestore_no_auto_restore', 14:19:28 INFO - 'tabpaint']}, 14:19:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:19:28 INFO - 'tests': ['a11yr', 14:19:28 INFO - 'ts_paint', 14:19:28 INFO - 'tpaint', 14:19:28 INFO - 'sessionrestore', 14:19:28 INFO - 'sessionrestore_no_auto_restore', 14:19:28 INFO - 'tabpaint']}, 14:19:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:19:28 INFO - 'tests': ['tsvgx', 14:19:28 INFO - 'tsvgr_opacity', 14:19:28 INFO - 'tart', 14:19:28 INFO - 'tscrollx', 14:19:28 INFO - 'cart']}, 14:19:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:19:28 INFO - 'tsvgr_opacity', 14:19:28 INFO - 'tart', 14:19:28 INFO - 'tscrollx', 14:19:28 INFO - 'cart']}, 14:19:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:19:28 INFO - 'talos_options': ['--disable-e10s'], 14:19:28 INFO - 'tests': ['tp5o']}, 14:19:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:19:28 INFO - 'tests': ['tp5o']}, 14:19:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:19:28 INFO - 'talos_options': ['--disable-e10s', 14:19:28 INFO - '--xperf_path', 14:19:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:19:28 INFO - 'tests': ['tp5n']}, 14:19:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:19:28 INFO - 'talos_options': ['--xperf_path', 14:19:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:19:28 INFO - 'tests': ['tp5n']}}, 14:19:28 INFO - 'talos.zip': {'path': '', 14:19:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:19:28 INFO - Running post-action listener: _resource_record_post_action 14:19:28 INFO - [mozharness: 2016-08-23 21:19:28.962887Z] Finished populate-webroot step (success) 14:19:28 INFO - [mozharness: 2016-08-23 21:19:28.962974Z] Running create-virtualenv step. 14:19:28 INFO - Running pre-action listener: _resource_record_pre_action 14:19:28 INFO - Running main action method: create_virtualenv 14:19:28 INFO - Creating virtualenv /builds/slave/test/build/venv 14:19:28 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 14:19:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:19:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:19:29 INFO - Using real prefix '/usr' 14:19:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:19:30 INFO - Installing distribute.............................................................................................................................................................................................done. 14:19:32 INFO - Installing pip.................done. 14:19:32 INFO - Return code: 0 14:19:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:19:32 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')]} 14:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:32 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')]} 14:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:32 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 0x7f7c3548df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f51850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c370>, '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 0x1f4f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4fd80>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105', '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 14:19:32 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 14:19:32 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 14:19:32 INFO - Using env: {'DISPLAY': ':0', 14:19:32 INFO - 'HOME': '/home/cltbld', 14:19:32 INFO - 'LANG': 'en_US.UTF-8', 14:19:32 INFO - 'LANGUAGE': 'en_US:en', 14:19:32 INFO - 'LOGNAME': 'cltbld', 14:19:32 INFO - 'MAIL': '/var/mail/cltbld', 14:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:32 INFO - 'MOZ_NO_REMOTE': '1', 14:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:19:32 INFO - 'NO_EM_RESTART': '1', 14:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:32 INFO - 'PWD': '/builds/slave/test', 14:19:32 INFO - 'SHELL': '/bin/bash', 14:19:32 INFO - 'SHLVL': '1', 14:19:32 INFO - 'TERM': 'linux', 14:19:32 INFO - 'TMOUT': '86400', 14:19:32 INFO - 'USER': 'cltbld', 14:19:32 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105', 14:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:32 INFO - '_': '/tools/buildbot/bin/python'} 14:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:32 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 14:19:32 INFO - Cleaning up... 14:19:32 INFO - Return code: 0 14:19:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:19:32 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')]} 14:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:32 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')]} 14:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:32 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 0x7f7c3548df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f51850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c370>, '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 0x1f4f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4fd80>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105', '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 14:19:32 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 14:19:32 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 14:19:32 INFO - Using env: {'DISPLAY': ':0', 14:19:32 INFO - 'HOME': '/home/cltbld', 14:19:32 INFO - 'LANG': 'en_US.UTF-8', 14:19:32 INFO - 'LANGUAGE': 'en_US:en', 14:19:32 INFO - 'LOGNAME': 'cltbld', 14:19:32 INFO - 'MAIL': '/var/mail/cltbld', 14:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:32 INFO - 'MOZ_NO_REMOTE': '1', 14:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:19:32 INFO - 'NO_EM_RESTART': '1', 14:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:32 INFO - 'PWD': '/builds/slave/test', 14:19:32 INFO - 'SHELL': '/bin/bash', 14:19:32 INFO - 'SHLVL': '1', 14:19:32 INFO - 'TERM': 'linux', 14:19:32 INFO - 'TMOUT': '86400', 14:19:32 INFO - 'USER': 'cltbld', 14:19:32 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105', 14:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:32 INFO - '_': '/tools/buildbot/bin/python'} 14:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:32 INFO - Downloading/unpacking psutil>=3.1.1 14:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:19:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:19:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:19:34 INFO - Installing collected packages: psutil 14:19:34 INFO - Running setup.py install for psutil 14:19:34 INFO - building 'psutil._psutil_linux' extension 14:19:34 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 14:19:35 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 14:19:35 INFO - building 'psutil._psutil_posix' extension 14:19:35 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 14:19:35 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 14:19:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:19:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:19:36 INFO - Successfully installed psutil 14:19:36 INFO - Cleaning up... 14:19:36 INFO - Return code: 0 14:19:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:36 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 0x7f7c3548df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f51850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c370>, '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 0x1f4f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4fd80>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105', '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 14:19:36 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 14:19:36 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 14:19:36 INFO - Using env: {'DISPLAY': ':0', 14:19:36 INFO - 'HOME': '/home/cltbld', 14:19:36 INFO - 'LANG': 'en_US.UTF-8', 14:19:36 INFO - 'LANGUAGE': 'en_US:en', 14:19:36 INFO - 'LOGNAME': 'cltbld', 14:19:36 INFO - 'MAIL': '/var/mail/cltbld', 14:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:36 INFO - 'MOZ_NO_REMOTE': '1', 14:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:19:36 INFO - 'NO_EM_RESTART': '1', 14:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:36 INFO - 'PWD': '/builds/slave/test', 14:19:36 INFO - 'SHELL': '/bin/bash', 14:19:36 INFO - 'SHLVL': '1', 14:19:36 INFO - 'TERM': 'linux', 14:19:36 INFO - 'TMOUT': '86400', 14:19:36 INFO - 'USER': 'cltbld', 14:19:36 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105', 14:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:36 INFO - '_': '/tools/buildbot/bin/python'} 14:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:19:36 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 14:19:36 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 14:19:36 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 14:19:36 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 14:19:36 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 14:19:36 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 14:19:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:19:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:19:38 INFO - Installing collected packages: mozsystemmonitor 14:19:38 INFO - Running setup.py install for mozsystemmonitor 14:19:38 INFO - Successfully installed mozsystemmonitor 14:19:38 INFO - Cleaning up... 14:19:38 INFO - Return code: 0 14:19:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:38 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 0x7f7c3548df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f51850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c370>, '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 0x1f4f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4fd80>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105', '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 14:19:38 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 14:19:38 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 14:19:38 INFO - Using env: {'DISPLAY': ':0', 14:19:38 INFO - 'HOME': '/home/cltbld', 14:19:38 INFO - 'LANG': 'en_US.UTF-8', 14:19:38 INFO - 'LANGUAGE': 'en_US:en', 14:19:38 INFO - 'LOGNAME': 'cltbld', 14:19:38 INFO - 'MAIL': '/var/mail/cltbld', 14:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:38 INFO - 'MOZ_NO_REMOTE': '1', 14:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:19:38 INFO - 'NO_EM_RESTART': '1', 14:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:38 INFO - 'PWD': '/builds/slave/test', 14:19:38 INFO - 'SHELL': '/bin/bash', 14:19:38 INFO - 'SHLVL': '1', 14:19:38 INFO - 'TERM': 'linux', 14:19:38 INFO - 'TMOUT': '86400', 14:19:38 INFO - 'USER': 'cltbld', 14:19:38 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105', 14:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:38 INFO - '_': '/tools/buildbot/bin/python'} 14:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:38 INFO - Downloading/unpacking jsonschema==2.5.1 14:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:19:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:19:40 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 14:19:40 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 14:19:40 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 14:19:40 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 14:19:40 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 14:19:40 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 14:19:40 INFO - Downloading functools32-3.2.3-2.tar.gz 14:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:19:40 INFO - warning: no files found matching '*.txt' 14:19:40 INFO - no previously-included directories found matching 'build' 14:19:40 INFO - no previously-included directories found matching 'dist' 14:19:40 INFO - no previously-included directories found matching '.git*' 14:19:40 INFO - Installing collected packages: jsonschema, functools32 14:19:40 INFO - Running setup.py install for functools32 14:19:40 INFO - warning: no files found matching '*.txt' 14:19:40 INFO - no previously-included directories found matching 'build' 14:19:40 INFO - no previously-included directories found matching 'dist' 14:19:40 INFO - no previously-included directories found matching '.git*' 14:19:40 INFO - Successfully installed jsonschema functools32 14:19:40 INFO - Cleaning up... 14:19:40 INFO - Return code: 0 14:19:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:40 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 0x7f7c3548df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f51850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c370>, '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 0x1f4f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4fd80>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105', '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 14:19:40 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 14:19:40 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 14:19:40 INFO - Using env: {'DISPLAY': ':0', 14:19:40 INFO - 'HOME': '/home/cltbld', 14:19:40 INFO - 'LANG': 'en_US.UTF-8', 14:19:40 INFO - 'LANGUAGE': 'en_US:en', 14:19:40 INFO - 'LOGNAME': 'cltbld', 14:19:40 INFO - 'MAIL': '/var/mail/cltbld', 14:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:40 INFO - 'MOZ_NO_REMOTE': '1', 14:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:19:40 INFO - 'NO_EM_RESTART': '1', 14:19:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:40 INFO - 'PWD': '/builds/slave/test', 14:19:40 INFO - 'SHELL': '/bin/bash', 14:19:40 INFO - 'SHLVL': '1', 14:19:40 INFO - 'TERM': 'linux', 14:19:40 INFO - 'TMOUT': '86400', 14:19:40 INFO - 'USER': 'cltbld', 14:19:40 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105', 14:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:40 INFO - '_': '/tools/buildbot/bin/python'} 14:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:19:41 INFO - Cleaning up... 14:19:41 INFO - Return code: 0 14:19:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7c3548df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f51850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c370>, '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 0x1f4f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4fd80>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105', '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 14:19:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:19:41 INFO - Using env: {'DISPLAY': ':0', 14:19:41 INFO - 'HOME': '/home/cltbld', 14:19:41 INFO - 'LANG': 'en_US.UTF-8', 14:19:41 INFO - 'LANGUAGE': 'en_US:en', 14:19:41 INFO - 'LOGNAME': 'cltbld', 14:19:41 INFO - 'MAIL': '/var/mail/cltbld', 14:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:41 INFO - 'MOZ_NO_REMOTE': '1', 14:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:19:41 INFO - 'NO_EM_RESTART': '1', 14:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:41 INFO - 'PWD': '/builds/slave/test', 14:19:41 INFO - 'SHELL': '/bin/bash', 14:19:41 INFO - 'SHLVL': '1', 14:19:41 INFO - 'TERM': 'linux', 14:19:41 INFO - 'TMOUT': '86400', 14:19:41 INFO - 'USER': 'cltbld', 14:19:41 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105', 14:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:41 INFO - '_': '/tools/buildbot/bin/python'} 14:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:41 INFO - Downloading/unpacking blobuploader==1.2.4 14:19:41 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 14:19:41 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 14:19:41 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 14:19:41 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 14:19:41 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 14:19:41 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 14:19:43 INFO - Downloading blobuploader-1.2.4.tar.gz 14:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:19:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:19:43 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 14:19:43 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 14:19:43 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 14:19:43 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 14:19:43 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 14:19:43 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 14:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:19:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:19:43 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 14:19:43 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 14:19:43 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 14:19:43 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 14:19:43 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 14:19:43 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 14:19:43 INFO - Downloading docopt-0.6.1.tar.gz 14:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:19:44 INFO - Installing collected packages: blobuploader, requests, docopt 14:19:44 INFO - Running setup.py install for blobuploader 14:19:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:19:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:19:44 INFO - Running setup.py install for requests 14:19:44 INFO - Running setup.py install for docopt 14:19:44 INFO - Successfully installed blobuploader requests docopt 14:19:44 INFO - Cleaning up... 14:19:44 INFO - Return code: 0 14:19:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:19:44 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')]} 14:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:44 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')]} 14:19:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:44 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 0x7f7c3548df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f51850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c370>, '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 0x1f4f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4fd80>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105', '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 14:19:44 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 14:19:44 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 14:19:44 INFO - Using env: {'DISPLAY': ':0', 14:19:44 INFO - 'HOME': '/home/cltbld', 14:19:44 INFO - 'LANG': 'en_US.UTF-8', 14:19:44 INFO - 'LANGUAGE': 'en_US:en', 14:19:44 INFO - 'LOGNAME': 'cltbld', 14:19:44 INFO - 'MAIL': '/var/mail/cltbld', 14:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:44 INFO - 'MOZ_NO_REMOTE': '1', 14:19:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:19:44 INFO - 'NO_EM_RESTART': '1', 14:19:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:44 INFO - 'PWD': '/builds/slave/test', 14:19:44 INFO - 'SHELL': '/bin/bash', 14:19:44 INFO - 'SHLVL': '1', 14:19:44 INFO - 'TERM': 'linux', 14:19:44 INFO - 'TMOUT': '86400', 14:19:44 INFO - 'USER': 'cltbld', 14:19:44 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105', 14:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:44 INFO - '_': '/tools/buildbot/bin/python'} 14:19:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:19:44 INFO - Running setup.py (path:/tmp/pip-sq27Ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:19:44 INFO - Running setup.py (path:/tmp/pip-UuyauT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:19:44 INFO - Running setup.py (path:/tmp/pip-H70Xwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:19:45 INFO - Running setup.py (path:/tmp/pip-dAE9vO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:19:45 INFO - Running setup.py (path:/tmp/pip-LoIuu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:19:45 INFO - Running setup.py (path:/tmp/pip-GuWoEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:19:45 INFO - Running setup.py (path:/tmp/pip-sZmEU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:19:45 INFO - Running setup.py (path:/tmp/pip-pv9jdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:19:45 INFO - Running setup.py (path:/tmp/pip-zCaiAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:19:45 INFO - Running setup.py (path:/tmp/pip-0K5Zgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:19:45 INFO - Running setup.py (path:/tmp/pip-MF57YE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:19:45 INFO - Running setup.py (path:/tmp/pip-vP6NXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:19:45 INFO - Running setup.py (path:/tmp/pip-C25iLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:19:45 INFO - Running setup.py (path:/tmp/pip-CZrHdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:19:45 INFO - Running setup.py (path:/tmp/pip-SkqBsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:19:45 INFO - Running setup.py (path:/tmp/pip-MrcoI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:19:45 INFO - Running setup.py (path:/tmp/pip-G9puOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:19:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:19:46 INFO - Running setup.py install for manifestparser 14:19:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:19:46 INFO - Running setup.py install for mozcrash 14:19:46 INFO - Running setup.py install for mozdebug 14:19:46 INFO - Running setup.py install for mozdevice 14:19:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:19:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:19:46 INFO - Running setup.py install for mozfile 14:19:46 INFO - Running setup.py install for mozhttpd 14:19:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:19:46 INFO - Running setup.py install for mozinfo 14:19:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:19:46 INFO - Running setup.py install for mozInstall 14:19:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:19:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:19:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:19:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:19:46 INFO - Running setup.py install for mozleak 14:19:46 INFO - Running setup.py install for mozlog 14:19:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:19:47 INFO - Running setup.py install for moznetwork 14:19:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:19:47 INFO - Running setup.py install for mozprocess 14:19:47 INFO - Running setup.py install for mozprofile 14:19:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:19:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:19:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:19:47 INFO - Running setup.py install for mozrunner 14:19:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:19:47 INFO - Running setup.py install for mozscreenshot 14:19:47 INFO - Running setup.py install for moztest 14:19:47 INFO - Running setup.py install for mozversion 14:19:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:19:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:19:47 INFO - Cleaning up... 14:19:47 INFO - Return code: 0 14:19:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14: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')]} 14:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14: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')]} 14:19:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:47 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 0x7f7c3548df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f51850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c370>, '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 0x1f4f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4fd80>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105', '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 14:19:47 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 14:19:47 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 14:19:47 INFO - Using env: {'DISPLAY': ':0', 14:19:47 INFO - 'HOME': '/home/cltbld', 14:19:47 INFO - 'LANG': 'en_US.UTF-8', 14:19:47 INFO - 'LANGUAGE': 'en_US:en', 14:19:47 INFO - 'LOGNAME': 'cltbld', 14:19:47 INFO - 'MAIL': '/var/mail/cltbld', 14:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:47 INFO - 'MOZ_NO_REMOTE': '1', 14:19:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:19:47 INFO - 'NO_EM_RESTART': '1', 14:19:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:47 INFO - 'PWD': '/builds/slave/test', 14:19:47 INFO - 'SHELL': '/bin/bash', 14:19:47 INFO - 'SHLVL': '1', 14:19:47 INFO - 'TERM': 'linux', 14:19:47 INFO - 'TMOUT': '86400', 14:19:47 INFO - 'USER': 'cltbld', 14:19:47 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105', 14:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:47 INFO - '_': '/tools/buildbot/bin/python'} 14:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:19:48 INFO - Running setup.py (path:/tmp/pip-C_oUML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:19:48 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)) 14:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:19:48 INFO - Running setup.py (path:/tmp/pip-DqYoGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:19:48 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)) 14:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:19:48 INFO - Running setup.py (path:/tmp/pip-VqaoRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:19:48 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)) 14:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:19:48 INFO - Running setup.py (path:/tmp/pip-2vGzlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:19:48 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)) 14:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:19:48 INFO - Running setup.py (path:/tmp/pip-sXh1er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:19:48 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)) 14:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:19:48 INFO - Running setup.py (path:/tmp/pip-7Qlaiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:19:48 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)) 14:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:19:48 INFO - Running setup.py (path:/tmp/pip-SrcPYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:19:48 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)) 14:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:19:48 INFO - Running setup.py (path:/tmp/pip-eZ27uv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:19:48 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)) 14:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:19:48 INFO - Running setup.py (path:/tmp/pip-Kll4P0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:19:48 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)) 14:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:19:48 INFO - Running setup.py (path:/tmp/pip-VIOF6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:19:48 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)) 14:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:19:48 INFO - Running setup.py (path:/tmp/pip-jQV7Vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:19:48 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)) 14:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:19:48 INFO - Running setup.py (path:/tmp/pip-ybgngB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:19:48 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)) 14:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:19:48 INFO - Running setup.py (path:/tmp/pip-OTTsi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:19:48 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)) 14:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:19:48 INFO - Running setup.py (path:/tmp/pip-bXHNCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:19:49 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)) 14:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:19:49 INFO - Running setup.py (path:/tmp/pip-Nd_MGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:19:49 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)) 14:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:19:49 INFO - Running setup.py (path:/tmp/pip-DB01Ja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:19:49 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)) 14:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:19:49 INFO - Running setup.py (path:/tmp/pip-9M_pI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:19:49 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)) 14:19:49 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)) 14:19:49 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)) 14:19:49 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)) 14:19:49 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)) 14:19:49 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)) 14:19:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:19:49 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 14:19:49 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 14:19:49 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 14:19:49 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 14:19:49 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 14:19:49 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 14:19:51 INFO - Downloading blessings-1.6.tar.gz 14:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:19:51 INFO - Installing collected packages: blessings 14:19:51 INFO - Running setup.py install for blessings 14:19:51 INFO - Successfully installed blessings 14:19:51 INFO - Cleaning up... 14:19:51 INFO - Return code: 0 14:19:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:19:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:19:51 INFO - Reading from file tmpfile_stdout 14:19:51 INFO - Current package versions: 14:19:51 INFO - argparse == 1.2.1 14:19:51 INFO - blessings == 1.6 14:19:51 INFO - blobuploader == 1.2.4 14:19:51 INFO - docopt == 0.6.1 14:19:51 INFO - functools32 == 3.2.3-2 14:19:51 INFO - jsonschema == 2.5.1 14:19:51 INFO - manifestparser == 1.1 14:19:51 INFO - mozInstall == 1.12 14:19:51 INFO - mozcrash == 0.17 14:19:51 INFO - mozdebug == 0.1 14:19:51 INFO - mozdevice == 0.48 14:19:51 INFO - mozfile == 1.2 14:19:51 INFO - mozhttpd == 0.7 14:19:51 INFO - mozinfo == 0.9 14:19:51 INFO - mozleak == 0.1 14:19:51 INFO - mozlog == 3.3 14:19:51 INFO - moznetwork == 0.27 14:19:51 INFO - mozprocess == 0.23 14:19:51 INFO - mozprofile == 0.28 14:19:51 INFO - mozrunner == 6.12 14:19:51 INFO - mozscreenshot == 0.1 14:19:51 INFO - mozsystemmonitor == 0.3 14:19:51 INFO - moztest == 0.7 14:19:51 INFO - mozversion == 1.4 14:19:51 INFO - psutil == 3.1.1 14:19:51 INFO - requests == 1.2.3 14:19:51 INFO - wsgiref == 0.1.2 14:19:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:51 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 0x7f7c3548df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f51850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c370>, '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 0x1f4f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4fd80>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105', '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 14:19:51 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 14:19:51 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 14:19:51 INFO - Using env: {'DISPLAY': ':0', 14:19:51 INFO - 'HOME': '/home/cltbld', 14:19:51 INFO - 'LANG': 'en_US.UTF-8', 14:19:51 INFO - 'LANGUAGE': 'en_US:en', 14:19:51 INFO - 'LOGNAME': 'cltbld', 14:19:51 INFO - 'MAIL': '/var/mail/cltbld', 14:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:51 INFO - 'MOZ_NO_REMOTE': '1', 14:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:19:51 INFO - 'NO_EM_RESTART': '1', 14:19:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:51 INFO - 'PWD': '/builds/slave/test', 14:19:51 INFO - 'SHELL': '/bin/bash', 14:19:51 INFO - 'SHLVL': '1', 14:19:51 INFO - 'TERM': 'linux', 14:19:51 INFO - 'TMOUT': '86400', 14:19:51 INFO - 'USER': 'cltbld', 14:19:51 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105', 14:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:51 INFO - '_': '/tools/buildbot/bin/python'} 14:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:51 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)) 14:19:51 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)) 14:19:51 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)) 14:19:51 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)) 14:19:51 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)) 14:19:51 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)) 14:19:51 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)) 14:19:51 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)) 14:19:51 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)) 14:19:51 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)) 14:19:51 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)) 14:19:51 INFO - Cleaning up... 14:19:51 INFO - Return code: 0 14:19:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:51 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 0x7f7c3548df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f51850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c370>, '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 0x1f4f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4fd80>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105', '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 14:19:51 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 14:19:51 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 14:19:51 INFO - Using env: {'DISPLAY': ':0', 14:19:51 INFO - 'HOME': '/home/cltbld', 14:19:51 INFO - 'LANG': 'en_US.UTF-8', 14:19:51 INFO - 'LANGUAGE': 'en_US:en', 14:19:51 INFO - 'LOGNAME': 'cltbld', 14:19:51 INFO - 'MAIL': '/var/mail/cltbld', 14:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:51 INFO - 'MOZ_NO_REMOTE': '1', 14:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:19:51 INFO - 'NO_EM_RESTART': '1', 14:19:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:51 INFO - 'PWD': '/builds/slave/test', 14:19:51 INFO - 'SHELL': '/bin/bash', 14:19:51 INFO - 'SHLVL': '1', 14:19:51 INFO - 'TERM': 'linux', 14:19:51 INFO - 'TMOUT': '86400', 14:19:51 INFO - 'USER': 'cltbld', 14:19:51 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105', 14:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:51 INFO - '_': '/tools/buildbot/bin/python'} 14:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:19:52 INFO - Cleaning up... 14:19:52 INFO - Return code: 0 14:19:52 INFO - Running post-action listener: _resource_record_post_action 14:19:52 INFO - Running post-action listener: _start_resource_monitoring 14:19:52 INFO - Starting resource monitoring. 14:19:52 INFO - [mozharness: 2016-08-23 21:19:52.091907Z] Finished create-virtualenv step (success) 14:19:52 INFO - [mozharness: 2016-08-23 21:19:52.092878Z] Running install step. 14:19:52 INFO - Running pre-action listener: _resource_record_pre_action 14:19:52 INFO - Running main action method: install 14:19:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:19:52 INFO - Reading from file tmpfile_stdout 14:19:52 INFO - Detecting whether we're running mozinstall >=1.0... 14:19:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:19:52 INFO - Reading from file tmpfile_stdout 14:19:52 INFO - Output received: 14:19:52 INFO - Usage: mozinstall [options] installer 14:19:52 INFO - Options: 14:19:52 INFO - -h, --help show this help message and exit 14:19:52 INFO - -d DEST, --destination=DEST 14:19:52 INFO - Directory to install application into. [default: 14:19:52 INFO - "/builds/slave/test"] 14:19:52 INFO - --app=APP Application being installed. [default: firefox] 14:19:52 INFO - mkdir: /builds/slave/test/build/application 14:19:52 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'] 14:19:52 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 14:20:09 INFO - Reading from file tmpfile_stdout 14:20:09 INFO - Output received: 14:20:09 INFO - /builds/slave/test/build/application/firefox/firefox 14:20:09 INFO - Running post-action listener: _resource_record_post_action 14:20:09 INFO - [mozharness: 2016-08-23 21:20:09.349970Z] Finished install step (success) 14:20:09 INFO - [mozharness: 2016-08-23 21:20:09.350220Z] Running run-tests step. 14:20:09 INFO - Running pre-action listener: _resource_record_pre_action 14:20:09 INFO - Running main action method: run_tests 14:20:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:20:09 INFO - Python 2.7.3 14:20:09 INFO - Return code: 0 14:20:09 INFO - grabbing minidump binary from tooltool 14:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:20:09 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 0x1f4c370>, '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 0x1f4f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4fd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:20:09 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 14:20:09 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 14:20:09 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 14:20:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:20:09 INFO - Return code: 0 14:20:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:20:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:20:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:20:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:20:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:20:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LB11U0A_QnO3IpL1biu6mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 14:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LB11U0A_QnO3IpL1biu6mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 14:20:09 INFO - Using env: {'DISPLAY': ':0', 14:20:09 INFO - 'HOME': '/home/cltbld', 14:20:09 INFO - 'LANG': 'en_US.UTF-8', 14:20:09 INFO - 'LANGUAGE': 'en_US:en', 14:20:09 INFO - 'LOGNAME': 'cltbld', 14:20:09 INFO - 'MAIL': '/var/mail/cltbld', 14:20:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:20:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:09 INFO - 'MOZ_NO_REMOTE': '1', 14:20:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:20:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:20:09 INFO - 'NO_EM_RESTART': '1', 14:20:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:09 INFO - 'PWD': '/builds/slave/test', 14:20:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:20:09 INFO - 'SHELL': '/bin/bash', 14:20:09 INFO - 'SHLVL': '1', 14:20:09 INFO - 'TERM': 'linux', 14:20:09 INFO - 'TMOUT': '86400', 14:20:09 INFO - 'USER': 'cltbld', 14:20:09 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105', 14:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:09 INFO - '_': '/tools/buildbot/bin/python'} 14:20:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LB11U0A_QnO3IpL1biu6mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 14:20:09 INFO - mozversion application_buildid: 20160823113035 14:20:09 INFO - mozversion application_changeset: 6e17a469a1b137c535adee7e476f86ee9dfcc071 14:20:09 INFO - mozversion application_display_name: Nightly 14:20:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:20:09 INFO - mozversion application_name: Firefox 14:20:09 INFO - mozversion application_remotingname: firefox 14:20:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:20:09 INFO - mozversion application_vendor: Mozilla 14:20:09 INFO - mozversion application_version: 51.0a1 14:20:09 INFO - mozversion platform_buildid: 20160823113035 14:20:09 INFO - mozversion platform_changeset: 6e17a469a1b137c535adee7e476f86ee9dfcc071 14:20:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:20:09 INFO - mozversion platform_version: 51.0a1 14:20:09 INFO - using testdate: 1471987209 14:20:09 INFO - actual date: 1471987209 14:20:09 INFO - starting webserver on 'localhost:60873' 14:20:09 INFO - SUITE-START | Running 2 tests 14:20:09 INFO - TEST-START | dromaeo_css 14:20:09 INFO - operating with platform_type : linux_ 14:20:09 INFO - Initialising browser for dromaeo_css test... 14:20:09 INFO - TEST-INFO | started process 3306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSGAIxX/profile http://localhost:60873/getInfo.html) 14:20:15 INFO - PROCESS | 3306 | __metrics Screen width/height:1600/1200 14:20:15 INFO - PROCESS | 3306 | colorDepth:24 14:20:15 INFO - PROCESS | 3306 | Browser inner width/height: 1024/697 14:20:15 INFO - PROCESS | 3306 | __metrics 14:20:16 INFO - PROCESS | 3306 | 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" 14:20:16 INFO - PROCESS | 3306 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:20:17 INFO - PROCESS | 3306 | console.error: PushService: 14:20:17 INFO - PROCESS | 3306 | stateChangeProcessEnqueue: Error transitioning state 14:20:17 INFO - PROCESS | 3306 | UnknownError 14:20:17 INFO - TEST-INFO | 3306: exit 0 14:20:17 INFO - Browser initialized. 14:20:17 INFO - Running cycle 1/1 for dromaeo_css test... 14:20:17 INFO - TEST-INFO | started process 3387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSGAIxX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:20:29 INFO - PROCESS | 3387 | RSS: Main: 182235136 14:20:29 INFO - PROCESS | 3387 | 14:21:21 INFO - PROCESS | 3387 | 1471987281407 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] 14:23:31 INFO - PROCESS | 3387 | Cycle 1(1): loaded http://localhost:60873/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60873/tests/dromaeo/cssquery-ext.html) 14:23:32 INFO - PROCESS | 3387 | RSS: Main: 318189568 14:23:32 INFO - PROCESS | 3387 | 14:26:35 INFO - PROCESS | 3387 | Cycle 1(1): loaded http://localhost:60873/tests/dromaeo/cssquery-ext.html (next: http://localhost:60873/tests/dromaeo/cssquery-jquery.html) 14:26:35 INFO - PROCESS | 3387 | RSS: Main: 268120064 14:26:35 INFO - PROCESS | 3387 | 14:29:37 INFO - PROCESS | 3387 | Cycle 1(1): loaded http://localhost:60873/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60873/tests/dromaeo/cssquery-mootools.html) 14:29:38 INFO - PROCESS | 3387 | RSS: Main: 218583040 14:29:38 INFO - PROCESS | 3387 | 14:32:40 INFO - PROCESS | 3387 | Cycle 1(1): loaded http://localhost:60873/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60873/tests/dromaeo/cssquery-prototype.html) 14:32:41 INFO - PROCESS | 3387 | RSS: Main: 247943168 14:32:41 INFO - PROCESS | 3387 | 14:35:44 INFO - PROCESS | 3387 | Cycle 1(1): loaded http://localhost:60873/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60873/tests/dromaeo/cssquery-yui.html) 14:35:44 INFO - PROCESS | 3387 | RSS: Main: 221065216 14:35:44 INFO - PROCESS | 3387 | 14:38:47 INFO - PROCESS | 3387 | Cycle 1(1): loaded http://localhost:60873/tests/dromaeo/cssquery-yui.html (next: http://localhost:60873/tests/dromaeo/cssquery-dojo.html) 14:38:48 INFO - PROCESS | 3387 | RSS: Main: 310480896 14:38:48 INFO - PROCESS | 3387 | 14:38:48 INFO - PROCESS | 3387 | __start_tp_report 14:38:48 INFO - PROCESS | 3387 | _x_x_mozilla_page_load 14:38:48 INFO - PROCESS | 3387 | _x_x_mozilla_page_load_details 14:38:48 INFO - PROCESS | 3387 | |i|pagename|runs| 14:38:48 INFO - PROCESS | 3387 | |0;dojo.html;3027.6972302769714;3034.939301213975;3047.573339732438;3073.677263887293;3087.490564056931;5153.613478989072;5254.7635356408955;5274.05067087924;5386.4882836130555;5411.756470958811;5297.311349524566;5300.231466437364;5313.335833020872;5319.6808191508535;5330.546903513206;4805.111054454937;4872.439669438007;4973.776180071905;4980.750962451881;4998.125328067574;4842.830500932468;4877.3903262092235;4879.756012199394;4937.827176048839;5009.2486127080865;4809.7835597398025;4890.046440944017;5007.37407824022;5080.949190508085;5084.567811736007;5009.499050094998;5025.648204625678;5027.120253955543;5074.898502029939;5085.644004919657;4793.3049707792525;4859.5383438573635;4865.805367785284;4915.410150781893;4974.403071631391;5329.493698098713;5336.893262134774;5348.973255133699;5350.491703288181;5487.259220005288;5744.6840423776675;5755.280589926259;5780.364159942403;5782.653040817564;5786.913196302059;5605.887882242332;5768.192453056534;5815.534757219454;5824.621399609012;5830.300363956352;5421.403645598981;5426.131818908955;5428.0500912340185;5439.972800136054;5514.283143191399;5947.791827286024;5956.136360227742;5974.4324289192455;5976.163337132805;5978.192943952511;5417.783288668488;5568;5668.8866222675315;5716.142578613159;5735.942640573624;5760.481556659837;5769.596128271065;5772.451617096369;5837.6497410155525;5860.941390586125;5748.511376533042;5758.021136406821;5760.683162426107;5770.653760774367;5773.682447465346;5508.9724551376985;5542.695151766691;5712.971435142797;5781.306243250837;5782.5663075268685;4506.977465112654;4508.797104130322;4511.278195488706;4550.522195169526;4561.543845615412;3972.503437070366;3998.640122388999;3999.280129576704;4034.0318323602123;4049.392591111298;5366.275552800322;5462.808801691922;5543.501084902378;5548.500634942875;5553.305836770403;5803.245578074823;5817.854553636193;5820.214271073435;5847.532197424281;5880.470757631833;5495;5497.230387745719;5499.752511137009;5505.256790333334;5507.614466987273;4950.5544500994365;5026.84919452417;5030.547250747451;5035.118854200574;5098.031374038921;6017.69911504423;6033.758649653964;6057.515398768;6124.785632502841;6139.447449729546;5838.766449342149;5841.9192449397;5842.38654941225;5843.649381037151;5847.883042339215;5705.315362156568;5984.042553191469;6002.0996850472775;6045.486133678686;6066.908996365147;5701.7149142541875;5740.225069615715;5741.081426971665;5803.82588522345;5805.593608447537;5803.448672376117;5804.071348584206;5815.709214539341;5819.0689489681445;5822.417758224144;5529.364123125731;5622.269105016322;5707.743151558273;5713.9142912855505;5720.399358067343;5656.1798539212405;5680.602357834912;5682.431756824284;5725.770969161187;5743.8851222976145;5603.607747457639;5610.803621873378;5614.129809879475;5616.1014237721765;5617.129344951539;5503.2020357048805;5607.5513958882375;5673.574481913955;5712.343080545625;5712.485876271156;5526.336839579276;5569.19246709233;5590.720463976866;5613;5672.886542269214 14:38:48 INFO - PROCESS | 3387 | |1;ext.html;579.5508480927281;595.4521839907283;599.1761328173761;600.7867207141464;629.2951893878857;31200.687993120064;34501.65498345019;41640.16719665609;42472.787636061854;42473.78763106188;39933;40417;40427;40430.59569404305;40518.18963620726;8788.82422351551;8883.46699198047;8899.243564297043;8902.910970890305;8943.463392196456;8012.759617211493;8792.208701216889;8898.59956301968;10396.896031039707;10605.469726513682;10807.729806754816;10873.075788557982;10873.347599144077;10882.40146791926;10892.074173695246;10685.519151638195;10744.462776861126;10751.193660475496;10758.300710453796;10766.24636275461;8082.959585202095;10362.222833287533;10537.683869483928;10637.627683031056;10660.360378377245;42217.36673949893;42796.144077118595;42841.785791071154;42868.57131428677;42879.142417151794;2889.4221155768932;2905.2010697058267;3002.4445477586714;3277.72139368154;3287.178205448638;31966.84016579902;32217.677823221704;32220.355592888245;32431.837840810644;32631.51052734211;3771.698264138862;3806.1816709407335;3842.8847134585726;3875.205582855508;3889.2804831106337;328777;328886;330597;330669;330855.34572327224;46979;48002.27996580054;48037;48164.518354816006;49457.50542494529;51488.742556286976;51594.484055159715;51670;51675;51742.48257517452;13401.597952061455;13466.596002119952;13523.053386263064;13604.31978401076;13608;9956.352837065568;9972.152367048882;10060.899391006142;10063.245256605784;10124.645637402655;15097.54707358781;16677.583060423585;16877.915610422115;16878.156092195342;17330.566735831453;6081.452669259788;6086.60437071589;6114.510839132859;6165.8458538536;6292.067457838851;890.9287257019423;983.9754006149903;1045.1795340657548;1065.2223876570147;1096.6874440784497;31251.531227031614;31435.214119646735;31538;31555.36889262202;31834.204144896565;1021.2238698589126;1041.807265655856;1066.7173199102244;1069.1660504806264;1076.4940477975495;15706.68586628261;16361.59096022585;16577.834221657627;16634.25145868439;17000;543740.406489833;544698;547284;549630;550366;57399.13901291484;57477.71261143751;57591.544507329694;57883.421165787804;57953.710231448575;1147.5639257082423;1175.61204802415;1175.641429364052;1204.3195594489262;1273.1597145883673;29116.563251551666;30436.39127217399;30854.84572577123;31119.37203643446;31270.218244544067;50961.23558146705;51381.22928156006;51413.7429312851;51431.48568514267;51549.7422512885;447203;447978;448103;449601;450589;27840.303992400353;28475.006749527332;28662.570061448678;29820.552691710076;41786.791066044476;39371.606283936795;41316.79341603273;47115;47496.287555686;51946.740266298424;39997;40640.59359406368;41167.97080073022;41179.58820411757;42906.78546607247;39722.40416393814;40570;40695;41198.38202427026;41948.37077443902;40233.79883100566;40644.904854175744;41860.1627967445;41977.1604567913;42040.57959420489;33475;36169.81915090513;36773.63226367809;37457.81271093627;38385.616143839325;27110.72889271082;27332.726672733017;27401.86299068492;27474;27831.582526262526 14:38:48 INFO - PROCESS | 3387 | |2;jquery.html;388.1906225519791;396.6846357146069;402.95768944260846;405.18962075848304;418.67761823395983;12907.070996042536;17911.55221119471;19599.216031358763;19732.40802775917;19867.900660496678;13749.762521373075;15820.683586328267;16295.185240737976;16353.83646163538;16638.75041874373;5744.597878148542;5966.970165149168;5967.880642387149;5970.1940238067955;6019.939800601982;5705.77176912923;5850.707464626773;5919.289685237777;5919.763209471616;5931.457820966537;5878.794242201524;5897.292324921015;5905.970470147643;5906.527477801766;5908.911366329487;5699.287589051369;5854.853628659296;5862.20860183874;5874.70626468677;5887.4112588741;5267.367915850123;5275.129603615399;5276.4459731728;5276.970990656823;5278.762455689503;21963.890180549155;21999.670004949938;22097.447563810874;22133.557328853334;22782.49002624798;2288.6795848581214;2347.272345572878;2424.672669189672;2811.5079861024237;3028.712272334125;14269.643258918506;14365.414225439417;14553;14572.854271457361;14674.63313417173;1917.4726950088698;1929.5947850951318;1960.3236883275247;1973.5756812285429;1974.9506262343414;82558;83785.58107209486;84359.57820210922;85187.5740621293;85749.57125214397;9665;10519.894801052045;10693.465326733633;10787.730306742395;10933.45332733376;14824.258787060604;14827.18450485212;14853.405863765329;14868.62828429298;14870.553883383516;7223.530470519399;7272.454565907578;7344.228855970153;7617.390608751287;7628.122765881994;6827.556208846409;6884.277150899184;6894.896576551356;7003.859922801617;7036.718531258794;5680.488756011979;6116.3577824328695;6118.938810611926;6290.21372328459;6517.283098859121;1853.5366158460386;1922.7212054252054;1932.3623204342534;1982.8215460608615;2006.0650799034247;881.3654168998439;921.755734730297;937.8171256604896;1076.7738774857212;1084.9132069434584;17282.395116170872;17816.46550603484;18984;19430.61138777245;19494.31769888047;948.7770373962113;983.468926779531;995.0546980368679;1020.9336393134422;1031.7730099378125;10252.38485690861;10775.407352595526;10810.783784324269;10819.188560857967;10837;504720;507639;512946;513920;532560;91902;91974;92235.53882230546;92654;94054.52972735092;972.7811242470387;976.4678250353575;980.4068538534227;990.8067926754213;992.0525897767759;16656.41702540405;16791.664166716353;17383.304667813147;17402.651946961243;17661;43145.568544314156;43361.78319108384;43798;44616;44726.3291050641;57487.1376929338;58377;60487.39512604818;60977.69511152416;61770.69114654398;6635.8009259722285;6711.765088221889;6848.897266541106;6878.7248510059035;6899.55152915079;10219.437930913573;13208.669783255495;13212.405441754952;13386.330683465983;13623;11170.832437513607;11606.88393116058;11687.917576650116;11765.294082355085;11810.586629467927;11331.716707082389;11380.601678941197;11407.657770266906;11439.485223164811;12266.815997759863;11401.258918170292;11522.193446458667;11794.76410471803;11968.940155299168;12329.876701232874;6570.342965703582;6587.868242635216;6663.933360666331;6821.488388370992;6848.623325716934;9443.622255109718;11317.830232546354;11495.252808567417;11624.360660163773;12051.156419050933 14:38:48 INFO - PROCESS | 3387 | |3;mootools.html;1306.0465859922263;1464.9602075692937;1494.708531836292;1617.5470868156913;1761.2690733345662;7385.224551422104;8376.53929033903;8639.56802159891;8644.610992505337;8867.733967980956;8090.271875531201;8147.877781833263;8153.673853045886;8161.469504482205;8170.305524030449;2048.600522898028;2355.1168311883043;2371.1108334374608;2418.3349578865777;2426.1265944260053;2437.171361737009;2479.1942618648923;2486.17956074495;2486.8880900359527;2488.328151399121;2399.7934807430674;2421.0799896039566;2425.0784701813286;2449.35092200567;2451.82837201396;2299.689541911854;2327.7439481657;2339.438534751656;2341.8711970841596;2372.2764556810166;2354.7645235476316;2359.7050368703913;2370.7510711375403;2373.0270589058578;2373.1456675596773;8978.326625503048;9033.23217526511;9039.096090390974;9042.412243204237;9047.411918225294;4914.926276105862;5048.873778155539;5050.898982020376;5059.266406371093;5095.974520127413;3400.302937897725;3409.2670075933793;3555.2000799820094;3559.982200088983;3568.1793187567005;1163.720707030315;1211.977068561441;1223.6145614131608;1228.0728050322039;1232.6240496648518;12139.817902731465;12161.817572736416;12183.086268529807;12199.14605977582;12218.694532636755;4311.245532031882;4466;4608.585227329557;4608.654350923627;4628.97685511577;9325.393849399903;9336.766580835534;9338.533073346442;9340.112689294507;9343.205827504738;4845.6608037437745;4850.393700787402;4860.416749989953;4866.270059491034;4873.147199240118;4092.7135100542678;4476.597106260452;4550.203714349976;4551.795169217393;4566.95433045672;3855.9228815424094;3870.1292209252692;3966.8809935701975;3967.563568007517;3978.104926391539;1186.3593659423987;1194.5878671858368;1210.406900618708;1213.2599114540124;1215.5380955236953;810.2181394953898;814.287498438866;846.6020970144023;941.1482608239418;984.3060642247199;6140.17107690465;6144.8771024579255;6179.598326108789;6353.142325786052;6477.77327793525;921.6681994481982;947.516766449116;956.7655924298591;978.8238117138841;980.3921568627496;3937.9606203938165;4161.583841615875;4182;4182.644475219579;4286.742795432284;11126.944365278121;11309.151813614011;11420.714482138013;11456.54173833054;11497.080233581293;10569.894301056891;11069.225154239126;11304.71738206535;11330.433478326215;11350.262232954832;8219.465734727342;8426.4944103354;8430.915690843136;8431.241188293207;8433.915660843313;5910.23166988306;5999;6174.506039516738;6210.347913469021;6348.573762815197;9641.517924103908;10062.899371006197;10099.545520451744;10172.949135254275;10288.12550933179;10313.793724125626;10344.948275258575;10392.16862650971;10392.688219353431;10399.428031458343;7797.532148071134;7797.92202077972;7825.1783562725095;7906.327962123284;7929.960350198212;8283.917160828314;8336.416450848383;8383.287420569077;8409.579521023801;8416.83166336682;7556.282153195438;7664.34853037498;7794.337481314152;8052.349268400081;8183.631736571988;7671.53970761756;7696.46124771283;7706.3449606781805;7767.883481747891;7779.260970207822;6993.790186294419;7044.929550704427;7089.574625522485;7091.326323999212;7099.0416293801745;5088.185890257541;5097.337346144977;5129.820456284012;5149.2276158576515;5329.786808527616;5267.394249661338;5271.262023316815;5293;5295.973520132375;5519.448055194448 14:38:48 INFO - PROCESS | 3387 | |4;prototype.html;332.7554247627993;336.99494507582403;339.93031428557134;346.3575068248399;347.65755730605355;5199.4800519948085;5260.631755777087;5309.442508536606;5371.060064488714;5374.6237763356585;5228.503292187245;5238.790448382069;5258.6318957672975;5270.209468579715;5277.261183434322;4178.289690752579;4183.226103170908;4187.225363307798;4195.181939521779;4203.222403855281;3953;4065.3292206785845;4186.288330983725;4193.706440549163;4230.13282277134;4065.4308396824467;4065.6747460203114;4089.3457046872504;4102.897427564305;4108.993296642327;4100.954256664561;4100.974756310922;4101.666958238585;4103.4050062740735;4139.2135494256;3618.9638103619154;3639.636036396366;3642.6721595056574;3654.634536546351;3655.6527129922615;5054.823081192178;5094.2103973884105;5099.872503187413;5100.515451032146;5194.870128246786;4657.580817726421;4693.741844198567;4696.365990591261;4706.576408123251;4716.481187069419;5464.26232458617;5472.20653005312;5474.72626368684;5476.616636835423;5484.122540393518;3747.257525250744;3911.198204368098;3928.487532300085;3941.3890846918775;3948.4274780157;5631.380548139701;5670.5747068969995;5694.77220911163;5710.514606258473;5711.172424824058;4069.552349241581;4075.4121133080707;4084.4690190275073;4092.7953602319767;4129.174165166918;3893.4549163117185;4004.7196696231567;4011.157656892027;4045.211183819127;4177.749335039907;4610.054938737618;4611.700239484423;4617.746023968647;4632.189366860854;4649.814007439732;5552.639078459887;5567.749451274703;5603.831885043455;5633.859153521113;5659.377468478464;1311.4557458654551;1345.643404497809;1422.679897023182;1430.592281199853;1438.216172186161;952.6522819170953;983.6803039012207;984.3552473130111;1000.4047591682937;1009.8535712321819;5358.651687640291;5363.168708850135;5364.471125729148;5368.57051435892;5391.32608423947;5626.746796394172;5632;5634.915476267859;5642.266505354278;5644.915326270109;5193.974030129825;5331.760070796823;5380.73096345189;5381.542568881689;5437.972810136003;3016.1403999859936;3027.8788848446256;3029.5152775555807;3034.878604855781;3053.541968704712;5899.262592175978;5917.881642367129;5925.259342582177;5989.460948514655;6003.459688628044;5544.279243698294;5795.565332600072;5849.444302791228;5851.414858514115;5888.175655408247;5894.02550145706;5946.167536544801;5956.463918247378;5960.135780311831;5978.611390259619;5533.703513042043;5608.2799842077375;5640.774369025193;5747.367789543064;5780.514378817149;5598.844444888666;5599;5621.133222056862;5642.971785141048;5668.7732490701555;5830.62100963436;5849.181114644039;5905.438983296752;5919.704014799329;5940.316863560746;3997.820098095651;4132.586741325843;4150.273702102059;4152.418661387348;4155.501339839238;5691.686957217393;5693.975084484832;5696.316442026983;5696.515796157208;5703.914441283301;5341.599380046589;5569.275994120739;5578.330600327987;5609.158626206102;5623.37292446378;5432.212329212163;5506.834794956158;5509.834704958857;5536;5536.7231638418725;5390.541803946551;5454.536364409069;5461.371942226536;5501.944980550144;5512.153428601463;5468.26178465902;5593.748281327432;5631.690257035739;5631.831045068655;5651.406602306699;5470.398256191896;5474.644148130359;5503.752331145028;5504.53211477029;5524.8342549723575 14:38:48 INFO - PROCESS | 3387 | |5;yui.html;629.3800606402692;646.6088016749866;655.8852200864848;698.5284932670446;716.8064622551911;13650.590482285523;14515.346809393577;14525.41898324067;14527.854721452783;14534.127952322868;12797.744045119092;12919.224846509216;12938.547150849723;12959.222446653208;13218.471261149567;665.4443539644403;784.705735349244;813.0365516862507;813.0730966697969;818.292177266663;797.5653268968426;803.2329125684956;807.1323327423014;820.8768684697313;822.391430341546;845.6025667936091;849.1084361420515;851.1233429567556;851.6252848746532;851.880736696863;688.187938232885;836.9748907532784;842.8735689646571;843.8101427178897;844.0209357145712;453.0214736169857;469.7533794757745;470.8422678402739;481.2468486818153;481.713380538579;13157.671058223621;13181.934090329583;13217.339133043406;13233.602991910258;13241.933790331082;13560.796588051187;14266.3580138894;14376.928115359357;14386.136831790127;14615.196164210964;12234.571789987396;12364.938175309157;12427.565035223814;12487.562935297312;12632.936835315764;4385.780710964439;4412.779361031968;4470.485894122185;4490.787487378389;4652.720836749806;83175;84163.5791821037;84746;85268.57365713194;87163.56418217868;10523.84214236787;10794.838077428845;10929.672109836718;11000.394978276112;11047.281926674741;22115.33653990383;22160.224392146196;22174.223902163347;22179.223727169796;22196.889015554818;8522.40952304865;8579.82840343202;8755.824883502422;8806.031336552975;8954.059823718415;4385.5135167541885;4439.911201775946;4558.749268790182;4595.356650068993;4702.059588082398;3191.5372271020574;3252.7397808175288;3272.378248132847;3289.358575077837;3293.75296852737;541.783286685329;543.6411968101035;551.8123837895135;557.1169696031754;559;510.6884800271831;552.9281193444826;573.3721574875505;598.5221184297014;609.1441524657863;9173.40372875761;9230.492322922304;9305.348625596278;9547.618095276111;9586.568604412818;521.8069314353713;568.6502800777574;575.6862509932097;597.489146779506;599.1073300781803;4320.891977700583;4331.028569434501;4416.53626369233;4571.5428457154685;4656.883577910579;122810;125309.37345313215;125947;128657.35671321584;129894.35052824675;107435.46282268695;107849;110206.44896775465;111041.44479277552;116289.02265864075;90392;93806;94791.52604236934;94843.52578237203;95778.52110739541;8100.635471403683;8542.572871356531;8576.44253123545;8589.82820343577;8641.135886411308;39749.80125099356;51210;51802.222966656285;52223.47776522338;53879.19181212363;71910.64044679744;80737.19262807297;82613.58693206737;83942;85204.57397712972;10706.250562460553;10726;10829.076308414076;11043.061339786209;11253.493592788507;12045.51817927273;12060.577879774166;12076.335801531;12124.636260912186;12238.449269782703;10851.728706782395;10956.233063685784;11279.605213817476;11281.943590282324;11882.881171188177;11344.943275283571;11671.649850504498;11902.702432439259;12075.27548347102;12237.20458170216;10377.429241391796;10551.208659350426;10630.30902991303;10942.343459392461;11068.225224234226;9127.817443651222;9220.44677319363;9473.810523789623;9753.170980466739;9859.260555458513;8829.205371516595;9724;9833.950830245803;9866.851997219905;9891.901080989386 14:38:48 INFO - PROCESS | 3387 | __end_tp_report 14:38:48 INFO - PROCESS | 3387 | __start_cc_report 14:38:48 INFO - PROCESS | 3387 | _x_x_mozilla_cycle_collect,1101 14:38:48 INFO - PROCESS | 3387 | __end_cc_report 14:38:48 INFO - PROCESS | 3387 | __startTimestamp1471988328111__endTimestamp 14:38:48 INFO - PROCESS | 3387 | 14:38:48 INFO - PROCESS | 3387 | ------- Summary: start ------- 14:38:48 INFO - PROCESS | 3387 | Number of tests: 6 14:38:48 INFO - PROCESS | 3387 | 14:38:48 INFO - PROCESS | 3387 | [#0] dojo.html Cycles:165 Average:5382.48 Median:5569.19 stddev:611.88 (11.0%) stddev-sans-first:585.21 14:38:48 INFO - PROCESS | 3387 | Values: 3027.7 3034.9 3047.6 3073.7 3087.5 5153.6 5254.8 5274.1 5386.5 5411.8 5297.3 5300.2 5313.3 5319.7 5330.5 4805.1 4872.4 4973.8 4980.8 4998.1 4842.8 4877.4 4879.8 4937.8 5009.2 4809.8 4890.0 5007.4 5080.9 5084.6 5009.5 5025.6 5027.1 5074.9 5085.6 4793.3 4859.5 4865.8 4915.4 4974.4 5329.5 5336.9 5349.0 5350.5 5487.3 5744.7 5755.3 5780.4 5782.7 5786.9 5605.9 5768.2 5815.5 5824.6 5830.3 5421.4 5426.1 5428.1 5440.0 5514.3 5947.8 5956.1 5974.4 5976.2 5978.2 5417.8 5568.0 5668.9 5716.1 5735.9 5760.5 5769.6 5772.5 5837.6 5860.9 5748.5 5758.0 5760.7 5770.7 5773.7 5509.0 5542.7 5713.0 5781.3 5782.6 4507.0 4508.8 4511.3 4550.5 4561.5 3972.5 3998.6 3999.3 4034.0 4049.4 5366.3 5462.8 5543.5 5548.5 5553.3 5803.2 5817.9 5820.2 5847.5 5880.5 5495.0 5497.2 5499.8 5505.3 5507.6 4950.6 5026.8 5030.5 5035.1 5098.0 6017.7 6033.8 6057.5 6124.8 6139.4 5838.8 5841.9 5842.4 5843.6 5847.9 5705.3 5984.0 6002.1 6045.5 6066.9 5701.7 5740.2 5741.1 5803.8 5805.6 5803.4 5804.1 5815.7 5819.1 5822.4 5529.4 5622.3 5707.7 5713.9 5720.4 5656.2 5680.6 5682.4 5725.8 5743.9 5603.6 5610.8 5614.1 5616.1 5617.1 5503.2 5607.6 5673.6 5712.3 5712.5 5526.3 5569.2 5590.7 5613.0 5672.9 14:38:48 INFO - PROCESS | 3387 | 14:38:48 INFO - PROCESS | 3387 | [#1] ext.html Cycles:180 Average:59385.24 Median:3859.05 stddev:119722.39 (3102.4%) stddev-sans-first:119976.82 14:38:48 INFO - PROCESS | 3387 | Values: 579.6 595.5 599.2 600.8 629.3 31200.7 34501.7 41640.2 42472.8 42473.8 39933.0 40417.0 40427.0 40430.6 40518.2 8788.8 8883.5 8899.2 8902.9 8943.5 8012.8 8792.2 8898.6 10396.9 10605.5 10807.7 10873.1 10873.3 10882.4 10892.1 10685.5 10744.5 10751.2 10758.3 10766.2 8083.0 10362.2 10537.7 10637.6 10660.4 42217.4 42796.1 42841.8 42868.6 42879.1 2889.4 2905.2 3002.4 3277.7 3287.2 31966.8 32217.7 32220.4 32431.8 32631.5 3771.7 3806.2 3842.9 3875.2 3889.3 328777.0 328886.0 330597.0 330669.0 330855.3 46979.0 48002.3 48037.0 48164.5 49457.5 51488.7 51594.5 51670.0 51675.0 51742.5 13401.6 13466.6 13523.1 13604.3 13608.0 9956.4 9972.2 10060.9 10063.2 10124.6 15097.5 16677.6 16877.9 16878.2 17330.6 6081.5 6086.6 6114.5 6165.8 6292.1 890.9 984.0 1045.2 1065.2 1096.7 31251.5 31435.2 31538.0 31555.4 31834.2 1021.2 1041.8 1066.7 1069.2 1076.5 15706.7 16361.6 16577.8 16634.3 17000.0 543740.4 544698.0 547284.0 549630.0 550366.0 57399.1 57477.7 57591.5 57883.4 57953.7 1147.6 1175.6 1175.6 1204.3 1273.2 29116.6 30436.4 30854.8 31119.4 31270.2 50961.2 51381.2 51413.7 51431.5 51549.7 447203.0 447978.0 448103.0 449601.0 450589.0 27840.3 28475.0 28662.6 29820.6 41786.8 39371.6 41316.8 47115.0 47496.3 51946.7 39997.0 40640.6 41168.0 41179.6 42906.8 39722.4 40570.0 40695.0 41198.4 41948.4 40233.8 40644.9 41860.2 41977.2 42040.6 33475.0 36169.8 36773.6 37457.8 38385.6 27110.7 27332.7 27401.9 27474.0 27831.6 14:38:48 INFO - PROCESS | 3387 | 14:38:48 INFO - PROCESS | 3387 | [#2] jquery.html Cycles:180 Average:29689.56 Median:411.93 stddev:84826.79 (20592.3%) stddev-sans-first:85036.22 14:38:48 INFO - PROCESS | 3387 | Values: 388.2 396.7 403.0 405.2 418.7 12907.1 17911.6 19599.2 19732.4 19867.9 13749.8 15820.7 16295.2 16353.8 16638.8 5744.6 5967.0 5967.9 5970.2 6019.9 5705.8 5850.7 5919.3 5919.8 5931.5 5878.8 5897.3 5906.0 5906.5 5908.9 5699.3 5854.9 5862.2 5874.7 5887.4 5267.4 5275.1 5276.4 5277.0 5278.8 21963.9 21999.7 22097.4 22133.6 22782.5 2288.7 2347.3 2424.7 2811.5 3028.7 14269.6 14365.4 14553.0 14572.9 14674.6 1917.5 1929.6 1960.3 1973.6 1975.0 82558.0 83785.6 84359.6 85187.6 85749.6 9665.0 10519.9 10693.5 10787.7 10933.5 14824.3 14827.2 14853.4 14868.6 14870.6 7223.5 7272.5 7344.2 7617.4 7628.1 6827.6 6884.3 6894.9 7003.9 7036.7 5680.5 6116.4 6118.9 6290.2 6517.3 1853.5 1922.7 1932.4 1982.8 2006.1 881.4 921.8 937.8 1076.8 1084.9 17282.4 17816.5 18984.0 19430.6 19494.3 948.8 983.5 995.1 1020.9 1031.8 10252.4 10775.4 10810.8 10819.2 10837.0 504720.0 507639.0 512946.0 513920.0 532560.0 91902.0 91974.0 92235.5 92654.0 94054.5 972.8 976.5 980.4 990.8 992.1 16656.4 16791.7 17383.3 17402.7 17661.0 43145.6 43361.8 43798.0 44616.0 44726.3 57487.1 58377.0 60487.4 60977.7 61770.7 6635.8 6711.8 6848.9 6878.7 6899.6 10219.4 13208.7 13212.4 13386.3 13623.0 11170.8 11606.9 11687.9 11765.3 11810.6 11331.7 11380.6 11407.7 11439.5 12266.8 11401.3 11522.2 11794.8 11968.9 12329.9 6570.3 6587.9 6663.9 6821.5 6848.6 9443.6 11317.8 11495.3 11624.4 12051.2 14:38:48 INFO - PROCESS | 3387 | 14:38:48 INFO - PROCESS | 3387 | [#3] mootools.html Cycles:180 Average:5784.89 Median:4855.41 stddev:3281.49 (67.6%) stddev-sans-first:3273.43 14:38:48 INFO - PROCESS | 3387 | Values: 1306.0 1465.0 1494.7 1617.5 1761.3 7385.2 8376.5 8639.6 8644.6 8867.7 8090.3 8147.9 8153.7 8161.5 8170.3 2048.6 2355.1 2371.1 2418.3 2426.1 2437.2 2479.2 2486.2 2486.9 2488.3 2399.8 2421.1 2425.1 2449.4 2451.8 2299.7 2327.7 2339.4 2341.9 2372.3 2354.8 2359.7 2370.8 2373.0 2373.1 8978.3 9033.2 9039.1 9042.4 9047.4 4914.9 5048.9 5050.9 5059.3 5096.0 3400.3 3409.3 3555.2 3560.0 3568.2 1163.7 1212.0 1223.6 1228.1 1232.6 12139.8 12161.8 12183.1 12199.1 12218.7 4311.2 4466.0 4608.6 4608.7 4629.0 9325.4 9336.8 9338.5 9340.1 9343.2 4845.7 4850.4 4860.4 4866.3 4873.1 4092.7 4476.6 4550.2 4551.8 4567.0 3855.9 3870.1 3966.9 3967.6 3978.1 1186.4 1194.6 1210.4 1213.3 1215.5 810.2 814.3 846.6 941.1 984.3 6140.2 6144.9 6179.6 6353.1 6477.8 921.7 947.5 956.8 978.8 980.4 3938.0 4161.6 4182.0 4182.6 4286.7 11126.9 11309.2 11420.7 11456.5 11497.1 10569.9 11069.2 11304.7 11330.4 11350.3 8219.5 8426.5 8430.9 8431.2 8433.9 5910.2 5999.0 6174.5 6210.3 6348.6 9641.5 10062.9 10099.5 10172.9 10288.1 10313.8 10344.9 10392.2 10392.7 10399.4 7797.5 7797.9 7825.2 7906.3 7930.0 8283.9 8336.4 8383.3 8409.6 8416.8 7556.3 7664.3 7794.3 8052.3 8183.6 7671.5 7696.5 7706.3 7767.9 7779.3 6993.8 7044.9 7089.6 7091.3 7099.0 5088.2 5097.3 5129.8 5149.2 5329.8 5267.4 5271.3 5293.0 5296.0 5519.4 14:38:48 INFO - PROCESS | 3387 | 14:38:48 INFO - PROCESS | 3387 | [#4] prototype.html Cycles:180 Average:4674.63 Median:5366.52 stddev:1374.97 (25.6%) stddev-sans-first:1339.65 14:38:48 INFO - PROCESS | 3387 | Values: 332.8 337.0 339.9 346.4 347.7 5199.5 5260.6 5309.4 5371.1 5374.6 5228.5 5238.8 5258.6 5270.2 5277.3 4178.3 4183.2 4187.2 4195.2 4203.2 3953.0 4065.3 4186.3 4193.7 4230.1 4065.4 4065.7 4089.3 4102.9 4109.0 4101.0 4101.0 4101.7 4103.4 4139.2 3619.0 3639.6 3642.7 3654.6 3655.7 5054.8 5094.2 5099.9 5100.5 5194.9 4657.6 4693.7 4696.4 4706.6 4716.5 5464.3 5472.2 5474.7 5476.6 5484.1 3747.3 3911.2 3928.5 3941.4 3948.4 5631.4 5670.6 5694.8 5710.5 5711.2 4069.6 4075.4 4084.5 4092.8 4129.2 3893.5 4004.7 4011.2 4045.2 4177.7 4610.1 4611.7 4617.7 4632.2 4649.8 5552.6 5567.7 5603.8 5633.9 5659.4 1311.5 1345.6 1422.7 1430.6 1438.2 952.7 983.7 984.4 1000.4 1009.9 5358.7 5363.2 5364.5 5368.6 5391.3 5626.7 5632.0 5634.9 5642.3 5644.9 5194.0 5331.8 5380.7 5381.5 5438.0 3016.1 3027.9 3029.5 3034.9 3053.5 5899.3 5917.9 5925.3 5989.5 6003.5 5544.3 5795.6 5849.4 5851.4 5888.2 5894.0 5946.2 5956.5 5960.1 5978.6 5533.7 5608.3 5640.8 5747.4 5780.5 5598.8 5599.0 5621.1 5643.0 5668.8 5830.6 5849.2 5905.4 5919.7 5940.3 3997.8 4132.6 4150.3 4152.4 4155.5 5691.7 5694.0 5696.3 5696.5 5703.9 5341.6 5569.3 5578.3 5609.2 5623.4 5432.2 5506.8 5509.8 5536.0 5536.7 5390.5 5454.5 5461.4 5501.9 5512.2 5468.3 5593.7 5631.7 5631.8 5651.4 5470.4 5474.6 5503.8 5504.5 5524.8 14:38:48 INFO - PROCESS | 3387 | 14:38:48 INFO - PROCESS | 3387 | [#5] yui.html Cycles:180 Average:21448.28 Median:2563.32 stddev:33194.97 (1295.0%) stddev-sans-first:33251.28 14:38:48 INFO - PROCESS | 3387 | Values: 629.4 646.6 655.9 698.5 716.8 13650.6 14515.3 14525.4 14527.9 14534.1 12797.7 12919.2 12938.5 12959.2 13218.5 665.4 784.7 813.0 813.1 818.3 797.6 803.2 807.1 820.9 822.4 845.6 849.1 851.1 851.6 851.9 688.2 837.0 842.9 843.8 844.0 453.0 469.8 470.8 481.2 481.7 13157.7 13181.9 13217.3 13233.6 13241.9 13560.8 14266.4 14376.9 14386.1 14615.2 12234.6 12364.9 12427.6 12487.6 12632.9 4385.8 4412.8 4470.5 4490.8 4652.7 83175.0 84163.6 84746.0 85268.6 87163.6 10523.8 10794.8 10929.7 11000.4 11047.3 22115.3 22160.2 22174.2 22179.2 22196.9 8522.4 8579.8 8755.8 8806.0 8954.1 4385.5 4439.9 4558.7 4595.4 4702.1 3191.5 3252.7 3272.4 3289.4 3293.8 541.8 543.6 551.8 557.1 559.0 510.7 552.9 573.4 598.5 609.1 9173.4 9230.5 9305.3 9547.6 9586.6 521.8 568.7 575.7 597.5 599.1 4320.9 4331.0 4416.5 4571.5 4656.9 122810.0 125309.4 125947.0 128657.4 129894.4 107435.5 107849.0 110206.4 111041.4 116289.0 90392.0 93806.0 94791.5 94843.5 95778.5 8100.6 8542.6 8576.4 8589.8 8641.1 39749.8 51210.0 51802.2 52223.5 53879.2 71910.6 80737.2 82613.6 83942.0 85204.6 10706.3 10726.0 10829.1 11043.1 11253.5 12045.5 12060.6 12076.3 12124.6 12238.4 10851.7 10956.2 11279.6 11281.9 11882.9 11344.9 11671.6 11902.7 12075.3 12237.2 10377.4 10551.2 10630.3 10942.3 11068.2 9127.8 9220.4 9473.8 9753.2 9859.3 8829.2 9724.0 9834.0 9866.9 9891.9 14:38:48 INFO - PROCESS | 3387 | -------- Summary: end -------- 14:38:48 INFO - PROCESS | 3387 | 14:38:49 INFO - TEST-INFO | 3387: exit 0 14:38:49 INFO - TEST-OK | dromaeo_css | took 1119103ms 14:38:49 INFO - TEST-START | kraken 14:38:49 INFO - operating with platform_type : linux_ 14:38:49 INFO - Initialising browser for kraken test... 14:38:49 INFO - TEST-INFO | started process 3688 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxAvnb_/profile http://localhost:60873/getInfo.html) 14:38:53 INFO - PROCESS | 3688 | __metrics Screen width/height:1600/1200 14:38:53 INFO - PROCESS | 3688 | colorDepth:24 14:38:53 INFO - PROCESS | 3688 | Browser inner width/height: 1024/697 14:38:53 INFO - PROCESS | 3688 | __metrics 14:38:53 INFO - PROCESS | 3688 | 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" 14:38:53 INFO - PROCESS | 3688 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:38:54 INFO - PROCESS | 3688 | console.error: PushService: 14:38:54 INFO - PROCESS | 3688 | stateChangeProcessEnqueue: Error transitioning state 14:38:54 INFO - PROCESS | 3688 | UnknownError 14:38:55 INFO - TEST-INFO | 3688: exit 0 14:38:55 INFO - Browser initialized. 14:38:55 INFO - Running cycle 1/1 for kraken test... 14:38:55 INFO - TEST-INFO | started process 3765 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxAvnb_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:39:07 INFO - PROCESS | 3765 | RSS: Main: 181362688 14:39:07 INFO - PROCESS | 3765 | 14:39:09 INFO - PROCESS | 3765 | Cycle 1(1): loaded http://localhost:60873/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60873/tests/kraken/driver.html?testName=audio-beat-detection) 14:39:10 INFO - PROCESS | 3765 | RSS: Main: 243519488 14:39:10 INFO - PROCESS | 3765 | 14:39:13 INFO - PROCESS | 3765 | Cycle 1(1): loaded http://localhost:60873/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60873/tests/kraken/driver.html?testName=audio-dft) 14:39:14 INFO - PROCESS | 3765 | RSS: Main: 225042432 14:39:14 INFO - PROCESS | 3765 | 14:39:17 INFO - PROCESS | 3765 | Cycle 1(1): loaded http://localhost:60873/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60873/tests/kraken/driver.html?testName=audio-fft) 14:39:17 INFO - PROCESS | 3765 | RSS: Main: 304324608 14:39:17 INFO - PROCESS | 3765 | 14:39:19 INFO - PROCESS | 3765 | Cycle 1(1): loaded http://localhost:60873/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60873/tests/kraken/driver.html?testName=audio-oscillator) 14:39:20 INFO - PROCESS | 3765 | RSS: Main: 212627456 14:39:20 INFO - PROCESS | 3765 | 14:39:22 INFO - PROCESS | 3765 | Cycle 1(1): loaded http://localhost:60873/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60873/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:39:23 INFO - PROCESS | 3765 | RSS: Main: 214781952 14:39:23 INFO - PROCESS | 3765 | 14:39:26 INFO - PROCESS | 3765 | Cycle 1(1): loaded http://localhost:60873/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60873/tests/kraken/driver.html?testName=imaging-darkroom) 14:39:27 INFO - PROCESS | 3765 | RSS: Main: 254898176 14:39:27 INFO - PROCESS | 3765 | 14:39:30 INFO - PROCESS | 3765 | Cycle 1(1): loaded http://localhost:60873/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60873/tests/kraken/driver.html?testName=imaging-desaturate) 14:39:31 INFO - PROCESS | 3765 | RSS: Main: 253448192 14:39:31 INFO - PROCESS | 3765 | 14:39:33 INFO - PROCESS | 3765 | Cycle 1(1): loaded http://localhost:60873/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60873/tests/kraken/driver.html?testName=json-parse-financial) 14:39:34 INFO - PROCESS | 3765 | RSS: Main: 253198336 14:39:34 INFO - PROCESS | 3765 | 14:39:35 INFO - PROCESS | 3765 | Cycle 1(1): loaded http://localhost:60873/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60873/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:39:36 INFO - PROCESS | 3765 | RSS: Main: 216526848 14:39:36 INFO - PROCESS | 3765 | 14:39:38 INFO - PROCESS | 3765 | Cycle 1(1): loaded http://localhost:60873/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60873/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:39:38 INFO - PROCESS | 3765 | RSS: Main: 223834112 14:39:38 INFO - PROCESS | 3765 | 14:39:41 INFO - PROCESS | 3765 | Cycle 1(1): loaded http://localhost:60873/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60873/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:39:41 INFO - PROCESS | 3765 | RSS: Main: 223825920 14:39:41 INFO - PROCESS | 3765 | 14:39:44 INFO - PROCESS | 3765 | Cycle 1(1): loaded http://localhost:60873/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60873/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:39:45 INFO - PROCESS | 3765 | RSS: Main: 218664960 14:39:45 INFO - PROCESS | 3765 | 14:39:48 INFO - PROCESS | 3765 | Cycle 1(1): loaded http://localhost:60873/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60873/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:39:48 INFO - PROCESS | 3765 | RSS: Main: 221216768 14:39:48 INFO - PROCESS | 3765 | 14:39:50 INFO - PROCESS | 3765 | Cycle 1(1): loaded http://localhost:60873/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60873/tests/kraken/driver.html?testName=ai-astar) 14:39:50 INFO - PROCESS | 3765 | RSS: Main: 272445440 14:39:50 INFO - PROCESS | 3765 | 14:39:50 INFO - PROCESS | 3765 | __start_tp_report 14:39:50 INFO - PROCESS | 3765 | _x_x_mozilla_page_load 14:39:50 INFO - PROCESS | 3765 | _x_x_mozilla_page_load_details 14:39:50 INFO - PROCESS | 3765 | |i|pagename|runs| 14:39:50 INFO - PROCESS | 3765 | |0;ai-astar;112;112;126;113;113;112;113;112;112;113 14:39:50 INFO - PROCESS | 3765 | |1;audio-beat-detection;156;125;155;182;117;144;151;120;175;119 14:39:50 INFO - PROCESS | 3765 | |2;audio-dft;161;162;160;160;161;160;161;161;162;161 14:39:50 INFO - PROCESS | 3765 | |3;audio-fft;74;73;76;171;76;76;79;76;175;76 14:39:50 INFO - PROCESS | 3765 | |4;audio-oscillator;84;85;144;85;87;85;143;85;84;147 14:39:50 INFO - PROCESS | 3765 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;117 14:39:50 INFO - PROCESS | 3765 | |6;imaging-darkroom;145;146;146;146;146;145;146;145;146;146 14:39:50 INFO - PROCESS | 3765 | |7;imaging-desaturate;96;96;96;95;96;96;95;95;95;95 14:39:50 INFO - PROCESS | 3765 | |8;json-parse-financial;52;51;53;53;51;53;53;52;51;52 14:39:50 INFO - PROCESS | 3765 | |9;json-stringify-tinderbox;60;61;60;61;61;60;60;62;60;62 14:39:50 INFO - PROCESS | 3765 | |10;stanford-crypto-aes;78;78;79;78;80;79;77;79;79;77 14:39:50 INFO - PROCESS | 3765 | |11;stanford-crypto-ccm;126;137;121;120;121;131;122;123;141;139 14:39:50 INFO - PROCESS | 3765 | |12;stanford-crypto-pbkdf2;163;165;165;162;165;168;164;164;169;171 14:39:50 INFO - PROCESS | 3765 | |13;stanford-crypto-sha256-iterative;66;65;65;65;68;68;64;63;65;65 14:39:50 INFO - PROCESS | 3765 | __end_tp_report 14:39:50 INFO - PROCESS | 3765 | __start_cc_report 14:39:50 INFO - PROCESS | 3765 | _x_x_mozilla_cycle_collect,1739 14:39:50 INFO - PROCESS | 3765 | __end_cc_report 14:39:50 INFO - PROCESS | 3765 | __startTimestamp1471988390572__endTimestamp 14:39:50 INFO - PROCESS | 3765 | 14:39:50 INFO - PROCESS | 3765 | ------- Summary: start ------- 14:39:50 INFO - PROCESS | 3765 | Number of tests: 14 14:39:50 INFO - PROCESS | 3765 | 14:39:50 INFO - PROCESS | 3765 | [#0] ai-astar Cycles:10 Average:113.80 Median:113.00 stddev:4.32 (3.8%) stddev-sans-first:4.53 14:39:50 INFO - PROCESS | 3765 | Values: 112.0 112.0 126.0 113.0 113.0 112.0 113.0 112.0 112.0 113.0 14:39:50 INFO - PROCESS | 3765 | 14:39:50 INFO - PROCESS | 3765 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:153.00 stddev:23.59 (15.4%) stddev-sans-first:24.64 14:39:50 INFO - PROCESS | 3765 | Values: 156.0 125.0 155.0 182.0 117.0 144.0 151.0 120.0 175.0 119.0 14:39:50 INFO - PROCESS | 3765 | 14:39:50 INFO - PROCESS | 3765 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 14:39:50 INFO - PROCESS | 3765 | Values: 161.0 162.0 160.0 160.0 161.0 160.0 161.0 161.0 162.0 161.0 14:39:50 INFO - PROCESS | 3765 | 14:39:50 INFO - PROCESS | 3765 | [#3] audio-fft Cycles:10 Average:95.20 Median:76.00 stddev:41.04 (54.0%) stddev-sans-first:42.81 14:39:50 INFO - PROCESS | 3765 | Values: 74.0 73.0 76.0 171.0 76.0 76.0 79.0 76.0 175.0 76.0 14:39:50 INFO - PROCESS | 3765 | 14:39:50 INFO - PROCESS | 3765 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:85.00 stddev:28.85 (33.9%) stddev-sans-first:29.78 14:39:50 INFO - PROCESS | 3765 | Values: 84.0 85.0 144.0 85.0 87.0 85.0 143.0 85.0 84.0 147.0 14:39:50 INFO - PROCESS | 3765 | 14:39:50 INFO - PROCESS | 3765 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:39:50 INFO - PROCESS | 3765 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 14:39:50 INFO - PROCESS | 3765 | 14:39:50 INFO - PROCESS | 3765 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 14:39:50 INFO - PROCESS | 3765 | Values: 145.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 146.0 14:39:50 INFO - PROCESS | 3765 | 14:39:50 INFO - PROCESS | 3765 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 14:39:50 INFO - PROCESS | 3765 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 14:39:50 INFO - PROCESS | 3765 | 14:39:50 INFO - PROCESS | 3765 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.50 stddev:0.88 (1.7%) stddev-sans-first:0.93 14:39:50 INFO - PROCESS | 3765 | Values: 52.0 51.0 53.0 53.0 51.0 53.0 53.0 52.0 51.0 52.0 14:39:50 INFO - PROCESS | 3765 | 14:39:50 INFO - PROCESS | 3765 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 14:39:50 INFO - PROCESS | 3765 | Values: 60.0 61.0 60.0 61.0 61.0 60.0 60.0 62.0 60.0 62.0 14:39:50 INFO - PROCESS | 3765 | 14:39:50 INFO - PROCESS | 3765 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:79.00 stddev:0.97 (1.2%) stddev-sans-first:1.01 14:39:50 INFO - PROCESS | 3765 | Values: 78.0 78.0 79.0 78.0 80.0 79.0 77.0 79.0 79.0 77.0 14:39:50 INFO - PROCESS | 3765 | 14:39:50 INFO - PROCESS | 3765 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:128.50 stddev:8.21 (6.4%) stddev-sans-first:8.67 14:39:50 INFO - PROCESS | 3765 | Values: 126.0 137.0 121.0 120.0 121.0 131.0 122.0 123.0 141.0 139.0 14:39:50 INFO - PROCESS | 3765 | 14:39:50 INFO - PROCESS | 3765 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.60 Median:165.00 stddev:2.84 (1.7%) stddev-sans-first:2.85 14:39:50 INFO - PROCESS | 3765 | Values: 163.0 165.0 165.0 162.0 165.0 168.0 164.0 164.0 169.0 171.0 14:39:50 INFO - PROCESS | 3765 | 14:39:50 INFO - PROCESS | 3765 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.00 stddev:1.58 (2.4%) stddev-sans-first:1.66 14:39:50 INFO - PROCESS | 3765 | Values: 66.0 65.0 65.0 65.0 68.0 68.0 64.0 63.0 65.0 65.0 14:39:50 INFO - PROCESS | 3765 | -------- Summary: end -------- 14:39:50 INFO - PROCESS | 3765 | 14:39:51 INFO - TEST-INFO | 3765: exit 0 14:39:51 INFO - TEST-OK | kraken | took 62755ms 14:39:51 INFO - SUITE-END | took 1181s 14:39:52 INFO - Completed test suite (00:19:42) 14:39:52 INFO - javascript benchmark 14:39:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3027.6972302769714, 3034.939301213975, 3047.573339732438, 3073.677263887293, 3087.490564056931, 5153.613478989072, 5254.7635356408955, 5274.05067087924, 5386.4882836130555, 5411.756470958811, 5297.311349524566, 5300.231466437364, 5313.335833020872, 5319.6808191508535, 5330.546903513206, 4805.111054454937, 4872.439669438007, 4973.776180071905, 4980.750962451881, 4998.125328067574, 4842.830500932468, 4877.3903262092235, 4879.756012199394, 4937.827176048839, 5009.2486127080865, 4809.7835597398025, 4890.046440944017, 5007.37407824022, 5080.949190508085, 5084.567811736007, 5009.499050094998, 5025.648204625678, 5027.120253955543, 5074.898502029939, 5085.644004919657, 4793.3049707792525, 4859.5383438573635, 4865.805367785284, 4915.410150781893, 4974.403071631391, 5329.493698098713, 5336.893262134774, 5348.973255133699, 5350.491703288181, 5487.259220005288, 5744.6840423776675, 5755.280589926259, 5780.364159942403, 5782.653040817564, 5786.913196302059, 5605.887882242332, 5768.192453056534, 5815.534757219454, 5824.621399609012, 5830.300363956352, 5421.403645598981, 5426.131818908955, 5428.0500912340185, 5439.972800136054, 5514.283143191399, 5947.791827286024, 5956.136360227742, 5974.4324289192455, 5976.163337132805, 5978.192943952511, 5417.783288668488, 5568.0, 5668.8866222675315, 5716.142578613159, 5735.942640573624, 5760.481556659837, 5769.596128271065, 5772.451617096369, 5837.6497410155525, 5860.941390586125, 5748.511376533042, 5758.021136406821, 5760.683162426107, 5770.653760774367, 5773.682447465346, 5508.9724551376985, 5542.695151766691, 5712.971435142797, 5781.306243250837, 5782.5663075268685, 4506.977465112654, 4508.797104130322, 4511.278195488706, 4550.522195169526, 4561.543845615412, 3972.503437070366, 3998.640122388999, 3999.280129576704, 4034.0318323602123, 4049.392591111298, 5366.275552800322, 5462.808801691922, 5543.501084902378, 5548.500634942875, 5553.305836770403, 5803.245578074823, 5817.854553636193, 5820.214271073435, 5847.532197424281, 5880.470757631833, 5495.0, 5497.230387745719, 5499.752511137009, 5505.256790333334, 5507.614466987273, 4950.5544500994365, 5026.84919452417, 5030.547250747451, 5035.118854200574, 5098.031374038921, 6017.69911504423, 6033.758649653964, 6057.515398768, 6124.785632502841, 6139.447449729546, 5838.766449342149, 5841.9192449397, 5842.38654941225, 5843.649381037151, 5847.883042339215, 5705.315362156568, 5984.042553191469, 6002.0996850472775, 6045.486133678686, 6066.908996365147, 5701.7149142541875, 5740.225069615715, 5741.081426971665, 5803.82588522345, 5805.593608447537, 5803.448672376117, 5804.071348584206, 5815.709214539341, 5819.0689489681445, 5822.417758224144, 5529.364123125731, 5622.269105016322, 5707.743151558273, 5713.9142912855505, 5720.399358067343, 5656.1798539212405, 5680.602357834912, 5682.431756824284, 5725.770969161187, 5743.8851222976145, 5603.607747457639, 5610.803621873378, 5614.129809879475, 5616.1014237721765, 5617.129344951539, 5503.2020357048805, 5607.5513958882375, 5673.574481913955, 5712.343080545625, 5712.485876271156, 5526.336839579276, 5569.19246709233, 5590.720463976866, 5613.0, 5672.886542269214], "value": 5340.7442693961075, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.5508480927281, 595.4521839907283, 599.1761328173761, 600.7867207141464, 629.2951893878857, 31200.687993120064, 34501.65498345019, 41640.16719665609, 42472.787636061854, 42473.78763106188, 39933.0, 40417.0, 40427.0, 40430.59569404305, 40518.18963620726, 8788.82422351551, 8883.46699198047, 8899.243564297043, 8902.910970890305, 8943.463392196456, 8012.759617211493, 8792.208701216889, 8898.59956301968, 10396.896031039707, 10605.469726513682, 10807.729806754816, 10873.075788557982, 10873.347599144077, 10882.40146791926, 10892.074173695246, 10685.519151638195, 10744.462776861126, 10751.193660475496, 10758.300710453796, 10766.24636275461, 8082.959585202095, 10362.222833287533, 10537.683869483928, 10637.627683031056, 10660.360378377245, 42217.36673949893, 42796.144077118595, 42841.785791071154, 42868.57131428677, 42879.142417151794, 2889.4221155768932, 2905.2010697058267, 3002.4445477586714, 3277.72139368154, 3287.178205448638, 31966.84016579902, 32217.677823221704, 32220.355592888245, 32431.837840810644, 32631.51052734211, 3771.698264138862, 3806.1816709407335, 3842.8847134585726, 3875.205582855508, 3889.2804831106337, 328777.0, 328886.0, 330597.0, 330669.0, 330855.34572327224, 46979.0, 48002.27996580054, 48037.0, 48164.518354816006, 49457.50542494529, 51488.742556286976, 51594.484055159715, 51670.0, 51675.0, 51742.48257517452, 13401.597952061455, 13466.596002119952, 13523.053386263064, 13604.31978401076, 13608.0, 9956.352837065568, 9972.152367048882, 10060.899391006142, 10063.245256605784, 10124.645637402655, 15097.54707358781, 16677.583060423585, 16877.915610422115, 16878.156092195342, 17330.566735831453, 6081.452669259788, 6086.60437071589, 6114.510839132859, 6165.8458538536, 6292.067457838851, 890.9287257019423, 983.9754006149903, 1045.1795340657548, 1065.2223876570147, 1096.6874440784497, 31251.531227031614, 31435.214119646735, 31538.0, 31555.36889262202, 31834.204144896565, 1021.2238698589126, 1041.807265655856, 1066.7173199102244, 1069.1660504806264, 1076.4940477975495, 15706.68586628261, 16361.59096022585, 16577.834221657627, 16634.25145868439, 17000.0, 543740.406489833, 544698.0, 547284.0, 549630.0, 550366.0, 57399.13901291484, 57477.71261143751, 57591.544507329694, 57883.421165787804, 57953.710231448575, 1147.5639257082423, 1175.61204802415, 1175.641429364052, 1204.3195594489262, 1273.1597145883673, 29116.563251551666, 30436.39127217399, 30854.84572577123, 31119.37203643446, 31270.218244544067, 50961.23558146705, 51381.22928156006, 51413.7429312851, 51431.48568514267, 51549.7422512885, 447203.0, 447978.0, 448103.0, 449601.0, 450589.0, 27840.303992400353, 28475.006749527332, 28662.570061448678, 29820.552691710076, 41786.791066044476, 39371.606283936795, 41316.79341603273, 47115.0, 47496.287555686, 51946.740266298424, 39997.0, 40640.59359406368, 41167.97080073022, 41179.58820411757, 42906.78546607247, 39722.40416393814, 40570.0, 40695.0, 41198.38202427026, 41948.37077443902, 40233.79883100566, 40644.904854175744, 41860.1627967445, 41977.1604567913, 42040.57959420489, 33475.0, 36169.81915090513, 36773.63226367809, 37457.81271093627, 38385.616143839325, 27110.72889271082, 27332.726672733017, 27401.86299068492, 27474.0, 27831.582526262526], "value": 19436.779189593344, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.1906225519791, 396.6846357146069, 402.95768944260846, 405.18962075848304, 418.67761823395983, 12907.070996042536, 17911.55221119471, 19599.216031358763, 19732.40802775917, 19867.900660496678, 13749.762521373075, 15820.683586328267, 16295.185240737976, 16353.83646163538, 16638.75041874373, 5744.597878148542, 5966.970165149168, 5967.880642387149, 5970.1940238067955, 6019.939800601982, 5705.77176912923, 5850.707464626773, 5919.289685237777, 5919.763209471616, 5931.457820966537, 5878.794242201524, 5897.292324921015, 5905.970470147643, 5906.527477801766, 5908.911366329487, 5699.287589051369, 5854.853628659296, 5862.20860183874, 5874.70626468677, 5887.4112588741, 5267.367915850123, 5275.129603615399, 5276.4459731728, 5276.970990656823, 5278.762455689503, 21963.890180549155, 21999.670004949938, 22097.447563810874, 22133.557328853334, 22782.49002624798, 2288.6795848581214, 2347.272345572878, 2424.672669189672, 2811.5079861024237, 3028.712272334125, 14269.643258918506, 14365.414225439417, 14553.0, 14572.854271457361, 14674.63313417173, 1917.4726950088698, 1929.5947850951318, 1960.3236883275247, 1973.5756812285429, 1974.9506262343414, 82558.0, 83785.58107209486, 84359.57820210922, 85187.5740621293, 85749.57125214397, 9665.0, 10519.894801052045, 10693.465326733633, 10787.730306742395, 10933.45332733376, 14824.258787060604, 14827.18450485212, 14853.405863765329, 14868.62828429298, 14870.553883383516, 7223.530470519399, 7272.454565907578, 7344.228855970153, 7617.390608751287, 7628.122765881994, 6827.556208846409, 6884.277150899184, 6894.896576551356, 7003.859922801617, 7036.718531258794, 5680.488756011979, 6116.3577824328695, 6118.938810611926, 6290.21372328459, 6517.283098859121, 1853.5366158460386, 1922.7212054252054, 1932.3623204342534, 1982.8215460608615, 2006.0650799034247, 881.3654168998439, 921.755734730297, 937.8171256604896, 1076.7738774857212, 1084.9132069434584, 17282.395116170872, 17816.46550603484, 18984.0, 19430.61138777245, 19494.31769888047, 948.7770373962113, 983.468926779531, 995.0546980368679, 1020.9336393134422, 1031.7730099378125, 10252.38485690861, 10775.407352595526, 10810.783784324269, 10819.188560857967, 10837.0, 504720.0, 507639.0, 512946.0, 513920.0, 532560.0, 91902.0, 91974.0, 92235.53882230546, 92654.0, 94054.52972735092, 972.7811242470387, 976.4678250353575, 980.4068538534227, 990.8067926754213, 992.0525897767759, 16656.41702540405, 16791.664166716353, 17383.304667813147, 17402.651946961243, 17661.0, 43145.568544314156, 43361.78319108384, 43798.0, 44616.0, 44726.3291050641, 57487.1376929338, 58377.0, 60487.39512604818, 60977.69511152416, 61770.69114654398, 6635.8009259722285, 6711.765088221889, 6848.897266541106, 6878.7248510059035, 6899.55152915079, 10219.437930913573, 13208.669783255495, 13212.405441754952, 13386.330683465983, 13623.0, 11170.832437513607, 11606.88393116058, 11687.917576650116, 11765.294082355085, 11810.586629467927, 11331.716707082389, 11380.601678941197, 11407.657770266906, 11439.485223164811, 12266.815997759863, 11401.258918170292, 11522.193446458667, 11794.76410471803, 11968.940155299168, 12329.876701232874, 6570.342965703582, 6587.868242635216, 6663.933360666331, 6821.488388370992, 6848.623325716934, 9443.622255109718, 11317.830232546354, 11495.252808567417, 11624.360660163773, 12051.156419050933], "value": 9144.595585273095, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1306.0465859922263, 1464.9602075692937, 1494.708531836292, 1617.5470868156913, 1761.2690733345662, 7385.224551422104, 8376.53929033903, 8639.56802159891, 8644.610992505337, 8867.733967980956, 8090.271875531201, 8147.877781833263, 8153.673853045886, 8161.469504482205, 8170.305524030449, 2048.600522898028, 2355.1168311883043, 2371.1108334374608, 2418.3349578865777, 2426.1265944260053, 2437.171361737009, 2479.1942618648923, 2486.17956074495, 2486.8880900359527, 2488.328151399121, 2399.7934807430674, 2421.0799896039566, 2425.0784701813286, 2449.35092200567, 2451.82837201396, 2299.689541911854, 2327.7439481657, 2339.438534751656, 2341.8711970841596, 2372.2764556810166, 2354.7645235476316, 2359.7050368703913, 2370.7510711375403, 2373.0270589058578, 2373.1456675596773, 8978.326625503048, 9033.23217526511, 9039.096090390974, 9042.412243204237, 9047.411918225294, 4914.926276105862, 5048.873778155539, 5050.898982020376, 5059.266406371093, 5095.974520127413, 3400.302937897725, 3409.2670075933793, 3555.2000799820094, 3559.982200088983, 3568.1793187567005, 1163.720707030315, 1211.977068561441, 1223.6145614131608, 1228.0728050322039, 1232.6240496648518, 12139.817902731465, 12161.817572736416, 12183.086268529807, 12199.14605977582, 12218.694532636755, 4311.245532031882, 4466.0, 4608.585227329557, 4608.654350923627, 4628.97685511577, 9325.393849399903, 9336.766580835534, 9338.533073346442, 9340.112689294507, 9343.205827504738, 4845.6608037437745, 4850.393700787402, 4860.416749989953, 4866.270059491034, 4873.147199240118, 4092.7135100542678, 4476.597106260452, 4550.203714349976, 4551.795169217393, 4566.95433045672, 3855.9228815424094, 3870.1292209252692, 3966.8809935701975, 3967.563568007517, 3978.104926391539, 1186.3593659423987, 1194.5878671858368, 1210.406900618708, 1213.2599114540124, 1215.5380955236953, 810.2181394953898, 814.287498438866, 846.6020970144023, 941.1482608239418, 984.3060642247199, 6140.17107690465, 6144.8771024579255, 6179.598326108789, 6353.142325786052, 6477.77327793525, 921.6681994481982, 947.516766449116, 956.7655924298591, 978.8238117138841, 980.3921568627496, 3937.9606203938165, 4161.583841615875, 4182.0, 4182.644475219579, 4286.742795432284, 11126.944365278121, 11309.151813614011, 11420.714482138013, 11456.54173833054, 11497.080233581293, 10569.894301056891, 11069.225154239126, 11304.71738206535, 11330.433478326215, 11350.262232954832, 8219.465734727342, 8426.4944103354, 8430.915690843136, 8431.241188293207, 8433.915660843313, 5910.23166988306, 5999.0, 6174.506039516738, 6210.347913469021, 6348.573762815197, 9641.517924103908, 10062.899371006197, 10099.545520451744, 10172.949135254275, 10288.12550933179, 10313.793724125626, 10344.948275258575, 10392.16862650971, 10392.688219353431, 10399.428031458343, 7797.532148071134, 7797.92202077972, 7825.1783562725095, 7906.327962123284, 7929.960350198212, 8283.917160828314, 8336.416450848383, 8383.287420569077, 8409.579521023801, 8416.83166336682, 7556.282153195438, 7664.34853037498, 7794.337481314152, 8052.349268400081, 8183.631736571988, 7671.53970761756, 7696.46124771283, 7706.3449606781805, 7767.883481747891, 7779.260970207822, 6993.790186294419, 7044.929550704427, 7089.574625522485, 7091.326323999212, 7099.0416293801745, 5088.185890257541, 5097.337346144977, 5129.820456284012, 5149.2276158576515, 5329.786808527616, 5267.394249661338, 5271.262023316815, 5293.0, 5295.973520132375, 5519.448055194448], "value": 4633.45951762252, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.7554247627993, 336.99494507582403, 339.93031428557134, 346.3575068248399, 347.65755730605355, 5199.4800519948085, 5260.631755777087, 5309.442508536606, 5371.060064488714, 5374.6237763356585, 5228.503292187245, 5238.790448382069, 5258.6318957672975, 5270.209468579715, 5277.261183434322, 4178.289690752579, 4183.226103170908, 4187.225363307798, 4195.181939521779, 4203.222403855281, 3953.0, 4065.3292206785845, 4186.288330983725, 4193.706440549163, 4230.13282277134, 4065.4308396824467, 4065.6747460203114, 4089.3457046872504, 4102.897427564305, 4108.993296642327, 4100.954256664561, 4100.974756310922, 4101.666958238585, 4103.4050062740735, 4139.2135494256, 3618.9638103619154, 3639.636036396366, 3642.6721595056574, 3654.634536546351, 3655.6527129922615, 5054.823081192178, 5094.2103973884105, 5099.872503187413, 5100.515451032146, 5194.870128246786, 4657.580817726421, 4693.741844198567, 4696.365990591261, 4706.576408123251, 4716.481187069419, 5464.26232458617, 5472.20653005312, 5474.72626368684, 5476.616636835423, 5484.122540393518, 3747.257525250744, 3911.198204368098, 3928.487532300085, 3941.3890846918775, 3948.4274780157, 5631.380548139701, 5670.5747068969995, 5694.77220911163, 5710.514606258473, 5711.172424824058, 4069.552349241581, 4075.4121133080707, 4084.4690190275073, 4092.7953602319767, 4129.174165166918, 3893.4549163117185, 4004.7196696231567, 4011.157656892027, 4045.211183819127, 4177.749335039907, 4610.054938737618, 4611.700239484423, 4617.746023968647, 4632.189366860854, 4649.814007439732, 5552.639078459887, 5567.749451274703, 5603.831885043455, 5633.859153521113, 5659.377468478464, 1311.4557458654551, 1345.643404497809, 1422.679897023182, 1430.592281199853, 1438.216172186161, 952.6522819170953, 983.6803039012207, 984.3552473130111, 1000.4047591682937, 1009.8535712321819, 5358.651687640291, 5363.168708850135, 5364.471125729148, 5368.57051435892, 5391.32608423947, 5626.746796394172, 5632.0, 5634.915476267859, 5642.266505354278, 5644.915326270109, 5193.974030129825, 5331.760070796823, 5380.73096345189, 5381.542568881689, 5437.972810136003, 3016.1403999859936, 3027.8788848446256, 3029.5152775555807, 3034.878604855781, 3053.541968704712, 5899.262592175978, 5917.881642367129, 5925.259342582177, 5989.460948514655, 6003.459688628044, 5544.279243698294, 5795.565332600072, 5849.444302791228, 5851.414858514115, 5888.175655408247, 5894.02550145706, 5946.167536544801, 5956.463918247378, 5960.135780311831, 5978.611390259619, 5533.703513042043, 5608.2799842077375, 5640.774369025193, 5747.367789543064, 5780.514378817149, 5598.844444888666, 5599.0, 5621.133222056862, 5642.971785141048, 5668.7732490701555, 5830.62100963436, 5849.181114644039, 5905.438983296752, 5919.704014799329, 5940.316863560746, 3997.820098095651, 4132.586741325843, 4150.273702102059, 4152.418661387348, 4155.501339839238, 5691.686957217393, 5693.975084484832, 5696.316442026983, 5696.515796157208, 5703.914441283301, 5341.599380046589, 5569.275994120739, 5578.330600327987, 5609.158626206102, 5623.37292446378, 5432.212329212163, 5506.834794956158, 5509.834704958857, 5536.0, 5536.7231638418725, 5390.541803946551, 5454.536364409069, 5461.371942226536, 5501.944980550144, 5512.153428601463, 5468.26178465902, 5593.748281327432, 5631.690257035739, 5631.831045068655, 5651.406602306699, 5470.398256191896, 5474.644148130359, 5503.752331145028, 5504.53211477029, 5524.8342549723575], "value": 4240.877860521284, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.3800606402692, 646.6088016749866, 655.8852200864848, 698.5284932670446, 716.8064622551911, 13650.590482285523, 14515.346809393577, 14525.41898324067, 14527.854721452783, 14534.127952322868, 12797.744045119092, 12919.224846509216, 12938.547150849723, 12959.222446653208, 13218.471261149567, 665.4443539644403, 784.705735349244, 813.0365516862507, 813.0730966697969, 818.292177266663, 797.5653268968426, 803.2329125684956, 807.1323327423014, 820.8768684697313, 822.391430341546, 845.6025667936091, 849.1084361420515, 851.1233429567556, 851.6252848746532, 851.880736696863, 688.187938232885, 836.9748907532784, 842.8735689646571, 843.8101427178897, 844.0209357145712, 453.0214736169857, 469.7533794757745, 470.8422678402739, 481.2468486818153, 481.713380538579, 13157.671058223621, 13181.934090329583, 13217.339133043406, 13233.602991910258, 13241.933790331082, 13560.796588051187, 14266.3580138894, 14376.928115359357, 14386.136831790127, 14615.196164210964, 12234.571789987396, 12364.938175309157, 12427.565035223814, 12487.562935297312, 12632.936835315764, 4385.780710964439, 4412.779361031968, 4470.485894122185, 4490.787487378389, 4652.720836749806, 83175.0, 84163.5791821037, 84746.0, 85268.57365713194, 87163.56418217868, 10523.84214236787, 10794.838077428845, 10929.672109836718, 11000.394978276112, 11047.281926674741, 22115.33653990383, 22160.224392146196, 22174.223902163347, 22179.223727169796, 22196.889015554818, 8522.40952304865, 8579.82840343202, 8755.824883502422, 8806.031336552975, 8954.059823718415, 4385.5135167541885, 4439.911201775946, 4558.749268790182, 4595.356650068993, 4702.059588082398, 3191.5372271020574, 3252.7397808175288, 3272.378248132847, 3289.358575077837, 3293.75296852737, 541.783286685329, 543.6411968101035, 551.8123837895135, 557.1169696031754, 559.0, 510.6884800271831, 552.9281193444826, 573.3721574875505, 598.5221184297014, 609.1441524657863, 9173.40372875761, 9230.492322922304, 9305.348625596278, 9547.618095276111, 9586.568604412818, 521.8069314353713, 568.6502800777574, 575.6862509932097, 597.489146779506, 599.1073300781803, 4320.891977700583, 4331.028569434501, 4416.53626369233, 4571.5428457154685, 4656.883577910579, 122810.0, 125309.37345313215, 125947.0, 128657.35671321584, 129894.35052824675, 107435.46282268695, 107849.0, 110206.44896775465, 111041.44479277552, 116289.02265864075, 90392.0, 93806.0, 94791.52604236934, 94843.52578237203, 95778.52110739541, 8100.635471403683, 8542.572871356531, 8576.44253123545, 8589.82820343577, 8641.135886411308, 39749.80125099356, 51210.0, 51802.222966656285, 52223.47776522338, 53879.19181212363, 71910.64044679744, 80737.19262807297, 82613.58693206737, 83942.0, 85204.57397712972, 10706.250562460553, 10726.0, 10829.076308414076, 11043.061339786209, 11253.493592788507, 12045.51817927273, 12060.577879774166, 12076.335801531, 12124.636260912186, 12238.449269782703, 10851.728706782395, 10956.233063685784, 11279.605213817476, 11281.943590282324, 11882.881171188177, 11344.943275283571, 11671.649850504498, 11902.702432439259, 12075.27548347102, 12237.20458170216, 10377.429241391796, 10551.208659350426, 10630.30902991303, 10942.343459392461, 11068.225224234226, 9127.817443651222, 9220.44677319363, 9473.810523789623, 9753.170980466739, 9859.260555458513, 8829.205371516595, 9724.0, 9833.950830245803, 9866.851997219905, 9891.901080989386], "value": 7087.143354326906, "unit": "score"}], "name": "dromaeo_css", "value": 7137.4717606247805, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 126.0, 113.0, 113.0, 112.0, 113.0, 112.0, 112.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 155.0, 182.0, 117.0, 144.0, 151.0, 120.0, 175.0, 119.0], "value": 144.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 160.0, 161.0, 160.0, 161.0, 161.0, 162.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 76.0, 171.0, 76.0, 76.0, 79.0, 76.0, 175.0, 76.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 144.0, 85.0, 87.0, 85.0, 143.0, 85.0, 84.0, 147.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 53.0, 53.0, 51.0, 53.0, 53.0, 52.0, 51.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 61.0, 60.0, 60.0, 62.0, 60.0, 62.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 79.0, 78.0, 80.0, 79.0, 77.0, 79.0, 79.0, 77.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 137.0, 121.0, 120.0, 121.0, 131.0, 122.0, 123.0, 141.0, 139.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 165.0, 162.0, 165.0, 168.0, 164.0, 164.0, 169.0, 171.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 68.0, 68.0, 64.0, 63.0, 65.0, 65.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1525.6, "alertThreshold": 2.0}]} 14:39:52 INFO - Return code: 0 14:39:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:39:52 INFO - # TBPL SUCCESS # 14:39:52 INFO - Running post-action listener: _resource_record_post_action 14:39:52 INFO - [mozharness: 2016-08-23 21:39:52.373411Z] Finished run-tests step (success) 14:39:52 INFO - Running post-run listener: _resource_record_post_run 14:39:52 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 7700480; Write bytes: 373862400; Read time: 1224; Write time: 262384 14:39:52 INFO - TinderboxPrint: CPU usage
13.3% 14:39:52 INFO - TinderboxPrint: I/O read bytes / time
7,700,480 / 1,224 14:39:52 INFO - TinderboxPrint: I/O write bytes / time
373,862,400 / 262,384 14:39:52 INFO - TinderboxPrint: CPU idle
8,301.6 (86.7%) 14:39:52 INFO - TinderboxPrint: CPU user
1,202.2 (12.6%) 14:39:52 INFO - TinderboxPrint: Swap in / out
0 / 0 14:39:52 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 30003200; Read time: 0; Write time: 17684 14:39:52 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 5464064; Write bytes: 277905408; Read time: 836; Write time: 186372 14:39:53 INFO - Running post-run listener: _upload_blobber_files 14:39:53 INFO - Blob upload gear active. 14:39:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:39:53 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 14:39:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:39:53 INFO - (blobuploader) - INFO - Open directory for files ... 14:39:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:39:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:39:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:39:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:39:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:39:54 INFO - (blobuploader) - INFO - Done attempting. 14:39:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:39:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:39:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:39:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:39:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:39:54 INFO - (blobuploader) - INFO - Done attempting. 14:39:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:39:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:39:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:39:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:39:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:39:58 INFO - (blobuploader) - INFO - Done attempting. 14:39:58 INFO - (blobuploader) - INFO - Iteration through files over. 14:39:58 INFO - Return code: 0 14:39:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:39:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:39:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b6cb58ee21ddaba83f0eaf515b51afeaf3a36d00df4a4ece882a2281d82635a41041b85d45129032ecfd656189a4f32be7aa0c8d0f9c18fb280476cabb87163", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b605e001b64785eab50ec94cd50f45bbe529cef5756a54be949cddf98815e18f7d50783a3a2055081abb8fe75f3ed7751510b41494699be9eaaeebfc498a34ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eed89198998e450c56a98c41692220503a3213a37c7749aa9a884214430409b42ad77dcde7edd6ed374c0037ecfc08177bd77dfe5ad10e1a165346415f81f8ec"} 14:39:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:39:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:39:58 INFO - Contents: 14:39:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b6cb58ee21ddaba83f0eaf515b51afeaf3a36d00df4a4ece882a2281d82635a41041b85d45129032ecfd656189a4f32be7aa0c8d0f9c18fb280476cabb87163", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b605e001b64785eab50ec94cd50f45bbe529cef5756a54be949cddf98815e18f7d50783a3a2055081abb8fe75f3ed7751510b41494699be9eaaeebfc498a34ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eed89198998e450c56a98c41692220503a3213a37c7749aa9a884214430409b42ad77dcde7edd6ed374c0037ecfc08177bd77dfe5ad10e1a165346415f81f8ec"} 14:39:58 INFO - Running post-run listener: copy_logs_to_upload_dir 14:39:58 INFO - Copying logs to upload dir... 14:39:58 INFO - mkdir: /builds/slave/test/build/upload/logs 14:39:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.303461 ========= master_lag: 0.41 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-23 14:39:58.884124) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 14:39:58.887420) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b6cb58ee21ddaba83f0eaf515b51afeaf3a36d00df4a4ece882a2281d82635a41041b85d45129032ecfd656189a4f32be7aa0c8d0f9c18fb280476cabb87163", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b605e001b64785eab50ec94cd50f45bbe529cef5756a54be949cddf98815e18f7d50783a3a2055081abb8fe75f3ed7751510b41494699be9eaaeebfc498a34ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eed89198998e450c56a98c41692220503a3213a37c7749aa9a884214430409b42ad77dcde7edd6ed374c0037ecfc08177bd77dfe5ad10e1a165346415f81f8ec"} build_url:https://queue.taskcluster.net/v1/task/LB11U0A_QnO3IpL1biu6mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/LB11U0A_QnO3IpL1biu6mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b6cb58ee21ddaba83f0eaf515b51afeaf3a36d00df4a4ece882a2281d82635a41041b85d45129032ecfd656189a4f32be7aa0c8d0f9c18fb280476cabb87163", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b605e001b64785eab50ec94cd50f45bbe529cef5756a54be949cddf98815e18f7d50783a3a2055081abb8fe75f3ed7751510b41494699be9eaaeebfc498a34ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eed89198998e450c56a98c41692220503a3213a37c7749aa9a884214430409b42ad77dcde7edd6ed374c0037ecfc08177bd77dfe5ad10e1a165346415f81f8ec"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 14:39:58.913178) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 14:39:58.913500) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1471987149.178444-2027213105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 14:39:58.996827) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 14:39:58.997285) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 14:39:58.997628) ========= ========= Total master_lag: 0.56 =========